ODL neon перестает посылать действие на коммутатор, коммутатор не может зарегистрировать контроллер в главной роли - PullRequest
0 голосов
/ 07 июня 2019

Я использую последнюю версию контроллера ODL (неон) для регистрации и управления коммутаторами Brocade SLX.
Я периодически сталкиваюсь с проблемой, связанной с тем же, когда через неопределенное время, даже если коммутатор был зарегистрирован, контроллер не может распространять действие на устройство.
В этот момент контроллер пытается изменить роль устройства для управления, однако происходит сбой с исключением времени ожидания после попытки в течение 9 секунд.
Я добавляю 2 снимка журналов ODL здесь

  1. Когда устройство работает нормально
2019-06-06T06:16:05,962 | INFO  | epollEventLoopGroup-7-1 | ConnectionAdapterImpl            | 259 - org.opendaylight.openflowplugin.openflowjava.openflow-protocol-impl - 0.8.1 | Hello received
2019-06-06T06:16:06,015 | INFO  | epollEventLoopGroup-7-1 | ContextChainHolderImpl           | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Device openflow:108437662859272 connected.
2019-06-06T06:16:06,015 | INFO  | epollEventLoopGroup-7-1 | ContextChainHolderImpl           | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | No context chain found for device: openflow:108437662859272, creating new.
2019-06-06T06:16:06,016 | INFO  | epollEventLoopGroup-7-1 | DeviceManagerImpl                | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | ConnectionEvent: Device connected to controller, Device:/10.25.225.42:57147, NodeId:Uri{_value=openflow:108437662859272}
2019-06-06T06:16:06,087 | INFO  | epollEventLoopGroup-7-1 | RoleContextImpl                  | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Started timer for setting SLAVE role on device openflow:108437662859272 if no role will be set in 20s.
2019-06-06T06:16:06,124 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-37 | DeviceOwnershipServiceImpl       | 240 - org.opendaylight.openflowplugin.applications.device-ownership-service - 0.8.1 | Entity ownership change received for node : openflow:108437662859272 : EntityOwnershipChange [entity=Entity [type=org.opendaylight.mdsal.ServiceEntityType, id=KeyedInstanceIdentifier{targetType=interface org.opendaylight.yang.gen.v1.urn.opendaylight.params.xml.ns.yang.mdsal.core.general.entity.rev150930.Entity, path=[org.opendaylight.yang.gen.v1.urn.opendaylight.params.xml.ns.yang.mdsal.core.general.entity.rev150930.Entity[key=EntityKey{_name=openflow:108437662859272}]]}], state=LOCAL_OWNERSHIP_GRANTED [wasOwner=false, isOwner=true, hasOwner=true], inJeopardy=false]
2019-06-06T06:16:06,135 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | GuardedContextImpl               | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Starting DeviceContextImpl[NEW] service for node openflow:108437662859272
2019-06-06T06:16:06,286 | INFO  | epollEventLoopGroup-7-1 | StringValueObjectFactory         | 205 - org.opendaylight.mdsal.binding-spec-util - 1.0.8 | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev130715.Ipv4Address
2019-06-06T06:16:06,288 | INFO  | epollEventLoopGroup-7-1 | StringValueObjectFactory         | 205 - org.opendaylight.mdsal.binding-spec-util - 1.0.8 | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev130715.Ipv4AddressNoZone
2019-06-06T06:16:06,291 | INFO  | epollEventLoopGroup-7-1 | StringValueObjectFactory         | 205 - org.opendaylight.mdsal.binding-spec-util - 1.0.8 | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev130715.Ipv4Prefix
2019-06-06T06:16:06,297 | INFO  | epollEventLoopGroup-7-1 | StringValueObjectFactory         | 205 - org.opendaylight.mdsal.binding-spec-util - 1.0.8 | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev130715.Ipv6Address
2019-06-06T06:16:06,301 | INFO  | epollEventLoopGroup-7-1 | StringValueObjectFactory         | 205 - org.opendaylight.mdsal.binding-spec-util - 1.0.8 | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev130715.Ipv6AddressNoZone
2019-06-06T06:16:06,302 | INFO  | epollEventLoopGroup-7-1 | StringValueObjectFactory         | 205 - org.opendaylight.mdsal.binding-spec-util - 1.0.8 | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev130715.Ipv6Prefix
2019-06-06T06:16:06,307 | INFO  | epollEventLoopGroup-7-1 | DeviceInitializationUtil         | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | IP address of the node openflow:108437662859272 is: IpAddress{_ipv4Address=Ipv4Address{_value=10.25.225.42}}
2019-06-06T06:16:06,309 | INFO  | epollEventLoopGroup-7-1 | DeviceInitializationUtil         | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Port number of the node openflow:108437662859272 is: 57147
2019-06-06T06:16:07,623 | INFO  | epollEventLoopGroup-7-1 | OF13DeviceInitializer            | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Static node openflow:108437662859272 info: OFPMPMETERFEATURES collected
2019-06-06T06:16:07,653 | INFO  | epollEventLoopGroup-7-1 | OF13DeviceInitializer            | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Static node openflow:108437662859272 info: OFPMPGROUPFEATURES collected
2019-06-06T06:16:07,741 | INFO  | epollEventLoopGroup-7-1 | StringValueObjectFactory         | 205 - org.opendaylight.mdsal.binding-spec-util - 1.0.8 | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.yang.types.rev130715.MacAddress
2019-06-06T06:16:07,747 | INFO  | epollEventLoopGroup-7-1 | StringValueObjectFactory         | 205 - org.opendaylight.mdsal.binding-spec-util - 1.0.8 | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.yang.types.rev130715.PhysAddress
2019-06-06T06:16:07,759 | INFO  | epollEventLoopGroup-7-1 | OF13DeviceInitializer            | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Static node openflow:108437662859272 info: OFPMPPORTDESC collected
2019-06-06T06:16:08,011 | INFO  | epollEventLoopGroup-7-1 | OF13DeviceInitializer            | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Static node openflow:108437662859272 successfully finished collecting
2019-06-06T06:16:08,039 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | GuardedContextImpl               | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Starting RpcContextImpl[NEW] service for node openflow:108437662859272
2019-06-06T06:16:08,292 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | GuardedContextImpl               | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Starting StatisticsContextImpl[NEW] service for node openflow:108437662859272
2019-06-06T06:16:08,420 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | GuardedContextImpl               | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Starting RoleContextImpl[NEW] service for node openflow:108437662859272
2019-06-06T06:16:08,425 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | SalRoleServiceImpl               | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | SetRole called with input:SetRoleInput{_controllerRole=BECOMEMASTER, _node=NodeRef{_value=KeyedInstanceIdentifier{targetType=interface org.opendaylight.yang.gen.v1.urn.opendaylight.inventory.rev130819.nodes.Node, path=[org.opendaylight.yang.gen.v1.urn.opendaylight.inventory.rev130819.Nodes, org.opendaylight.yang.gen.v1.urn.opendaylight.inventory.rev130819.nodes.Node[key=NodeKey{_id=Uri{_value=openflow:108437662859272}}]]}}, augmentation=[]}
2019-06-06T06:16:08,443 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | SalRoleServiceImpl               | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Requesting state change to BECOMEMASTER
2019-06-06T06:16:08,444 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | SalRoleServiceImpl               | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | RoleChangeTask called on device:openflow:108437662859272 OFPRole:BECOMEMASTER
2019-06-06T06:16:08,446 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | RoleService                      | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | getGenerationIdFromDevice called for device: openflow:108437662859272
2019-06-06T06:16:08,537 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | RoleService                      | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | submitRoleChange called for device:Uri{_value=openflow:108437662859272}, role:BECOMEMASTER
2019-06-06T06:16:08,551 | INFO  | opendaylight-cluster-data-akka.actor.default-dispatcher-24 | ContextChainImpl                 | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Started clustering services for node openflow:108437662859272
2019-06-06T06:16:08,564 | INFO  | epollEventLoopGroup-7-1 | RoleService                      | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | submitRoleChange onSuccess for device:Uri{_value=openflow:108437662859272}, role:BECOMEMASTER
2019-06-06T06:16:08,980 | INFO  | ofppool-0        | FlowNodeReconciliationImpl       | 241 - org.opendaylight.openflowplugin.applications.forwardingrules-manager - 0.8.1 | Triggering reconciliation for device NodeKey{_id=Uri{_value=openflow:108437662859272}}
2019-06-06T06:16:08,997 | INFO  | ListenableFutureAdapter-thread-0 | ContextChainHolderImpl           | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Device openflow:108437662859272 connection is enabled by reconciliation framework.
2019-06-06T06:16:09,056 | INFO  | ListenableFutureAdapter-thread-0 | ContextChainImpl                 | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Device openflow:108437662859272 is able to work as master.
2019-06-06T06:16:09,068 | INFO  | ListenableFutureAdapter-thread-0 | ContextChainHolderImpl           | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Role MASTER was granted to device openflow:108437662859272
2019-06-06T06:16:09,112 | INFO  | ListenableFutureAdapter-thread-0 | DeviceManagerImpl                | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Publishing node added notification for Uri{_value=openflow:108437662859272}
2019-06-06T06:16:09,156 | INFO  | ListenableFutureAdapter-thread-0 | StatisticsContextImpl            | 252 - org.opendaylight.openflowplugin.impl - 0.8.1 | Starting statistics gathering for node openflow:108437662859272
2019-06-06T06:16:09,284 | INFO  | opendaylight-cluster-data-notification-dispatcher-78 | StaticConfiguration              | 199 - org.opendaylight.mdsal.binding-dom-adapter - 3.0.8 | Binding-over-DOM codec shortcuts are enabled
Когда устройство не регистрируется и не может распространять действия
2019-05-31 02:37:55,989 | INFO  | entLoopGroup-7-2 | ConnectionAdapterImpl            | 340 - org.opendaylight.openflowplugin.openflowjava.openflow-protocol-impl - 0.5.1 | Hello received
2019-05-31 02:37:55,993 | INFO  | entLoopGroup-7-2 | ContextChainHolderImpl           | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Device openflow:108437662859272 connected.
2019-05-31 02:37:55,993 | INFO  | entLoopGroup-7-2 | ContextChainHolderImpl           | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | No context chain found for device: openflow:108437662859272, creating new.
2019-05-31 02:37:55,993 | INFO  | entLoopGroup-7-2 | DeviceManagerImpl                | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | ConnectionEvent: Device connected to controller, Device:/10.25.225.42:48927, NodeId:Uri [_value=openflow:108437662859272]
2019-05-31 02:37:55,994 | INFO  | entLoopGroup-7-2 | RoleContextImpl                  | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Started timer for setting SLAVE role on device openflow:108437662859272 if no role will be set in 20s.
2019-05-31 02:37:55,994 | INFO  | entLoopGroup-7-2 | GuardedContextImpl               | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Starting DeviceContextImpl[NEW] service for node openflow:108437662859272
2019-05-31 02:38:04,996 | WARN  | entLoopGroup-7-2 | ContextChainImpl                 | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Not able to start clustering services for node openflow:108437662859272
2019-05-31 02:38:04,997 | WARN  | ofppool-3        | ContextChainHolderImpl           | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Not able to set MASTER role on device openflow:108437662859272, reason: java.lang.RuntimeException: Failed to initialize device openflow:108437662859272 in 9s: java.util.concurrent.TimeoutException
2019-05-31 02:38:04,997 | WARN  | ofppool-3        | ContextChainHolderImpl           | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | This mastering is mandatory, destroying context chain and closing connection for device openflow:108437662859272.
2019-05-31 02:38:04,997 | INFO  | ofppool-3        | ReconciliationManagerImpl        | 360 - org.opendaylight.openflowplugin.applications.reconciliation-framework - 0.5.1 | Stopping reconciliation for node Uri [_value=openflow:108437662859272]
2019-05-31 02:38:04,997 | WARN  | ofppool-3        | ClusterSingletonServiceGroupImpl | 273 - org.opendaylight.mdsal.singleton-dom-impl - 2.3.1 | Service group openflow:108437662859272 stopping unregistered service org.opendaylight.openflowplugin.impl.lifecycle.ContextChainImpl@6ad955c5
2019-05-31 02:38:04,997 | INFO  | ofppool-3        | ReconciliationManagerImpl        | 360 - org.opendaylight.openflowplugin.applications.reconciliation-framework - 0.5.1 | Stopping reconciliation for node Uri [_value=openflow:108437662859272]
2019-05-31 02:38:04,997 | INFO  | ofppool-3        | ContextChainHolderImpl           | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Role SLAVE was granted to device openflow:108437662859272
2019-05-31 02:38:04,997 | INFO  | ofppool-3        | GuardedContextImpl               | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Stopping RoleContextImpl[NEW] service for node openflow:108437662859272
2019-05-31 02:38:04,997 | INFO  | ofppool-3        | GuardedContextImpl               | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Stopping StatisticsContextImpl[NEW] service for node openflow:108437662859272
2019-05-31 02:38:04,998 | INFO  | ofppool-3        | StatisticsContextImpl            | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Stopping running statistics gathering for node openflow:108437662859272
2019-05-31 02:38:04,998 | INFO  | ofppool-3        | GuardedContextImpl               | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Stopping RpcContextImpl[NEW] service for node openflow:108437662859272
2019-05-31 02:38:04,998 | INFO  | ofppool-3        | GuardedContextImpl               | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Stopping DeviceContextImpl[STARTING] service for node openflow:108437662859272
2019-05-31 02:38:05,005 | INFO  | ofppool-0        | ContextChainImpl                 | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Closed clustering services for node openflow:108437662859272
2019-05-31 02:38:05,006 | INFO  | ofppool-3        | ContextChainImpl                 | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Closed clustering services registration for node openflow:108437662859272
2019-05-31 02:38:05,006 | INFO  | ofppool-3        | GuardedContextImpl               | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Terminating DeviceContextImpl[TERMINATED] service for node openflow:108437662859272
2019-05-31 02:38:05,006 | INFO  | ofppool-3        | GuardedContextImpl               | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Terminating RpcContextImpl[TERMINATED] service for node openflow:108437662859272
2019-05-31 02:38:05,006 | INFO  | ofppool-3        | GuardedContextImpl               | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Terminating StatisticsContextImpl[TERMINATED] service for node openflow:108437662859272
2019-05-31 02:38:05,006 | INFO  | ofppool-3        | StatisticsContextImpl            | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Stopping running statistics gathering for node openflow:108437662859272
2019-05-31 02:38:05,006 | INFO  | ofppool-3        | GuardedContextImpl               | 353 - org.opendaylight.openflowplugin.impl - 0.5.1 | Terminating RoleContextImpl[TERMINATED] service for node openflow:108437662859272

Ниже приведен список устанавливаемых плагинов

odl-openflowplugin-app-bulk-o-matic
odl-openflowplugin-app-config-pusher
odl-openflowplugin-app-forwardingrules-manager
odl-openflowplugin-app-forwardingrules-sync
odl-openflowplugin-app-notifications
odl-openflowplugin-app-reconciliation-framework
odl-openflowplugin-app-southbound-cli
odl-openflowplugin-app-table-miss-enforcer
odl-openflowplugin-app-topology
odl-openflowplugin-drop-test
odl-openflowplugin-flow-services
odl-openflowplugin-flow-services-rest
odl-openflowplugin-nsf-model
odl-openflowplugin-nxm-extensions
odl-openflowplugin-onf-extensions
odl-openflowplugin-southbound
odl-restconf-all
odl-yanglib

ODL настроен в Ubuntu16 на виртуальной машине в сети с openjdk8
Коммутатор доступен в этой сети.
Опубликуйте проблему, я попытался

  1. остановить и запустить ODL
  2. удалить папку с данными и начать установку и заново установить плагины
  3. ПолностьюСотрите настройки и начните заново настройку установки плагинов снова
  4. Перезапустите коммутатор
  5. Очистите контроллер OpenFlow от коммутатора и перезапустите коммутатор

Но это не такТ помочь.Мы заканчиваем настраивать его на новую виртуальную машину каждый раз.
Пожалуйста, сообщите, если есть какие-либо настройки для изменения тайм-аута назначения главной роли
Любые указатели вокруг этой проблемы будут полезны.

...