Port-channel goes up and down

[seb1303]

Hello,

I am struggeling with my setup. I created a port-channel between two C9500 SVLs but the port-channel between those two goesn up and down again and again. I acitvated debug logging. Maybe someone can see the problem...

# SVL1

Spoiler

Feb 10 07:30:01 svl1 338375: svl1: 14w5d: %LINEPROTO-5-UPDOWN: Line protocol on Interface Port-channel1, changed state to up

Feb 10 07:30:02 svl1 338376: svl1: Feb 10 07:30:01.355: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:02 svl1 338377: svl1: Feb 10 07:30:02.064: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:02 svl1 338378: svl1: Feb 10 07:30:02.325: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:04 svl1 338379: svl1: Feb 10 07:30:03.063: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:04 svl1 338380: svl1: Feb 10 07:30:03.229: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:04 svl1 338381: svl1: Feb 10 07:30:03.975: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:05 svl1 338382: svl1: Feb 10 07:30:04.169: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:05 svl1 338383: svl1: Feb 10 07:30:04.889: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:05 svl1 338384: svl1: Feb 10 07:30:05.127: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:06 svl1 338385: svl1: Feb 10 07:30:05.881: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:06 svl1 338386: svl1: Feb 10 07:30:06.074: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:06 svl1 338387: svl1: Feb 10 07:30:06.791: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl1 338388: svl1: Feb 10 07:30:07.074: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl1 338389: svl1: Feb 10 07:30:07.782: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl1 338390: svl1: Feb 10 07:30:07.933: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl1 338391: svl1: Feb 10 07:30:07.982: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:08 svl1 338392: svl1: Feb 10 07:30:07.982: LACP : packet size: 124

Feb 10 07:30:08 svl1 338393: svl1: Feb 10 07:30:07.982: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:08 svl1 338394: svl1: Feb 10 07:30:07.982: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x1,

Feb 10 07:30:08 svl1 338395: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:08 svl1 338396: svl1: Feb 10 07:30:07.982: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:08 svl1 338397: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:08 svl1 338398: svl1: Feb 10 07:30:07.982: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:08 svl1 338399: svl1: Feb 10 07:30:07.982: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:08 svl1 338400: svl1: Feb 10 07:30:07.982: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:08 svl1 338401: svl1: Feb 10 07:30:07.982:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:08 svl1 338402: svl1: Feb 10 07:30:07.983: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:08 svl1 338403: svl1: Feb 10 07:30:07.983: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:08 svl1 338404: svl1: Feb 10 07:30:07.983: LACP: update_Selected: Partner LAG components have changed,Unselecting Hu2/0/28.

Feb 10 07:30:08 svl1 338405: svl1: Feb 10 07:30:07.983: LACP: Hu2/0/28 set to UNSELECTED

Feb 10 07:30:08 svl1 338406: svl1: Feb 10 07:30:07.983:     lacp_mux Hu2/0/28 - mux: during state COLLECTING_DISTRIBUTING, got event 3(unselected)

Feb 10 07:30:08 svl1 338407: svl1: Feb 10 07:30:07.983: @@@ lacp_mux Hu2/0/28 - mux: COLLECTING_DISTRIBUTING -> ATTACHED

Feb 10 07:30:08 svl1 338408: svl1: Feb 10 07:30:07.983: LACP: Hu2/0/28 lacp_action_mx_cd_exit is entered

Feb 10 07:30:08 svl1 338409: svl1: Feb 10 07:30:07.983: LACP: Hu2/0/28 lacp_action_mx_attached entered

Feb 10 07:30:08 svl1 338410: svl1: Feb 10 07:30:07.983: LACP: Hu2/0/28 Disabling collecting and distributing

Feb 10 07:30:08 svl1 338411: svl1: Feb 10 07:30:07.997: LACP: timer lacp_t(Hu2/0/28) started with interval 1000.

Feb 10 07:30:08 svl1 338412: svl1: Feb 10 07:30:07.997: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl1 338413: svl1: Feb 10 07:30:07.997: LACP:

Feb 10 07:30:08 svl1 338414: svl1: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:08 svl1 338415: svl1: Feb 10 07:30:07.997: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:08 svl1 338416: svl1: Feb 10 07:30:07.997: LACP : packet size: 124

Feb 10 07:30:08 svl1 338417: svl1: Feb 10 07:30:07.997: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:08 svl1 338418: svl1: Feb 10 07:30:07.997: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:08 svl1 338419: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:08 svl1 338420: svl1: Feb 10 07:30:07.997: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:08 svl1 338421: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:08 svl1 338422: svl1: Feb 10 07:30:07.997: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:08 svl1 338423: svl1: Feb 10 07:30:07.997: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:08 svl1 338424: svl1: Feb 10 07:30:07.997: LACP:

Feb 10 07:30:08 svl1 338425: svl1: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:08 svl1 338426: svl1: Feb 10 07:30:07.997: @@@ lacp_mux Hu2/0/28 - mux: ATTACHED -> DETACHED

Feb 10 07:30:08 svl1 338427: svl1: Feb 10 07:30:07.997: LACP: Hu2/0/28 lacp_action_mx_detached entered

Feb 10 07:30:08 svl1 338428: svl1: Feb 10 07:30:07.997: LACP: Hu2/0/28 Detaching mux from aggregator

Feb 10 07:30:08 svl1 338429: svl1: Feb 10 07:30:07.997: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl1 338430: svl1: Feb 10 07:30:07.997: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:08 svl1 338431: svl1: Feb 10 07:30:07.997: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:08 svl1 338432: svl1: Feb 10 07:30:07.997: LACP : packet size: 124

Feb 10 07:30:08 svl1 338433: svl1: Feb 10 07:30:07.997: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:08 svl1 338434: svl1: Feb 10 07:30:07.997: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:08 svl1 338435: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:08 svl1 338436: svl1: Feb 10 07:30:07.997: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:08 svl1 338437: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:08 svl1 338438: svl1: Feb 10 07:30:07.997: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:08 svl1 338439: svl1: Feb 10 07:30:07.997: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:08 svl1 338440: svl1: Feb 10 07:30:07.997: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:08 svl1 338441: svl1: Feb 10 07:30:07.997: LACP: HA: Syncing LACP IDB HundredGigE2/0/28

Feb 10 07:30:08 svl1 338442: svl1: Feb 10 07:30:07.997: LACP: HA: Sync LACPIDBs

Feb 10 07:30:08 svl1 338443: svl1: Feb 10 07:30:07.997: LACP: HA ISSU: xmit xform

Feb 10 07:30:08 svl1 338444: svl1: Feb 10 07:30:07.997: lacp_handle_standby_port_internal called, depth = 1

Feb 10 07:30:08 svl1 338445: svl1: Feb 10 07:30:07.997: LACP: lacp_handle_standby_port_internal: No Standby port found for LAG 1

Feb 10 07:30:08 svl1 338446: svl1: Feb 10 07:30:07.997: LACP: lacp_w(Hu2/0/28) timer stopped

Feb 10 07:30:08 svl1 338447: svl1: Feb 10 07:30:07.997: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl1 338448: svl1: Feb 10 07:30:07.997: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:08 svl1 338449: svl1: Feb 10 07:30:07.997: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:08 svl1 338450: svl1: Feb 10 07:30:07.997: LACP : packet size: 124

Feb 10 07:30:08 svl1 338451: svl1: Feb 10 07:30:07.997: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:08 svl1 338452: svl1: Feb 10 07:30:07.998: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:08 svl1 338453: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:08 svl1 338454: svl1: Feb 10 07:30:07.998: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:08 svl1 338455: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:08 svl1 338456: svl1: Feb 10 07:30:07.998: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:08 svl1 338457: svl1: Feb 10 07:30:07.998: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:08 svl1 338458: svl1: Feb 10 07:30:07.998: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:08 svl1 338459: svl1: Feb 10 07:30:07.998: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 3D

Feb 10 07:30:08 svl1 338460: svl1: Feb 10 07:30:07.998: LACP: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:08 svl1 338461: svl1: Feb 10 07:30:07.998: LACP: Hu2/0/28 Partners oper state is hex 1

Feb 10 07:30:08 svl1 338462: svl1: Feb 10 07:30:07.998: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:08 svl1 338463: svl1: Feb 10 07:30:07.998: LACP: Hu2/0/28 partner behaves like LAG_PARTNER_INDIVIDUAL_PORT.

Feb 10 07:30:08 svl1 338464: svl1: Feb 10 07:30:07.998: LACP: Hu2/0/28 LAG has changed

Feb 10 07:30:08 svl1 338465: svl1: Feb 10 07:30:07.998: LACP: Hu2/0/28 set to SELECTED

Feb 10 07:30:08 svl1 338466: svl1: Feb 10 07:30:07.998:     lacp_mux Hu2/0/28 - mux: during state DETACHED, got event 1(selected)

Feb 10 07:30:08 svl1 338467: svl1: Feb 10 07:30:07.998: @@@ lacp_mux Hu2/0/28 - mux: DETACHED -> WAITING

Feb 10 07:30:08 svl1 338468: svl1: Feb 10 07:30:07.998: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:08 svl1 338469: svl1: Feb 10 07:30:07.998: LACP: timer lacp_w(Hu2/0/28) started with interval 6000.

Feb 10 07:30:08 svl1 338470: svl1: Feb 10 07:30:07.998: LACP: Hu2/0/28 selected to be independent

Feb 10 07:30:08 svl1 338471: svl1: Feb 10 07:30:07.998:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:08 svl1 338472: svl1: Feb 10 07:30:07.998: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:08 svl1 338473: svl1: Feb 10 07:30:07.998: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:08 svl1 338474: svl1: Feb 10 07:30:08.105: LACP: CF: sync successfully completed

Feb 10 07:30:08 svl1 338475: svl1: Feb 10 07:30:08.703: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl1 338476: svl1: Feb 10 07:30:08.808: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl1 338477: svl1: Feb 10 07:30:08.872: LACP: lacp_t(Hu2/0/28) timer stopped

Feb 10 07:30:08 svl1 338478: svl1: Feb 10 07:30:08.872: LACP: lacp_t(Hu2/0/28) expired

Feb 10 07:30:09 svl1 338479: svl1: 14w5d: %LINEPROTO-5-UPDOWN: Line protocol on Interface HundredGigE2/0/28, changed state to down

Feb 10 07:30:09 svl1 338480: svl1: 14w5d: %LINEPROTO-5-UPDOWN: Line protocol on Interface Port-channel1, changed state to down

Feb 10 07:30:10 svl1 338481: svl1: Feb 10 07:30:09.590: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:10 svl1 338482: svl1: Feb 10 07:30:09.754: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:10 svl1 338483: svl1: 14w5d: %LINK-3-UPDOWN: Interface Port-channel1, changed state to down

Feb 10 07:30:10 svl1 338484: svl1: Feb 10 07:30:10.483: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:10 svl1 338485: svl1: Feb 10 07:30:10.678: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:10 svl1 338486: svl1: Feb 10 07:30:10.876: LACP: lacp_c(Hu2/0/28) timer stopped

Feb 10 07:30:10 svl1 338487: svl1: Feb 10 07:30:10.876: LACP: lacp_c(Hu2/0/28) expired

Feb 10 07:30:10 svl1 338488: svl1: Feb 10 07:30:10.876:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 6(ct_expired)

Feb 10 07:30:10 svl1 338489: svl1: Feb 10 07:30:10.876: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> EXPIRED

Feb 10 07:30:10 svl1 338490: svl1: Feb 10 07:30:10.876: LACP: Hu2/0/28 lacp_action_rx_current_exit entered

Feb 10 07:30:10 svl1 338491: svl1: Feb 10 07:30:10.876: LACP: lacp_c(Hu2/0/28) timer stopped

Feb 10 07:30:10 svl1 338492: svl1: Feb 10 07:30:10.876: LACP: Hu2/0/28 lacp_action_rx_expired entered

Feb 10 07:30:10 svl1 338493: svl1: Feb 10 07:30:10.876: LACP:

Feb 10 07:30:10 svl1 338494: svl1: Hu2/0/28 partner timeout mode changed to 1

Feb 10 07:30:10 svl1 338495: svl1: Feb 10 07:30:10.876:     lacp_ptx Hu2/0/28 - ptx: during state SLOW_PERIODIC, got event 4(short_timeout)

Feb 10 07:30:10 svl1 338496: svl1: Feb 10 07:30:10.876: @@@ lacp_ptx Hu2/0/28 - ptx: SLOW_PERIODIC -> PERIODIC_TX

Feb 10 07:30:10 svl1 338497: svl1: Feb 10 07:30:10.876: LACP: Hu2/0/28 lacp_action_ptx_slow_periodic_exit entered

Feb 10 07:30:10 svl1 338498: svl1: Feb 10 07:30:10.876: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:10 svl1 338499: svl1: Feb 10 07:30:10.876: LACP: Hu2/0/28 lacp_action_ptx_periodic_tx entered

Feb 10 07:30:10 svl1 338500: svl1: Feb 10 07:30:10.876: LACP: timer lacp_t(Hu2/0/28) started with interval 1000.

Feb 10 07:30:10 svl1 338501: svl1: Feb 10 07:30:10.876: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:10 svl1 338502: svl1: Feb 10 07:30:10.876: LACP:

Feb 10 07:30:10 svl1 338503: svl1: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:10 svl1 338504: svl1: Feb 10 07:30:10.876: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:10 svl1 338505: svl1: Feb 10 07:30:10.876: LACP : packet size: 124

Feb 10 07:30:10 svl1 338506: svl1: Feb 10 07:30:10.876: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:10 svl1 338507: svl1: Feb 10 07:30:10.876: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:10 svl1 338508: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:10 svl1 338509: svl1: Feb 10 07:30:10.876: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3,

Feb 10 07:30:10 svl1 338510: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:10 svl1 338511: svl1: Feb 10 07:30:10.876: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:10 svl1 338512: svl1: Feb 10 07:30:10.876: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:10 svl1 338513: svl1: Feb 10 07:30:10.876: LACP:

Feb 10 07:30:10 svl1 338514: svl1: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:10 svl1 338515: svl1: Feb 10 07:30:10.876:     lacp_ptx Hu2/0/28 - ptx: during state PERIODIC_TX, got event 4(short_timeout)

Feb 10 07:30:10 svl1 338516: svl1: Feb 10 07:30:10.876: @@@ lacp_ptx Hu2/0/28 - ptx: PERIODIC_TX -> FAST_PERIODIC

Feb 10 07:30:10 svl1 338517: svl1: Feb 10 07:30:10.876: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic entered

Feb 10 07:30:10 svl1 338518: svl1: Feb 10 07:30:10.876: LACP: timer lacp_p_f(Hu2/0/28) started with interval 1000.

Feb 10 07:30:10 svl1 338519: svl1: Feb 10 07:30:10.876: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:10 svl1 338520: svl1: Feb 10 07:30:10.876:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:10 svl1 338521: svl1: Feb 10 07:30:10.876: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:10 svl1 338522: svl1: Feb 10 07:30:10.876: LACP:

Feb 10 07:30:11 svl1 338523: svl1: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:11 svl1 338524: svl1: Feb 10 07:30:11.095: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl1 338525: svl1: Feb 10 07:30:11.095: LACP : packet size: 124

Feb 10 07:30:11 svl1 338526: svl1: Feb 10 07:30:11.095: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl1 338527: svl1: Feb 10 07:30:11.095: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl1 338528: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl1 338529: svl1: Feb 10 07:30:11.095: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x36,

Feb 10 07:30:11 svl1 338530: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl1 338531: svl1: Feb 10 07:30:11.095: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl1 338532: svl1: Feb 10 07:30:11.095: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl1 338533: svl1: Feb 10 07:30:11.095: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:11 svl1 338534: svl1: Feb 10 07:30:11.095:     lacp_rx Hu2/0/28 - rx: during state EXPIRED, got event 5(recv_lacpdu)

Feb 10 07:30:11 svl1 338535: svl1: Feb 10 07:30:11.095: @@@ lacp_rx Hu2/0/28 - rx: EXPIRED -> CURRENT

Feb 10 07:30:11 svl1 338536: svl1: Feb 10 07:30:11.095: LACP: Hu2/0/28 lacp_action_rx_expired_exit entered

Feb 10 07:30:11 svl1 338537: svl1: Feb 10 07:30:11.095: LACP: lacp_c(Hu2/0/28) timer stopped

Feb 10 07:30:11 svl1 338538: svl1: Feb 10 07:30:11.095: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:11 svl1 338539: svl1: Feb 10 07:30:11.095: LACP: update_Selected: Partner LAG components have changed,Unselecting Hu2/0/28.

Feb 10 07:30:11 svl1 338540: svl1: Feb 10 07:30:11.095: LACP: Hu2/0/28 set to UNSELECTED

Feb 10 07:30:11 svl1 338541: svl1: Feb 10 07:30:11.095:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 3(unselected)

Feb 10 07:30:11 svl1 338542: svl1: Feb 10 07:30:11.095: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> DETACHED

Feb 10 07:30:11 svl1 338543: svl1: Feb 10 07:30:11.095: LACP: Hu2/0/28 lacp_action_mx_detached entered

Feb 10 07:30:11 svl1 338544: svl1: Feb 10 07:30:11.095: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl1 338545: svl1: Feb 10 07:30:11.095: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:11 svl1 338546: svl1: Feb 10 07:30:11.095: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl1 338547: svl1: Feb 10 07:30:11.095: LACP : packet size: 124

Feb 10 07:30:11 svl1 338548: svl1: Feb 10 07:30:11.095: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl1 338549: svl1: Feb 10 07:30:11.095: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl1 338550: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl1 338551: svl1: Feb 10 07:30:11.095: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3,

Feb 10 07:30:11 svl1 338552: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl1 338553: svl1: Feb 10 07:30:11.095: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl1 338554: svl1: Feb 10 07:30:11.095: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl1 338555: svl1: Feb 10 07:30:11.095: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:11 svl1 338556: svl1: Feb 10 07:30:11.095: LACP: HA: Syncing LACP IDB HundredGigE2/0/28

Feb 10 07:30:11 svl1 338557: svl1: Feb 10 07:30:11.095: LACP: HA: Sync LACPIDBs

Feb 10 07:30:11 svl1 338558: svl1: Feb 10 07:30:11.095: LACP: HA ISSU: xmit xform

Feb 10 07:30:11 svl1 338559: svl1: Feb 10 07:30:11.095: LACP: lacp_w(Hu2/0/28) timer stopped

Feb 10 07:30:11 svl1 338560: svl1: Feb 10 07:30:11.095: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl1 338561: svl1: Feb 10 07:30:11.095: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:11 svl1 338562: svl1: Feb 10 07:30:11.095: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl1 338563: svl1: Feb 10 07:30:11.095: LACP : packet size: 124

Feb 10 07:30:11 svl1 338564: svl1: Feb 10 07:30:11.095: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl1 338565: svl1: Feb 10 07:30:11.095: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl1 338566: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl1 338567: svl1: Feb 10 07:30:11.095: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3,

Feb 10 07:30:11 svl1 338568: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl1 338569: svl1: Feb 10 07:30:11.095: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl1 338570: svl1: Feb 10 07:30:11.095: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl1 338571: svl1: Feb 10 07:30:11.095: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:11 svl1 338572: svl1: Feb 10 07:30:11.095: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 3

Feb 10 07:30:11 svl1 338573: svl1: Feb 10 07:30:11.095: LACP:

Feb 10 07:30:11 svl1 338574: svl1: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:11 svl1 338575: svl1: Feb 10 07:30:11.095: LACP: Hu2/0/28 Partners oper state is hex 87

Feb 10 07:30:11 svl1 338576: svl1: Feb 10 07:30:11.095: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:11 svl1 338577: svl1: Feb 10 07:30:11.095: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:11 svl1 338578: svl1: Feb 10 07:30:11.095: LACP: Hu2/0/28 LAG has changed

Feb 10 07:30:11 svl1 338579: svl1: Feb 10 07:30:11.096: LACP: Hu2/0/28 SELECTED aggregator hex address is 7FF141C705F0

Feb 10 07:30:11 svl1 338580: svl1: Feb 10 07:30:11.096: LACP: Hu2/0/28 set to SELECTED

Feb 10 07:30:11 svl1 338581: svl1: Feb 10 07:30:11.096:     lacp_mux Hu2/0/28 - mux: during state DETACHED, got event 1(selected)

Feb 10 07:30:11 svl1 338582: svl1: Feb 10 07:30:11.096: @@@ lacp_mux Hu2/0/28 - mux: DETACHED -> WAITING

Feb 10 07:30:11 svl1 338583: svl1: Feb 10 07:30:11.096: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:11 svl1 338584: svl1: Feb 10 07:30:11.096: LACP: timer lacp_w(Hu2/0/28) started with interval 2000.

Feb 10 07:30:11 svl1 338585: svl1: Feb 10 07:30:11.096:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:11 svl1 338586: svl1: Feb 10 07:30:11.096: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:11 svl1 338587: svl1: Feb 10 07:30:11.096: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:11 svl1 338588: svl1: Feb 10 07:30:11.097: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl1 338589: svl1: Feb 10 07:30:11.097: LACP : packet size: 124

Feb 10 07:30:11 svl1 338590: svl1: Feb 10 07:30:11.097: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl1 338591: svl1: Feb 10 07:30:11.097: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl1 338592: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl1 338593: svl1: Feb 10 07:30:11.097: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x36,

Feb 10 07:30:11 svl1 338594: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl1 338595: svl1: Feb 10 07:30:11.097: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl1 338596: svl1: Feb 10 07:30:11.097: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl1 338597: svl1: Feb 10 07:30:11.097: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:11 svl1 338598: svl1: Feb 10 07:30:11.097:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:11 svl1 338599: svl1: Feb 10 07:30:11.097: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:11 svl1 338600: svl1: Feb 10 07:30:11.097: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:11 svl1 338601: svl1: Feb 10 07:30:11.097: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 87

Feb 10 07:30:11 svl1 338602: svl1: Feb 10 07:30:11.097: LACP:

Feb 10 07:30:11 svl1 338603: svl1: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:11 svl1 338604: svl1: Feb 10 07:30:11.097: LACP: Hu2/0/28 Partners oper state is hex 87

Feb 10 07:30:11 svl1 338605: svl1: Feb 10 07:30:11.098: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:11 svl1 338606: svl1: Feb 10 07:30:11.098: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:11 svl1 338607: svl1: Feb 10 07:30:11.098: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:11 svl1 338608: svl1: Feb 10 07:30:11.098:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:11 svl1 338609: svl1: Feb 10 07:30:11.098: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:11 svl1 338610: svl1: Feb 10 07:30:11.098: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:11 svl1 338611: svl1: Feb 10 07:30:11.098: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl1 338612: svl1: Feb 10 07:30:11.098: LACP : packet size: 124

Feb 10 07:30:11 svl1 338613: svl1: Feb 10 07:30:11.098: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl1 338614: svl1: Feb 10 07:30:11.098: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl1 338615: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl1 338616: svl1: Feb 10 07:30:11.098: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl1 338617: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl1 338618: svl1: Feb 10 07:30:11.098: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl1 338619: svl1: Feb 10 07:30:11.098: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl1 338620: svl1: Feb 10 07:30:11.098: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:11 svl1 338621: svl1: Feb 10 07:30:11.098:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:11 svl1 338622: svl1: Feb 10 07:30:11.098: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:11 svl1 338623: svl1: Feb 10 07:30:11.098: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:11 svl1 338624: svl1: Feb 10 07:30:11.098: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 87

Feb 10 07:30:11 svl1 338625: svl1: Feb 10 07:30:11.098: LACP: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:11 svl1 338626: svl1: Feb 10 07:30:11.098: LACP: Hu2/0/28 Partners oper state is hex 7

Feb 10 07:30:11 svl1 338627: svl1: Feb 10 07:30:11.098: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:11 svl1 338628: svl1: Feb 10 07:30:11.098: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:11 svl1 338629: svl1: Feb 10 07:30:11.098: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:11 svl1 338630: svl1: Feb 10 07:30:11.098:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:11 svl1 338631: svl1: Feb 10 07:30:11.098: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:11 svl1 338632: svl1: Feb 10 07:30:11.098: LACP:

Feb 10 07:30:11 svl1 338633: svl1: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:11 svl1 338634: svl1: Feb 10 07:30:11.364: LACP: CF: sync successfully completed

Feb 10 07:30:11 svl1 338635: svl1: Feb 10 07:30:11.451: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl1 338636: svl1: Feb 10 07:30:11.629: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl1 338637: svl1: Feb 10 07:30:11.785: LACP: lacp_t(Hu2/0/28) timer stopped

Feb 10 07:30:11 svl1 338638: svl1: Feb 10 07:30:11.785: LACP: lacp_t(Hu2/0/28) expired

Feb 10 07:30:11 svl1 338639: svl1: Feb 10 07:30:11.785: LACP: timer lacp_t(Hu2/0/28) started with interval 1000.

Feb 10 07:30:11 svl1 338640: svl1: Feb 10 07:30:11.785: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl1 338641: svl1: Feb 10 07:30:11.785: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:11 svl1 338642: svl1: Feb 10 07:30:11.785: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl1 338643: svl1: Feb 10 07:30:11.785: LACP : packet size: 124

Feb 10 07:30:11 svl1 338644: svl1: Feb 10 07:30:11.785: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl1 338645: svl1: Feb 10 07:30:11.785: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl1 338646: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl1 338647: svl1: Feb 10 07:30:11.785: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl1 338648: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl1 338649: svl1: Feb 10 07:30:11.785: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl1 338650: svl1: Feb 10 07:30:11.785: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl1 338651: svl1: Feb 10 07:30:11.785: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:11 svl1 338652: svl1: Feb 10 07:30:11.821: LACP:

Feb 10 07:30:11 svl1 338653: svl1: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:11 svl1 338654: svl1: Feb 10 07:30:11.821: LACP: lacp_p(Hu2/0/28) expired

Feb 10 07:30:11 svl1 338655: svl1: Feb 10 07:30:11.821:     lacp_ptx Hu2/0/28 - ptx: during state FAST_PERIODIC, got event 3(pt_expired)

Feb 10 07:30:11 svl1 338656: svl1: Feb 10 07:30:11.821: @@@ lacp_ptx Hu2/0/28 - ptx: FAST_PERIODIC -> PERIODIC_TX

Feb 10 07:30:11 svl1 338657: svl1: Feb 10 07:30:11.821: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic_exit entered

Feb 10 07:30:11 svl1 338658: svl1: Feb 10 07:30:11.821: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:11 svl1 338659: svl1: Feb 10 07:30:11.821: LACP: Hu2/0/28 lacp_action_ptx_periodic_tx entered

Feb 10 07:30:11 svl1 338660: svl1: Feb 10 07:30:11.821: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl1 338661: svl1: Feb 10 07:30:11.821: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:11 svl1 338662: svl1: Feb 10 07:30:11.821: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl1 338663: svl1: Feb 10 07:30:11.821: LACP : packet size: 124

Feb 10 07:30:11 svl1 338664: svl1: Feb 10 07:30:11.821: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl1 338665: svl1: Feb 10 07:30:11.821: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl1 338666: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl1 338667: svl1: Feb 10 07:30:11.821: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl1 338668: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl1 338669: svl1: Feb 10 07:30:11.821: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl1 338670: svl1: Feb 10 07:30:11.821: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl1 338671: svl1: Feb 10 07:30:11.821: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:12 svl1 338672: svl1: Feb 10 07:30:11.821:     lacp_ptx Hu2/0/28 - ptx: during state PERIODIC_TX, got event 4(short_timeout)

Feb 10 07:30:12 svl1 338673: svl1: Feb 10 07:30:11.821: @@@ lacp_ptx Hu2/0/28 - ptx: PERIODIC_TX -> FAST_PERIODIC

Feb 10 07:30:12 svl1 338674: svl1: Feb 10 07:30:11.822: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic entered

Feb 10 07:30:12 svl1 338675: svl1: Feb 10 07:30:11.822: LACP: timer lacp_p_f(Hu2/0/28) started with interval 1000.

Feb 10 07:30:12 svl1 338676: svl1: Feb 10 07:30:12.078: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:12 svl1 338677: svl1: Feb 10 07:30:12.078: LACP : packet size: 124

Feb 10 07:30:12 svl1 338678: svl1: Feb 10 07:30:12.078: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:12 svl1 338679: svl1: Feb 10 07:30:12.078: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl1 338680: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:12 svl1 338681: svl1: Feb 10 07:30:12.078: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl1 338682: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:12 svl1 338683: svl1: Feb 10 07:30:12.078: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:12 svl1 338684: svl1: Feb 10 07:30:12.078: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:12 svl1 338685: svl1: Feb 10 07:30:12.078: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:12 svl1 338686: svl1: Feb 10 07:30:12.078:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:12 svl1 338687: svl1: Feb 10 07:30:12.078: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:12 svl1 338688: svl1: Feb 10 07:30:12.078: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:12 svl1 338689: svl1: Feb 10 07:30:12.078: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 7

Feb 10 07:30:12 svl1 338690: svl1: Feb 10 07:30:12.078: LACP:

Feb 10 07:30:12 svl1 338691: svl1: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:12 svl1 338692: svl1: Feb 10 07:30:12.078: LACP: Hu2/0/28 Partners oper state is hex 7

Feb 10 07:30:12 svl1 338693: svl1: Feb 10 07:30:12.078: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:12 svl1 338694: svl1: Feb 10 07:30:12.078: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:12 svl1 338695: svl1: Feb 10 07:30:12.078: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:12 svl1 338696: svl1: Feb 10 07:30:12.078:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:12 svl1 338697: svl1: Feb 10 07:30:12.078: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:12 svl1 338698: svl1: Feb 10 07:30:12.078: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:12 svl1 338699: svl1: Feb 10 07:30:12.332: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:12 svl1 338700: svl1: Feb 10 07:30:12.608: LACP:

Feb 10 07:30:12 svl1 338701: svl1: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:12 svl1 338702: svl1: Feb 10 07:30:12.655: LACP: lacp_t(Hu2/0/28) timer stopped

Feb 10 07:30:12 svl1 338703: svl1: Feb 10 07:30:12.655: LACP: lacp_t(Hu2/0/28) expired

Feb 10 07:30:12 svl1 338704: svl1: Feb 10 07:30:12.810: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:12 svl1 338705: svl1: Feb 10 07:30:12.810: LACP: lacp_p(Hu2/0/28) expired

Feb 10 07:30:12 svl1 338706: svl1: Feb 10 07:30:12.810:     lacp_ptx Hu2/0/28 - ptx: during state FAST_PERIODIC, got event 3(pt_expired)

Feb 10 07:30:12 svl1 338707: svl1: Feb 10 07:30:12.810: @@@ lacp_ptx Hu2/0/28 - ptx: FAST_PERIODIC -> PERIODIC_TX

Feb 10 07:30:12 svl1 338708: svl1: Feb 10 07:30:12.810: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic_exit entered

Feb 10 07:30:12 svl1 338709: svl1: Feb 10 07:30:12.810: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:12 svl1 338710: svl1: Feb 10 07:30:12.810: LACP: Hu2/0/28 lacp_action_ptx_periodic_tx entered

Feb 10 07:30:12 svl1 338711: svl1: Feb 10 07:30:12.810: LACP: timer lacp_t(Hu2/0/28) started with interval 1000.

Feb 10 07:30:12 svl1 338712: svl1: Feb 10 07:30:12.810: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:12 svl1 338713: svl1: Feb 10 07:30:12.810: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:12 svl1 338714: svl1: Feb 10 07:30:12.810: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:12 svl1 338715: svl1: Feb 10 07:30:12.810: LACP : packet size: 124

Feb 10 07:30:12 svl1 338716: svl1: Feb 10 07:30:12.810: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:12 svl1 338717: svl1: Feb 10 07:30:12.810: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl1 338718: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:12 svl1 338719: svl1: Feb 10 07:30:12.810: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl1 338720: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:12 svl1 338721: svl1: Feb 10 07:30:12.810: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:12 svl1 338722: svl1: Feb 10 07:30:12.810: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:12 svl1 338723: svl1: Feb 10 07:30:12.810: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:12 svl1 338724: svl1: Feb 10 07:30:12.810:     lacp_ptx Hu2/0/28 - ptx: during state PERIODIC_TX, got event 4(short_timeout)

Feb 10 07:30:12 svl1 338725: svl1: Feb 10 07:30:12.810: @@@ lacp_ptx Hu2/0/28 - ptx: PERIODIC_TX -> FAST_PERIODIC

Feb 10 07:30:12 svl1 338726: svl1: Feb 10 07:30:12.810: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic entered

Feb 10 07:30:12 svl1 338727: svl1: Feb 10 07:30:12.810: LACP: timer lacp_p_f(Hu2/0/28) started with interval 1000.

Feb 10 07:30:12 svl1 338728: svl1: Feb 10 07:30:12.858: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:12 svl1 338729: svl1: Feb 10 07:30:12.858: LACP : packet size: 124

Feb 10 07:30:12 svl1 338730: svl1: Feb 10 07:30:12.858: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:12 svl1 338731: svl1: Feb 10 07:30:12.858: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:12 svl1 338732: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:12 svl1 338733: svl1: Feb 10 07:30:12.858: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl1 338734: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:12 svl1 338735: svl1: Feb 10 07:30:12.858: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:12 svl1 338736: svl1: Feb 10 07:30:12.858: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:12 svl1 338737: svl1: Feb 10 07:30:12.858: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:12 svl1 338738: svl1: Feb 10 07:30:12.858:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:12 svl1 338739: svl1: Feb 10 07:30:12.858: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:12 svl1 338740: svl1: Feb 10 07:30:12.858: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:12 svl1 338741: svl1: Feb 10 07:30:12.858: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 7

Feb 10 07:30:12 svl1 338742: svl1: Feb 10 07:30:12.858: LACP: recordPDU Hu2/0/28 Partner in sync and aggregating

Feb 10 07:30:12 svl1 338743: svl1: Feb 10 07:30:12.858: LACP: Hu2/0/28 Partners oper state is hex F

Feb 10 07:30:12 svl1 338744: svl1: Feb 10 07:30:12.858: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:12 svl1 338745: svl1: Feb 10 07:30:12.858: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:12 svl1 338746: svl1: Feb 10 07:30:12.858: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:12 svl1 338747: svl1: Feb 10 07:30:12.858:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 5(in_sync) (ignored)

Feb 10 07:30:12 svl1 338748: svl1: Feb 10 07:30:12.958: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:12 svl1 338749: svl1: Feb 10 07:30:12.958: LACP : packet size: 124

Feb 10 07:30:12 svl1 338750: svl1: Feb 10 07:30:12.958: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:12 svl1 338751: svl1: Feb 10 07:30:12.958: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:12 svl1 338752: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:12 svl1 338753: svl1: Feb 10 07:30:12.958: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl1 338754: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:12 svl1 338755: svl1: Feb 10 07:30:12.958: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:12 svl1 338756: svl1: Feb 10 07:30:12.958: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:12 svl1 338757: svl1: Feb 10 07:30:12.958: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:12 svl1 338758: svl1: Feb 10 07:30:12.958:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:12 svl1 338759: svl1: Feb 10 07:30:12.958: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:12 svl1 338760: svl1: Feb 10 07:30:12.958: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:12 svl1 338761: svl1: Feb 10 07:30:12.958: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex F

Feb 10 07:30:12 svl1 338762: svl1: Feb 10 07:30:12.958: LACP: recordPDU Hu2/0/28 Partner in sync and aggregating

Feb 10 07:30:12 svl1 338763: svl1: Feb 10 07:30:12.958: LACP: Hu2/0/28 Partners oper state is hex F

Feb 10 07:30:12 svl1 338764: svl1: Feb 10 07:30:12.958: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:12 svl1 338765: svl1: Feb 10 07:30:12.958: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:13 svl1 338766: svl1: Feb 10 07:30:12.958: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:13 svl1 338767: svl1: Feb 10 07:30:12.959:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 5(in_sync) (ignored)

Feb 10 07:30:13 svl1 338768: svl1: Feb 10 07:30:12.992: LACP: lacp_w(Hu2/0/28) timer stopped

Feb 10 07:30:13 svl1 338769: svl1: Feb 10 07:30:12.992: LACP: lacp_w(Hu2/0/28) expired

Feb 10 07:30:13 svl1 338770: svl1: Feb 10 07:30:12.992:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 4(ready)

Feb 10 07:30:13 svl1 338771: svl1: Feb 10 07:30:12.992: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> ATTACHED

Feb 10 07:30:13 svl1 338772: svl1: Feb 10 07:30:12.992: LACP: Hu2/0/28 lacp_action_mx_attached entered

Feb 10 07:30:13 svl1 338773: svl1: Feb 10 07:30:12.992: LACP: Hu2/0/28 Attaching mux to aggregator

Feb 10 07:30:13 svl1 338774: svl1: Feb 10 07:30:12.992: LACP: Hu2/0/28 Attach_Mux_To_Aggregator skipping adding the member to channel-group

Feb 10 07:30:13 svl1 338775: svl1: Feb 10 07:30:12.992: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:13 svl1 338776: svl1: Feb 10 07:30:12.992: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:13 svl1 338777: svl1: Feb 10 07:30:12.992: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:13 svl1 338778: svl1: Feb 10 07:30:12.992: LACP : packet size: 124

Feb 10 07:30:13 svl1 338779: svl1: Feb 10 07:30:12.992: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:13 svl1 338780: svl1: Feb 10 07:30:12.992: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:13 svl1 338781: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:13 svl1 338782: svl1: Feb 10 07:30:12.992: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:13 svl1 338783: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:13 svl1 338784: svl1: Feb 10 07:30:12.992: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:13 svl1 338785: svl1: Feb 10 07:30:12.992: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:13 svl1 338786: svl1: Feb 10 07:30:12.992: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:13 svl1 338787: svl1: Feb 10 07:30:12.992:     lacp_mux Hu2/0/28 - mux: during state ATTACHED, got event 5(in_sync)

Feb 10 07:30:13 svl1 338788: svl1: Feb 10 07:30:12.992: @@@ lacp_mux Hu2/0/28 - mux: ATTACHED -> COLLECTING_DISTRIBUTING

Feb 10 07:30:13 svl1 338789: svl1: Feb 10 07:30:12.993: LACP: Hu2/0/28 lacp_action_mx_collecting_distributing entered

Feb 10 07:30:13 svl1 338790: svl1: Feb 10 07:30:12.993: LACP: Hu2/0/28 Enabling collecting and distributing

Feb 10 07:30:13 svl1 338791: svl1: Feb 10 07:30:13.002: LACP: Hu2/0/28 request far-end rate goes long

Feb 10 07:30:13 svl1 338792: svl1: Feb 10 07:30:13.002: LACP: timer lacp_c_l(Hu2/0/28) started with interval 90000.

Feb 10 07:30:13 svl1 338793: svl1: Feb 10 07:30:13.002: LACP:

Feb 10 07:30:13 svl1 338794: svl1: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:13 svl1 338795: svl1: Feb 10 07:30:13.002: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:13 svl1 338796: svl1: Feb 10 07:30:13.002: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:13 svl1 338797: svl1: Feb 10 07:30:13.002: LACP : packet size: 124

Feb 10 07:30:13 svl1 338798: svl1: Feb 10 07:30:13.002: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:13 svl1 338799: svl1: Feb 10 07:30:13.002: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:13 svl1 338800: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:13 svl1 338801: svl1: Feb 10 07:30:13.002: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:13 svl1 338802: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:13 svl1 338803: svl1: Feb 10 07:30:13.002: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:13 svl1 338804: svl1: Feb 10 07:30:13.002: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:13 svl1 338805: svl1: Feb 10 07:30:13.002: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:13 svl1 338806: svl1: Feb 10 07:30:13.002: LACP: HA: Syncing LACP IDB HundredGigE2/0/28

Feb 10 07:30:13 svl1 338807: svl1: Feb 10 07:30:13.002: LACP: HA: Sync LACPIDBs

Feb 10 07:30:13 svl1 338808: svl1: Feb 10 07:30:13.002: LACP: HA ISSU: xmit xform

Feb 10 07:30:13 svl1 338809: svl1: Feb 10 07:30:13.002: lacp_handle_standby_port_internal called, depth = 1

Feb 10 07:30:13 svl1 338810: svl1: Feb 10 07:30:13.002: LACP: lacp_handle_standby_port_internal: No Standby port found for LAG 1

Feb 10 07:30:13 svl1 338811: svl1: Feb 10 07:30:13.071: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:13 svl1 338812: svl1: Feb 10 07:30:13.071: LACP : packet size: 124

Feb 10 07:30:13 svl1 338813: svl1: Feb 10 07:30:13.071: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:13 svl1 338814: svl1: Feb 10 07:30:13.071: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:13 svl1 338815: svl1: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:13 svl1 338816: svl1: Feb 10 07:30:13.071: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:13 svl1 338817: svl1: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:13 svl1 338818: svl1: Feb 10 07:30:13.072: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:13 svl1 338819: svl1: Feb 10 07:30:13.072: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:13 svl1 338820: svl1: Feb 10 07:30:13.072: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:13 svl1 338821: svl1: Feb 10 07:30:13.072:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:13 svl1 338822: svl1: Feb 10 07:30:13.072: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:13 svl1 338823: svl1: Feb 10 07:30:13.072: LACP:

Feb 10 07:30:13 svl1 338824: svl1: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:13 svl1 338825: svl1: Feb 10 07:30:13.072: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex F

Feb 10 07:30:13 svl1 338826: svl1: Feb 10 07:30:13.072: LACP: Hu2/0/28 partner timeout mode changed to 0

Feb 10 07:30:13 svl1 338827: svl1: Feb 10 07:30:13.072:     lacp_ptx Hu2/0/28 - ptx: during state FAST_PERIODIC, got event 2(long_timeout)

Feb 10 07:30:13 svl1 338828: svl1: Feb 10 07:30:13.072: @@@ lacp_ptx Hu2/0/28 - ptx: FAST_PERIODIC -> SLOW_PERIODIC

Feb 10 07:30:13 svl1 338829: svl1: Feb 10 07:30:13.072: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic_exit entered

Feb 10 07:30:13 svl1 338830: svl1: Feb 10 07:30:13.072: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:13 svl1 338831: svl1: Feb 10 07:30:13.072: LACP: Hu2/0/28 lacp_action_ptx_slow_periodic entered

Feb 10 07:30:13 svl1 338832: svl1: Feb 10 07:30:13.072: LACP: timer lacp_p_s(Hu2/0/28) started with interval 30000.

Feb 10 07:30:13 svl1 338833: svl1: Feb 10 07:30:13.072: LACP: recordPDU Hu2/0/28 Partner in sync and aggregating

Feb 10 07:30:13 svl1 338834: svl1: Feb 10 07:30:13.072: LACP: Hu2/0/28 Partners oper state is hex 3D

Feb 10 07:30:13 svl1 338835: svl1: Feb 10 07:30:13.072: LACP: timer lacp_c_l(Hu2/0/28) started with interval 90000.

Feb 10 07:30:13 svl1 338836: svl1: Feb 10 07:30:13.072: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:13 svl1 338837: svl1: Feb 10 07:30:13.072: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:13 svl1 338838: svl1: Feb 10 07:30:13.072:     lacp_mux Hu2/0/28 - mux: during state COLLECTING_DISTRIBUTING, got event 5(in_sync) (ignored)

Feb 10 07:30:13 svl1 338839: svl1: Feb 10 07:30:13.133: LACP: CF: sync successfully completed

Feb 10 07:30:13 svl1 338840: svl1: Feb 10 07:30:13.269: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:13 svl1 338841: svl1: Feb 10 07:30:13.488: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:14 svl1 338842: svl1: Feb 10 07:30:13.770: LACP: lacp_t(Hu2/0/28) timer stopped

Feb 10 07:30:14 svl1 338843: svl1: Feb 10 07:30:13.770: LACP: lacp_t(Hu2/0/28) expired

Feb 10 07:30:14 svl1 338844: svl1: 14w5d: %LINEPROTO-5-UPDOWN: Line protocol on Interface HundredGigE2/0/28, changed state to up

Feb 10 07:30:14 svl1 338845: svl1: Feb 10 07:30:14.139: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:14 svl1 338846: svl1: Feb 10 07:30:14.437: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:15 svl1 338847: svl1: 14w5d: %LINK-3-UPDOWN: Interface Port-channel1, changed state to up

Feb 10 07:30:15 svl1 338848: svl1: Feb 10 07:30:14.998: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:15 svl1 338849: svl1: Feb 10 07:30:15.291: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:15 svl1 338850: svl1: Feb 10 07:30:15.881: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:16 svl1 338851: svl1: 14w5d: %LINEPROTO-5-UPDOWN: Line protocol on Interface Port-channel1, changed state to up

# SVL2

Spoiler

Feb 10 07:30:01 svl2 277419: svl2: .Feb 10 07:30:00.583: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:01 svl2 277420: svl2: .Feb 10 07:30:01.238: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:01 svl2 277421: svl2: .Feb 10 07:30:01.252: %LINEPROTO-5-UPDOWN: Line protocol on Interface Port-channel1, changed state to up

Feb 10 07:30:02 svl2 277422: svl2: .Feb 10 07:30:01.563: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:02 svl2 277423: svl2: .Feb 10 07:30:02.212: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:02 svl2 277424: svl2: .Feb 10 07:30:02.479: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:04 svl2 277425: svl2: .Feb 10 07:30:03.091: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:04 svl2 277426: svl2: .Feb 10 07:30:03.392: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:04 svl2 277427: svl2: .Feb 10 07:30:04.083: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:05 svl2 277428: svl2: .Feb 10 07:30:04.378: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:05 svl2 277429: svl2: .Feb 10 07:30:05.007: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:05 svl2 277430: svl2: .Feb 10 07:30:05.315: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:06 svl2 277431: svl2: .Feb 10 07:30:05.901: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:06 svl2 277432: svl2: .Feb 10 07:30:06.265: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:06 svl2 277433: svl2: .Feb 10 07:30:06.884: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:07 svl2 277434: svl2: .Feb 10 07:30:07.240: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:07 svl2 277435: svl2: .Feb 10 07:30:07.789: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:07 svl2 277436: svl2: .Feb 10 07:30:08.022: LACP: lacp_hw_off: Hu2/0/28 is going down

Feb 10 07:30:07 svl2 277437: svl2: .Feb 10 07:30:08.022: LACP: if_down: Hu2/0/28

Feb 10 07:30:07 svl2 277438: svl2: .Feb 10 07:30:08.022: LACP: lacp_hw_off: send pdu out Hu2/0/28

Feb 10 07:30:07 svl2 277439: svl2: .Feb 10 07:30:08.022: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:07 svl2 277440: svl2: .Feb 10 07:30:08.022: LACP: lacp_send_lacp_off: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:07 svl2 277441: svl2: .Feb 10 07:30:08.022: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:07 svl2 277442: svl2: .Feb 10 07:30:08.022: LACP : packet size: 124

Feb 10 07:30:07 svl2 277443: svl2: .Feb 10 07:30:08.022: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:07 svl2 277444: svl2: .Feb 10 07:30:08.022: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x1,

Feb 10 07:30:07 svl2 277445: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:07 svl2 277446: svl2: .Feb 10 07:30:08.022: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:07 svl2 277447: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:07 svl2 277448: svl2: .Feb 10 07:30:08.022: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:07 svl2 277449: svl2: .Feb 10 07:30:08.022: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:07 svl2 277450: svl2: .Feb 10 07:30:08.022: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:07 svl2 277451: svl2: .Feb 10 07:30:08.022:     lacp_ptx Hu2/0/28 - ptx: during state SLOW_PERIODIC, got event 0(no_periodic)

Feb 10 07:30:07 svl2 277452: svl2: .Feb 10 07:30:08.022: @@@ lacp_ptx Hu2/0/28 - ptx: SLOW_PERIODIC -> NO_PERIODIC

Feb 10 07:30:07 svl2 277453: svl2: .Feb 10 07:30:08.022: LACP: Hu2/0/28 lacp_action_ptx_slow_periodic_exit entered

Feb 10 07:30:07 svl2 277454: svl2: .Feb 10 07:30:08.022: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:07 svl2 277455: svl2: .Feb 10 07:30:08.022: LACP: Hu2/0/28 lacp_action_ptx_no_periodic entered

Feb 10 07:30:07 svl2 277456: svl2: .Feb 10 07:30:08.022: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:07 svl2 277457: svl2: .Feb 10 07:30:08.022:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 1(port_disabled)

Feb 10 07:30:07 svl2 277458: svl2: .Feb 10 07:30:08.022: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> PORT_DISABLED

Feb 10 07:30:07 svl2 277459: svl2: .Feb 10 07:30:08.022: LACP: Hu2/0/28 lacp_action_rx_current_exit entered

Feb 10 07:30:07 svl2 277460: svl2: .Feb 10 07:30:08.022: LACP: lacp_c(Hu2/0/28) timer stopped

Feb 10 07:30:07 svl2 277461: svl2: .Feb 10 07:30:08.022: LACP: Hu2/0/28 lacp_action_rx_port_disabled entered

Feb 10 07:30:07 svl2 277462: svl2: .Feb 10 07:30:08.022:     lacp_mux Hu2/0/28 - mux: during state COLLECTING_DISTRIBUTING, got event 6(outof_sync)

Feb 10 07:30:07 svl2 277463: svl2: .Feb 10 07:30:08.022: @@@ lacp_mux Hu2/0/28 - mux: COLLECTING_DISTRIBUTING -> ATTACHED

Feb 10 07:30:07 svl2 277464: svl2: .Feb 10 07:30:08.022: LACP: Hu2/0/28 lacp_action_mx_cd_exit is entered

Feb 10 07:30:07 svl2 277465: svl2: .Feb 10 07:30:08.022: LACP: Hu2/0/28 lacp_action_mx_attached entered

Feb 10 07:30:07 svl2 277466: svl2: .Feb 10 07:30:08.022: LACP: Hu2/0/28 Disabling collecting and distributing

Feb 10 07:30:07 svl2 277467: svl2: .Feb 10 07:30:08.023: LACP: Hu2/0/28 set to UNSELECTED

Feb 10 07:30:07 svl2 277468: svl2: .Feb 10 07:30:08.023:     lacp_mux Hu2/0/28 - mux: during state ATTACHED, got event 3(unselected)

Feb 10 07:30:07 svl2 277469: svl2: .Feb 10 07:30:08.023: @@@ lacp_mux Hu2/0/28 - mux: ATTACHED -> DETACHED

Feb 10 07:30:07 svl2 277470: svl2: .Feb 10 07:30:08.023: LACP: Hu2/0/28 lacp_action_mx_detached entered

Feb 10 07:30:07 svl2 277471: svl2: .Feb 10 07:30:08.023: LACP: Hu2/0/28 Detaching mux from aggregator

Feb 10 07:30:07 svl2 277472: svl2: .Feb 10 07:30:08.023: LACP: HA: Syncing LACP IDB HundredGigE2/0/28

Feb 10 07:30:07 svl2 277473: svl2: .Feb 10 07:30:08.023: LACP: HA: Sync LACPIDBs

Feb 10 07:30:07 svl2 277474: svl2: .Feb 10 07:30:08.023: LACP: HA ISSU: xmit xform

Feb 10 07:30:07 svl2 277475: svl2: .Feb 10 07:30:08.023: lacp_handle_standby_port_internal called, depth = 1

Feb 10 07:30:07 svl2 277476: svl2: .Feb 10 07:30:08.023: LACP: lacp_handle_standby_port_internal: No Standby port found for LAG 1

Feb 10 07:30:07 svl2 277477: svl2: .Feb 10 07:30:08.023: LACP: lacp_w(Hu2/0/28) timer stopped

Feb 10 07:30:07 svl2 277478: svl2: .Feb 10 07:30:08.023: LACP: lacp_c(Hu2/0/28) timer stopped

Feb 10 07:30:08 svl2 277479: svl2: .Feb 10 07:30:08.023: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:08 svl2 277480: svl2: .Feb 10 07:30:08.023: LACP: lacp_w(Hu2/0/28) timer stopped

Feb 10 07:30:08 svl2 277481: svl2: .Feb 10 07:30:08.023: LACP: lacp_t(Hu2/0/28) timer stopped

Feb 10 07:30:08 svl2 277482: svl2: .Feb 10 07:30:08.038: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:08 svl2 277483: svl2: .Feb 10 07:30:08.038: LACP : packet size: 124

Feb 10 07:30:08 svl2 277484: svl2: .Feb 10 07:30:08.038: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:08 svl2 277485: svl2: .Feb 10 07:30:08.038: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:08 svl2 277486: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:08 svl2 277487: svl2: .Feb 10 07:30:08.038: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:08 svl2 277488: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:08 svl2 277489: svl2: .Feb 10 07:30:08.038: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:08 svl2 277490: svl2: .Feb 10 07:30:08.038: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:08 svl2 277491: svl2: .Feb 10 07:30:08.038: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:08 svl2 277492: svl2: .Feb 10 07:30:08.038:     lacp_rx Hu2/0/28 - rx: during state PORT_DISABLED, got event 5(recv_lacpdu) (ignored)

Feb 10 07:30:08 svl2 277493: svl2: .Feb 10 07:30:08.038: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:08 svl2 277494: svl2: .Feb 10 07:30:08.038: LACP : packet size: 124

Feb 10 07:30:08 svl2 277495: svl2: .Feb 10 07:30:08.038: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:08 svl2 277496: svl2: .Feb 10 07:30:08.038: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:08 svl2 277497: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:08 svl2 277498: svl2: .Feb 10 07:30:08.038: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:08 svl2 277499: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:08 svl2 277500: svl2: .Feb 10 07:30:08.038: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:08 svl2 277501: svl2: .Feb 10 07:30:08.038: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:08 svl2 277502: svl2: .Feb 10 07:30:08.038: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:08 svl2 277503: svl2: .Feb 10 07:30:08.038:     lacp_rx Hu2/0/28 - rx: during state PORT_DISABLED, got event 5(recv_lacpdu) (ignored)

Feb 10 07:30:08 svl2 277504: svl2: .Feb 10 07:30:08.038: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:08 svl2 277505: svl2: .Feb 10 07:30:08.038: LACP : packet size: 124

Feb 10 07:30:08 svl2 277506: svl2: .Feb 10 07:30:08.038: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:08 svl2 277507: svl2: .Feb 10 07:30:08.038: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:08 svl2 277508: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:08 svl2 277509: svl2: .Feb 10 07:30:08.038: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:08 svl2 277510: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:08 svl2 277511: svl2: .Feb 10 07:30:08.038: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:08 svl2 277512: svl2: .Feb 10 07:30:08.038: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:08 svl2 277513: svl2: .Feb 10 07:30:08.038: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:08 svl2 277514: svl2: .Feb 10 07:30:08.038:     lacp_rx Hu2/0/28 - rx: during state PORT_DISABLED, got event 5(recv_lacpdu) (ignored)

Feb 10 07:30:08 svl2 277515: svl2: .Feb 10 07:30:08.191: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:08 svl2 277516: svl2: .Feb 10 07:30:08.231: LACP: CF: sync successfully completed

Feb 10 07:30:08 svl2 277517: svl2: .Feb 10 07:30:08.663: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:09 svl2 277518: svl2: .Feb 10 07:30:09.006: %LINEPROTO-5-UPDOWN: Line protocol on Interface HundredGigE2/0/28, changed state to down

Feb 10 07:30:09 svl2 277519: svl2: .Feb 10 07:30:09.014: %LINEPROTO-5-UPDOWN: Line protocol on Interface Port-channel1, changed state to down

Feb 10 07:30:09 svl2 277520: svl2: .Feb 10 07:30:09.046: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:09 svl2 277521: svl2: .Feb 10 07:30:09.643: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:09 svl2 277522: svl2: .Feb 10 07:30:09.961: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:10 svl2 277523: svl2: .Feb 10 07:30:10.021: %LINK-3-UPDOWN: Interface Port-channel1, changed state to down

Feb 10 07:30:10 svl2 277524: svl2: .Feb 10 07:30:10.634: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:10 svl2 277525: svl2: .Feb 10 07:30:10.830: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:10 svl2 277526: svl2: .Feb 10 07:30:10.917: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:10 svl2 277527: svl2: .Feb 10 07:30:10.917: LACP : packet size: 124

Feb 10 07:30:10 svl2 277528: svl2: .Feb 10 07:30:10.917: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:10 svl2 277529: svl2: .Feb 10 07:30:10.917: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:10 svl2 277530: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:10 svl2 277531: svl2: .Feb 10 07:30:10.917: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3,

Feb 10 07:30:10 svl2 277532: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:10 svl2 277533: svl2: .Feb 10 07:30:10.917: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:10 svl2 277534: svl2: .Feb 10 07:30:10.917: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:10 svl2 277535: svl2: .Feb 10 07:30:10.917: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:10 svl2 277536: svl2: .Feb 10 07:30:10.917:     lacp_rx Hu2/0/28 - rx: during state PORT_DISABLED, got event 5(recv_lacpdu) (ignored)

Feb 10 07:30:11 svl2 277537: svl2: .Feb 10 07:30:11.013: %LINEPROTO-5-UPDOWN: Line protocol on Interface Vlan2252, changed state to down

Feb 10 07:30:11 svl2 277538: svl2: .Feb 10 07:30:11.134: LACP: Hu2/0/28 oper-key: 0x1

Feb 10 07:30:11 svl2 277539: svl2: .Feb 10 07:30:11.134: LACP: lacp_hw_on: Hu2/0/28 is coming up

Feb 10 07:30:11 svl2 277540: svl2: .Feb 10 07:30:11.134: LACP: lacp_hw_on: Hu2/0/28 set mode 6

Feb 10 07:30:11 svl2 277541: svl2: .Feb 10 07:30:11.134:     lacp_ptx Hu2/0/28 - ptx: during state NO_PERIODIC, got event 0(no_periodic)

Feb 10 07:30:11 svl2 277542: svl2: .Feb 10 07:30:11.134: @@@ lacp_ptx Hu2/0/28 - ptx: NO_PERIODIC -> NO_PERIODIC

Feb 10 07:30:11 svl2 277543: svl2: .Feb 10 07:30:11.134: LACP: Hu2/0/28 lacp_action_ptx_no_periodic entered

Feb 10 07:30:11 svl2 277544: svl2: .Feb 10 07:30:11.134: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:11 svl2 277545: svl2: .Feb 10 07:30:11.134:     lacp_ptx Hu2/0/28 - ptx: during state NO_PERIODIC, got event 1(start_periodic)

Feb 10 07:30:11 svl2 277546: svl2: .Feb 10 07:30:11.134: @@@ lacp_ptx Hu2/0/28 - ptx: NO_PERIODIC -> FAST_PERIODIC

Feb 10 07:30:11 svl2 277547: svl2: .Feb 10 07:30:11.134: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic entered

Feb 10 07:30:11 svl2 277548: svl2: .Feb 10 07:30:11.134: LACP: timer lacp_p_f(Hu2/0/28) started with interval 1000.

Feb 10 07:30:11 svl2 277549: svl2: .Feb 10 07:30:11.134:     lacp_ptx Hu2/0/28 - ptx: during state FAST_PERIODIC, got event 2(long_timeout)

Feb 10 07:30:11 svl2 277550: svl2: .Feb 10 07:30:11.134: @@@ lacp_ptx Hu2/0/28 - ptx: FAST_PERIODIC -> SLOW_PERIODIC

Feb 10 07:30:11 svl2 277551: svl2: .Feb 10 07:30:11.134: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic_exit entered

Feb 10 07:30:11 svl2 277552: svl2: .Feb 10 07:30:11.134: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:11 svl2 277553: svl2: .Feb 10 07:30:11.134: LACP: Hu2/0/28 lacp_action_ptx_slow_periodic entered

Feb 10 07:30:11 svl2 277554: svl2: .Feb 10 07:30:11.134: LACP: timer lacp_p_s(Hu2/0/28) started with interval 30000.

Feb 10 07:30:11 svl2 277555: svl2: .Feb 10 07:30:11.134:     lacp_rx Hu2/0/28 - rx: during state PORT_DISABLED, got event 3(lacp_enabled)

Feb 10 07:30:11 svl2 277556: svl2: .Feb 10 07:30:11.134: @@@ lacp_rx Hu2/0/28 - rx: PORT_DISABLED -> EXPIRED

Feb 10 07:30:11 svl2 277557: svl2: .Feb 10 07:30:11.134: LACP: Hu2/0/28 lacp_action_rx_expired entered

Feb 10 07:30:11 svl2 277558: svl2: .Feb 10 07:30:11.134: LACP: Hu2/0/28 partner timeout mode changed to 1

Feb 10 07:30:11 svl2 277559: svl2: .Feb 10 07:30:11.134:     lacp_ptx Hu2/0/28 - ptx: during state SLOW_PERIODIC, got event 4(short_timeout)

Feb 10 07:30:11 svl2 277560: svl2: .Feb 10 07:30:11.134: @@@ lacp_ptx Hu2/0/28 - ptx: SLOW_PERIODIC -> PERIODIC_TX

Feb 10 07:30:11 svl2 277561: svl2: .Feb 10 07:30:11.134: LACP: Hu2/0/28 lacp_action_ptx_slow_periodic_exit entered

Feb 10 07:30:11 svl2 277562: svl2: .Feb 10 07:30:11.134: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:11 svl2 277563: svl2: .Feb 10 07:30:11.134: LACP:

Feb 10 07:30:11 svl2 277564: svl2: Hu2/0/28 lacp_action_ptx_periodic_tx entered

Feb 10 07:30:11 svl2 277565: svl2: .Feb 10 07:30:11.134: LACP: timer lacp_t(Hu2/0/28) started with interval 1000.

Feb 10 07:30:11 svl2 277566: svl2: .Feb 10 07:30:11.134: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl2 277567: svl2: .Feb 10 07:30:11.134: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:11 svl2 277568: svl2: .Feb 10 07:30:11.134: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl2 277569: svl2: .Feb 10 07:30:11.134: LACP : packet size: 124

Feb 10 07:30:11 svl2 277570: svl2: .Feb 10 07:30:11.134: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl2 277571: svl2: .Feb 10 07:30:11.134: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl2 277572: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl2 277573: svl2: .Feb 10 07:30:11.134: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x36,

Feb 10 07:30:11 svl2 277574: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl2 277575: svl2: .Feb 10 07:30:11.134: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl2 277576: svl2: .Feb 10 07:30:11.134: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl2 277577: svl2: .Feb 10 07:30:11.134: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:11 svl2 277578: svl2: .Feb 10 07:30:11.135:     lacp_ptx Hu2/0/28 - ptx: during state PERIODIC_TX, got event 4(short_timeout)

Feb 10 07:30:11 svl2 277579: svl2: .Feb 10 07:30:11.135: @@@ lacp_ptx Hu2/0/28 - ptx: PERIODIC_TX -> FAST_PERIODIC

Feb 10 07:30:11 svl2 277580: svl2: .Feb 10 07:30:11.135: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic entered

Feb 10 07:30:11 svl2 277581: svl2: .Feb 10 07:30:11.135: LACP: timer lacp_p_f(Hu2/0/28) started with interval 1000.

Feb 10 07:30:11 svl2 277582: svl2: .Feb 10 07:30:11.135: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:11 svl2 277583: svl2: .Feb 10 07:30:11.135:     lacp_mux Hu2/0/28 - mux: during state DETACHED, got event 6(outof_sync) (ignored)

Feb 10 07:30:11 svl2 277584: svl2: .Feb 10 07:30:11.136: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl2 277585: svl2: .Feb 10 07:30:11.136: LACP : packet size: 124

Feb 10 07:30:11 svl2 277586: svl2: .Feb 10 07:30:11.136: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl2 277587: svl2: .Feb 10 07:30:11.136: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl2 277588: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl2 277589: svl2: .Feb 10 07:30:11.136: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3,

Feb 10 07:30:11 svl2 277590: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl2 277591: svl2: .Feb 10 07:30:11.136: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl2 277592: svl2: .Feb 10 07:30:11.136: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl2 277593: svl2: .Feb 10 07:30:11.136: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:11 svl2 277594: svl2: .Feb 10 07:30:11.136:     lacp_rx Hu2/0/28 - rx: during state EXPIRED, got event 5(recv_lacpdu)

Feb 10 07:30:11 svl2 277595: svl2: .Feb 10 07:30:11.136: @@@ lacp_rx Hu2/0/28 - rx: EXPIRED -> CURRENT

Feb 10 07:30:11 svl2 277596: svl2: .Feb 10 07:30:11.136: LACP: Hu2/0/28 lacp_action_rx_expired_exit entered

Feb 10 07:30:11 svl2 277597: svl2: .Feb 10 07:30:11.136: LACP: lacp_c(Hu2/0/28) timer stopped

Feb 10 07:30:11 svl2 277598: svl2: .Feb 10 07:30:11.136: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:11 svl2 277599: svl2: .Feb 10 07:30:11.136: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl2 277600: svl2: .Feb 10 07:30:11.136: LACP:

Feb 10 07:30:11 svl2 277601: svl2: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:11 svl2 277602: svl2: .Feb 10 07:30:11.136: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl2 277603: svl2: .Feb 10 07:30:11.136: LACP : packet size: 124

Feb 10 07:30:11 svl2 277604: svl2: .Feb 10 07:30:11.136: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl2 277605: svl2: .Feb 10 07:30:11.136: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl2 277606: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl2 277607: svl2: .Feb 10 07:30:11.136: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x36,

Feb 10 07:30:11 svl2 277608: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl2 277609: svl2: .Feb 10 07:30:11.136: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl2 277610: svl2: .Feb 10 07:30:11.136: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl2 277611: svl2: .Feb 10 07:30:11.136: LACP:

Feb 10 07:30:11 svl2 277612: svl2: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:11 svl2 277613: svl2: .Feb 10 07:30:11.137: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 36

Feb 10 07:30:11 svl2 277614: svl2: .Feb 10 07:30:11.137: LACP: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:11 svl2 277615: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 Partners oper state is hex 87

Feb 10 07:30:11 svl2 277616: svl2: .Feb 10 07:30:11.137: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:11 svl2 277617: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:11 svl2 277618: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:11 svl2 277619: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 SELECTED aggregator hex address is 7F592CB45B10

Feb 10 07:30:11 svl2 277620: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 set to SELECTED

Feb 10 07:30:11 svl2 277621: svl2: .Feb 10 07:30:11.137:     lacp_mux Hu2/0/28 - mux: during state DETACHED, got event 1(selected)

Feb 10 07:30:11 svl2 277622: svl2: .Feb 10 07:30:11.137: @@@ lacp_mux Hu2/0/28 - mux: DETACHED -> WAITING

Feb 10 07:30:11 svl2 277623: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:11 svl2 277624: svl2: .Feb 10 07:30:11.137: LACP: timer lacp_w(Hu2/0/28) started with interval 2000.

Feb 10 07:30:11 svl2 277625: svl2: .Feb 10 07:30:11.137:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:11 svl2 277626: svl2: .Feb 10 07:30:11.137: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:11 svl2 277627: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:11 svl2 277628: svl2: .Feb 10 07:30:11.137: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl2 277629: svl2: .Feb 10 07:30:11.137: LACP : packet size: 124

Feb 10 07:30:11 svl2 277630: svl2: .Feb 10 07:30:11.137: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl2 277631: svl2: .Feb 10 07:30:11.137: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl2 277632: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl2 277633: svl2: .Feb 10 07:30:11.137: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3,

Feb 10 07:30:11 svl2 277634: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl2 277635: svl2: .Feb 10 07:30:11.137: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl2 277636: svl2: .Feb 10 07:30:11.137: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl2 277637: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:11 svl2 277638: svl2: .Feb 10 07:30:11.137:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:11 svl2 277639: svl2: .Feb 10 07:30:11.137: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:11 svl2 277640: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:11 svl2 277641: svl2: .Feb 10 07:30:11.137: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl2 277642: svl2: .Feb 10 07:30:11.137: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:11 svl2 277643: svl2: .Feb 10 07:30:11.137: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl2 277644: svl2: .Feb 10 07:30:11.137: LACP : packet size: 124

Feb 10 07:30:11 svl2 277645: svl2: .Feb 10 07:30:11.137: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl2 277646: svl2: .Feb 10 07:30:11.137: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl2 277647: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl2 277648: svl2: .Feb 10 07:30:11.137: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x87,

Feb 10 07:30:11 svl2 277649: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl2 277650: svl2: .Feb 10 07:30:11.137: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl2 277651: svl2: .Feb 10 07:30:11.137: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl2 277652: svl2: .Feb 10 07:30:11.137: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:11 svl2 277653: svl2: .Feb 10 07:30:11.137: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 87

Feb 10 07:30:11 svl2 277654: svl2: .Feb 10 07:30:11.137: LACP: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:11 svl2 277655: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 Partners oper state is hex 87

Feb 10 07:30:11 svl2 277656: svl2: .Feb 10 07:30:11.137: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:11 svl2 277657: svl2: .Feb 10 07:30:11.137: LACP:

Feb 10 07:30:11 svl2 277658: svl2: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:11 svl2 277659: svl2: .Feb 10 07:30:11.137: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:11 svl2 277660: svl2: .Feb 10 07:30:11.138:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:11 svl2 277661: svl2: .Feb 10 07:30:11.138: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:11 svl2 277662: svl2: .Feb 10 07:30:11.138: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:11 svl2 277663: svl2: .Feb 10 07:30:11.575: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl2 277664: svl2: .Feb 10 07:30:11.734: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:11 svl2 277665: svl2: .Feb 10 07:30:11.825: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl2 277666: svl2: .Feb 10 07:30:11.825: LACP : packet size: 124

Feb 10 07:30:11 svl2 277667: svl2: .Feb 10 07:30:11.825: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl2 277668: svl2: .Feb 10 07:30:11.825: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl2 277669: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl2 277670: svl2: .Feb 10 07:30:11.825: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl2 277671: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl2 277672: svl2: .Feb 10 07:30:11.825: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl2 277673: svl2: .Feb 10 07:30:11.825: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl2 277674: svl2: .Feb 10 07:30:11.825: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:11 svl2 277675: svl2: .Feb 10 07:30:11.825:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:11 svl2 277676: svl2: .Feb 10 07:30:11.825: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:11 svl2 277677: svl2: .Feb 10 07:30:11.825: LACP:

Feb 10 07:30:11 svl2 277678: svl2: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:11 svl2 277679: svl2: .Feb 10 07:30:11.825: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 87

Feb 10 07:30:11 svl2 277680: svl2: .Feb 10 07:30:11.825: LACP: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:11 svl2 277681: svl2: .Feb 10 07:30:11.826: LACP: Hu2/0/28 Partners oper state is hex 7

Feb 10 07:30:11 svl2 277682: svl2: .Feb 10 07:30:11.826: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:11 svl2 277683: svl2: .Feb 10 07:30:11.826: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:11 svl2 277684: svl2: .Feb 10 07:30:11.826: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:11 svl2 277685: svl2: .Feb 10 07:30:11.826:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:11 svl2 277686: svl2: .Feb 10 07:30:11.826: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:11 svl2 277687: svl2: .Feb 10 07:30:11.826: LACP:

Feb 10 07:30:11 svl2 277688: svl2: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:11 svl2 277689: svl2: .Feb 10 07:30:11.862: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:11 svl2 277690: svl2: .Feb 10 07:30:11.862: LACP : packet size: 124

Feb 10 07:30:11 svl2 277691: svl2: .Feb 10 07:30:11.862: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:11 svl2 277692: svl2: .Feb 10 07:30:11.862: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl2 277693: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:11 svl2 277694: svl2: .Feb 10 07:30:11.862: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:11 svl2 277695: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:11 svl2 277696: svl2: .Feb 10 07:30:11.862: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:11 svl2 277697: svl2: .Feb 10 07:30:11.862: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:11 svl2 277698: svl2: .Feb 10 07:30:11.862: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:11 svl2 277699: svl2: .Feb 10 07:30:11.862:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:11 svl2 277700: svl2: .Feb 10 07:30:11.862: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:11 svl2 277701: svl2: .Feb 10 07:30:11.862: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:11 svl2 277702: svl2: .Feb 10 07:30:11.862: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 7

Feb 10 07:30:11 svl2 277703: svl2: .Feb 10 07:30:11.862: LACP: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:11 svl2 277704: svl2: .Feb 10 07:30:11.862: LACP: Hu2/0/28 Partners oper state is hex 7

Feb 10 07:30:11 svl2 277705: svl2: .Feb 10 07:30:11.862: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:11 svl2 277706: svl2: .Feb 10 07:30:11.862: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:11 svl2 277707: svl2: .Feb 10 07:30:11.862: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:12 svl2 277708: svl2: .Feb 10 07:30:11.862:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:12 svl2 277709: svl2: .Feb 10 07:30:11.862: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:12 svl2 277710: svl2: .Feb 10 07:30:11.862: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:12 svl2 277711: svl2: .Feb 10 07:30:12.034: LACP: lacp_t(Hu2/0/28) timer stopped

Feb 10 07:30:12 svl2 277712: svl2: .Feb 10 07:30:12.034: LACP: lacp_t(Hu2/0/28) expired

Feb 10 07:30:12 svl2 277713: svl2: .Feb 10 07:30:12.117: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:12 svl2 277714: svl2: .Feb 10 07:30:12.117: LACP: lacp_p(Hu2/0/28) expired

Feb 10 07:30:12 svl2 277715: svl2: .Feb 10 07:30:12.117:     lacp_ptx Hu2/0/28 - ptx: during state FAST_PERIODIC, got event 3(pt_expired)

Feb 10 07:30:12 svl2 277716: svl2: .Feb 10 07:30:12.117: @@@ lacp_ptx Hu2/0/28 - ptx: FAST_PERIODIC -> PERIODIC_TX

Feb 10 07:30:12 svl2 277717: svl2: .Feb 10 07:30:12.117: LACP:

Feb 10 07:30:12 svl2 277718: svl2: Hu2/0/28 lacp_action_ptx_fast_periodic_exit entered

Feb 10 07:30:12 svl2 277719: svl2: .Feb 10 07:30:12.117: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:12 svl2 277720: svl2: .Feb 10 07:30:12.117: LACP: Hu2/0/28 lacp_action_ptx_periodic_tx entered

Feb 10 07:30:12 svl2 277721: svl2: .Feb 10 07:30:12.117: LACP: timer lacp_t(Hu2/0/28) started with interval 1000.

Feb 10 07:30:12 svl2 277722: svl2: .Feb 10 07:30:12.117: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:12 svl2 277723: svl2: .Feb 10 07:30:12.117: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:12 svl2 277724: svl2: .Feb 10 07:30:12.117: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:12 svl2 277725: svl2: .Feb 10 07:30:12.117: LACP : packet size: 124

Feb 10 07:30:12 svl2 277726: svl2: .Feb 10 07:30:12.117: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:12 svl2 277727: svl2: .Feb 10 07:30:12.118: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl2 277728: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:12 svl2 277729: svl2: .Feb 10 07:30:12.118: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl2 277730: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:12 svl2 277731: svl2: .Feb 10 07:30:12.118: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:12 svl2 277732: svl2: .Feb 10 07:30:12.118: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:12 svl2 277733: svl2: .Feb 10 07:30:12.118: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:12 svl2 277734: svl2: .Feb 10 07:30:12.118:     lacp_ptx Hu2/0/28 - ptx: during state PERIODIC_TX, got event 4(short_timeout)

Feb 10 07:30:12 svl2 277735: svl2: .Feb 10 07:30:12.118: @@@ lacp_ptx Hu2/0/28 - ptx: PERIODIC_TX -> FAST_PERIODIC

Feb 10 07:30:12 svl2 277736: svl2: .Feb 10 07:30:12.118: LACP:

Feb 10 07:30:12 svl2 277737: svl2: Hu2/0/28 lacp_action_ptx_fast_periodic entered

Feb 10 07:30:12 svl2 277738: svl2: .Feb 10 07:30:12.118: LACP: timer lacp_p_f(Hu2/0/28) started with interval 1000.

Feb 10 07:30:12 svl2 277739: svl2: .Feb 10 07:30:12.550: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:12 svl2 277740: svl2: .Feb 10 07:30:12.721: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:12 svl2 277741: svl2: .Feb 10 07:30:12.851: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:12 svl2 277742: svl2: .Feb 10 07:30:12.851: LACP : packet size: 124

Feb 10 07:30:12 svl2 277743: svl2: .Feb 10 07:30:12.851: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:12 svl2 277744: svl2: .Feb 10 07:30:12.851: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl2 277745: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:12 svl2 277746: svl2: .Feb 10 07:30:12.851: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl2 277747: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:12 svl2 277748: svl2: .Feb 10 07:30:12.851: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:12 svl2 277749: svl2: .Feb 10 07:30:12.851: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:12 svl2 277750: svl2: .Feb 10 07:30:12.851: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:12 svl2 277751: svl2: .Feb 10 07:30:12.851:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:12 svl2 277752: svl2: .Feb 10 07:30:12.851: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:12 svl2 277753: svl2: .Feb 10 07:30:12.851: LACP: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:12 svl2 277754: svl2: .Feb 10 07:30:12.851: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 7

Feb 10 07:30:12 svl2 277755: svl2: .Feb 10 07:30:12.851: LACP: recordPDU Hu2/0/28 Partner out of sync

Feb 10 07:30:12 svl2 277756: svl2: .Feb 10 07:30:12.851: LACP: Hu2/0/28 Partners oper state is hex 7

Feb 10 07:30:12 svl2 277757: svl2: .Feb 10 07:30:12.851: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:12 svl2 277758: svl2: .Feb 10 07:30:12.851: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:12 svl2 277759: svl2: .Feb 10 07:30:12.851: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:12 svl2 277760: svl2: .Feb 10 07:30:12.851:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 6(outof_sync)

Feb 10 07:30:12 svl2 277761: svl2: .Feb 10 07:30:12.851: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> WAITING

Feb 10 07:30:12 svl2 277762: svl2: .Feb 10 07:30:12.851: LACP: Hu2/0/28 lacp_action_mx_waiting entered

Feb 10 07:30:12 svl2 277763: svl2: .Feb 10 07:30:12.897: LACP: lacp_w(Hu2/0/28) timer stopped

Feb 10 07:30:12 svl2 277764: svl2: .Feb 10 07:30:12.897: LACP: lacp_w(Hu2/0/28) expired

Feb 10 07:30:12 svl2 277765: svl2: .Feb 10 07:30:12.897:     lacp_mux Hu2/0/28 - mux: during state WAITING, got event 4(ready)

Feb 10 07:30:12 svl2 277766: svl2: .Feb 10 07:30:12.897: @@@ lacp_mux Hu2/0/28 - mux: WAITING -> ATTACHED

Feb 10 07:30:12 svl2 277767: svl2: .Feb 10 07:30:12.897: LACP: Hu2/0/28 lacp_action_mx_attached entered

Feb 10 07:30:12 svl2 277768: svl2: .Feb 10 07:30:12.897: LACP: Hu2/0/28 Attaching mux to aggregator

Feb 10 07:30:12 svl2 277769: svl2: .Feb 10 07:30:12.897: LACP: Hu2/0/28 Attach_Mux_To_Aggregator skipping adding the member to channel-group

Feb 10 07:30:12 svl2 277770: svl2: .Feb 10 07:30:12.898: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:12 svl2 277771: svl2: .Feb 10 07:30:12.898: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:12 svl2 277772: svl2: .Feb 10 07:30:12.898: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:12 svl2 277773: svl2: .Feb 10 07:30:12.898: LACP : packet size: 124

Feb 10 07:30:12 svl2 277774: svl2: .Feb 10 07:30:12.898: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:12 svl2 277775: svl2: .Feb 10 07:30:12.898: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:12 svl2 277776: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:12 svl2 277777: svl2: .Feb 10 07:30:12.898: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl2 277778: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:12 svl2 277779: svl2: .Feb 10 07:30:12.898: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:12 svl2 277780: svl2: .Feb 10 07:30:12.898: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:12 svl2 277781: svl2: .Feb 10 07:30:12.898: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:12 svl2 277782: svl2: .Feb 10 07:30:12.898: lacp_handle_standby_port_internal called, depth = 1

Feb 10 07:30:12 svl2 277783: svl2: .Feb 10 07:30:12.898: LACP:

Feb 10 07:30:12 svl2 277784: svl2: lacp_handle_standby_port_internal: No Standby port found for LAG 1

Feb 10 07:30:12 svl2 277785: svl2: .Feb 10 07:30:12.998: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:12 svl2 277786: svl2: .Feb 10 07:30:12.998: LACP: lacp_p(Hu2/0/28) expired

Feb 10 07:30:12 svl2 277787: svl2: .Feb 10 07:30:12.998:     lacp_ptx Hu2/0/28 - ptx: during state FAST_PERIODIC, got event 3(pt_expired)

Feb 10 07:30:12 svl2 277788: svl2: .Feb 10 07:30:12.998: @@@ lacp_ptx Hu2/0/28 - ptx: FAST_PERIODIC -> PERIODIC_TX

Feb 10 07:30:12 svl2 277789: svl2: .Feb 10 07:30:12.998: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic_exit entered

Feb 10 07:30:12 svl2 277790: svl2: .Feb 10 07:30:12.998: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:12 svl2 277791: svl2: .Feb 10 07:30:12.998: LACP: Hu2/0/28 lacp_action_ptx_periodic_tx entered

Feb 10 07:30:12 svl2 277792: svl2: .Feb 10 07:30:12.998: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:12 svl2 277793: svl2: .Feb 10 07:30:12.998: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:12 svl2 277794: svl2: .Feb 10 07:30:12.998: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:12 svl2 277795: svl2: .Feb 10 07:30:12.998: LACP : packet size: 124

Feb 10 07:30:12 svl2 277796: svl2: .Feb 10 07:30:12.998: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:12 svl2 277797: svl2: .Feb 10 07:30:12.998: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:12 svl2 277798: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:12 svl2 277799: svl2: .Feb 10 07:30:12.998: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x7,

Feb 10 07:30:12 svl2 277800: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:12 svl2 277801: svl2: .Feb 10 07:30:12.998: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:12 svl2 277802: svl2: .Feb 10 07:30:12.998: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:13 svl2 277803: svl2: .Feb 10 07:30:12.998: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:13 svl2 277804: svl2: .Feb 10 07:30:12.998:     lacp_ptx Hu2/0/28 - ptx: during state PERIODIC_TX, got event 4(short_timeout)

Feb 10 07:30:13 svl2 277805: svl2: .Feb 10 07:30:12.998: @@@ lacp_ptx Hu2/0/28 - ptx: PERIODIC_TX -> FAST_PERIODIC

Feb 10 07:30:13 svl2 277806: svl2: .Feb 10 07:30:12.998: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic entered

Feb 10 07:30:13 svl2 277807: svl2: .Feb 10 07:30:12.998: LACP: timer lacp_p_f(Hu2/0/28) started with interval 1000.

Feb 10 07:30:13 svl2 277808: svl2: .Feb 10 07:30:13.033: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:13 svl2 277809: svl2: .Feb 10 07:30:13.033: LACP : packet size: 124

Feb 10 07:30:13 svl2 277810: svl2: .Feb 10 07:30:13.033: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:13 svl2 277811: svl2: .Feb 10 07:30:13.033: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:13 svl2 277812: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:13 svl2 277813: svl2: .Feb 10 07:30:13.033: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:13 svl2 277814: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:13 svl2 277815: svl2: .Feb 10 07:30:13.033: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:13 svl2 277816: svl2: .Feb 10 07:30:13.033: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:13 svl2 277817: svl2: .Feb 10 07:30:13.033: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:13 svl2 277818: svl2: .Feb 10 07:30:13.033:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:13 svl2 277819: svl2: .Feb 10 07:30:13.033: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:13 svl2 277820: svl2: .Feb 10 07:30:13.033: LACP:

Feb 10 07:30:13 svl2 277821: svl2: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:13 svl2 277822: svl2: .Feb 10 07:30:13.033: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex 7

Feb 10 07:30:13 svl2 277823: svl2: .Feb 10 07:30:13.033: LACP: recordPDU Hu2/0/28 Partner in sync and aggregating

Feb 10 07:30:13 svl2 277824: svl2: .Feb 10 07:30:13.033: LACP: Hu2/0/28 Partners oper state is hex F

Feb 10 07:30:13 svl2 277825: svl2: .Feb 10 07:30:13.033: LACP: timer lacp_c_s(Hu2/0/28) started with interval 3000.

Feb 10 07:30:13 svl2 277826: svl2: .Feb 10 07:30:13.033: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:13 svl2 277827: svl2: .Feb 10 07:30:13.033: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:13 svl2 277828: svl2: .Feb 10 07:30:13.033:     lacp_mux Hu2/0/28 - mux: during state ATTACHED, got event 5(in_sync)

Feb 10 07:30:13 svl2 277829: svl2: .Feb 10 07:30:13.033: @@@ lacp_mux Hu2/0/28 - mux: ATTACHED -> COLLECTING_DISTRIBUTING

Feb 10 07:30:13 svl2 277830: svl2: .Feb 10 07:30:13.033: LACP:

Feb 10 07:30:13 svl2 277831: svl2: Hu2/0/28 lacp_action_mx_collecting_distributing entered

Feb 10 07:30:13 svl2 277832: svl2: .Feb 10 07:30:13.033: LACP: Hu2/0/28 Enabling collecting and distributing

Feb 10 07:30:13 svl2 277833: svl2: .Feb 10 07:30:13.043: LACP: Hu2/0/28 request far-end rate goes long

Feb 10 07:30:13 svl2 277834: svl2: .Feb 10 07:30:13.043: LACP: timer lacp_c_l(Hu2/0/28) started with interval 90000.

Feb 10 07:30:13 svl2 277835: svl2: .Feb 10 07:30:13.043: LACP: HA: Syncing LACP IDB HundredGigE2/0/28

Feb 10 07:30:13 svl2 277836: svl2: .Feb 10 07:30:13.043: LACP: HA: Sync LACPIDBs

Feb 10 07:30:13 svl2 277837: svl2: .Feb 10 07:30:13.043: LACP: HA ISSU: xmit xform

Feb 10 07:30:13 svl2 277838: svl2: .Feb 10 07:30:13.043: LACP :lacp_bugpak: Receive LACP-PDU packet via Hu2/0/28

Feb 10 07:30:13 svl2 277839: svl2: .Feb 10 07:30:13.043: LACP : packet size: 124

Feb 10 07:30:13 svl2 277840: svl2: .Feb 10 07:30:13.043: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:13 svl2 277841: svl2: .Feb 10 07:30:13.043: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:13 svl2 277842: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:13 svl2 277843: svl2: .Feb 10 07:30:13.043: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0xF,

Feb 10 07:30:13 svl2 277844: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:13 svl2 277845: svl2: .Feb 10 07:30:13.043: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:13 svl2 277846: svl2: .Feb 10 07:30:13.043: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:13 svl2 277847: svl2: .Feb 10 07:30:13.043: LACP: Hu2/0/28 LACP packet received, processing

Feb 10 07:30:13 svl2 277848: svl2: .Feb 10 07:30:13.043:     lacp_rx Hu2/0/28 - rx: during state CURRENT, got event 5(recv_lacpdu)

Feb 10 07:30:13 svl2 277849: svl2: .Feb 10 07:30:13.043: @@@ lacp_rx Hu2/0/28 - rx: CURRENT -> CURRENT

Feb 10 07:30:13 svl2 277850: svl2: .Feb 10 07:30:13.043: LACP:

Feb 10 07:30:13 svl2 277851: svl2: Hu2/0/28 lacp_action_rx_current entered

Feb 10 07:30:13 svl2 277852: svl2: .Feb 10 07:30:13.043: LACP: recordPDU Hu2/0/28 LACP PDU Rcvd. Partners oper state is hex F

Feb 10 07:30:13 svl2 277853: svl2: .Feb 10 07:30:13.043: LACP: Hu2/0/28 partner timeout mode changed to 0

Feb 10 07:30:13 svl2 277854: svl2: .Feb 10 07:30:13.043:     lacp_ptx Hu2/0/28 - ptx: during state FAST_PERIODIC, got event 2(long_timeout)

Feb 10 07:30:13 svl2 277855: svl2: .Feb 10 07:30:13.043: @@@ lacp_ptx Hu2/0/28 - ptx: FAST_PERIODIC -> SLOW_PERIODIC

Feb 10 07:30:13 svl2 277856: svl2: .Feb 10 07:30:13.043: LACP: Hu2/0/28 lacp_action_ptx_fast_periodic_exit entered

Feb 10 07:30:13 svl2 277857: svl2: .Feb 10 07:30:13.043: LACP: lacp_p(Hu2/0/28) timer stopped

Feb 10 07:30:13 svl2 277858: svl2: .Feb 10 07:30:13.043: LACP: Hu2/0/28 lacp_action_ptx_slow_periodic entered

Feb 10 07:30:13 svl2 277859: svl2: .Feb 10 07:30:13.043: LACP:

Feb 10 07:30:13 svl2 277860: svl2: timer lacp_p_s(Hu2/0/28) started with interval 30000.

Feb 10 07:30:13 svl2 277861: svl2: .Feb 10 07:30:13.043: LACP: recordPDU Hu2/0/28 Partner in sync and aggregating

Feb 10 07:30:13 svl2 277862: svl2: .Feb 10 07:30:13.043: LACP: Hu2/0/28 Partners oper state is hex 3D

Feb 10 07:30:13 svl2 277863: svl2: .Feb 10 07:30:13.043: LACP: timer lacp_c_l(Hu2/0/28) started with interval 90000.

Feb 10 07:30:13 svl2 277864: svl2: .Feb 10 07:30:13.043: LACP: Hu2/0/28 LAG_PARTNER_UP.

Feb 10 07:30:13 svl2 277865: svl2: .Feb 10 07:30:13.043: LACP: Hu2/0/28 LAG unchanged

Feb 10 07:30:13 svl2 277866: svl2: .Feb 10 07:30:13.043:     lacp_mux Hu2/0/28 - mux: during state COLLECTING_DISTRIBUTING, got event 5(in_sync) (ignored)

Feb 10 07:30:13 svl2 277867: svl2: .Feb 10 07:30:13.107: LACP: lacp_t(Hu2/0/28) timer stopped

Feb 10 07:30:13 svl2 277868: svl2: .Feb 10 07:30:13.107: LACP: lacp_t(Hu2/0/28) expired

Feb 10 07:30:13 svl2 277869: svl2: .Feb 10 07:30:13.107: LACP:

Feb 10 07:30:13 svl2 277870: svl2: timer lacp_t(Hu2/0/28) started with interval 1000.

Feb 10 07:30:13 svl2 277871: svl2: .Feb 10 07:30:13.107: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:13 svl2 277872: svl2: .Feb 10 07:30:13.107: LACP: lacp_send_lacpdu: (Hu2/0/28) About to send the 110 LACPDU

Feb 10 07:30:13 svl2 277873: svl2: .Feb 10 07:30:13.107: LACP :lacp_bugpak: Send LACP-PDU packet via Hu2/0/28

Feb 10 07:30:13 svl2 277874: svl2: .Feb 10 07:30:13.107: LACP : packet size: 124

Feb 10 07:30:13 svl2 277875: svl2: .Feb 10 07:30:13.107: LACP: pdu: subtype: 1, version: 1

Feb 10 07:30:13 svl2 277876: svl2: .Feb 10 07:30:13.107: LACP: Act: tlv:1, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:13 svl2 277877: svl2: s-pri:0x8000, s-mac:3c8b.7f57.30e0

Feb 10 07:30:13 svl2 277878: svl2: .Feb 10 07:30:13.107: LACP: Part: tlv:2, tlv-len:20, key:0x1, p-pri:0x8000, p:0x51D, p-state:0x3D,

Feb 10 07:30:13 svl2 277879: svl2: s-pri:0x8000, s-mac:3c8b.7f57.b2e0

Feb 10 07:30:14 svl2 277880: svl2: .Feb 10 07:30:13.107: LACP: col-tlv:3, col-tlv-len:16, col-max-d:0x8000

Feb 10 07:30:14 svl2 277881: svl2: .Feb 10 07:30:13.107: LACP: term-tlv:0 termr-tlv-len:0

Feb 10 07:30:14 svl2 277882: svl2: .Feb 10 07:30:13.107: LACP: lacp_write: LACP 124 bytes out Hu2/0/28

Feb 10 07:30:14 svl2 277883: svl2: .Feb 10 07:30:13.250: LACP: CF: sync successfully completed

Feb 10 07:30:14 svl2 277884: svl2: .Feb 10 07:30:13.446: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:14 svl2 277885: svl2: .Feb 10 07:30:13.591: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:14 svl2 277886: svl2: .Feb 10 07:30:14.003: LACP: lacp_t(Hu2/0/28) timer stopped

Feb 10 07:30:14 svl2 277887: svl2: .Feb 10 07:30:14.003: LACP: lacp_t(Hu2/0/28) expired

Feb 10 07:30:14 svl2 277888: svl2: .Feb 10 07:30:14.043: %LINEPROTO-5-UPDOWN: Line protocol on Interface HundredGigE2/0/28, changed state to up

Feb 10 07:30:14 svl2 277889: svl2: .Feb 10 07:30:14.440: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:14 svl2 277890: svl2: .Feb 10 07:30:14.533: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:15 svl2 277891: svl2: .Feb 10 07:30:15.035: %LINK-3-UPDOWN: Interface Port-channel1, changed state to up

Feb 10 07:30:15 svl2 277892: svl2: .Feb 10 07:30:15.340: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:15 svl2 277893: svl2: .Feb 10 07:30:15.484: LACP: lacp_insert_partner_cd_inhibitor: didn't change sync flag.

Feb 10 07:30:16 svl2 277894: svl2: .Feb 10 07:30:16.035: %LINEPROTO-5-UPDOWN: Line protocol on Interface Port-channel1, changed state to up

I added logoutput from the last time the port-channel gone up to down and again up.

Can anyone of you see the problem? Maybe enable debugging of some other parts?

[marce1000]

 - How is the port channel configured  (at both ends) ? What LACP modes are being used ? Are they different or the same at both ends ? Further look into : https://www.cisco.com/c/en/us/support/docs/switches/catalyst-9300-series-switches/220367-troubleshoot-etherchannels-on-catalyst-9.html
               Also checkout : # show etherchannel summary

 M.

[seb1303]

Config on both sides is:

Spoiler

interface Port-channel1

 switchport mode trunk

end

interface HundredGigE1/0/28

 switchport mode trunk

 channel-group 1 mode active

end

interface HundredGigE2/0/28

 switchport mode trunk

 channel-group 1 mode active

end

#show etherchannel 1 summary

Flags:  D - down        P - bundled in port-channel

        I - stand-alone s - suspended

        H - Hot-standby (LACP only)

        R - Layer3      S - Layer2

        U - in use      f - failed to allocate aggregator

        M - not in use, minimum links not met

        u - unsuitable for bundling

        w - waiting to be aggregated

        d - default port

        A - formed by Auto LAG

Number of channel-groups in use: 3

Number of aggregators:           3

Group  Port-channel  Protocol    Ports

------+-------------+-----------+-----------------------------------------------

1      Po1(SD)         LACP        Hu1/0/28(D)     Hu2/0/28(D)

[balaji.bandi]

You had some thread before : (you mentioned and resolved due to Fibre ? ) - is this extension of the problem ?

https://community.cisco.com/t5/switching/vlan-trunk-interface-goes-down-after-seconds/td-p/5001779

[seb1303]

Yes, I think so. But it looked good - I thought the problem was solved. The connection seemed stable. Traffic was passing the port-channel for 4-5 days without measurable problems. After those 4-5 days the port-channel was completely down. And the logfile flooded with those up/down messages.

[Georg Pauwen]

Hello,

try avoiding PAgP or LACP altogether. This might not be best practice, but it could result in a stable link:

> channel-group 1 mode on

[seb1303]

So I tried the above setting but without luck. The port-channel goes still up and down. 

[balaji.bandi]

This looks for me again layer 2 issue - so investigate on that first.

until unless this is bug - not that i am aware of any ?

[seb1303]

Do you mean the cabling or transceivers?

[Leo Laohoo]

Turn off the 2nd physical link.  Is the EtherChannel stable?

[seb1303]

Tried this but the problem persists...

[Leo Laohoo]

Upgrade the firmware to the latest 17.3.X train or go up to 17.9.5.

[seb1303]

Just updated to the latest by Cisco suggestes release 17.9.4a. But the problem is still there

[Leo Laohoo]

What sort of optics (speed and wavelength) are used on Hu1/0/28 & Hu2/0/28? 

[balaji.bandi]

Cable again - if you have any Bert meters to test.

if all Physicals ok, suggest to raise an TAC case also will be helpful to debug for you.