Uploaded image for project: 'VOLTHA'
  1. VOLTHA
  2. VOL-3523

BBSim doesn't clear the DHCP state machine on DHCP flow removal

    XMLWordPrintable

    Details

    • Type: Bug
    • Status: In Progress (View Workflow)
    • Priority: Low
    • Resolution: Unresolved
    • Affects Version/s: VOLTHA v2.5
    • Fix Version/s: VOLTHA v2.12
    • Component/s: bbsim
    • Labels:
      None

      Description

      When we receive a flow removal we should clear the DHCP state machine so that we can restart it when a new flow is received:

      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:09Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=0 ClassifierIVid=55 ClassifierOPbits=5 ClassifierOVid=555 Cookie=3659178765203948 DstPort=0 FlowId=1905 FlowType=downstream GemportId=2194 InnerVlan=55 IntfId=9 IpProto=0 OnuId=16 OnuSn=BBSM00000910 OuterVlan=555 PortNo=37120 SrcPort=0 UniID=0 module=ONU
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:19Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=0 ClassifierIVid=1203 ClassifierOPbits=255 ClassifierOVid=900 Cookie=3659176391591833 DstPort=0 FlowId=2265 FlowType=downstream GemportId=2405 InnerVlan=1203 IntfId=9 IpProto=0 OnuId=16 OnuSn=BBSM00000910 OuterVlan=900 PortNo=37120 SrcPort=0 UniID=0 module=ONU
      
      // First DHCP Flow
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:34Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=800 ClassifierIVid=0 ClassifierOPbits=7 ClassifierOVid=444 Cookie=3659177266491809 DstPort=67 FlowId=2650 FlowType=upstream GemportId=2491 InnerVlan=0 IntfId=9 IpProto=17 OnuId=16 OnuSn=BBSM00000910 OuterVlan=444 PortNo=37120 SrcPort=68 UniID=0 module=ONU
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:34Z" level=debug msg="Changing Service.DHCPState InternalState from created to dhcp_started" IntfId=9 Name=voip OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:34Z" level=debug msg=HandleDHCPStart GemPortId=2491 IntfId=9 Name=voip OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:34Z" level=info msg="DHCPDiscovery Sent" IntfId=9 OnuId=16 OnuSn=BBSM00000910 ServiceName=voip module=DHCP
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:34Z" level=debug msg="Changing Service.DHCPState InternalState from dhcp_started to dhcp_discovery_sent" IntfId=9 Name=voip OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:34Z" level=debug msg="ONU receives FlowRemove" FlowId=2650 FlowType=upstream IntfId=9 OnuId=16 SerialNumber=BBSM00000910 module=ONU
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:40Z" level=info msg="DHCPRequest Sent" IntfId=9 OfferedIp=192.168.243.77 OnuId=16 OnuSn=BBSM00000910 ServiceName=voip module=DHCP
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:40Z" level=debug msg="Changing Service.DHCPState InternalState from dhcp_discovery_sent to dhcp_request_sent" IntfId=9 Name=voip OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:45Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=0 ClassifierIVid=0 ClassifierOPbits=255 ClassifierOVid=1203 Cookie=3659177637759457 DstPort=0 FlowId=2265 FlowType=upstream GemportId=2405 InnerVlan=0 IntfId=9 IpProto=0 OnuId=16 OnuSn=BBSM00000910 OuterVlan=1203 PortNo=37120 SrcPort=0 UniID=0 module=ONU
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:48Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=0 ClassifierIVid=0 ClassifierOPbits=7 ClassifierOVid=444 Cookie=3659175025581738 DstPort=0 FlowId=2924 FlowType=upstream GemportId=2547 InnerVlan=0 IntfId=9 IpProto=0 OnuId=16 OnuSn=BBSM00000910 OuterVlan=444 PortNo=37120 SrcPort=0 UniID=0 module=ONU
      
      // Second DHCP flow (note that flow was removed before being pushed again)
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:51Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=800 ClassifierIVid=0 ClassifierOPbits=7 ClassifierOVid=444 Cookie=3659177266491809 DstPort=67 FlowId=2996 FlowType=upstream GemportId=2547 InnerVlan=0 IntfId=9 IpProto=17 OnuId=16 OnuSn=BBSM00000910 OuterVlan=444 PortNo=37120 SrcPort=68 UniID=0 module=ONU
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:51Z" level=error msg="Can't start DHCP for this Service" IntfId=9 Name=voip OnuId=16 OnuSn=BBSM00000910 err="event start_dhcp inappropriate in current state dhcp_request_sent" module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:52Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=800 ClassifierIVid=0 ClassifierOPbits=5 ClassifierOVid=0 Cookie=3659175935558580 DstPort=0 FlowId=3027 FlowType=upstream GemportId=2194 InnerVlan=0 IntfId=9 IpProto=2 OnuId=16 OnuSn=BBSM00000910 OuterVlan=0 PortNo=37120 SrcPort=0 UniID=0 module=ONU
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:53Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=800 ClassifierIVid=0 ClassifierOPbits=5 ClassifierOVid=55 Cookie=3659176090299810 DstPort=67 FlowId=3053 FlowType=upstream GemportId=2194 InnerVlan=0 IntfId=9 IpProto=17 OnuId=16 OnuSn=BBSM00000910 OuterVlan=55 PortNo=37120 SrcPort=68 UniID=0 module=ONU
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:53Z" level=debug msg="Changing Service.DHCPState InternalState from created to dhcp_started" IntfId=9 Name=vod OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:53Z" level=debug msg=HandleDHCPStart GemPortId=2194 IntfId=9 Name=vod OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:53Z" level=info msg="DHCPDiscovery Sent" IntfId=9 OnuId=16 OnuSn=BBSM00000910 ServiceName=vod module=DHCP
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:53Z" level=debug msg="Changing Service.DHCPState InternalState from dhcp_started to dhcp_discovery_sent" IntfId=9 Name=vod OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:54Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=0 ClassifierIVid=444 ClassifierOPbits=7 ClassifierOVid=333 Cookie=3659175111432702 DstPort=0 FlowId=2924 FlowType=downstream GemportId=2547 InnerVlan=444 IntfId=9 IpProto=0 OnuId=16 OnuSn=BBSM00000910 OuterVlan=333 PortNo=37120 SrcPort=0 UniID=0 module=ONU
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:28:54Z" level=debug msg="OLT receives FlowAdd for ONU" ClassifierEthType=0 ClassifierIVid=0 ClassifierOPbits=5 ClassifierOVid=55 Cookie=3659178315208206 DstPort=0 FlowId=1905 FlowType=upstream GemportId=2194 InnerVlan=0 IntfId=9 IpProto=0 OnuId=16 OnuSn=BBSM00000910 OuterVlan=55 PortNo=37120 SrcPort=0 UniID=0 module=ONU
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:29:06Z" level=info msg="DHCPRequest Sent" IntfId=9 OfferedIp=192.168.244.72 OnuId=16 OnuSn=BBSM00000910 ServiceName=vod module=DHCP
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:29:06Z" level=debug msg="Changing Service.DHCPState InternalState from dhcp_discovery_sent to dhcp_request_sent" IntfId=9 Name=vod OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:29:12Z" level=debug msg="Changing Service.DHCPState InternalState from dhcp_request_sent to dhcp_ack_received" IntfId=9 Name=vod OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:29:12Z" level=info msg="DHCP State machine completed" IntfId=9 OnuId=16 OnuSn=BBSM00000910 ServiceName=vod module=DHCP
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:29:34Z" level=warning msg="DHCP failed, resetting DHCP State" DHCPState=dhcp_request_sent IntfId=9 Name=voip OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      default/bbsim0-7856df4cd6-stmb5[bbsim]: time="2020-09-28T22:29:34Z" level=debug msg="Changing Service.DHCPState InternalState from dhcp_request_sent to dhcp_failed" IntfId=9 Name=voip OnuId=16 OnuSn=BBSM00000910 module=SERVICE
      

       

        Attachments

        No reviews matched the request. Check your Options in the drop-down menu of this sections header.

          Activity

            People

            Assignee:
            nitin Nitin Subramanian
            Reporter:
            teone Matteo Scandolo
            Watchers:
            2 Start watching this issue

              Dates

              Created:
              Updated:

                Gerrit Reviews

                There are no open Gerrit changes