Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

[LLDP] lldp portidsubtype was NOT set to "locally assigned" but "mac address" #1457

Closed
keboliu opened this issue Mar 5, 2018 · 9 comments
Closed

[LLDP] lldp portidsubtype was NOT set to "locally assigned" but "mac address" #1457

keboliu opened this issue Mar 5, 2018 · 9 comments
Labels
Bug 🐛

Comments

@keboliu
Copy link
Collaborator

keboliu commented Mar 5, 2018 •
edited
Loading

In the latest version

SONiC Software Version: SONiC.HEAD.253-20ab99b
Distribution: Debian 8.10
Kernel: 3.16.0-5-amd64
Build commit: 20ab99b
Build date: Sun Mar  4 07:39:19 UTC 2018
Built by: johnar@jenkins-worker-3

the lldp portidsubtype wasn't set to "locally assigned" but "mac address", it can be verified on the peer Arista VM with t0 topology.

ARISTA04T1#show lldp neighbors detail
Interface Ethernet1 detected 1 LLDP neighbors:

  Neighbor 248a.0740.0966/248a.0740.0940, age 2 seconds
  Discovered 0:09:01 ago; Last changed 0:09:01 ago
  - Chassis ID type: MAC address (4)
    Chassis ID     : 248a.0740.0966
  - Port ID type: MAC address (3)
    Port ID     : 248a.0740.0940
  - Time To Live: 120 seconds
  - Port Description: "Ethernet120"
  - System Name: "arc-mtbc-1001"
  - System Description: "Debian GNU/Linux 8 (jessie) Linux 3.16.0-5-amd64 #1 SMP Debian 3.16.51-3+deb8u1 (2018-01-08) x86_64"
  - System Capabilities : Bridge, WLAN Access Point, Router, Station Only
    Enabled Capabilities: Bridge, Router
  - Management Address Subtype: IPv4 
    Management Address        : 10.12.206.180
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 2
    OID String                : 
  - Management Address Subtype: IPv6 
    Management Address        : fc00:2::32
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 2
    OID String                : 
  - IEEE802.1/IEEE802.3 Link Aggregation
    Link Aggregation Status: Capable, Disabled (0x01)
    Port ID                : 0
  - IEEE802.3 MAC/PHY Configuration/Status
    Auto-negotiation       : Not Supported
    Operational MAU Type   : Unknown

This is different with the version build on 28th Feb, on this version it was set to "locally assigned"

ARISTA04T1#show lldp neighbors detail
Interface Ethernet1 detected 1 LLDP neighbors:

  Neighbor 248a.0740.0966/"Ethernet120", age 27 seconds
  Discovered 0:00:26 ago; Last changed 0:00:26 ago
  - Chassis ID type: MAC address (4)
    Chassis ID     : 248a.0740.0966
  - Port ID type: Locally assigned (7)
    Port ID     : "Ethernet120"
  - Time To Live: 120 seconds
  - Port Description: "ARISTA04T1:Ethernet1"
  - System Name: "arc-mtbc-1001"
  - System Description: "Debian GNU/Linux 8 (jessie) Linux 3.16.0-5-amd64 #1 SMP Debian 3.16.51-3+deb8u1 (2018-01-08) x86_64"
  - System Capabilities : Bridge, WLAN Access Point, Router, Station Only
    Enabled Capabilities: Bridge, Router
  - Management Address Subtype: IPv4 
    Management Address        : 10.1.0.32
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 1
    OID String                : 
  - Management Address Subtype: IPv6 
    Management Address        : fc00:1::32
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 1
    OID String                : 
  - IEEE802.1/IEEE802.3 Link Aggregation
    Link Aggregation Status: Capable, Disabled (0x01)
    Port ID                : 0
  - IEEE802.3 MAC/PHY Configuration/Status
    Auto-negotiation       : Not Supported
    Operational MAU Type   : Unknown

when this happened, the lldpmgrd is running:

root@arc-mtbc-1001:/# ps -A
  PID TTY          TIME CMD
    1 ?        00:00:00 supervisord
   16 ?        00:00:00 rsyslogd
   21 ?        00:00:00 lldpd
   23 ?        00:00:00 lldpd
   25 ?        00:00:00 python2
   31 ?        00:00:00 python
  191 ?        00:00:00 bash
  196 ?        00:00:00 ps

root@arc-mtbc-1001:/# cat /proc/31/environ
TERM=xtermSUPERVISOR_SERVER_URL=unix:///var/run/supervisor.sockDEBIAN_FRONTEND=noninteractiveHOSTNAME=arc-mtbc-1001SUPERVISOR_ENABLED=1SUPERVISOR_PROCESS_NAME=lldpmgrdSUPERVISOR_GROUP_NAME=lldpmgrdHOME=/rootPATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
root@arc-mtbc-1001:/#
@keboliu keboliu changed the title [LLDP] lldp portidsubtype wasn't set to "locally assign" but "mac address" [LLDP] lldp portidsubtype was NOT set to "locally assign" but "mac address" Mar 5, 2018
@keboliu keboliu changed the title [LLDP] lldp portidsubtype was NOT set to "locally assign" but "mac address" [LLDP] lldp portidsubtype was NOT set to "locally assigned" but "mac address" Mar 5, 2018
@jleveque
Copy link
Contributor

jleveque commented Mar 5, 2018

I am unable to reproduce this problem on two different devices, both also configured for a T0 test topology, and both running a build from last night. Below is my output from two peer Arista VMs of one of the devices. Note that the portidsubtype is correctly set to "Locally assigned" and both Port ID and Port Description are also configured correctly.

Could you please provide all log messages from lldpmgrd so that I can determine whether or not it is behaving correctly for you?

ARISTA01T1>show lldp neighbors detail
Interface Ethernet1 detected 1 LLDP neighbors:

  Neighbor 7cfe.906d.b9c8/"Ethernet112", age 0 seconds
  Discovered 1:21:14 ago; Last changed 1:21:14 ago
  - Chassis ID type: MAC address (4)
    Chassis ID     : 7cfe.906d.b9c8
  - Port ID type: Locally assigned (7)
    Port ID     : "Ethernet112"
  - Time To Live: 120 seconds
  - Port Description: "ARISTA01T1:Ethernet1"
  - System Name: "str-msn2700-04"
  - System Description: "Debian GNU/Linux 8 (jessie) Linux 3.16.0-4-amd64 #1 SMP Debian 3.16.43-2+deb8u5 (2015-12-19) x86_64"
  - System Capabilities : Bridge, WLAN Access Point, Router, Station Only
    Enabled Capabilities: Bridge, Router
  - Management Address Subtype: IPv4
    Management Address        : 10.1.0.32
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 1
    OID String                :
  - Management Address Subtype: IPv6
    Management Address        : fc00:1::32
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 1
    OID String                :
  - IEEE802.1/IEEE802.3 Link Aggregation
    Link Aggregation Status: Capable, Disabled (0x01)
    Port ID                : 0
  - IEEE802.3 MAC/PHY Configuration/Status
    Auto-negotiation       : Not Supported
    Operational MAU Type   : Unknown

ARISTA02T1>show lldp neighbors detail
Interface Ethernet1 detected 1 LLDP neighbors:

  Neighbor 7cfe.906d.b9c8/"Ethernet116", age 63 seconds
  Discovered 1:24:10 ago; Last changed 1:24:10 ago
  - Chassis ID type: MAC address (4)
    Chassis ID     : 7cfe.906d.b9c8
  - Port ID type: Locally assigned (7)
    Port ID     : "Ethernet116"
  - Time To Live: 120 seconds
  - Port Description: "ARISTA02T1:Ethernet1"
  - System Name: "str-msn2700-04"
  - System Description: "Debian GNU/Linux 8 (jessie) Linux 3.16.0-4-amd64 #1 SMP Debian 3.16.43-2+deb8u5 (2015-12-19) x86_64"
  - System Capabilities : Bridge, WLAN Access Point, Router, Station Only
    Enabled Capabilities: Bridge, Router
  - Management Address Subtype: IPv4
    Management Address        : 10.1.0.32
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 1
    OID String                :
  - Management Address Subtype: IPv6
    Management Address        : fc00:1::32
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 1
    OID String                :
  - IEEE802.1/IEEE802.3 Link Aggregation
    Link Aggregation Status: Capable, Disabled (0x01)
    Port ID                : 0
  - IEEE802.3 MAC/PHY Configuration/Status
    Auto-negotiation       : Not Supported
    Operational MAU Type   : Unknown

@keboliu
Copy link
Collaborator Author

keboliu commented Mar 6, 2018

@jleveque I tried on 4 devices with t0 and t1 and t1-lag topo, all of them still have this issue with the image built on 5th Mar.

SONiC Software Version: SONiC.HEAD.544-126d08d
Distribution: Debian 8.10
Kernel: 3.16.0-5-amd64
Build commit: 126d08d
Build date: Mon Mar  5 09:42:01 UTC 2018
Built by: johnar@jenkins-worker-4

check on Arista VM

ARISTA04T1#show lldp neighbors detail
Interface Ethernet1 detected 1 LLDP neighbors:

  Neighbor 248a.0740.0966/248a.0740.0940, age 21 seconds
  Discovered 0:04:20 ago; Last changed 0:04:20 ago
  - Chassis ID type: MAC address (4)
    Chassis ID     : 248a.0740.0966
  - Port ID type: MAC address (3)
    Port ID     : 248a.0740.0940
  - Time To Live: 120 seconds
  - Port Description: "Ethernet120"
  - System Name: "arc-mtbc-1001"
  - System Description: "Debian GNU/Linux 8 (jessie) Linux 3.16.0-5-amd64 #1 SMP Debian 3.16.51-3+deb8u1 (2018-01-08) x86_64"
  - System Capabilities : Bridge, WLAN Access Point, Router, Station Only
    Enabled Capabilities: Bridge, Router
  - Management Address Subtype: IPv4 
    Management Address        : 10.12.206.180
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 2
    OID String                : 
  - Management Address Subtype: IPv6 
    Management Address        : fc00:1::32
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 1
    OID String                : 
  - IEEE802.1/IEEE802.3 Link Aggregation
    Link Aggregation Status: Capable, Disabled (0x01)
    Port ID                : 0
  - IEEE802.3 MAC/PHY Configuration/Status
    Auto-negotiation       : Not Supported
    Operational MAU Type   : Unknown

I filtered out the lldpmgr log as below

Mar  6 01:56:52.342498 arc-mtbc-1001 INFO supervisord 2018-03-06 01:29:15,011 INFO spawned: 'lldpmgrd' with pid 30
Mar  6 01:56:52.342562 arc-mtbc-1001 INFO supervisord 2018-03-06 01:29:16,015 INFO success: lldpmgrd entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
Mar  6 01:56:52.342584 arc-mtbc-1001 INFO supervisord 2018-03-06 01:32:56,117 INFO waiting for lldp-syncd, rsyslogd, lldpd, lldpmgrd to die
Mar  6 01:56:52.342584 arc-mtbc-1001 INFO supervisord 2018-03-06 01:32:59,121 INFO waiting for lldp-syncd, rsyslogd, lldpd, lldpmgrd to die
Mar  6 01:56:52.342665 arc-mtbc-1001 INFO supervisord 2018-03-06 01:33:02,125 INFO waiting for lldp-syncd, rsyslogd, lldpd, lldpmgrd to die
Mar  6 01:56:52.342665 arc-mtbc-1001 INFO supervisord 2018-03-06 01:33:05,128 INFO waiting for lldp-syncd, rsyslogd, lldpd, lldpmgrd to die
Mar  6 01:56:52.342853 arc-mtbc-1001 INFO supervisord 2018-03-06 01:34:37,227 INFO spawned: 'lldpmgrd' with pid 30
Mar  6 01:56:52.342853 arc-mtbc-1001 INFO supervisord 2018-03-06 01:34:38,234 INFO success: lldpmgrd entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
Mar  6 01:56:52.342879 arc-mtbc-1001 INFO supervisord 2018-03-06 01:55:48,135 INFO waiting for lldp-syncd, rsyslogd, lldpd, lldpmgrd to die
Mar  6 01:56:52.342879 arc-mtbc-1001 INFO supervisord 2018-03-06 01:55:51,310 INFO waiting for lldp-syncd, rsyslogd, lldpd, lldpmgrd to die
Mar  6 01:56:52.342974 arc-mtbc-1001 INFO supervisord 2018-03-06 01:55:54,313 INFO waiting for lldp-syncd, rsyslogd, lldpd, lldpmgrd to die
Mar  6 01:56:52.342974 arc-mtbc-1001 INFO supervisord 2018-03-06 01:55:57,316 INFO waiting for lldp-syncd, rsyslogd, lldpd, lldpmgrd to die
Mar  6 01:56:56.030982 arc-mtbc-1001 INFO lldp.sh[1279]: 2018-03-06 01:56:56,030 INFO spawned: 'lldpmgrd' with pid 29
Mar  6 01:56:56.090300 arc-mtbc-1001 INFO lldpmgrd: Starting up...
Mar  6 01:56:57.035406 arc-mtbc-1001 INFO lldp.sh[1279]: 2018-03-06 01:56:57,034 INFO success: lldpmgrd entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
Mar  6 01:56:57.037041 arc-mtbc-1001 INFO supervisord: start.sh lldpmgrd: started
Mar  6 01:57:02.348679 arc-mtbc-1001 INFO supervisord 2018-03-06 01:56:56,030 INFO spawned: 'lldpmgrd' with pid 29
Mar  6 01:57:02.348679 arc-mtbc-1001 INFO supervisord 2018-03-06 01:56:57,034 INFO success: lldpmgrd entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
Mar  6 01:57:21.471111 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet0'. Not adding port description.
Mar  6 01:57:21.471111 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet0 lldp portidsubtype local Ethernet0'
Mar  6 01:57:21.875987 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet4'. Not adding port description.
Mar  6 01:57:21.875987 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet4 lldp portidsubtype local Ethernet4'
Mar  6 01:57:21.974991 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet8'. Not adding port description.
Mar  6 01:57:21.974991 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet8 lldp portidsubtype local Ethernet8'
Mar  6 01:57:22.072637 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet12'. Not adding port description.
Mar  6 01:57:22.072680 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet12 lldp portidsubtype local Ethernet12'
Mar  6 01:57:22.191863 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet16'. Not adding port description.
Mar  6 01:57:22.191863 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet16 lldp portidsubtype local Ethernet16'
Mar  6 01:57:22.301296 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet20'. Not adding port description.
Mar  6 01:57:22.301378 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet20 lldp portidsubtype local Ethernet20'
Mar  6 01:57:22.397205 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet24'. Not adding port description.
Mar  6 01:57:22.397279 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet24 lldp portidsubtype local Ethernet24'
Mar  6 01:57:22.564501 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet28'. Not adding port description.
Mar  6 01:57:22.564583 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet28 lldp portidsubtype local Ethernet28'
Mar  6 01:57:22.659155 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet32'. Not adding port description.
Mar  6 01:57:22.659209 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet32 lldp portidsubtype local Ethernet32'
Mar  6 01:57:22.757494 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet36'. Not adding port description.
Mar  6 01:57:22.757494 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet36 lldp portidsubtype local Ethernet36'
Mar  6 01:57:22.855299 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet40'. Not adding port description.
Mar  6 01:57:22.855750 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet40 lldp portidsubtype local Ethernet40'
Mar  6 01:57:22.957502 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet44'. Not adding port description.
Mar  6 01:57:22.957502 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet44 lldp portidsubtype local Ethernet44'
Mar  6 01:57:23.054904 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet48'. Not adding port description.
Mar  6 01:57:23.054904 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet48 lldp portidsubtype local Ethernet48'
Mar  6 01:57:23.158086 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet52'. Not adding port description.
Mar  6 01:57:23.158086 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet52 lldp portidsubtype local Ethernet52'
Mar  6 01:57:23.257454 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet56'. Not adding port description.
Mar  6 01:57:23.257560 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet56 lldp portidsubtype local Ethernet56'
Mar  6 01:57:23.475051 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet60'. Not adding port description.
Mar  6 01:57:23.475159 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet60 lldp portidsubtype local Ethernet60'
Mar  6 01:57:23.635011 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet64'. Not adding port description.
Mar  6 01:57:23.635011 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet64 lldp portidsubtype local Ethernet64'
Mar  6 01:57:23.781336 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet68'. Not adding port description.
Mar  6 01:57:23.781435 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet68 lldp portidsubtype local Ethernet68'
Mar  6 01:57:23.887974 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet72'. Not adding port description.
Mar  6 01:57:23.887974 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet72 lldp portidsubtype local Ethernet72'
Mar  6 01:57:23.988308 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet76'. Not adding port description.
Mar  6 01:57:23.988308 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet76 lldp portidsubtype local Ethernet76'
Mar  6 01:57:24.088825 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet80'. Not adding port description.
Mar  6 01:57:24.088905 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet80 lldp portidsubtype local Ethernet80'
Mar  6 01:57:24.185804 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet84'. Not adding port description.
Mar  6 01:57:24.185804 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet84 lldp portidsubtype local Ethernet84'
Mar  6 01:57:24.284633 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet88'. Not adding port description.
Mar  6 01:57:24.284633 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet88 lldp portidsubtype local Ethernet88'
Mar  6 01:57:24.388417 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet92'. Not adding port description.
Mar  6 01:57:24.388563 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet92 lldp portidsubtype local Ethernet92'
Mar  6 01:57:24.655604 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet96'. Not adding port description.
Mar  6 01:57:24.655821 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet96 lldp portidsubtype local Ethernet96'
Mar  6 01:57:24.799235 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet100'. Not adding port description.
Mar  6 01:57:24.799235 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet100 lldp portidsubtype local Ethernet100'
Mar  6 01:57:24.940228 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet104'. Not adding port description.
Mar  6 01:57:24.940301 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet104 lldp portidsubtype local Ethernet104'
Mar  6 01:57:25.082299 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet108 lldp portidsubtype local Ethernet108 description ARISTA01T1:Ethernet1'
Mar  6 01:57:25.164126 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet112 lldp portidsubtype local Ethernet112 description ARISTA02T1:Ethernet1'
Mar  6 01:57:25.378758 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet116 lldp portidsubtype local Ethernet116 description ARISTA03T1:Ethernet1'
Mar  6 01:57:25.780732 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet120 lldp portidsubtype local Ethernet120 description ARISTA04T1:Ethernet1'
Mar  6 01:57:26.063409 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet124'. Not adding port description.
Mar  6 01:57:26.063432 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet124 lldp portidsubtype local Ethernet124'
Mar  6 01:57:26.210748 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet128'. Not adding port description.
Mar  6 01:57:26.210802 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet128 lldp portidsubtype local Ethernet128'
Mar  6 01:57:26.348310 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet132'. Not adding port description.
Mar  6 01:57:26.348310 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet132 lldp portidsubtype local Ethernet132'
Mar  6 01:57:26.495355 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet136'. Not adding port description.
Mar  6 01:57:26.495470 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet136 lldp portidsubtype local Ethernet136'
Mar  6 01:57:26.677188 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet140'. Not adding port description.
Mar  6 01:57:26.677188 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet140 lldp portidsubtype local Ethernet140'
Mar  6 01:57:26.821957 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet144'. Not adding port description.
Mar  6 01:57:26.821957 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet144 lldp portidsubtype local Ethernet144'
Mar  6 01:57:26.969174 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet148'. Not adding port description.
Mar  6 01:57:26.969253 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet148 lldp portidsubtype local Ethernet148'
Mar  6 01:57:27.110502 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet152'. Not adding port description.
Mar  6 01:57:27.110553 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet152 lldp portidsubtype local Ethernet152'
Mar  6 01:57:27.245086 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet156'. Not adding port description.
Mar  6 01:57:27.245542 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet156 lldp portidsubtype local Ethernet156'
Mar  6 01:57:27.340670 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet160'. Not adding port description.
Mar  6 01:57:27.340911 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet160 lldp portidsubtype local Ethernet160'
Mar  6 01:57:27.439896 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet164'. Not adding port description.
Mar  6 01:57:27.439896 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet164 lldp portidsubtype local Ethernet164'
Mar  6 01:57:27.715120 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet168'. Not adding port description.
Mar  6 01:57:27.715120 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet168 lldp portidsubtype local Ethernet168'
Mar  6 01:57:27.881801 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet172'. Not adding port description.
Mar  6 01:57:27.881855 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet172 lldp portidsubtype local Ethernet172'
Mar  6 01:57:28.054959 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet176'. Not adding port description.
Mar  6 01:57:28.055268 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet176 lldp portidsubtype local Ethernet176'
Mar  6 01:57:28.208227 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet180'. Not adding port description.
Mar  6 01:57:28.208821 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet180 lldp portidsubtype local Ethernet180'
Mar  6 01:57:28.344984 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet184'. Not adding port description.
Mar  6 01:57:28.345066 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet184 lldp portidsubtype local Ethernet184'
Mar  6 01:57:28.538784 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet188'. Not adding port description.
Mar  6 01:57:28.538784 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet188 lldp portidsubtype local Ethernet188'
Mar  6 01:57:28.649661 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet192'. Not adding port description.
Mar  6 01:57:28.649661 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet192 lldp portidsubtype local Ethernet192'
Mar  6 01:57:28.764447 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet196'. Not adding port description.
Mar  6 01:57:28.764594 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet196 lldp portidsubtype local Ethernet196'
Mar  6 01:57:28.859807 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet200'. Not adding port description.
Mar  6 01:57:28.859874 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet200 lldp portidsubtype local Ethernet200'
Mar  6 01:57:28.976395 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet204'. Not adding port description.
Mar  6 01:57:28.976610 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet204 lldp portidsubtype local Ethernet204'
Mar  6 01:57:29.031072 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet208'. Not adding port description.
Mar  6 01:57:29.031442 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet208 lldp portidsubtype local Ethernet208'
Mar  6 01:57:29.178186 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet212'. Not adding port description.
Mar  6 01:57:29.178238 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet212 lldp portidsubtype local Ethernet212'
Mar  6 01:57:29.291570 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet216'. Not adding port description.
Mar  6 01:57:29.291570 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet216 lldp portidsubtype local Ethernet216'
Mar  6 01:57:29.411051 arc-mtbc-1001 INFO lldpmgrd: Unable to retrieve neighbor information for port 'Ethernet220'. Not adding port description.
Mar  6 01:57:29.412181 arc-mtbc-1001 INFO lldpmgrd: Running command: 'lldpcli configure ports Ethernet220 lldp portidsubtype local Ethernet220'

@keboliu
Copy link
Collaborator Author

keboliu commented Mar 6, 2018

@jleveque btw, if I run the command "lldpcli configure ports Ethernet120 lldp portidsubtype local Ethernet120 description ARISTA04T1:Ethernet1" explicitly, from the Arista VM can see that the port id and port description changed as expected:

ARISTA04T1#show lldp neighbors detail
Interface Ethernet1 detected 1 LLDP neighbors:

  Neighbor 248a.0740.0966/"Ethernet120", age 5 seconds
  Discovered 0:03:04 ago; Last changed 0:03:04 ago
  - Chassis ID type: MAC address (4)
    Chassis ID     : 248a.0740.0966
  - Port ID type: Locally assigned (7)
    Port ID     : "Ethernet120"
  - Time To Live: 120 seconds
  - Port Description: "ARISTA04T1:Ethernet1"
  - System Name: "arc-mtbc-1001"
  - System Description: "Debian GNU/Linux 8 (jessie) Linux 3.16.0-5-amd64 #1 SMP Debian 3.16.51-3+deb8u1 (2018-01-08) x86_64"
  - System Capabilities : Bridge, WLAN Access Point, Router, Station Only
    Enabled Capabilities: Bridge, Router
  - Management Address Subtype: IPv4 
    Management Address        : 10.12.206.180
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 2
    OID String                : 
  - Management Address Subtype: IPv6 
    Management Address        : fc00:1::32
    Interface Number Subtype  : ifIndex (2)
    Interface Number          : 1
    OID String                : 
  - IEEE802.1/IEEE802.3 Link Aggregation
    Link Aggregation Status: Capable, Disabled (0x01)
    Port ID                : 0
  - IEEE802.3 MAC/PHY Configuration/Status
    Auto-negotiation       : Not Supported
    Operational MAU Type   : Unknown

@jleveque
Copy link
Contributor

jleveque commented Mar 6, 2018 •
edited
Loading

@keboliu: I was able to reproduce the issue. It appears to be caused by a race condition when the interfaces are initially created. We are still investigating the root cause, but if you wouldn't mind, could you please test the following workaround to confirm whether this also resolves the issue on your devices?

Add a time.sleep(1) above line 145 of lldpmgrd. Example:

...
        else:
            log_info("Unable to retrieve neighbor information for port '{}'. Not adding port description.".format(port_name))

        time.sleep(1)

        log_info("Running command: '{}'".format(lldpcli_cmd))

        proc = subprocess.Popen(lldpcli_cmd, shell=True, stdout=subprocess.PIPE, stderr=subprocess.PIPE)
...

@keboliu
Copy link
Collaborator Author

keboliu commented Mar 6, 2018

@jleveque good to know it can be reproduced, I can test it, will update you when having the result.

@keboliu
Copy link
Collaborator Author

keboliu commented Mar 6, 2018

@jleveque the workaround doesn't work on my testbed, still have the same issue.

@jleveque
Copy link
Contributor

jleveque commented Mar 6, 2018

@keboliu: I forgot to mention you would also need to add the line import time at the top of the lldpmgrd file as well as the time.sleep(1) line. Sorry.

@keboliu
Copy link
Collaborator Author

keboliu commented Mar 7, 2018 •
edited
Loading

@jleveque I sent out the tetst log with Guohan's lldpcli patch. do you still need to test this workaround?

@jleveque
Copy link
Contributor

jleveque commented Mar 7, 2018

@keboliu: If you have time, please do. It would help confirm the race condition we found.

@jleveque jleveque mentioned this issue Mar 7, 2018
Merged
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
Bug 🐛
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@stcheng @jleveque @keboliu