ASR 5000 / 5500 Series Solução de problemas relacionados a portas/NPU
Contents
Introduction
Este artigo apresenta ideias sobre como solucionar vários problemas relacionados à porta plataformas ASR 5000 e 5500, incluindo problemas relacionados à NPU (Network Processing Unit, Unidade de processamento de rede), e também aborda um pouco os problemas da LAG (Link Aggregation, Agregação de links). Essas técnicas não são ciência de foguetes e, na verdade, são mais conhecidas por engenheiros, mas muitas vezes uma ou mais podem ser ignoradas no processo de solução de problemas simplesmente devido à supervisão na corrida através das etapas para uma possível resolução. O artigo começa com as verificações de integridade relacionadas a portas. Então ele apresenta todas as abordagens em algum tipo de ordem metódica. Por fim, ele oferece uma série de exemplos reais que vão além da solução básica de problemas de porta para aqueles que desejam detalhar.
Comandos para Troubleshooting
show snmp trap history
Procure os padrões de PortLinkUp e PortLinkDown. Considere:
- a frequência com que ocorre e em que período
- várias portas ou apenas uma porta ou algum outro padrão
- trabalhos de manutenção que os técnicos podem ou não ter conhecimento
show port table all
- indica se os links estão ativos ou inativos
- Link Aggregation (LAG) - confirme se as portas estão no estado correto, seja + (distribuindo/ativando) ou ~ (acordado/standby). Outros estados * ou - necessitam de ser investigados.
show port info
- várias informações, como estado do link, modo da porta, configurações de porta, configurações de agregação de link (LAG), módulo SFP etc.
show card diag
- informações básicas de diagnóstico, geralmente não tão úteis
show rct stats [verbose]
- rastreia todas as atividades PSC/DPC/SMC/MIO (switchovers, migrações, desligamentos, etc.) desde a inicialização
show port usage table
- é o throughput esperado para a hora do dia
- As portas ECMP (Equal Cost Multi Path) e LAG devem transmitir de forma bastante uniforme
- A largura de banda Rx está sob controle da outra extremidade
show logical-port usage table
- divide a utilização da porta por ID da VLAN
- se os números forem pequenos comparados à tabela de utilização de porta, isso implica que os pacotes não chegam à NPU da porta
show port datalink counters <slot/port>
- relata contagens de pacotes nas próprias portas físicas
- verifique os vários contadores de falha para ver se há algum aumento e a que taxa
-Importante: esse é um desses poucos comandos coletados TWICE em um SSD, que pode ser muito valioso para o Troubleshooting de aumentos na contagem de pacotes em um período relativamente curto
show port npu counters <slot/port> [vlan <vlan>]
- todas as portas estão conectadas ao resto do sistema através da NPU (Network Processor Unit, Unidade de Processador de Rede), localizada na Placa de Serviços de Pacotes (PSC, ASR 5000) conectada (quer a PSC esteja diretamente conectada ou mapeada através da RCC (Redundancy Crossbar Cards, Placas de Barra de Redundância) ou na MIO (Management Input - MIO)) (ASR 55555555550500000000) na qual a porta também está localizada na porta.
- verifique os vários contadores de falha para ver se há algum aumento e a que taxa
- para a implementação de LAG, os contadores são relatados para a porta mestre que captura os totais em todas as portas do grupo LAG, e portanto não há como saber qual porta está causando as falhas. Nesse caso, para o ASR 5000, "show port npu stats debug all_pacs" relata contagens de falhas no nível PSC #, o que, esperamos, ajude a apontar para a placa culpada.
- Problemas foram observados quando o aumento nos contadores de falhas desse comando são causados por falhas na placa de linha, onde "show port datalink counters" não mostra o problema.
- nem todos os problemas de NPU são capturados com esse comando. Há outros comandos de suporte técnico somente NPU (por exemplo, show npu stats debug all_pacs, show npu stats sf all_pacs, etc.) que capturam problemas de descarte de pacotes que não são abordados aqui.
-Importante: esse é um desses poucos comandos coletados TWICE em um SSD, que pode ser muito valioso para o Troubleshooting de aumentos na contagem de pacotes em um período relativamente curto
show logs
- procure entradas relacionadas às portas, incluindo instalação npu, npuctrl, etc.
show port transceiver (somente ASR 5500)
- procurar níveis de luz consistentes em todas as portas
Ações de correção
Entre cada uma das etapas a seguir, verifique a saída dos comandos acima, conforme aplicável, para detectar qualquer melhoria e/ou alteração no comportamento. Se o problema for esporádico, pode ser necessário um período de espera apropriado antes de declarar o sucesso/falha.
Não se trata de uma lista rápida e difícil que precisa ser executada na ordem ou até mesmo completamente. Há muitas variáveis que desempenham um papel na solução de problemas desse tipo e, portanto, esse é um guia para que, no mínimo, o solucionador tenha acesso a todas as opções em potencial. Aqueles com muitos anos de experiência provavelmente estão familiarizados com algumas dessas abordagens à medida que se aplicam a outras plataformas, mas uma lista de verificação de lembrete é sempre uma boa ideia, e aqueles que não conhecem a plataforma podem não estar familiarizados com algumas das abordagens e/ou comandos específicos da plataforma disponíveis.
Lembre-se: cada cenário é diferente e as etapas de solução de problemas revelarão novas informações que ditarão as etapas futuras que serão diferentes entre os cenários. Isto é apenas um guia.
As etapas consideradas e o pedido realizado variam de acordo com a gravidade do problema, o possível impacto no assinante e o sentimento do cliente.
Comutação para a porta redundante ou LAG
- Precisa considerar o fato de que a porta que está enfrentando problemas está lidando com o tráfego OU não está lidando com o tráfego
- ASR5000: agora, as placas de linha de tamanho completo estão conectadas a uma PSC (NPU) diferente, enquanto a placa de linha de tamanho médio continuará conectada à mesma PSC
- a comutação não altera nenhum cabeamento, e, portanto, mais provável que isso não faça diferença em um cenário de devolução de porta, mas, no mínimo, se o problema estivesse na porta ativa, o impacto será minimizado, pois agora é uma porta em standby
Troque as conexões dos cabos por uma porta redundante
- dependendo do cabo puxado primeiro, a porta ativa final pode ser qualquer porta, portanto a porta pode precisar ser comutada de volta para voltar ao layout inicial
- se o problema persistir na porta com problema, observe mais atentamente essa porta no ASR
- se o problema mudar para a outra porta, observe mais atentamente a conexão dessa porta na extremidade oposta
Fibras limpas
- se a porta que está sendo limpa estiver ativa, então ela precisa ser mudada de volta para depois da limpeza
- a limpeza de fibras tem sido definitivamente uma atividade que resolve problemas com frequência
Substitua os elementos no caminho, incluindo cabo Ethernet/fibra/patch panel/interconexões/torneiras
- se a porta que está sendo limpa estiver ativa, ela precisará ser comutada de volta para depois da limpeza
- pode ser surpreendente descobrir com que frequência essa etapa resolve problemas
Substituição SFP (Small Form-Fator Pluggable) em ambos os lados da conexão
- os SFPs podem ser solicitados separadamente
- Verificar SFPs não utilizados para fins de teste
—
Apenas ASR 5000:
Reinicialização da placa de linha
Placa de linha recolocada
- Recolocar realizará um superconjunto de reinicialização e será mais intrusivo e vale a pena tentar
migração de PSC
- O PSC conectado à placa de linha que hospeda a porta com problema (mostrar mapeamentos de cartão / mostrar tabela de cartão tudo)
Reinicialização de PSC
PSC novamente
- A migração para a PSC resultará na reinicialização da PSC, mas não é equivalente a uma reinicialização
- Da mesma forma, uma reinicialização de PSC é mais invasiva do que uma reinicialização de PSC
- Uma reinstalação de PSC realizará uma reinicialização de superconjunto de PSC em uma etapa
- Em todos os aspectos acima referidos, se a questão for resolvida, seria necessário proceder novamente a uma migração para tornar o CPS ativo, a fim de confirmar se a questão está totalmente resolvida (partindo do princípio de que a atividade do CPS resolveu o problema do porto). Observe que, dependendo do layout da placa e da configuração da placa inicial (isto é, a Placa de Linha está com o problema fisicamente por trás da PSC conectada?, etc.), mudar a PSC de volta para ativa pode ou não resultar no mesmo mapeamento da Placa de Linha PSC <-> como acontecia antes da atividade.
switchover de placa de gerenciamento do sistema (SMC)
Reinicialização do SMC
Recolocar o SMC
Apenas ASR 5500:
switchover MIO
- isso é diferente de apenas uma porta ou um switchover de LAG. Todas as portas ativas no MIO que está sendo comutado se tornarão em espera. Se a porta com problema já estiver ativa no modo de espera MIO, o switchover de MIO não altera o status da porta, mas ainda é uma etapa válida
—
Recarga do chassi
- embora improvável, é sempre possível que exista algum tipo de anomalia que só possa ser resolvida com uma recarga
Substituição de hardware no switch adjacente
Substituição de hardware em ASR 5x00 (PSC, LC, MIO, SMC ou RCC)
Referência de comando das etapas de correção:
migração de placa de <x> para <y> - migração de PSC/DPC
- Enquanto levantar a alavanca for outra maneira, não faça isso E depois puxe a placa ou o cartão para desligar
switch de placa de <x> para <y> - switchover SMC/MIO/LC/RCC
port switch to <x> - non-LAG port switchover
switch de porta de agregação de link para <x> - switchover de LAG
- X deve ser a porta do LAG mestre ou o par do mestre dependendo da direção
placa de reinicialização X
- a reinicialização da placa é outra opção, mas a reinicialização é recomendada
Exemplo de cenários de solução de problemas
O nó de recuperação de sessão entre chassis (ICSR - Inter Chassis Session Recovery) PGW em standby está recebendo um alto volume de tráfego da Juniper MX-960
Este exemplo mostra as portas de LAG ativas que recebem tráfego significativo, mesmo que o chassi seja o Service Redundancy Protocol (SRP) Standby, caso em que o throughput deve ser quase nulo. O valor dos dois comandos a seguir usados em conjunto é que as portas estão mostrando tráfego significativo sendo recebido, mas a NPU não está mostrando tráfego. Isso implica que o tráfego está sendo descartado antes de alcançar a NPU, possivelmente mesmo nas próprias portas. Os "show port datalink counters" e "show port npu counters" corrigem isso, pois os contadores NPU dificilmente aumentam enquanto os contadores de datalink estão aumentando rapidamente.
[local]PGW-ICSR> show port utilization table
Sunday July 26 00:13:32 UTC 2015
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
5/1 1000 Ethernet 0 0 0 0 0 0
5/10 10G Ethernet 0 0 0 0 0 0
5/11 10G Ethernet 0 0 0 0 0 0
5/15 10G Ethernet 0 0 0 0 0 0
5/16 10G Ethernet 0 0 0 0 0 0
5/28 10G Ethernet 105 13 105 13 105 13
5/29 10G Ethernet 0 0 0 0 0 0
6/1 1000 Ethernet 0 0 0 0 0 0
6/10 10G Ethernet 4214 0 4121 0 3993 0
6/11 10G Ethernet 4089 0 4103 0 3995 0
6/15 10G Ethernet 4166 0 4172 0 3996 0
6/16 10G Ethernet 4163 0 4174 0 3997 0
6/28 10G Ethernet 0 0 0 0 0 0
6/29 10G Ethernet 1 0 1 0 1 0
[local]PGW-ICSR> show logical-port utilization table
Sunday July 26 00:13:45 UTC 2015
------ Average Port Utilization (in mbps) ------
Slot/Port vlan Current 5min 15min
Rx Tx Rx Tx Rx Tx
-------------- -------- -------- -------- -------- -------- --------
5/10 2427 0 0 0 0 0 0
5/10 2407 0 0 0 0 0 0
5/10 2011 0 0 0 0 0 0
5/10 2405 0 0 0 0 0 0
5/10 2015 0 0 0 0 0 0
5/10 2455 0 0 0 0 0 0
6/10 2427 0 0 0 0 0 0
6/10 2407 0 0 0 0 0 0
6/10 2011 0 0 0 0 0 0
6/10 2405 0 0 0 0 0 0
6/10 2015 0 0 0 0 0 0
6/10 2455 0 0 0 0 0 0
6/29 31 0 0 0 0 0 0
[local]PGW-ICSR> clear port npu counters all
Saturday July 25 01:44:38 UTC 2015
[local]PGW-ICSR> clear port data count all
Saturday July 25 01:44:43 UTC 2015
[local]PGW-ICSR> show port data counters 6/10
Saturday July 25 01:45:30 UTC 2015
rt npu counteCounters for port 6/10:
Line Card 10 Gigabit Ethernet Port
Rx Counter Data | Tx Counter Data
----------------------- -------------- + ----------------------- -------------
RX Bytes 20310895783 | TX Bytes 9746
RX Unicast frames 25564965 | TX Unicast frames 41
RX Multicast frames 85 | TX Multicast frames 48
RX Broadcast frames 0 | TX Broadcast frames 0
RX Size 64 frames 338598 | TX Size 64 frames 9
RX Size 65 .. 127 fr 6881254 | TX Size 65 .. 127 fr 32
RX Size 128 .. 255 fr 4151284 | TX Size 128 .. 255 fr 48
RX Size 256 .. 511 fr 761933 | TX Size 256 .. 511 fr 0
RX Size 512 .. 1023 fr 599377 | TX Size 512 .. 1023 fr 0
RX Size 1024 .. 1518 fr 12678554 | TX Size 1024 .. 1518 fr 0
RX Size 1519 .. 1522 fr 154050 | TX Size 1519 .. 1522 fr 0
[local]PGW-ICSR> show port npu counters 6/10
Saturday July 25 01:45:31 UTC 2015
Counters for port 6/10
Counter Rx Frames Rx Bytes Tx Frames Tx Bytes
---------------------- -------------------- ----------- --------------------
Unicast 147 11716 150 12234
Multicast 870 73376 416 51584
Broadcast 4 240 0 0
IPv4 unicast 66 4436 66 4550
IPv4 non-unicast 238 15232 0 0
IPv6 unicast 83 7400 84 7684
IPv6 non-unicast 632 8144 0 0
Fragments received 0 0 n/a n/a
Packets reassembled 0 0 n/a n/a
Fragments to kernel 0 0 n/a n/a
HW error 0 0 n/a n/a
Port non-operational 0 0 0 0
SRC MAC is multicast 0 0 n/a n/a
Unknown VLAN tag 0 0 n/a n/a
Other protocols 97 8240 n/a n/a
Not IPv4 399 36472 n/a n/a
Bad IPv4 header 0 0 n/a n/a
Pacotes ausentes entre contadores de link de dados e de npu
Este exemplo para o ASR 5000 mostra a saída comparando contadores de enlace de dados e de npu. Nesse caso, os pacotes multicast e broadcast correspondem entre comandos, mas a contagem Rx para npu é menor que para datalink. O comando "show npu stats debug" pode possivelmente ser responsável pela diferença, mas não em todos os casos, como é o caso aqui em que nenhum dos contadores desse comando pode ser responsável pelas diferenças.
[local]DO-HSGW> clear port npu counters all
Thursday August 06 02:05:51 UTC 2015
[local]DO-HSGW> clear port datalink counters all
Thursday August 06 02:05:52 UTC 2015
[local]DO-HSGW> show npu stats debug all-pacs clear
Thursday August 06 02:05:52 UTC 2015
[local]DO-HSGW> show card table
Thursday August 06 02:18:59 UTC 2015
Slot Card Type Oper State SPOF Attach
----------- -------------------------------------- ------------- ---- ------
5: PSC Packet Services Card 3 Active No 21 37
[local]DO-HSGW> show port npu count 21/1
Thursday August 06 02:13:52 UTC 2015
Counters for port 21/1
sCounter Rx Frames Rx Bytes Tx Frames Tx Bytes
-------------------- ------------- --------------- ------------- ---------------
Unicast 2502 289800 1726 308932
Multicast 1091 92000 0 0
Broadcast 1231 79781 0 0
IPv4 unicast 2400 283272 1624 304240
IPv4 non-unicast 534 34176 0 0
IPv6 unicast 0 0 0 0
IPv6 non-unicast 539 52982 0 0
Fragments received 0 0 n/a n/a
Packets reassembled 0 0 n/a n/a
Fragments to kernel 0 0 n/a n/a
HW error 0 0 n/a n/a
Port non-operational 0 0 0 0
SRC MAC is multicast 0 0 n/a n/a
Unknown VLAN tag 0 0 n/a n/a
Other protocols 50 7850 n/a n/a
Not IPv4 0 0 n/a n/a
Bad IPv4 header 0 0 n/a n/a
IPv4 MRU exceeded 0 0 n/a n/a
TCP tiny fragment 0 0 0 0
No ACL match 0 0 0 0
Filtered by ACL 0 0 0 0
TTL expired 0 0 n/a n/a
Flow lookup twice 0 0 n/a n/a
Unknown IPv4 class 0 0 n/a n/a
Too short: IP 0 0 n/a n/a
Too short: ICMP 0 0 0 0
Too short: IGMP 0 0 0 0
Too short: TCP 0 0 0 0
Too short: UDP 0 0 0 0
Too short: IPIP 0 0 n/a n/a
Too short: GRE 0 0 n/a n/a
Too short: GRE key 0 0 n/a n/a
Don't frag discards n/a n/a 0 0
Fragment packets n/a n/a 0 0
Fragment fragments n/a n/a 0 0
IPv4VlanMap dropped 0 0 n/a n/a
IPSec NATT keep alive 0 0 n/a n/a
MPLS Flow not found 0 0 n/a n/a
MPLS unicast 0 0 0 0
Size < 17 0 0 0 0
Size 17 .. 64 1834 117376 102 4692
Size 65 .. 127 1385 113948 36 2520
Size 128 .. 255 1589 225633 1191 170710
Size 256 .. 511 16 4624 397 131010
Size 512 .. 1023 0 0 0 0
Size 1024 .. 2047 0 0 0 0
Size 2048 .. 4095 0 0 0 0
Size 4096 .. 4500 0 0 0 0
Size > 4500 0 0 0 0
[local]DO-HSGW> show port data counters 21/1
Thursday August 06 02:13:52 UTC 2015
how npu Counters for port 21/1:
Line Card Gigabit Ethernet Port
Rx Counter Data | Tx Counter Data
----------------------- -------------- + ----------------------- -------------
RX Unicast frames 5555 | TX Unicast frames 1726
RX Multicast frames 1091 | TX Multicast frames 0
RX Broadcast frames 1233 | TX Broadcast frames 0
RX Size 64 frames 0 | TX Size 64 frames 102
RX Size 65 .. 127 fr 4219 | TX Size 65 .. 127 fr 36
RX Size 128 .. 255 fr 1681 | TX Size 128 .. 255 fr 1191
RX Size 256 .. 511 fr 49 | TX Size 256 .. 511 fr 397
RX Size 512 .. 1023 fr 1828 | TX Size 512 .. 1023 fr 0
RX Size 1024 .. 1518 fr 18 | TX Size 1024 .. 1518 fr 0
RX Size > 1518 frames 84 | TX Size > 1518 frames 0
RX Bytes OK 1934599 | TX Bytes OK 317264
RX Bytes BAD 0 | TX Bytes BAD 0
RX SHORT OK 0 | TX PAUSE 0
RX SHORT CRC 0 | TX ERR 0
RX OVF 0 |
RX NORM CRC 0 |
RX LONG OK 0 |
RX LONG CRC 0 |
RX PAUSE 0 |
RX FALS CRS 0 |
RX SYM ERR 0 |
RX FIFO CORR ECC ERR 0 | TX FIFO CORR ECC ERR 0
RX FIFO UNREC ECC ERR 0 | TX FIFO UNREC ECC ERR 0
RX Disc frames 0 | TX Disc frames 0
RX Disc bytes 0 | TX Disc bytes 0
RX ERR frames 0 | TX ERR frames 0
----------------------- -------------- + ----------------------- -------------
[local]DO-HSGW> show npu stats debug slot 5
Thursday August 06 02:13:53 UTC 2015
NPU debug stats for slot 5
Total number of NPU debug stat counters: 267
WARN: ----------------------------------
lc-rx-drop (id: 234) 50
INFO: ----------------------------------
csix-idle-cnt (id: 29) 36268853
npu-resent-fc-msg (id: 45) 951
npu-tx-fc-cframe (id: 46) 44701
npu-rx-sf-xon (id: 60) 13316
cp2npu-unk-mac-drop-cnt (id: 153) 177255
ipv6-unk-nexthdr (id: 155) 262
rx-cp-sft-pkt (id: 164) 33439
rx-sf0-sft-pkt (id: 165) 33439
rx-sf1-sft-pkt (id: 166) 33439
lc-rx-arp-slowpath (id: 316) 70
flow-notfound-done-slowpath (id: 325) 1233
flow-lkup-done-slowpath (id: 326) 3473
Pausar TX de Enlace de Dados e OVF de RX no ASR 5000
A pausa de TX indica que essa porta atingiu algum pico de carga em algum momento e enviou um quadro PAUSE para o switch peer, de modo que o switch peer possa reduzir graciosamente o tráfego em direção a essa porta. No entanto, parece que o switch peer não está habilitado com controle de fluxo e, portanto, há alguns contadores na placa de linha que indicam algumas quedas de excesso na porta.
Mesmo que a utilização média da porta não esteja alcançando o valor de pico (como 6 GBPS), a porta pode receber um pico repentino de tráfego que pode levar ao PAUSE TX. Portanto, é aconselhável ter o controle de fluxo ativado no switch peer sempre por precaução.
show port datalink counters
Counters for port 21/1: Line Card 10 Gigabit Ethernet Port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX Unicast frames 11562820841545 | TX Unicast frames 8643405785924 RX Multicast frames 401729121 | TX Multicast frames 0 RX Broadcast frames 16900986 | TX Broadcast frames 0 RX Size 64 frames 2562649224215 | TX Size 64 frames 5324800463761 RX Size 65 .. 127 fr 1827916995441 | TX Size 65 .. 127 fr 1921108746736 RX Size 128 .. 255 fr 527160156402 | TX Size 128 .. 255 fr 377388275894 RX Size 256 .. 511 fr 384674712910 | TX Size 256 .. 511 fr 285180922294 RX Size 512 .. 1023 fr 335734722295 | TX Size 512 .. 1023 fr 248088896685 RX Size 1024 .. 1518 fr 5894848662488 | TX Size 1024 .. 1518 fr 486837840991 RX Size > 1518 frames 29836364100 | TX Size > 1518 frames 0 RX Bytes OK 9248285853715092 | TX Bytes OK 1491301613652484 RX Bytes BAD 5358 | TX Bytes BAD 0 RX SHORT OK 0 | TX PAUSE 639563 RX SHORT CRC 0 | TX ERR 0 RX OVF 12768 | RX NORM CRC 0 | RX LONG OK 0 | RX LONG CRC 0 | RX PAUSE 0 | RX FALS CRS 0 | RX SYM ERR 0 | RX SPI FRAME COUNT 11555373252519 | TX SPI FRAME COUNT 8637801817136 RX SPI LEN ERR 0 | TX SPI LEN ERR 0 RX SPI DIP 2 ERR 0 | TX SPI DIP 4 ERR 0 RX SPI STATUS OOF ERR 0 | TX SPI DATA OOF ERR 0 RX FIFO OVERFLOW 0 | TX FIFO FULL DROP 0 RX PAUSE COUNT 0 | TX DIP 4 PACKET DROP 0 SPI EOP/ABORT 0 | RX FRAGMENTS COUNT 0 | RX MAC ERR 26 | RX JABBER COUNT 0 |
Um comando de nível muito baixo (somente Suporte Técnico, pode ser recuperado do SSD) é "show data Congestion slot X". Neste exemplo, observe o alto congestionamento no slot 5 (padrão conectado a XCLC 21/1) na interface NPU para Switch Fabric (SF). Especificamente, uma alta contagem de mensagens de controle de fluxo do Switch Fabric para a NPU, juntamente com um alto número de quedas de pacote nessa mesma direção confirma o problema.
******** Data-path congestion information for slot 5 ********
NPU Percentage of Frames Dropped:
Subsystem | 5 Sec | 5 Min | 15 Min | Total Frames and Drops
-------------|---------|---------|---------|-----------------------------
LC Top rx | 0.00% | 0.00% | 0.00% | Frames: 715193480189
| | | | Drops: 0
LC Top tx | 0.00% | 0.00% | 0.00% | Frames: 0
| | | | Drops: 0
LC Bot rx | 0.00% | 0.00% | 0.00% | Frames: 0
| | | | Drops: 0
LC Bot tx | 0.00% | 0.00% | 0.00% | Frames: 0
| | | | Drops: 0
LC RCC1 rx | 0.00% | 0.00% | 0.00% | Frames: 0
| | | | Drops: 0
LC RCC1 tx | 0.00% | 0.00% | 0.00% | Frames: 0
| | | | Drops: 0
LC RCC2 rx | 0.00% | 0.00% | 0.00% | Frames: 0
| | | | Drops: 0
LC RCC2 tx | 0.00% | 0.00% | 0.00% | Frames: 0
| | | | Drops: 0
CPU rx | 0.00% | 0.00% | 0.00% | Frames: 121566003797
| | | | Drops: 0
CPU tx | 0.00% | 0.00% | 0.00% | Frames: 59870967969
| | | | Drops: 35226625
SF A rx | 0.00% | 0.00% | 0.00% | Frames: 224008179
| | | | Drops: 0
SF A tx | 0.01% | 0.00% | 0.00% | Frames: 378241304254 | | | | Drops: 274645028
SF B rx | 0.00% | 0.00% | 0.00% | Frames: 656009419
| | | | Drops: 0
SF B tx | 0.00% | 0.00% | 0.00% | Frames: 392219947264 | | | | Drops: 320394097
EDC rx | 0.00% | 0.00% | 0.00% | Frames: 0
| | | | Drops: 0
EDC tx | 0.00% | 0.00% | 0.00% | Frames: 0
| | | | Drops: 0
NPU Received Flow Control Events:
Event | 5 Sec | 5 Min | 15 Min | Total Event Count
----------------|-------------|-------------|-------------|--------------------
rx-sf-xoff | 21668 | 843417 | 2358340 | 828378025 rx-sf-xon | 21811 | 851786 | 2383440 | 873518866
rx-lc-xoff | 0 | 0 | 0 | 0
rx-lc-xon | 0 | 0 | 0 | 0
rx-cp-xoff | 53 | 5021 | 15176 | 17316366
rx-cp-xon | 53 | 5021 | 15176 | 17316366
rx-edc-xoff | 0 | 0 | 0 | 0
rx-edc-xon | 0 | 0 | 0 | 0
Aumentando o ERR do TX devido a configurações de porta incompatíveis na porta de gerenciamento ASR 5500
Neste exemplo, os tíquetes começaram a ser abertos referindo-se a um aumento nos contadores TX ERR na porta 5/1, a porta de gerenciamento no ASR 5500. Em um local, não foi "percebido" como um problema até que um MOP foi executado e implementou a criação e geração de arquivos de registro de eventos, um recurso do Serviço de Carregamento Avançado. Não foi possível estabelecer correlação entre a implementação desse recurso e um aumento repentino dessas falhas, exceto para observar que também houve um aumento repentino no throughput para a porta de gerenciamento, que deve transportar o tráfego de gerenciamento em 30/12 quando a alteração foi feita. Aqui, os txpackets variáveis do esquema PORTSch1 estão em gráfico mostrando o aumento:
Uma auditoria da rede mostrou que o problema estava acontecendo em muitos nós, por exemplo, aqui está apenas um pequeno trecho da auditoria:
*************** ALPR-DXGW-ICSR *************** show port datalink counters 5/1 | grep "TX ERR" Monday January 04 03:33:14 UTC 2016 RX SHORT CRC 0 | TX ERR 2038860 *************** ANJT-PGW *************** show port datalink counters 5/1 | grep "TX ERR" Monday January 04 03:33:14 UTC 2016 RX SHORT CRC 0 | TX ERR 1975169 *************** AZUS-PGW-00 *************** show port datalink counters 5/1 | grep "TX ERR" Monday January 04 03:33:15 UTC 2016 RX SHORT CRC 0 | TX ERR 1709395 *************** AZUSPND-PGW-00 *************** show port datalink counters 5/1 | grep "TX ERR" Monday January 04 03:33:15 UTC 2016 RX SHORT CRC 0 | TX ERR 1211060
Voltando a SSDs antigas (já que somente os contadores básicos estão sendo rastreados por Bulkstats), pode-se ver que o erro estava acontecendo lentamente até 30/12, mas depois da execução do MOP, o erro estava acontecendo em uma taxa muito mais alta:
Thursday November 19 13:41:44 UTC 2015 Counters for port 5/1: Line Card Gigabit Ethernet Port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX SHORT CRC 0 | TX ERR 5927969 Monday November 30 13:35:45 UTC 2015 Counters for port 5/1: Line Card Gigabit Ethernet Port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX SHORT CRC 0 | TX ERR 6116249 Tuesday December 01 13:39:26 UTC 2015 Counters for port 5/1: Line Card Gigabit Ethernet Port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX SHORT CRC 0 | TX ERR 6130958 Counters cleared ... [local]ASR5500-PGW> show port datalink counters 5/1 Monday January 04 02:41:29 UTC 2016 Counters for port 5/1: Line Card Gigabit Ethernet Port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX Unicast frames 171008921 | TX Unicast frames 221976127 RX SHORT CRC 0 | TX ERR 5852770 ******** show port datalink counters ******* Tuesday January 05 13:38:51 UTC 201 Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX Unicast frames 216450269 | TX Unicast frames 8080952673 RX SHORT CRC 0 | TX ERR 11497275
******** show port info *******
Tuesday January 05 13:33:07 UTC 2016
Port: 5/1
Port Type : 1000 Ethernet
Configured Duplex : Auto
Configured Speed : Auto
Link State : Up
Link Duplex : Half
Link Speed : 100 Mb Issue fixed ... Wednesday January 06 14:29:28 UTC 2016 Counters for port 5/1: Line Card Gigabit Ethernet Port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX SHORT CRC 0 | TX ERR 0
[local]PGW> show port info 5/1
Wednesday January 06 12:58:50 UTC 2016
Port: 5/1
Port Type : 1000 Ethernet
Role : Management Port
Configured Duplex : Auto
Configured Speed : Auto
Link State : Up
Link Duplex : Full
Link Speed : 1000 Mb
O problema acabou sendo uma incompatibilidade nas configurações de porta entre o ASR 5500 e o novo switch ao qual ele se conecta, o Nexus 7000. A correção era definir portas em ambas as extremidades para autonegociação. O ASR 5500 já estava definido como automático, enquanto o Nexus foi definido manualmente como full duplex. A correção:
ASR 5500 (already set to this)
port ethernet 5/1
medium speed 1000 duplex full
no shutdown
bind interface 5/1-MGMT local
#exit
Nexus 7K (needed to be set to this)
interface Ethernet152/1/11
description MGMT-PORT-5/01
switchport
switchport access vlan 10
spanning-tree port type edge
no snmp trap link-status
no shutdown
Acontece que o problema estava ocorrendo o tempo todo, mas nunca foi percebido porque o único indicador era o contador TX ERR, que não é algo que possa ser medido por meio de qualquer relatório automatizado, pois não há variáveis de bulkstat para nada além dos contadores básicos de porta (pacotes Tx/Rx/bytes, etc.). Mas o problema foi severamente exacerbado quando o MOP foi executado e como os pacotes Tx/Rx são capturados por Bulkstats e são um KPI medido pelo cliente, ele foi observado.
Então a próxima questão foi o que causou o aumento repentino do tráfego? A análise da alteração mostra a seguinte definição chamada "via contexto local", que especifica a utilização da porta de contexto local (5/1 ou 6/1) para o novo tráfego de eventos em vez da porta 5/29 no contexto ECS, em que o tráfego de registro de faturação de registro de dados de eventos (EDR) existente sempre foi (e continuou a ser) enviado pela porta 5/29 existente nesse contexto. Esta NÃO foi uma descoberta óbvia, pois essa configuração raramente é usada em qualquer configuração do cliente.
context ECS
interface 5/29-ECS
ip address 10.192.102.75 255.255.255.0
#exit
session-event-module file name evt-repo rotation volume 40000000 rotation time 120 storage-limit 500000000 exclude-checksum-record time-stamp rotated-format compression gzip event transfer-mode push primary encrypted-url +A19y2j... via local-context module-only edr-module active-charging-service file name FDR70 rotation volume 40000000 rotation time 300 storage-limit 500000000 headers reset-indicator edr-format-name trap-on-file-delete charging-service-name omit compression gzip file-sequence-number rulebase-seq-num cdr use-harddisk cdr remove-file-after-transfer cdr transfer-mode push primary encrypted-url +A0d2...
Aumento de quadros defeituosos e colisões Tx na porta de gerenciamento devido ao half duplex
As interfaces 24/1 e 25/1 que compõem a interface 24/1-MGMT estão passando por "Quadros defeituosos", "colisões TX" e "colisões atrasadas TX".
Em show support details:
******** show port datalink counters ******* Friday January 03 14:14:59 UTC 2014 Counters for port 25/1: SPIO 10/100/1000 Ethernet port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX Bytes 12808872101 | TX Bytes 20451927433 RX BAD frames 0 | TX BAD frames 1403971 RX Runt frames 0 | TX Runt frames 0 RX Oversize frames 0 | TX Oversize frames 0 RX Good frames 95621882 | TX Good frames 39395979 RX Multicast frames 6686008 | TX Collisions 1501475 RX Broadcast frames 56656415 | TX Excessive collis 0 RX Code ERROR 0 | TX Late Collisions 1403968 RX CRC ERROR 0 | TX CRC ERROR 0 RX length ERROR 0 | TX ABORT 3 RX Align ERROR 0 | ----------------------- -------------- + ----------------------- -------------
A partir do sistema um pouco mais tarde, observe o aumento de Quadros defeituosos e colisões/colisões tardias:
[local]DO-HSGW> show port datalink counters 25/1 Friday January 03 14:26:04 UTC 2014 Counters for port 25/1: SPIO 10/100/1000 Ethernet port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX Bytes 12809750383 | TX Bytes 20456667635 RX BAD frames 0 | TX BAD frames 1404930 RX Runt frames 0 | TX Runt frames 0 RX Oversize frames 0 | TX Oversize frames 0 RX Good frames 95628788 | TX Good frames 39400838 RX Multicast frames 6686366 | TX Collisions 1502503 RX Broadcast frames 56659440 | TX Excessive collis 0 RX Code ERROR 0 | TX Late Collisions 1404927 RX CRC ERROR 0 | TX CRC ERROR 0 RX length ERROR 0 | TX ABORT 3 RX Align ERROR 0 | ----------------------- -------------- + ----------------------- -------------
Geralmente, isso é indicativo de uma incompatibilidade de configuração em cada extremidade da interface Ethernet. Ambas portas de gerenciamento negociaram como half duplex:
[local]DO-HSGW> show port info 24/1 Friday January 03 14:33:19 UTC 2014 Port: 24/1 Port Type : 1000 Ethernet Dual Media Role : Management Port Description : (None Set) Controlled By Card : 8 (System Management Card) Redundancy Mode : Port Mode Framing Mode : Unspecified Redundant With : 25/1 Preferred Port : Non-Revertive Physical ifIndex : 402718720 Administrative State : Enabled Configured Duplex : Auto Configured Speed : Auto Media Selection : RJ45 MAC Address : 00-05-47-02-5D-EE Link State : Up Link Duplex : Half Link Speed : 100 Mb Link Aggregation Group : None Logical ifIndex : 402718721 Operational State : Down, Standby SFP Module : Present (1000BASE-SX, M5, M610G SFP+Cu)
A outra extremidade do link, o Cisco Catalyst 6500, foi definida como Speed = 100 e duplex = full. Para corrigir o problema, codifique o ASR 5000 como também full duplex:
port ethernet 24/1
medium speed 100 duplex full
no shutdown
bind interface 24/1-MGMT local
Ou, em alternativa, defina AMBOS os lados para serem autonegociados.
Mas ter um lado tão automático e o outro como cheio pode resultar em estabelecimento half-duplex.
Comutação LAG Inesperada - Problema na Porta LAG 23/1
O seguinte foi observado onde a porta 23/1 no LAG estava presa no estado negociado do LAG após um inesperado switchover do LAG:
2015-May-15+16:47:40.410 [snmp 22002 info] [1/0/13147 <lagmgr:0>
trap_api.c:2387] [software internal system syslog] Internal trap notification
1205 (LAGGroupUp) card:19, port:1, partner:(007F,64-87-88-66-F7-C0,0016)
2015-May-15+16:47:40.410 [snmp 22002 info] [1/0/13147 <lagmgr:0>
trap_api.c:2387] [software internal system syslog] Internal trap notification
1204 (LAGGroupDown) card:19, port:1, partner:(007F,64-87-88-67-87-C0,0016)
2015-May-15+16:47:40.410 [lagmgr 179050 warning] [1/0/13147 <lagmgr:0>
lagmgr_state.c:1314] [software internal system critical-info syslog] LAG group
50 (global) with master port 19/1 has changed partner
from (007F,64-87-88-67-87-C0,0016) on 17/1, 19/1, 23/1, 27/1, 29/1
to (007F,64-87-88-66-F7-C0,0016) on 18/1, 20/1, 26/1, 28/1, 30/1
[local]PDSN> show port table | grep LA 17/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 18/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 19/1 Srvc 10G Ethernet Enabled - Up - None LA~ 19/1 20/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 23/1 Srvc 10G Ethernet Enabled Up Up Active None LA* 19/1 26/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 27/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 28/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 29/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 30/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1
[local]PDSN> show port info 23/1
Port: 23/1
Port Type : 10G Ethernet
Role : Service Port
Description : Ingress-Egress Line Card
Controlled By Card : 7 (Packet Services Card 3)
Redundancy Mode : Port Mode
Framing Mode : Unspecified
Redundant With : Not Redundant
Preferred Port : Non-Revertive
Physical ifIndex : 385941504
Administrative State : Enabled
Configured Duplex : Auto
Configured Speed : Auto
Configured Flow Control : Enabled
MAC Address : 00-05-47-02-A6-96
Link State : Up
Link Duplex : Full
Link Speed : 10 Gb
Flow Control : Enabled
Link Aggregation Group : 50 (global, member)
Link Aggregation LACP : Active, Short, Auto
Link Aggregation Master : 19/1
Link Aggregation State : Agreed with LACP peer
Link Aggregation Actor : (8000,00-05-47-02-B1-97,001A,8000,1701)
Link Aggregation Peer : (007F,64-87-88-67-87-C0,0016,007F,0013)
Logical ifIndex : 385941505
Operational State : Up, Active
SFP Module : Present (10G Base SR)
[local]PDSN>show card diag 23
Card 23:
Counters:
In Service Date : Tue Aug 24 06:58:31 2010 (Estimated)
Status:
IDEEPROM Magic Number : Good
Card Diagnostics : Pass
Current Failure : None
Last Failure : None
Card Usable : Yes
Current Environment:
Temperature: Card : 48 C (limit 90 C)
Temperature: LM87 : 49 C (limit 85 C)
Temperature: PHY : 48 C (limit 90 C)
Voltage: 1.2V : 1.205 V (min 1.140 V, max 1.260 V)
Voltage: 1.2V : 1.205 V (min 1.140 V, max 1.260 V)
Voltage: 2.5V : 2.522 V (min 2.375 V, max 2.625 V)
Voltage: 3.3V : 3.285 V (min 3.135 V, max 3.465 V)
Voltage: 1.8V : 1.805 V (min 1.710 V, max 1.890 V)
Os contadores de enlace de dados não mostraram nenhum problema:
[local]PDSN# show port datalink counters 23/1 Counters for port 23/1: Line Card 10 Gigabit Ethernet Port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX Unicast frames 3782 | TX Unicast frames 6043 RX Multicast frames 3782 | TX Multicast frames 0 RX Broadcast frames 0 | TX Broadcast frames 0 RX Size 64 frames 0 | TX Size 64 frames 0 RX Size 65 .. 127 fr 0 | TX Size 65 .. 127 fr 6043 RX Size 128 .. 255 fr 3782 | TX Size 128 .. 255 fr 0 RX Size 256 .. 511 fr 0 | TX Size 256 .. 511 fr 0 RX Size 512 .. 1023 fr 0 | TX Size 512 .. 1023 fr 0 RX Size 1024 .. 1518 fr 0 | TX Size 1024 .. 1518 fr 0 RX Size > 1518 frames 0 | TX Size > 1518 frames 0 RX Bytes OK 483456 | TX Bytes OK 748092 RX Bytes BAD 0 | TX Bytes BAD 0 RX SHORT OK 0 | TX PAUSE 0 RX SHORT CRC 0 | TX ERR 0 RX OVF 0 | RX NORM CRC 0 | RX LONG OK 0 | RX LONG CRC 0 | RX PAUSE 0 | RX FALS CRS 0 | RX SYM ERR 0 | SPI RX LEN ERR CNT 0 | SPI TX LEN ERR CNT 0 SPI RX DIP2 ERR CNT 0 | SPI TX DIP4 ERR CNT 0 SPI RX STAT OOF ERR CNT 0 | SPI TX DATA OOF ERR CNT 0 RX MAC ERR CNT 0 | RX FIFO CORR ECC ERR 0 | TX FIFO CORR ECC ERR 0 RX FIFO UNRECOV ECC ERR 0 | TX FIFO UNRECOV ECC ERR 0 RX Disc frames 0 | TX Disc frames 0 RX Disc Bytes 0 | TX Disc Bytes 0 RX ERR frames 0 | TX ERR frames 0 RX SPI FRAME COUNT 3782 | TX SPI FRAME COUNT 6044 RX SPI LEN ERR 0 | TX SPI LEN ERR 0 RX SPI DIP 2 ERR 0 | TX SPI DIP 4 ERR 0 RX SPI STATUS OOF ERR 0 | TX SPI DATA OOF ERR 0 RX FIFO OVERFLOW 0 | TX FIFO FULL DROP 0 RX PAUSE COUNT 0 | TX DIP 4 PACKET DROP 0 SPI EOP/ABORT 0 | RX FRAGMENTS COUNT 0 | RX MAC ERR 0 | RX JABBER COUNT 0 | ----------------------- -------------- + ----------------------- -------------
Os contadores de NPU também estavam OK. Aqui estão os contadores de porta 23/1 alguns segundos depois e nada de ruim está aumentando:
[local]PDSN# show port datalink counters 23/1 Counters for port 23/1: Line Card 10 Gigabit Ethernet Port Rx Counter Data | Tx Counter Data ----------------------- -------------- + ----------------------- ------------- RX Unicast frames 3802 | TX Unicast frames 6066 RX Multicast frames 3802 | TX Multicast frames 0 RX Broadcast frames 0 | TX Broadcast frames 0 RX Size 64 frames 0 | TX Size 64 frames 0 RX Size 65 .. 127 fr 0 | TX Size 65 .. 127 fr 6066 RX Size 128 .. 255 fr 3802 | TX Size 128 .. 255 fr 0 RX Size 256 .. 511 fr 0 | TX Size 256 .. 511 fr 0 RX Size 512 .. 1023 fr 0 | TX Size 512 .. 1023 fr 0 RX Size 1024 .. 1518 fr 0 | TX Size 1024 .. 1518 fr 0 RX Size > 1518 frames 0 | TX Size > 1518 frames 0 RX Bytes OK 486016 | TX Bytes OK 750944 RX Bytes BAD 0 | TX Bytes BAD 0 RX SHORT OK 0 | TX PAUSE 0 RX SHORT CRC 0 | TX ERR 0 RX OVF 0 | RX NORM CRC 0 | RX LONG OK 0 | RX LONG CRC 0 | RX PAUSE 0 | RX FALS CRS 0 | RX SYM ERR 0 | SPI RX LEN ERR CNT 0 | SPI TX LEN ERR CNT 0 SPI RX DIP2 ERR CNT 0 | SPI TX DIP4 ERR CNT 0 SPI RX STAT OOF ERR CNT 0 | SPI TX DATA OOF ERR CNT 0 RX MAC ERR CNT 0 | RX FIFO CORR ECC ERR 0 | TX FIFO CORR ECC ERR 0 RX FIFO UNRECOV ECC ERR 0 | TX FIFO UNRECOV ECC ERR 0 RX Disc frames 0 | TX Disc frames 0 RX Disc Bytes 0 | TX Disc Bytes 0 RX ERR frames 0 | TX ERR frames 0 RX SPI FRAME COUNT 3802 | TX SPI FRAME COUNT 6067 RX SPI LEN ERR 0 | TX SPI LEN ERR 0 RX SPI DIP 2 ERR 0 | TX SPI DIP 4 ERR 0 RX SPI STATUS OOF ERR 0 | TX SPI DATA OOF ERR 0 RX FIFO OVERFLOW 0 | TX FIFO FULL DROP 0 RX PAUSE COUNT 0 | TX DIP 4 PACKET DROP 0 SPI EOP/ABORT 0 | RX FRAGMENTS COUNT 0 | RX MAC ERR 0 | RX JABBER COUNT 0 |
Mas o comando de suporte técnico "show lag event" mostrou eventos contínuos na porta 23/1. Essa é a melhor maneira de ver o problema relatado.
[local]PDSN> show lag event
lagmgr event history [4096/4096]
May 15 18:36:57.222 50 23/01 New MUX State: DETACHED
May 15 18:36:57.222 50 23/01 SYNC cleared
May 15 18:36:57.222 50 23/01 COLL disabled
May 15 18:36:58.212 50 23/01 New MUX State: WAITING
May 15 18:36:58.223 50 23/01 LACP State Change: 0x07:ACTV:TIMO:AGGR
...
Na próxima janela de manutenção, a Cisco entrou em contato com o e foi feita uma migração de PSC para colocar os mapeamentos de placa de volta ao mapeamento padrão (de modo que o PSC esteja mapeado para a placa de linha fisicamente atrás dela: 7 + 16 = 23), pois foi feita uma migração antes de entrar em contato com a Cisco.
[local]PDSN card migrate from 16 to 7 Are you sure? [Yes|No]: yes [local]PDSN# show port table | grep LA 17/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 18/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 19/1 Srvc 10G Ethernet Enabled - Up - None LA~ 19/1 20/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 23/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 26/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 27/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 28/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 29/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 30/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 [local]PDSN# show rct stats RCT stats Details (Last 8 Actions) Action Type From To Start Time Duration ----------------- --------- ---- ---- ------------------------ ---------- Migration Planned 10 15 2015-Jan-12+07:02:33.842 32.911 sec Shutdown N/A 10 0 2015-Jan-12+07:08:35.098 0.218 sec Migration Planned 16 10 2015-Jan-12+07:19:40.842 32.451 sec Shutdown N/A 1 16 2015-Mar-19+05:00:54.430 1.368 sec Migration Planned 16 1 2015-Mar-27+06:05:48.902 19.085 sec Shutdown N/A 16 0 2015-Mar-27+06:13:00.397 0.027 sec Migration Planned 7 16 2015-May-16+07:04:51.264 37.629 sec Migration Planned 16 7 2015-May-16+08:39:48.761 Unfinished RCT stats Summary ----------------- Migrations = 5, Average time = 30.519 sec Switchovers = 0 Migration Planned 16 7 2015-May-16+08:39:48.761 43.248 sec
Sat May 16 08:40:33 2015 Internal trap notification 1257 (MigrateComplete) from card 16 to card 7
Uma reinicialização da placa de linha 23 foi executada:
[local]PDSN# card reboot 23 Are you sure? [Yes|No]: yes
Sat May 16 08:41:38 2015 Internal trap notification 4 (CardRebootRequest) card
23 type 10 Gig Ethernet Line Card
Sat May 16 08:41:44 2015 Internal trap notification 1025 (PortUp) card 23 port 1
port type 10G Ethernet
Sat May 16 08:41:44 2015 Internal trap notification 1502 (EntStateOperEnabled)
Port(23/1) Admin state:"Unlocked", Alarm severity:"No active alarm"
Sat May 16 08:41:44 2015 Internal trap notification 55 (CardActive) card 23 type
10 Gig Ethernet Line Card
A porta está agora em bom estado:
[local]PDSN# show port table | grep LA 17/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 18/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 19/1 Srvc 10G Ethernet Enabled - Up - None LA~ 19/1 20/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 23/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 26/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 27/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 28/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1 29/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1 30/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1
Mas o lado da Juniper ainda apresentava erros (nenhuma saída mostrada aqui).
O problema permaneceu por resolver no lado da Juniper.
A fibra foi então movida de 23/1 para 17/1 e o erro ficou com 23/1 e foi movida para uma porta diferente no lado da Juniper.
Sat May 16 08:46:28 2015 Internal trap notification 1024 (PortDown) card 17 port
1 port type 10G Ethernet Sat May 16 08:46:28 2015 Internal trap notification 93 (CardStandby) card 17
type 10 Gig Ethernet Line Card Sat May 16 08:46:31 2015 Internal trap notification 1024 (PortDown) card 23 port
1 port type 10G Ethernet Sat May 16 08:46:31 2015 Internal trap notification 93 (CardStandby) card 23
type 10 Gig Ethernet Line Card
Sat May 16 08:46:33 2015 Internal trap notification 1025 (PortUp) card 23 port 1
port type 10G Ethernet Sat May 16 08:46:33 2015 Internal trap notification 55 (CardActive) card 23 type
10 Gig Ethernet Line Card Sat May 16 08:46:40 2015 Internal trap notification 1025 (PortUp) card 17 port 1
port type 10G Ethernet Sat May 16 08:46:40 2015 Internal trap notification 55 (CardActive) card 17 type
10 Gig Ethernet Line Card
As fibras foram movidas de volta para o local original e o problema ainda estava na porta 23/1 (isso é da perspectiva da Juniper porque, como mencionado acima, o problema não estava mais sendo visto no ASR 5000 após reiniciar a placa de linha 23).
Sat May 16 08:51:53 2015 Internal trap notification 1024 (PortDown) card 23 port
1 port type 10G Ethernet Sat May 16 08:51:53 2015 Internal trap notification 93 (CardStandby) card 23
type 10 Gig Ethernet Line Card Sat May 16 08:51:57 2015 Internal trap notification 1024 (PortDown) card 17 port
1 port type 10G Ethernet Sat May 16 08:51:57 2015 Internal trap notification 93 (CardStandby) card 17
type 10 Gig Ethernet Line Card Sat May 16 08:51:58 2015 Internal trap notification 1025 (PortUp) card 23 port 1
port type 10G Ethernet Sat May 16 08:51:58 2015 Internal trap notification 55 (CardActive) card 23 type
10 Gig Ethernet Line Card Sat May 16 08:51:59 2015 Internal trap notification 1025 (PortUp) card 17 port 1
port type 10G Ethernet
Sat May 16 08:51:59 2015 Internal trap notification 55 (CardActive) card 17 type
10 Gig Ethernet Line Card
A troca dos SFPs entre 23/1 e 17/1 não mudou nada.
Sat May 16 08:52:50 2015 Internal trap notification 1024 (PortDown) card 23 port
1 port type 10G Ethernet Sat May 16 08:52:50 2015 Internal trap notification 93 (CardStandby) card 23
type 10 Gig Ethernet Line Card Sat May 16 08:52:58 2015 Internal trap notification 1024 (PortDown) card 17 port
1 port type 10G Ethernet Sat May 16 08:52:59 2015 Internal trap notification 93 (CardStandby) card 17
type 10 Gig Ethernet Line Card Sat May 16 08:53:46 2015 Internal trap notification 1025 (PortUp) card 17 port 1
port type 10G Ethernet Sat May 16 08:53:46 2015 Internal trap notification 55 (CardActive) card 17 type
10 Gig Ethernet Line Card Sat May 16 08:53:53 2015 Internal trap notification 1025 (PortUp) card 23 port 1
port type 10G Ethernet Sat May 16 08:53:53 2015 Internal trap notification 55 (CardActive) card 23 type
10 Gig Ethernet Line Card
Uma recolocação da placa de linha 23/1 eliminou o problema no lado da Juniper.
Sat May 16 08:55:39 2015 Internal trap notification 1024 (PortDown) card 23 port
1 port type 10G Ethernet Sat May 16 08:55:39 2015 Internal trap notification 35 (PortLinkDown) ifindex
385941505 adminstate Disabled operstate Down Sat May 16 08:55:39 2015 Internal trap notification 1504 (CiscoFruCardStatusChanged) FRU entity Card : 23 operational status changed to
Offline Sat May 16 08:55:39 2015 Internal trap notification 60 (CardDown) card 23 type
10 Gig Ethernet Line Card Sat May 16 08:55:39 2015 Internal trap notification 1503 (EntStateOperDisabled)
Card(23) Admin state:"Locked", Alarm severity:"Critical" Sat May 16 08:55:39 2015 Internal trap notification 140 (CardSPOFClear) card 23
type 10 Gig Ethernet Line Card Sat May 16 08:55:40 2015 Internal trap notification 84 (ServiceLossLC) Slots 23
and 39 has configured for card type 10 Gig Ethernet Line Card, but neither active
Sat May 16 08:55:41 2015 Internal trap notification 1505
(CiscoFruPowerStatusChanged) FRU entity Card : 23 Power OFF Sat May 16 08:55:41 2015 Internal trap notification 1504
(CiscoFruCardStatusChanged) FRU entity Card : 23 operational status changed to
Empty Sat May 16 08:55:41 2015 Internal trap notification 7 (CardRemoved) card 23 type
10 Gig Ethernet Line Card Sat May 16 08:55:41 2015 Internal trap notification 1507 (CiscoFruRemoved) FRU
entity Card : 23 removed Sat May 16 08:55:41 2015 Internal trap notification 1505
(CiscoFruPowerStatusChanged) FRU entity Card : 23 Power OFF Sat May 16 08:56:19 2015 Internal trap notification 1505
(CiscoFruPowerStatusChanged) FRU entity Card : 23 Power ON Sat May 16 08:56:21 2015 Internal trap notification 1504
(CiscoFruCardStatusChanged) FRU entity Card : 23 operational status changed to
Offline Sat May 16 08:56:21 2015 Internal trap notification 8 (CardInserted) card 23
type 10 Gig Ethernet Line Card Sat May 16 08:56:21 2015 Internal trap notification 1506 (CiscoFruInserted) FRU
entity Card : 23 inserted Sat May 16 08:56:23 2015 Internal trap notification 1504
(CiscoFruCardStatusChanged) FRU entity Card : 23 operational status changed to
Ready Sat May 16 08:56:23 2015 Internal trap notification 5 (CardUp) card 23 type 10
Gig Ethernet Line Card Sat May 16 08:56:23 2015 Internal trap notification 1502 (EntStateOperEnabled)
Card(23) Admin state:"Unlocked", Alarm severity:"No active alarm" Sat May 16 08:56:25 2015 Internal trap notification 1504 (CiscoFruCardStatusChanged) FRU entity Card : 23 operational status changed to
Active Sat May 16 08:56:25 2015 Internal trap notification 55 (CardActive) card 23 type
10 Gig Ethernet Line Card Sat May 16 08:56:26 2015 Internal trap notification 1111 (ServiceLossLCClear)
Slots 23 and 39 has configured for card type 10 Gig Ethernet Line Card, one of
them is active now Sat May 16 08:56:26 2015 Internal trap notification 93 (CardStandby) card 23
type 10 Gig Ethernet Line Card Sat May 16 08:56:28 2015 Internal trap notification 1025 (PortUp) card 23 port 1
port type 10G Ethernet Sat May 16 08:56:28 2015 Internal trap notification 1502 (EntStateOperEnabled)
Port(23/1) Admin state:"Unlocked", Alarm severity:"No active alarm" Sat May 16 08:56:28 2015 Internal trap notification 55 (CardActive) card 23 type
10 Gig Ethernet Line Card
Erros de porta inexplicados no roteador Juniper em par com a porta 27/1 XGLC (impacto no assinante)
Este próximo exemplo, tem muitas das mesmas etapas de solução de problemas aplicadas e vale a pena estudar. Começou com alguns registros de aviso desconhecidos do resmgr 14537 sendo reportados juntamente com uma devolução de porta 25/1, mas evoluiu para um problema de porta 27/1 e aumentou as falhas de configuração de chamada.
2015-May-03+05:29:21.083 [resmgr 14537 warning] [8/0/4643 <rmmgr:80>
_resource_cpu.c:4974] [software internal system critical-info syslog] The CPU
8/0's network i/f cpeth0 is receiving 803.7 Mbit/sec over the past 5 min.
A utilização da porta era irregular na porta 27/1:
[local]PDSN# show port utilization table
Monday May 04 17:49:02 UTC 2015
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 1058 1049 1034 1050 1022 1042
20/1 10G Ethernet 0 0 0 0 0 0
23/1 10G Ethernet 1108 1064 1114 1033 1102 1032
26/1 10G Ethernet 0 0 0 0 0 0
27/1 10G Ethernet 1002 2472 989 2456 981 2440
28/1 10G Ethernet 0 0 0 0 0 0
No lado Juniper MX-960 da interface PDSN em questão, os erros de entrada aumentavam constantemente:
show interfaces xe-0/1/2 extensive | grep Error
BPDU Error: None, MAC-REWRITE Error: None, Loopback: None,
Input errors:
Errors: 2432742, Drops: 0, Framing errors: 0, Runts: 0, Policed discards: 0,
L3 incompletes: 2432742, L2 channel errors: 0, L2 mismatch timeouts: 0,
FIFO errors: 0, Resource errors: 0
Output errors:
Carrier transitions: 1, Errors: 0, Drops: 0, Collisions: 0, Aged packets: 0,
FIFO errors: 0, HS link CRC errors: 0, MTU errors: 0, Resource errors: 0
Bit errors 0
Errored blocks 1
CRC/Align errors 0 0
FIFO errors 0 0
Total errors 0 0
Output packet error count 0
{master}
show interfaces xe-0/1/2 extensive | grep Error
BPDU Error: None, MAC-REWRITE Error: None, Loopback: None,
Input errors:
Errors: 2432851, Drops: 0, Framing errors: 0, Runts: 0, Policed discards: 0,
L3 incompletes: 2432851, L2 channel errors: 0, L2 mismatch timeouts: 0,
FIFO errors: 0, Resource errors: 0
Output errors:
Carrier transitions: 1, Errors: 0, Drops: 0, Collisions: 0, Aged packets: 0,
FIFO errors: 0, HS link CRC errors: 0, MTU errors: 0, Resource errors: 0
Bit errors 0
Errored blocks 1
CRC/Align errors 0 0
FIFO errors 0 0
Total errors 0 0
Output packet error count 0
As portas no PDSN foram limpas e, como resultado, houve um switchover de LAG e o desequilíbrio de portas desapareceu nas portas recém-ativas (até mesmo numeradas) junto com os erros na parada do lado do Juniper. Erros de CHAP e LCP visualizados anteriormente relacionados às configurações de chamada de IP móvel também pararam.
[local]PDSN# show port utilization table
Thursday May 07 15:27:46 UTC 2015
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- ---
19/1 10G Ethernet 0 0 0 0 0 0
20/1 10G Ethernet 908 875 901 879 904 884
23/1 10G Ethernet 0 0 0 0 0 0
26/1 10G Ethernet 916 857 922 856 929 861
27/1 10G Ethernet 0 0 0 0 0 0
28/1 10G Ethernet 835 883 838 880 844 889
37/1 1000 Ethernet 0 0 0 0 0 0
[local]PDSN# show port table
Thursday May 07 15:22:11 UTC 2015
Port Role Type Admin Oper Link State Pair Redundant
----- ---- ------------------------ -------- ---- ---- ------- ----- ----
19/1 Srvc 10G Ethernet Enabled - Up - None LA~ 19/1
20/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1
21/1 Srvc 1000 Ethernet Enabled - Up - 37/1 L2 Link
23/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1
24/1 Mgmt 1000 Ethernet Dual Media Enabled Up Up Active 25/1 L2 Link
24/2 Mgmt 1000 Ethernet Dual Media Disabled Down Down Active 25/2 L2 Link
24/3 Mgmt RS232 Serial Console Enabled Down Down Active 25/3 L2 Link
24/4 Mgmt BITS T1/E1 Timing Disabled Down Down Active 25/4 L2 Link
25/1 Mgmt 1000 Ethernet Dual Media Enabled Down Up Standby 24/1 L2 Link
25/2 Mgmt 1000 Ethernet Dual Media Disabled Down Down Standby 24/2 L2 Link
25/3 Mgmt RS232 Serial Console Enabled Down Down Standby 24/3 L2 Link
25/4 Mgmt BITS T1/E1 Timing Disabled Down Down Standby 24/4 L2 Link
26/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1
27/1 Srvc 10G Ethernet Enabled Up Up Active None LA~ 19/1
28/1 Srvc 10G Ethernet Enabled Up Up Active None LA+ 19/1
37/1 Srvc 1000 Ethernet Enabled - Up - 21/1 L2 Link
Após redefinir as estatísticas da porta e retornar o LAG às portas ímpares, os erros de entrada no Juniper começaram a aumentar novamente. Como o caminho já tinha sido limpo, decidiu-se ignorar completamente o caminho existente, substituindo ambos os SFPs (porta 0/1/2 no Juniper e porta 27/1 no PDSN) e executando uma fibra diretamente entre os nós. Depois que o tráfego foi devolvido ao LAG ímpar, os erros de entrada continuaram a aumentar exatamente como foi testemunhado com o caminho existente. A utilização da porta também voltou a ser desequilibrada na porta 27.
show interfaces xe-0/1/2 extensive | grep Error
BPDU Error: None, MAC-REWRITE Error: None, Loopback: None,
Input errors:
Errors: 2898, Drops: 0, Framing errors: 114, Runts: 0, Policed discards: 0,
L3 incompletes: 2784, L2 channel errors: 0, L2 mismatch timeouts: 0,
FIFO errors: 0, Resource errors: 0
Como os SFPs e a fibra eram completamente novos e o caminho era uma captura direta entre os nós, parece que os erros de entrada estão começando a montante das fibras, possivelmente no PDSN XCLC 27. O tráfego falhou de volta às portas pares para interromper o impacto por enquanto antes de decidir sobre as próximas etapas. A Juniper confirmou pacotes IPv4/IPv6 incorretos da porta ASR 27.
Em uma janela de manutenção posterior, as fibras foram trocadas entre as portas 23 e 27:
Mon May 11 05:33:52 2015 Internal trap notification 1024 (PortDown) card 23 port
1 port type 10G Ethernet Mon May 11 05:33:52 2015 Internal trap notification 93 (CardStandby) card 23
type 10 Gig Ethernet Line Card Mon May 11 05:34:12 2015 Internal trap notification 1024 (PortDown) card 27 port
1 port type 10G Ethernet Mon May 11 05:34:12 2015 Internal trap notification 93 (CardStandby) card 27
type 10 Gig Ethernet Line Card Mon May 11 05:34:13 2015 Internal trap notification 1025 (PortUp) card 27 port 1
port type 10G Ethernetalarm" Mon May 11 05:34:13 2015 Internal trap notification 55 (CardActive) card 27 type
10 Gig Ethernet Line Card Mon May 11 05:34:14 2015 Internal trap notification 1024 (PortDown) card 27 port
1 port type 10G Ethernet Mon May 11 05:34:14 2015 Internal trap notification 93 (CardStandby) card 27
type 10 Gig Ethernet Line Card Mon May 11 05:34:20 2015 Internal trap notification 1025 (PortUp) card 27 port 1
port type 10G Ethernet Mon May 11 05:34:21 2015 Internal trap notification 55 (CardActive) card 27 type
10 Gig Ethernet Line Card Mon May 11 05:34:58 2015 Internal trap notification 1025 (PortUp) card 23 port 1
port type 10G Ethernet Mon May 11 05:34:58 2015 Internal trap notification 55 (CardActive) card 23 type
10 Gig Ethernet Line Card
Depois de um switchover de LAG, a porta 27 continuou a enviar erros e desequilíbrio de portas.
Mon May 11 05:37:20 2015 Internal trap notification 1204 (LAGGroupDown) card:19,
port:1, partner:(007F,2C-21-72-5E-57-C0,0016) Mon May 11 05:37:20 2015 Internal trap notification 1205 (LAGGroupUp) card:19,
port:1, partner:(007F,2C-21-72-1A-B7-C0,0016) [local]NWBLWICZPN2 DO-PDSN> show port utilization table
Monday May 11 05:40:06 UTC 2015
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Txx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- ----
19/1 10G Ethernet 357 386 137 138 45 46
20/1 10G Ethernet 0 0 178 168 314 301
23/1 10G Ethernet 346 349 173 185 57 61
26/1 10G Ethernet 0 0 197 189 324 316
27/1 10G Ethernet 404 1921 147 701 49 233
28/1 10G Ethernet 0 0 207 226 299 318 Mon May 11 05:40:42 2015 Internal trap notification 39 (AAAAuthSvrUnreachable)
server 1 ip address 209.165.200.225 Mon May 11 05:41:05 2015 Internal trap notification 40 (AAAAuthSvrReachable)
server 1 ip address 209.165.200.225 Mon May 11 05:41:42 2015 Internal trap notification 39 (AAAAuthSvrUnreachable)
server 1 ip address 209.165.200.225 Mon May 11 05:42:05 2015 Internal trap notification 40 (AAAAuthSvrReachable)
server 1 ip address 209.165.200.225 Mon May 11 05:49:42 2015 Internal trap notification 39 (AAAAuthSvrUnreachable)
server 1 ip address 209.165.200.225 Mon May 11 05:50:04 2015 Internal trap notification 40 (AAAAuthSvrReachable)
server 1 ip address 209.165.200.225 Mon May 11 05:52:42 2015 Internal trap notification 39 (AAAAuthSvrUnreachable)
server 1 ip address 209.165.200.225 Mon May 11 05:53:05 2015 Internal trap notification 40 (AAAAuthSvrReachable)
server 1 ip address 209.165.200.225 Mon May 11 05:54:29 2015 Internal trap notification 1204 (LAGGroupDown) card:19,
port:1, partner:(007F,2C-21-72-1A-B7-C0,0016) Mon May 11 05:54:29 2015 Internal trap notification 1205 (LAGGroupUp) card:19,
port:1, partner:(007F,2C-21-72-5E-57-C0,0016)
As fibras foram trocadas de volta:
Mon May 11 05:59:38 2015 Internal trap notification 1024 (PortDown) card 23 port
1 port type 10G Ethernet Mon May 11 05:59:38 2015 Internal trap notification 93 (CardStandby) card 23
type 10 Gig Ethernet Line Card Mon May 11 05:59:43 2015 Internal trap notification 1024 (PortDown) card 27 port
1 port type 10G Ethernet Mon May 11 05:59:43 2015 Internal trap notification 93 (CardStandby) card 27
type 10 Gig Ethernet Line Card Mon May 11 05:59:46 2015 Internal trap notification 1025 (PortUp) card 23 port 1
port type 10G Ethernet Mon May 11 05:59:46 2015 Internal trap notification 55 (CardActive) card 23 type
10 Gig Ethernet Line Card Mon May 11 05:59:54 2015 Internal trap notification 1025 (PortUp) card 27 port 1
port type 10G Ethernet Mon May 11 05:59:54 2015 Internal trap notification 55 (CardActive) card 27 type
10 Gig Ethernet Line Card
XCLC 27 foi recolocado:
Mon May 11 06:02:02 2015 Internal trap notification 1024 (PortDown) card 27 port
1 port type 10G Ethernet Mon May 11 06:02:02 2015 Internal trap notification 60 (CardDown) card 27 type
10 Gig Ethernet Line Card Mon May 11 06:02:04 2015 Internal trap notification 7 (CardRemoved) card 27 type
10 Gig Ethernet Line Card Mon May 11 06:03:04 2015 Internal trap notification 8 (CardInserted) card 27
type 10 Gig Ethernet Line Card Mon May 11 06:03:06 2015 Internal trap notification 5 (CardUp) card 27 type 10
Gig Ethernet Line Card Mon May 11 06:03:08 2015 Internal trap notification 55 (CardActive) card 27 type 10 Gig Ethernet Line Card Mon May 11 06:03:09 2015 Internal trap notification 93 (CardStandby) card 27
type 10 Gig Ethernet Line Card Mon May 11 06:03:11 2015 Internal trap notification 1025 (PortUp) card 27 port 1
port type 10G Ethernet Mon May 11 06:03:11 2015 Internal trap notification 55 (CardActive) card 27 type
10 Gig Ethernet Line Card
O LAG foi ativado novamente e o problema ainda foi visto.
Mon May 11 06:08:21 2015 Internal trap notification 1204 (LAGGroupDown) card:19,
port:1, partner:(007F,2C-21-72-5E-57-C0,0016) Mon May 11 06:08:21 2015 Internal trap notification 1205 (LAGGroupUp) card:19,
port:1, partner:(007F,2C-21-72-1A-B7-C0,0016) Mon May 11 06:12:42 2015 Internal trap notification 39 (AAAAuthSvrUnreachable)
server 1 ip address 209.165.200.225 Mon May 11 06:13:04 2015 Internal trap notification 40 (AAAAuthSvrReachable)
server 1 ip address 209.165.200.225 Mon May 11 06:14:42 2015 Internal trap notification 39 (AAAAuthSvrUnreachable)
server 1 ip address 209.165.200.225 Mon May 11 06:15:05 2015 Internal trap notification 40 (AAAAuthSvrReachable)
server 1 ip address 209.165.200.225 Mon May 11 06:15:42 2015 Internal trap notification 39 (AAAAuthSvrUnreachable)
server 1 ip address 209.165.200.225 Mon May 11 06:16:07 2015 Internal trap notification 40 (AAAAuthSvrReachable)
server 1 ip address 209.165.200.225
A migração da PSC 11 (residente atrás da placa de linha 27) para 16 resolve o problema à medida que o LAG muda para portas pares (esperado).
Mon May 11 06:26:03 2015 Internal trap notification 1256 (MigrateStart) from
card 11 to card 16 Mon May 11 06:26:40 2015 Internal trap notification 1024 (PortDown) card 27 port
1 port type 10G Ethernet Mon May 11 06:26:40 2015 Internal trap notification 55 (CardActive) card 27 type
10 Gig Ethernet Line Card Mon May 11 06:26:41 2015 Internal trap notification 55 (CardActive) card 16 type
Packet Services Card 3 Mon May 11 06:26:41 2015 Internal trap notification 55 (CardActive) card 40 type
Redundancy Crossbar Card Mon May 11 06:26:41 2015 Internal trap notification 55 (CardActive) card 41 type
Redundancy Crossbar Card Mon May 11 06:26:41 2015 Internal trap notification 60 (CardDown) card 11 type
Packet Services Card 3 Mon May 11 06:26:42 2015 Internal trap notification 1257 (MigrateComplete) from
card 11 to card 16 Mon May 11 06:26:42 2015 Internal trap notification 1025 (PortUp) card 27 port 1
port type 10G Ethernet Mon May 11 06:27:55 2015 Internal trap notification 5 (CardUp) card 11 type
Packet Services Card 3 Mon May 11 06:27:55 2015 Internal trap notification 93 (CardStandby) card 11
type Packet Services Card 3
PSC 11 foi recolocado e reinicializado (este último deve ser desnecessário)
Mon May 11 06:39:48 2015 Internal trap notification 60 (CardDown) card 11 type
Packet Services Card 3 Mon May 11 06:40:00 2015 Internal trap notification 7 (CardRemoved) card 11 type
Packet Services Card 3 Mon May 11 06:40:42 2015 Internal trap notification 13 (CardMismatch) card 11
type Unknown Card (0x00000000) Mon May 11 06:40:45 2015 Internal trap notification 8 (CardInserted) card 11
type Packet Services Card 3 Mon May 11 06:44:57 2015 Internal trap notification 4 (CardRebootRequest) card
11 type Packet Services Card 3 Mon May 11 06:46:44 2015 Internal trap notification 7 (CardRemoved) card 11 type
Packet Services Card 3 Mon May 11 06:46:59 2015 Internal trap notification 8 (CardInserted) card 11
type Packet Services Card 3 Mon May 11 06:50:20 2015 Internal trap notification 5 (CardUp) card 11 type
Packet Services Card 3 Mon May 11 06:50:20 2015 Internal trap notification 93 (CardStandby) card 11
type Packet Services Card 3
A migração foi feita de volta ao PSC 11 e o assunto retomou. O problema parecia estar isolado do PSC 11 ligado ao XGLC 27.
Mon May 11 06:51:55 2015 Internal trap notification 1256 (MigrateStart) from
card 16 to card 11 Mon May 11 06:52:37 2015 Internal trap notification 1024 (PortDown) card 27 port
1 port type 10G Ethernet Mon May 11 06:52:37 2015 Internal trap notification 93 (CardStandby) card 40
type Redundancy Crossbar Card Mon May 11 06:52:37 2015 Internal trap notification 93 (CardStandby) card 41
type Redundancy Crossbar Card Mon May 11 06:52:37 2015 Internal trap notification 55 (CardActive) card 27 type
10 Gig Ethernet Line Card Mon May 11 06:52:38 2015 Internal trap notification 55 (CardActive) card 11 type
Packet Services Card 3 Mon May 11 06:52:38 2015 Internal trap notification 60 (CardDown) card 16 type
Packet Services Card 3 Mon May 11 06:52:38 2015 Internal trap notification 1257 (MigrateComplete) from
card 16 to card 11 Mon May 11 06:52:38 2015 Internal trap notification 1025 (PortUp) card 27 port 1
port type 10G Ethernet Mon May 11 06:53:42 2015 Internal trap notification 39 (AAAAuthSvrUnreachable)
server 1 ip address 209.165.200.225 Mon May 11 06:53:52 2015 Internal trap notification 5 (CardUp) card 16 type
Packet Services Card 3 Mon May 11 06:53:52 2015 Internal trap notification 93 (CardStandby) card 16 type Packet Services Card 3 Mon May 11 06:54:07 2015 Internal trap notification 40 (AAAAuthSvrReachable)
server 1 ip address 209.165.200.225
Uma Migração foi feita de volta ao PSC 16 para resolver o problema por enquanto até a substituição de RMA:
Mon May 11 06:56:07 2015 Internal trap notification 1256 (MigrateStart) from
card 11 to card 16 Mon May 11 06:56:43 2015 Internal trap notification 1024 (PortDown) card 27 port
1 port type 10G Ethernet Mon May 11 06:56:43 2015 Internal trap notification 55 (CardActive) card 27 type
10 Gig Ethernet Line Card Mon May 11 06:56:44 2015 Internal trap notification 55 (CardActive) card 16 type
Packet Services Card 3 Mon May 11 06:56:44 2015 Internal trap notification 55 (CardActive) card 40 type
Redundancy Crossbar Card Mon May 11 06:56:44 2015 Internal trap notification 55 (CardActive) card 41 type
Redundancy Crossbar Card Mon May 11 06:56:44 2015 Internal trap notification 60 (CardDown) card 11 type
Packet Services Card 3 Mon May 11 06:56:44 2015 Internal trap notification 1257 (MigrateComplete) from
card 11 to card 16 Mon May 11 06:56:44 2015 Internal trap notification 1025 (PortUp) card 27 port 1
port type 10G Ethernet Mon May 11 06:57:58 2015 Internal trap notification 5 (CardUp) card 11 type
Packet Services Card 3 [local]PDSN> show rct stats Monday May 11 07:08:26 UTC 2015 RCT stats Details (Last 4 Actions) Action Type From To Start Time Duration ----------------- --------- ---- ---- ------------------------ ----------
Migration Planned 11 16 2015-May-11+06:26:04.373 36.453 sec Shutdown N/A 11 0 2015-May-11+06:39:48.153 0.223 sec Migration Planned 16 11 2015-May-11+06:51:55.785 41.630 sec Migration Planned 11 16 2015-May-11+06:56:08.452 35.037 sec RCT stats Summary ----------------- Migrations = 3, Average time = 37.707 sec Switchovers = 0 [local]PDSN> show card mappings Monday May 11 07:10:22 UTC 2015 Slot Mapping Slot ----------------------------------- -------------- -------------------------- 17 None - 18 None - 19 10 Gig Ethernet Line Card <-- direct --> 3 Packet Services Card 3 20 10 Gig Ethernet Line Card <-- direct --> 4 Packet Services Card 3 21 1000 Ethernet Line Card <-- direct --> 5 Packet Services Card 3 22 None - 23 10 Gig Ethernet Line Card <-- direct --> 7 Packet Services Card 3 24 Switch Processor I/O Card <------------> 8 System Management Card 25 Switch Processor I/O Card <------------> 8 System Management Card 26 10 Gig Ethernet Line Card <-- direct --> 10 Packet Services Card 3 27 10 Gig Ethernet Line Card <--- RCCs ---> 16 Packet Services Card 3 28 10 Gig Ethernet Line Card <-- direct --> 12 Packet Services Card 3
Mas a RMA ainda não resolveu o problema.
[local]PDSN# show port utilization table verbose
Tuesday May 12 06:04:57 UTC 2015
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 333.497 331.132 345.255 347.328 354.989 358.539
20/1 10G Ethernet 0.003 0.000 0.003 0.000 0.003 0.000
23/1 10G Ethernet 361.103 334.488 353.180 354.668 363.226 363.388
26/1 10G Ethernet 0.002 0.000 0.002 0.000 0.002 0.000
27/1 10G Ethernet 309.096 1897 335.379 1892 339.740 890
28/1 10G Ethernet 0.003 0.000 0.003 0.000 0.003 0.000
37/1 1000 Ethernet 0.014 0.005 0.014 0.018 0.014 0.016
Foi necessário recarregar o chassi para resolver finalmente o problema. Nenhuma causa raiz foi determinada. Mas, o ponto aqui são as etapas de solução de problemas tomadas para tentar resolver o problema finalmente com uma recarga. Às vezes, os resultados não são o esperado originalmente com base nas etapas de solução de problemas realizadas. Pensava-se que a RMA iria, com certeza, resolver finalmente o problema, mas não o fez. No entanto, foram tomadas medidas adequadas para eliminar potenciais culpados.
O switchover de LAG falhou devido à falha do XGLC
Um switchover de LAG estranho para portas pares (19, 23, 27 => 20, 26, 28) não seria suspenso e retornaria em um minuto. Isso pode implicar em um problema com uma ou mais portas LAG não conseguirem manter a conexão. Observe a diminuição na utilização da porta, mas o conjunto de dados é limitado devido ao curto tempo que as portas pares permaneceriam ativas:
[XGWout]XGW# show port util table
Thursday April 26 07:17:31 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 895 907 906 931 939 983
20/1 10G Ethernet 0 0 20 14 6 4
21/1 1000 Ethernet 0 0 0 3 0 3
22/1 1000 Ethernet 3 46 3 46 3 47
23/1 10G Ethernet 948 946 883 917 918 956
26/1 10G Ethernet 0 0 16 11 5 3
27/1 10G Ethernet 949 950 989 934 1029 955
28/1 10G Ethernet 0 0 4 14 1 4
[XGWout]XGW# link-aggregation port switch to 20/1
Thursday April 26 07:20:20 UTC 2012
Are you sure? [Yes|No]: yes
Thursday April 26 07:20:22 UTC 2012
2012-Apr-26+07:20:22.826 [lagmgr 179050 warning] [1/0/2337 <lagmgr:0>
lagmgr_state.c:1163] [software internal system critical-info syslog] LAG group
50 (global) with master port 19/1 has changed partner from (007F,00-26-88-8E-
4F-F0,0034) to (007F,00-26-88-A7-FF-F0,0034)
Apr 26 07:21:28 kslxmsce2.msc.vzwnet.com evlogd: [local-60sec28.393]
[lagmgr 179050 warning] [1/0/2337 <lagmgr:0> lagmgr_state.c:1163]
[software internal system critical-info syslog] LAG group 50 (global)
with master port 19/1 has changed partner from
(007F,00-26-88-A7-FF-F0,0034) to (007F,00-26-88-8E-4F-F0,0034)
[XGWout]XGW# show port util table
Thursday April 26 07:20:46 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 896 917 927 965
20/1 10G Ethernet 678 526 45 33 15 11
21/1 1000 Ethernet 0 0 0 3 0 3
22/1 1000 Ethernet 3 45 3 46 3 46
23/1 10G Ethernet 0 0 881 898 903 943
26/1 10G Ethernet 627 442 16 11 5 3
27/1 10G Ethernet 0 0 874 850 980 914
28/1 10G Ethernet 138 436 15 47 5 15
[XGWout]XGW# show port util table
Thursday April 26 07:24:58 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 847 911 742 719 860 874
20/1 10G Ethernet 0 0 137 104 52 39
21/1 1000 Ethernet 0 0 0 4 0 4
22/1 1000 Ethernet 3 48 3 47 3 47
23/1 10G Ethernet 840 804 710 718 837 862
26/1 10G Ethernet 0 0 133 95 50 35
27/1 10G Ethernet 833 814 671 697 883 856
28/1 10G Ethernet 0 0 33 92 12 35
Para fazer troubleshooting adicional, uma das portas do LAG (27/1) foi desabilitada, forçando o switchover do LAG a permanecer no lugar e não a voltar (o sistema não mudará a menos que as portas para comutação tenham uma capacidade mais alta do que as portas atualmente ativas). Como pode ser visto abaixo, a utilização da porta cai significativamente nas portas EVEN. Quando a porta 27/1 é reativada, o LAG volta às portas ímpares sem intervenção devido às portas EVEN terem mais capacidade.
[local]XGW# show port util table
Thursday April 26 08:53:47 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 670 639 654 609 590 556
20/1 10G Ethernet 0 0 0 0 0 0
21/1 1000 Ethernet 0 20 0 3 0 2
22/1 1000 Ethernet 3 41 3 40 7 83
23/1 10G Ethernet 598 676 574 662 535 585
26/1 10G Ethernet 0 0 0 0 0 0
27/1 10G Ethernet 662 612 658 608 611 585
28/1 10G Ethernet 0 0 0 0 0 0
[local]XGW(config)# port ether 27/1
Thursday April 26 08:53:58 UTC 2012
[local]XGW(config-port-27/1)# shut
Thursday April 26 08:54:02 UTC 2012
Thu Apr 26 08:54:02 2012 Internal trap notification 35 (PortLinkDown) card 27
port 1 ifindex 453050368
Thu Apr 26 08:54:02 2012 Internal trap notification 1024 (PortDown) card 27 port 1 ifindex 453050368port type 10G Ethernet
Thu Apr 26 08:54:02 2012 Internal trap notification 93 (CardStandby) card 27
[local]XGW# show port util table
Thursday April 26 08:54:26 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 634 596 625 591
20/1 10G Ethernet 371 278 27 19 9 6
21/1 1000 Ethernet 0 0 0 3 0 2
22/1 1000 Ethernet 3 39 3 40 3 86
23/1 10G Ethernet 0 0 573 654 572 627
26/1 10G Ethernet 346 268 0 0 0 0
28/1 10G Ethernet 107 233 0 0 0 0
[local]XGW# show port util table
Thursday April 26 08:57:11 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 375 349 552 520
20/1 10G Ethernet 445 342 203 156 67 52
21/1 1000 Ethernet 0 0 0 3 0 2
22/1 1000 Ethernet 4 50 3 42 3 40
23/1 10G Ethernet 0 0 223 260 465 515
26/1 10G Ethernet 390 323 215 169 71 56
28/1 10G Ethernet 214 302 84 148 28 49
[local]XGW# show port util table
Thursday April 26 09:00:18 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 0 0 428 401
20/1 10G Ethernet 414 339 410 320 145 113
21/1 1000 Ethernet 0 0 0 2 0 3
22/1 1000 Ethernet 4 56 3 48 3 42
23/1 10G Ethernet 0 0 0 0 345 391
26/1 10G Ethernet 373 307 391 312 147 117
28/1 10G Ethernet 244 287 203 292 71 106
[local]XGW# show port util table
Thursday April 26 09:08:33 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 0 0 37 36
20/1 10G Ethernet 346 302 394 315 358 284
21/1 1000 Ethernet 0 11 0 4 0 3
22/1 1000 Ethernet 4 86 4 80 4 59
23/1 10G Ethernet 0 0 0 0 36 41
26/1 10G Ethernet 331 278 354 307 339 281
28/1 10G Ethernet 252 253 245 273 203 255
[local]XGW# config
Thursday April 26 09:08:43 UTC 2012
[local]XGW(config)# port ether 27/1
Thursday April 26 09:08:49 UTC 2012
[local]XGW(config-port-27/1)# no shut
Thursday April 26 09:08:53 UTC 2012
Thu Apr 26 09:08:53 2012 Internal trap notification 55 (CardActive) card 27
Thu Apr 26 09:08:53 2012 Internal trap notification 36 (PortLinkUp) card 27 port
1 ifindex 453050369
Thu Apr 26 09:08:53 2012 Internal trap notification 1025 (PortUp) card 27 port 1
ifindex 453050369port type 10G Ethernet
[local]XGW# show port util table
Thursday April 26 09:10:11 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 698 656 0 0 0 0
20/1 10G Ethernet 0 0 370 300 395 315
21/1 1000 Ethernet 0 0 0 3 0 3
22/1 1000 Ethernet 3 85 4 88 4 66
23/1 10G Ethernet 618 702 0 0 0 0
26/1 10G Ethernet 0 0 310 270 357 298
27/1 10G Ethernet 681 624 44 36 14 12
28/1 10G Ethernet 0 0 235 251 227 27
Não é óbvio sobre qual porta o problema existe, e a utilização de Tx não é tão irregular.
"show port npu counters" mostra claramente um problema com o contador de erros "Cabeçalho IPv4 defeituoso" aumentando em uma taxa alta (e não deveria estar acontecendo de todo), mas como essa é uma implementação LAG, baseada na implementação atual, todos os contadores são cumulativos para todas as portas LAG em um grupo LAG, e portanto não é possível determinar qual porta está tendo o problema - ela pode ser qualquer uma delas. (as estatísticas de todas as portas combinadas são encontradas na porta principal, nesse caso 19/1 - as estatísticas de todas as portas LAG individuais do grupo LAG NÃO têm significado e devem ser ignoradas).
Mas o comando de suporte técnico "show npu stats debug all_pacs" captura estatísticas de NPU com base em PSC, e o seguinte mostra que o problema está claramente "associado" ao PSC 12 e ao seu XGLC 28 (padrão) conectado:
******** show npu stats debug all_pacs *******
Thursday April 26 09:01:41 UTC 2012
Line 524176: debug-pkt-drop-invalid-iphdr 3601919
Line 524245: debug-pkt-drop-invalid-iphdr 265
Line 524303: debug-pkt-drop-invalid-iphdr 141
Line 524407: debug-pkt-drop-invalid-iphdr 3468928
Line 524471: debug-pkt-drop-invalid-iphdr 216
Line 524529: debug-pkt-drop-invalid-iphdr 3701708
Line 524595: debug-pkt-drop-invalid-iphdr 6501414 <= NPU debug
stats for slot 12
******** show port npu counters *******
Thursday April 26 09:01:40 UTC 2012
Counters for port 19/1
Counter Rx Frames Rx Bytes Tx Frames Tx Bytes
-------------------- ------------- --------------- ------------- ---------------
Bad IPv4 header 6493067 2820637429 n/a n/a
******** show npu stats debug all_pacs *******
Thursday April 26 09:03:36 UTC 2012
Line 985303: debug-pkt-drop-invalid-iphdr 3601919
Line 985372: debug-pkt-drop-invalid-iphdr 292
Line 985430: debug-pkt-drop-invalid-iphdr 141
Line 985534: debug-pkt-drop-invalid-iphdr 3468928
Line 985598: debug-pkt-drop-invalid-iphdr 226
Line 985656: debug-pkt-drop-invalid-iphdr 3701708
Line 985722: debug-pkt-drop-invalid-iphdr 7190387 <= NPU debug
stats for slot 12 (INCREASING)
******** show port npu counters *******
Thursday April 26 09:03:35 UTC 2012
Counters for port 19/1
Counter Rx Frames Rx Bytes Tx Frames Tx Bytes
-------------------- ------------- --------------- ------------- ---------------
Bad IPv4 header 7182088 3089244876 n/a n/a
A questão ainda é qual placa está realmente causando esse problema, o PSC 12 conectado ao XGLC 28 ou ao próprio XGLC 28?
Normalmente, os problemas de NPU seriam resolvidos com a migração do PSC 12 para o XGLC 28, o que implica um problema com o PSC. Quando isso foi tentado em uma janela de manutenção posterior, ele não resolveu o problema, assim como uma redefinição da placa de linha e uma redefinição do nbomgr.
Aqui está a saída da solução de problemas da reinicialização do nbomgr, redefinição do XGLC 28 e migração do PSC 12 a 16, a última das quais resulta na conexão do PSC 16 ao XGLC 28 e, portanto, elimina o PSC 12 sendo o problema. Verificações para o aumento de debug-pkt-drop-invalid-iphdr foram feitas entre cada uma das etapas para confirmar se o problema não foi resolvido. O desligamento de uma das portas LAG (27/1) foi feito para forçar um switchover de LAG a permanecer comutado para fins de coleta de dados, e não é permitido que o LAG troque de volta quando terminar o teste.
[local]XGW# show port util table
Saturday April 28 05:03:49 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 2311 2395 2384 2415 2384 2402
20/1 10G Ethernet 0 0 0 0 0 0
21/1 1000 Ethernet 0 9 0 9 0 9
22/1 1000 Ethernet 4 70 4 77 4 73
23/1 10G Ethernet 2230 2224 2222 2293 2202 2268
26/1 10G Ethernet 0 0 0 0 0 0
27/1 10G Ethernet 2496 2433 2505 2427 2440 2381
28/1 10G Ethernet 0 0 0 0 0 0
[local]XGW(config)# port ether 27/1
Saturday April 28 05:04:44 UTC 2012
[local]XGW(config-port-27/1)# shutdown
Saturday April 28 05:04:50 UTC 2012
Sat Apr 28 05:04:50 2012 Internal trap notification 35 (PortLinkDown) card 27
port 1 ifindex 453050368
Sat Apr 28 05:04:50 2012 Internal trap notification 1024 (PortDown) card 27 port
1 ifindex 453050368port type 10G Ethernet
Sat Apr 28 05:04:50 2012 Internal trap notification 93 (CardStandby) card 27
[local]XGW# show port table all
Saturday April 28 05:04:59 UTC 2012
Port Type Admin Oper Link State Redundant
----- ------------------------ -------- ---- ---- ---------------- -----------
19/1 10G Ethernet Enabled - Up - None ~19/1
Untagged Enabled Up - Active -
20/1 10G Ethernet Enabled Up Up Active None +19/1
[local]XGW# show port util table
Saturday April 28 05:05:42 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 2150 2182 2311 2333
20/1 10G Ethernet 1488 1064 0 0 0 0
21/1 1000 Ethernet 0 0 0 9 0 10
22/1 1000 Ethernet 4 70 4 72 4 73
23/1 10G Ethernet 0 0 2163 2225 2182 2251
26/1 10G Ethernet 1353 989 94 68 31 22
28/1 10G Ethernet 372 1042 14 41 4 13
[local]XGW# show npu stats debug all-pacs
Saturday April 28 05:07:28 UTC 2012
NPU debug stats for slot 12
debug-pkt-drop-invalid-iphdr 10786357
[local]XGW# show npu stats debug all-pacs
Saturday April 28 05:07:47 UTC 2012
NPU debug stats for slot 12
debug-pkt-drop-invalid-iphdr 10966718
[local]XGW# task kill facility npumgr instance 12
Saturday April 28 05:33:18 UTC 2012
Sat Apr 28 05:33:18 2012 Internal trap notification 73 (ManagerFailure) facility
npumgr instance 12 card 12 cpu 1
Sat Apr 28 05:33:18 2012 Internal trap notification 150 (TaskFailed) facility
npumgr instance 12 on card 12 cpu 1
Sat Apr 28 05:33:26 2012 Internal trap notification 35 (PortLinkDown) card 28
port 1 ifindex 469827585
Sat Apr 28 05:33:26 2012 Internal trap notification 1024 (PortDown) card 28 port
1 ifindex 469827585port type 10G Ethernet
Sat Apr 28 05:33:26 2012 Internal trap notification 36 (PortLinkUp) card 28 port
1 ifindex 469827585
Sat Apr 28 05:33:26 2012 Internal trap notification 1025 (PortUp) card 28 port 1
ifindex 469827585port type 10G Ethernet
[local]XGW# show port util table
Saturday April 28 05:34:24 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 0 0 0 0
20/1 10G Ethernet 894 723 837 661 935 728
21/1 1000 Ethernet 0 36 0 7 0 7
22/1 1000 Ethernet 4 127 4 78 4 79
23/1 10G Ethernet 0 0 0 0 0 0
26/1 10G Ethernet 906 647 780 571 865 644
28/1 10G Ethernet 356 649 0 0 0 0
[local]XGW# show npu stats debug slot 12
Saturday April 28 05:35:16 UTC 2012
NPU debug stats for slot 12
debug-pkt-drop-invalid-iphdr 540273
[local]XGW# show npu stats debug slot 12
Saturday April 28 05:35:38 UTC 2012
NPU debug stats for slot 12
debug-pkt-drop-invalid-iphdr 692665
Sat Apr 28 05:38:49 2012 Internal trap notification 35 (PortLinkDown) card 28
port 1 ifindex 469827584
Sat Apr 28 05:38:49 2012 Internal trap notification 1024 (PortDown) card 28 port
1 ifindex 469827584port type 10G Ethernet
Sat Apr 28 05:38:49 2012 Internal trap notification 35 (PortLinkDown) card 28
port 1 ifindex 469827585
Sat Apr 28 05:38:49 2012 Internal trap notification 60 (CardDown) card 28
Sat Apr 28 05:38:51 2012 Internal trap notification 5 (CardUp) card 28
Sat Apr 28 05:38:51 2012 Internal trap notification 4 (CardRebootRequest) card 28
Sat Apr 28 05:38:51 2012 Internal trap notification 84 (ServiceLossLC) Slots 28
and 44 has configured for card type 10 Gig Ethernet
Line Card, but neither active
Sat Apr 28 05:38:53 2012 Internal trap notification 55 (CardActive) card 28
Sat Apr 28 05:38:53 2012 Internal trap notification 1111 (ServiceLossLCClear)
Slots 28 and 44 has configured for card type 10 Gig Et
hernet Line Card, one of them is active now
Sat Apr 28 05:38:53 2012 Internal trap notification 93 (CardStandby) card 28
Sat Apr 28 05:38:55 2012 Internal trap notification 36 (PortLinkUp) card 28 port
1 ifindex 469827584
Sat Apr 28 05:38:55 2012 Internal trap notification 1025 (PortUp) card 28 port 1
ifindex 469827584port type 10G Ethernet
Sat Apr 28 05:38:55 2012 Internal trap notification 55 (CardActive) card 28
Sat Apr 28 05:38:55 2012 Internal trap notification 36 (PortLinkUp) card 28 port
1 ifindex 469827585
Sat Apr 28 05:38:55 2012 Internal trap notification 1025 (PortUp) card 28 port 1
ifindex 469827585port type 10G Ethernet
[local]XGW# show port util table
Saturday April 28 05:39:47 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 0 0 0 0
20/1 10G Ethernet 236 174 688 544 816 637
21/1 1000 Ethernet 0 17 0 7 0 7
22/1 1000 Ethernet 3 29 3 69 4 75
23/1 10G Ethernet 0 0 0 0 0 0
26/1 10G Ethernet 201 156 779 568 810 597
28/1 10G Ethernet 114 181 0 0 0 0
[local]XGW# show npu stats debug slot 12
Saturday April 28 05:40:04 UTC 2012
NPU debug stats for slot 12
debug-pkt-drop-invalid-iphdr 2219078
[local]XGW# show npu stats debug slot 12
Saturday April 28 05:40:15 UTC 2012
NPU debug stats for slot 12
debug-pkt-drop-invalid-iphdr 2289375
[local]XGW# show port util table
Saturday April 28 05:41:08 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 0 0 0 0
20/1 10G Ethernet 769 545 682 528 804 625
21/1 1000 Ethernet 0 0 0 6 0 6
22/1 1000 Ethernet 3 70 3 63 4 73
23/1 10G Ethernet 0 0 0 0 0 0
26/1 10G Ethernet 723 560 634 480 760 561
28/1 10G Ethernet 317 585 81 141 27 47
[local]XGW# show npu stat debug slot 12 clear
Saturday April 28 05:41:59 UTC 2012
NPU debug stats for slot 12
debug-pkt-drop-invalid-iphdr 2980554
[local]XGW# show npu stat debug slot 12 clear
Saturday April 28 05:42:10 UTC 2012
debug-pkt-drop-invalid-iphdr 60103
Sat Apr 28 05:42:43 2012 Internal trap notification 16 (PACMigrateStart) from
card 12 to card 16
Sat Apr 28 05:43:55 2012 Internal trap notification 17 (PACMigrateComplete) from
card 12 to card 16
Sat Apr 28 05:44:45 2012 Internal trap notification 5 (CardUp) card 12
Sat Apr 28 05:44:45 2012 Internal trap notification 93 (CardStandby) card 12
[local]XGW# show npu stat debug slot 16 clear
Saturday April 28 05:44:35 UTC 2012
NPU debug stats for slot 16
debug-pkt-drop-invalid-iphdr 14650
[local]XGW# show npu stat debug slot 16 clear
Saturday April 28 05:45:48 UTC 2012
NPU debug stats for slot 16
debug-pkt-drop-invalid-iphdr 70940
Sat Apr 28 05:45:20 2012 Internal trap notification 126 (SRPSwitchoverInitiated) vpn SRP ipaddr 10.209.74.164
Sat Apr 28 05:45:21 2012 Internal trap notification 121 (SRPStandby) vpn SRP
ipaddr 10.209.74.164 rtmod 2
[local]XGW(config)# port ether 27/1
Saturday April 28 05:52:27 UTC 2012
[local]XGW(config-port-27/1)# no shut
Saturday April 28 05:52:35 UTC 2012
Sat Apr 28 05:52:35 2012 Internal trap notification 36 (PortLinkUp) card 27 port
1 ifindex 453050368
Sat Apr 28 05:52:35 2012 Internal trap notification 1025 (PortUp) card 27 port 1
ifindex 453050368port type 10G Ethernet
Sat Apr 28 05:52:35 2012 Internal trap notification 55 (CardActive) card 27
Sat Apr 28 05:52:35 2012 Internal trap notification 36 (PortLinkUp) card 27 port
1 ifindex 453050369
Sat Apr 28 05:52:35 2012 Internal trap notification 1025 (PortUp) card 27 port 1
ifindex 453050369port type 10G Ethernet
[local]XGW# link-aggregation port switch to 19/1
Saturday April 28 05:56:39 UTC 2012
Are you sure? [Yes|No]: yes
Saturday April 28 05:56:42 UTC 2012
Sat Apr 28 07:09:46 2012 Internal trap notification 120 (SRPActive) vpn SRP
ipaddr 10.209.74.164 rtmod 2
[local]XGW# show card table
Saturday April 28 06:06:09 UTC 2012
Slot Card Type Oper State SPOF Attach
----------- -------------------------------- ------------- ---- ------
1: PSC Packet Services Card 2 Active No - -
2: PSC Packet Services Card 2 Active No - -
3: PSC Packet Services Card 2 Active No 19 -
4: PSC Packet Services Card 2 Active No 20 -
5: PSC Packet Services Card 2 Active No 21 37
6: PSC Packet Services Card 2 Active No 22 38
7: PSC Packet Services Card 2 Active No 23 -
8: SMC System Management Card Active No 24 25
9: SMC System Management Card Standby - - -
10: PSC Packet Services Card 2 Active No 26 -
11: PSC Packet Services Card 2 Active No 27 -
12: PSC Packet Services Card 2 Standby - - -
13: PSC Packet Services Card 2 Active No - -
14: PSC Packet Services Card 2 Active No - -
15: PSC Packet Services Card 2 Active No - -
16: PSC Packet Services Card 2 Active No 28 -
A conclusão improvável acabou sendo uma placa de linha defeituosa, que, quando substituída, resolveu o problema.
Note: quando XGLC 28 foi substituído, o sistema reconectou o XGLC substituto ao Demux PSC 1 em vez do PSC 16 previamente anexado. A tarefa Card-Slot-Port (CSP) tem o direito de anexar um XGLC a qualquer PSC gratuito que desejar, neste caso PSC 1 em vez de PSC 16. Como resultado, o teste de XGLC 28 foi efetuado contra PSC 1 e não PSC 16 ou PSC 12, mas, nesta altura, com base em todos os testes efetuados até agora (isto é, a questão acontece se está ligado ao PSC 12 ou PSC 16), concluiu-se que as falhas se devem a XGLC 28 e não a nenhuma PSC.
Sun Apr 29 05:17:25 2012 Internal trap notification 60 (CardDown) card 28
Sun Apr 29 05:17:25 2012 Internal trap notification 7 (CardRemoved) card 28
Sun Apr 29 05:19:56 2012 Internal trap notification 8 (CardInserted) card 28
Sun Apr 29 05:19:58 2012 Internal trap notification 5 (CardUp) card 28
Sun Apr 29 05:20:00 2012 Internal trap notification 55 (CardActive) card 28
[local]XGW# show port util table
Sunday April 29 05:23:53 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 1817 1770 1852 1868 1899 1929
20/1 10G Ethernet 0 0 0 0 0 0
21/1 1000 Ethernet 0 0 0 7 0 7
22/1 1000 Ethernet 3 55 3 58 3 59
23/1 10G Ethernet 1685 1867 1718 1858 1782 1868
26/1 10G Ethernet 0 0 0 0 0 0
27/1 10G Ethernet 1982 1866 1982 1846 2022 1927
28/1 10G Ethernet 0 0 0 0 0 0
[local]XGW# link-aggregation port switch to 20/1
Sunday April 29 05:33:18 UTC 2012
Are you sure? [Yes|No]: yes
Sunday April 29 05:33:21 UTC 2012
2012-Apr-29+05:33:21.124 [lagmgr 179050 warning] [1/0/2337 <lagmgr:0>
lagmgr_state.c:1163] [software internal system critical-info syslog] LAG group
50 (global) with master port 19/1 has changed partner from (007F,00-26-88-8E-
4F-F0,0034) to (007F,00-26-88-A7-FF-F0,0034)
[local]LENYKSCJPNR XGW# show port util table
Sunday April 29 05:34:05 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 1724 1688 1795 1783
20/1 10G Ethernet 1785 1737 112 108 37 36
21/1 1000 Ethernet 0 29 0 8 0 7
22/1 1000 Ethernet 3 55 3 56 3 57
23/1 10G Ethernet 0 0 1430 1522 1609 1720
26/1 10G Ethernet 1632 1790 89 95 29 31
27/1 10G Ethernet 0 0 1719 1669 1865 1780
28/1 10G Ethernet 1840 1738 0 0 0 0
[local]XGW# show npu stats debug slot 1
Sunday April 29 05:34:18 UTC 2012
NPU debug stats for slot 1
debug-pkt-drop-invalid-iphdr 9
[local]XGW# show card table
Sunday April 29 05:34:27 UTC 2012
Slot Card Type Oper State SPOF Attach
----------- -------------------------------- ------------- ---- ------
1: PSC Packet Services Card 2 Active No 28 -
2: PSC Packet Services Card 2 Active No - -
3: PSC Packet Services Card 2 Active No 19 -
4: PSC Packet Services Card 2 Active No 20 -
5: PSC Packet Services Card 2 Active No 21 37
6: PSC Packet Services Card 2 Active No 22 38
7: PSC Packet Services Card 2 Active No 23 -
8: SMC System Management Card Active No 24 25
9: SMC System Management Card Standby - - -
10: PSC Packet Services Card 2 Active No 26 -
11: PSC Packet Services Card 2 Active No 27 -
12: PSC Packet Services Card 2 Standby - - -
13: PSC Packet Services Card 2 Active No - -
14: PSC Packet Services Card 2 Active No - -
15: PSC Packet Services Card 2 Active No - -
16: PSC Packet Services Card 2 Active No - -
[local]LENYKSCJPNR XGW# show port npu count 28/1
Sunday April 29 05:35:39 UTC 2012
Counters for port 28/1
Counter Rx Frames Rx Bytes Tx Frames Tx Bytes
-------------------- ------------- --------------- ------------- ---------------
Bad IPv4 header 0 0 n/a n/a
[local]XGW# show npu stats debug all-pac
Sunday April 29 05:36:05 UTC 2012
NPU debug stats for slot 1
debug-pkt-drop-invalid-iphdr 32
[local]XGW# show npu stats debug all-pac | grep debug-pkt-drop-invalid-iphdr
Sunday April 29 05:36:47 UTC 2012
debug-pkt-drop-invalid-iphdr 41 <== PSC 1
debug-pkt-drop-invalid-iphdr 3722008
debug-pkt-drop-invalid-iphdr 920
debug-pkt-drop-invalid-iphdr 141
debug-pkt-drop-invalid-iphdr 3579872
debug-pkt-drop-invalid-iphdr 47
debug-pkt-drop-invalid-iphdr 3817343
[local]XGW# show port util table
Sunday April 29 05:37:52 UTC 2012
------ Average Port Utilization (in mbps) ------
Port Type Current 5min 15min
Rx Tx Rx Tx Rx Tx
----- ------------------------ ------- ------- ------- ------- ------- -------
19/1 10G Ethernet 0 0 301 297 1300 1280
20/1 10G Ethernet 1686 1603 1490 1454 496 484
21/1 1000 Ethernet 0 0 0 6 0 7
22/1 1000 Ethernet 3 53 3 55 3 55
23/1 10G Ethernet 0 0 448 475 1265 1349
26/1 10G Ethernet 1539 1692 1383 1460 461 486
27/1 10G Ethernet 0 0 252 246 1334 1288
28/1 10G Ethernet 1758 1705 1413 1390 471 463
FeedbackContate a Cisco
- Abrir um caso de suporte
- (É necessário um Contrato de Serviço da Cisco)