Pomoc UPS "automatyczne" odłączanie się

Paweł Tołoczko

Enterprise Admin...
Q's Architect
8 Listopad 2013
939
270
113
43
Cork
QNAP
TS-x70
Ethernet
1 GbE
Jak w temacie.
Chcialbym, aby posiadacze UPSow APC (innych tez :) ) - ktore znjduja sie na liscie kompatyblnosci Qnap, a zachowuja sie dziwnie zostaly tu wymienione.
Co rozumiem przez dziwne zachowanie:
moj np. Poprawni jest rozpoznawany, wszystko niby OK, ale po paru dniach .. zostaje przez system zgloszony jako odlaczony (kabel USB).
Co chcialbym zeby bylo wymienione w temacie:

Model Serwera:
Wersja Firmware:
Model UPSa:
Zachowanie:
Mozliwe kroki debug - co zostalo zrobione, by przywrocic polaczenie.

TO ja zaczne:

Model Serwera: Ts-870
Wersja Firmware: 4.1.3 2015.03.13
Model UPSa: APC (American Power Conversion) 1500G
Zachowanie: samoistne odlaczenie (odmontowanie) urzadzenia.
20150326194836.jpg

Debug:
1. odlaczenie kabla i ponowne podlaczenie do tego samego portu USB (USB 2.0 tyl, pierwsze gniazzdo on portu ethernet) - kicha nei dziala
2. podlaczenie do 2 portu USB 2.0 - nie dziala
3. reboot i zostawienie podlaczonego kabla do 1 gniazda (gdzie byl orginalnie) - nie dziala
4. wlozenie do 2 portu USB 2.0 - zostal znaleziony przez system - dziala
5. wlozenie do 1 portu USB 2.0 - gdzie byl od samego poczatku - dziala :)
 
Tak było jeszcze jakiś czas temu. Nawet pisałem o tym na forum bo wku.. mnie to niesamowicie. Teraz po tych ostatnich update'ach jakoś się ponownie spina więc nie ruszam. Na bank wtyczka i kabel jest OK, bo mam drugiego NAS'a konkurencyjnej firmy i tam nic się nie dzieje.

Chcesz to prześledzić ? Bo ja już przestałem zwracać na to uwagę - ale mogę teraz pilnować logów, może coś wyplują po takim resecie połączenia z upsem.
 
Tak, postaram sie zwrocic uwage jak to u mnie sie zachowuje - poki co bombarduje Support Emailami ;p wytykajac, ze to ONI maj problem a nie ja ;-)
Kod:
[~] # dmesg
>[  57.853121] md: Resyncing done: md256
[  57.944073] RAID1 conf printout:
[  57.944075]  --- wd:2 rd:2
[  57.944076]  disk 0, wo:0, o:1, dev:sdd2
[  57.944077]  disk 1, wo:0, o:1, dev:sdc2
[  57.969082] RAID1 conf printout:
[  57.969086]  --- wd:2 rd:2
[  57.969088]  disk 0, wo:0, o:1, dev:sdd2
[  57.969091]  disk 1, wo:0, o:1, dev:sdc2
[  57.969092] RAID1 conf printout:
[  57.969094]  --- wd:2 rd:2
[  57.969096]  disk 0, wo:0, o:1, dev:sdd2
[  57.969098]  disk 1, wo:0, o:1, dev:sdc2
[  57.969099] RAID1 conf printout:
[  57.969101]  --- wd:2 rd:2
[  57.969103]  disk 0, wo:0, o:1, dev:sdd2
[  57.969105]  disk 1, wo:0, o:1, dev:sdc2
[  57.969106] RAID1 conf printout:
[  57.969108]  --- wd:2 rd:2
[  57.969110]  disk 0, wo:0, o:1, dev:sdd2
[  57.969112]  disk 1, wo:0, o:1, dev:sdc2
[  57.969113] RAID1 conf printout:
[  57.969114]  --- wd:2 rd:2
[  57.969116]  disk 0, wo:0, o:1, dev:sdd2
[  57.969118]  disk 1, wo:0, o:1, dev:sdc2
[  57.969120] RAID1 conf printout:
[  57.969121]  --- wd:2 rd:2
[  57.969123]  disk 0, wo:0, o:1, dev:sdd2
[  57.969125]  disk 1, wo:0, o:1, dev:sdc2
[  75.994363] e1000e 0000:00:19.0: irq 49 for MSI/MSI-X
[  76.095275] e1000e 0000:00:19.0: irq 49 for MSI/MSI-X
[  76.180792] 8021q: adding VLAN 0 to HW filter on device eth1
[  76.404120] 8021q: adding VLAN 0 to HW filter on device eth2
[  76.630928] 8021q: adding VLAN 0 to HW filter on device eth3
[  78.984886] e1000e: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control:  Rx/Tx
[  79.324457] igb: eth2 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/  TX
[  79.386634] e1000e: eth1 NIC Link is Up 1000 Mbps Full Duplex, Flow Control:  Rx/Tx
[  79.763102] igb: eth3 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/  TX
[  100.191882] e1000e: eth1 NIC Link is Up 1000 Mbps Full Duplex, Flow Control:  Rx/Tx
[  100.653440] e1000e: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control:  Rx/Tx
[  100.824133] igb: eth2 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/  TX
[  100.993998] igb: eth3 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/  TX
[  118.331040] warning: `proftpd' uses 32-bit capabilities (legacy support in us  e)
[  138.387301] rule type=2, num=0
[  138.450007] Loading iSCSI transport class v2.0-871.
[  138.451636] iscsi: registered transport (tcp)
[  142.499870] PPP generic driver version 2.4.2
[  142.501339] PPP MPPE Compression module registered
[  142.501741] PPP BSD Compression module registered
[  142.502156] PPP Deflate Compression module registered
[  142.504546] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[  142.506862] ip_tables: (C) 2000-2006 Netfilter Core Team
[  142.651706] tun: Universal TUN/TAP device driver, 1.6
[  142.651708] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[  143.370319] Set msys_nodify as 31743
[  172.419895] NET: Registered protocol family 10
[  172.424090] Bridge firewalling registered
[  172.516763] device eth3 entered promiscuous mode
[  172.518331] br0: port 1(eth3) entered forwarding state
[  172.518337] br0: port 1(eth3) entered forwarding state
[  174.057317] device virbr0-nic entered promiscuous mode
[  174.094136] device virbr0-nic left promiscuous mode
[  174.094139] virbr0: port 1(virbr0-nic) entered disabled state
[  175.220600] [fintek_proc_write] cir enable
[  175.220604] [fintek_enable_cir]
[  175.220638] fintek_cir: fintek-cir: Dump CIR logical device registers:
[  175.220646] fintek_cir:  * CR CIR BASE ADDR: 0x0
[  175.220649] fintek_cir:  * CR CIR IRQ NUM:  0x0
[  175.220652] fintek_cir: fintek-cir: Dump CIR registers:
[  175.220655] fintek_cir:  * STATUS:  0x0
[  175.220658] fintek_cir:  * CONTROL:  0xf6
[  175.220661] fintek_cir:  * RX_DATA:  0xed
[  175.220663] fintek_cir:  * TX_CONTROL: 0xf6
[  175.220665] fintek_cir:  * TX_DATA:  0xcc
[  176.805368] udevd[12829]: starting version 175
[  178.729799] ALSA sound/pci/hda/patch_hdmi.c:772 HDMI hot plug event: Codec=3  Pin=6 Presence_Detect=0 ELD_Valid=1
[  178.729845] ALSA sound/pci/hda/patch_hdmi.c:990 HDMI status: Codec=3 Pin=6 Pr  esence_Detect=0 ELD_Valid=0
[  178.867454] ALSA sound/pci/hda/patch_hdmi.c:772 HDMI hot plug event: Codec=3  Pin=6 Presence_Detect=1 ELD_Valid=1
[  178.867504] ALSA sound/pci/hda/patch_hdmi.c:990 HDMI status: Codec=3 Pin=6 Pr  esence_Detect=1 ELD_Valid=1
[  178.867608] ALSA sound/pci/hda/hda_eld.c:368 HDMI: 0 ELD data
[  179.168137] ALSA sound/pci/hda/patch_hdmi.c:990 HDMI status: Codec=3 Pin=6 Pr  esence_Detect=1 ELD_Valid=1
[  179.171665] ALSA sound/pci/hda/hda_eld.c:447 HDMI: detected monitor CAT-6066  at connection type HDMI
[  179.171668] ALSA sound/pci/hda/hda_eld.c:452 HDMI: available speakers: FL/FR  LFE FC RL/RR RC FLC/FRC RLC/RRC
[  179.171671] ALSA sound/pci/hda/hda_eld.c:426 HDMI: supports coding type LPCM:  channels = 2, rates = 32000 44100 48000, bits = 16 20 24
[  180.963360] input: uinput-remotepad-rel_x_y as /devices/virtual/input/input11
[  183.447286] input: uinput-QTV as /devices/virtual/input/input12
[  184.037235] eth3: no IPv6 routers present
[  187.512408] br0: port 1(eth3) entered forwarding state
[  217.088980] usb 2-1.2: USB disconnect, device number 3
[  230.317929] usb 3-1: new full-speed USB device number 2 using etxhci_hcd_1405  22
[  230.348403] usb 3-1: ep 0x81 - rounding interval to 512 microframes, ep desc  says 800 microframes
[  230.519393] generic-usb 0003:051D:0002.0002: hiddev0: USB HID v1.00 Device [A  merican Power Conversion Back-UPS RS 1500G FW:878.L4 .I USB FW:L4 ] on usb-0000:  06:00.0-1/input0
[  233.480015] usb 3-1: ep 0x81 - rounding interval to 512 microframes, ep desc  says 800 microframes
[  247.037187] usb 3-1: USB disconnect, device number 2
[  251.366988] usb 3-2: new full-speed USB device number 3 using etxhci_hcd_1405  22
[  251.397583] usb 3-2: ep 0x81 - rounding interval to 512 microframes, ep desc  says 800 microframes
[  251.568406] generic-usb 0003:051D:0002.0003: hiddev0: USB HID v1.00 Device [A  merican Power Conversion Back-UPS RS 1500G FW:878.L4 .I USB FW:L4 ] on usb-0000:  06:00.0-2/input0
[  254.497056] usb 3-2: ep 0x81 - rounding interval to 512 microframes, ep desc  says 800 microframes
[  269.428258] usb 3-2: USB disconnect, device number 3
[  283.149375] usb 3-1: new full-speed USB device number 4 using etxhci_hcd_1405  22
[  283.180446] usb 3-1: ep 0x81 - rounding interval to 512 microframes, ep desc  says 800 microframes
[  283.351291] generic-usb 0003:051D:0002.0004: hiddev0: USB HID v1.00 Device [A  merican Power Conversion Back-UPS RS 1500G FW:878.L4 .I USB FW:L4 ] on usb-0000:  06:00.0-1/input0
[  286.278918] usb 3-1: ep 0x81 - rounding interval to 512 microframes, ep desc  says 800 microframes
[ 1107.364274] device vnet0 entered promiscuous mode
[ 1107.373011] br0: port 2(vnet0) entered forwarding state
[ 1107.373015] br0: port 2(vnet0) entered forwarding state
[ 1118.780040] vnet0: no IPv6 routers present
[ 1122.375144] br0: port 2(vnet0) entered forwarding state
[ 1143.897453] kvm: 14407: cpu0 unhandled rdmsr: 0x606
[20692.457933] etxhci_hcd_140522 0000:06:00.0: WARN Event TRB for slot 1 ep 2 wi  th no TDs queued?
[45636.154396] etxhci_hcd_140522 0000:06:00.0: WARN Event TRB for slot 1 ep 2 wi  th no TDs queued?
[59058.468837] br0: port 2(vnet0) entered disabled state
[59058.470414] br0: port 2(vnet0) entered disabled state
[59058.470465] device vnet0 left promiscuous mode
[59058.470467] br0: port 2(vnet0) entered disabled state
[59061.664754] device vnet0 entered promiscuous mode
[59061.673485] br0: port 2(vnet0) entered forwarding state
[59061.673490] br0: port 2(vnet0) entered forwarding state
[59072.963608] vnet0: no IPv6 routers present
[59076.702597] br0: port 2(vnet0) entered forwarding state
[59095.642529] kvm: 7261: cpu0 unhandled rdmsr: 0x606
[59431.452143] etxhci_hcd_140522 0000:06:00.0: WARN Event TRB for slot 1 ep 2 wi  th no TDs queued?
 
Niestety u mnie jest tak samo na FW 4.1.3 z 13.03.2015. Dotyczy to wszystkiego co na USB. Szczególnie wnerwiający jest tuner TV. Jak nie trudno się domyślić nie da się z niego korzystać :( Za to na poprzedniej wersji 4.1.3 było OK.
 
U mnie po aktualizacji z 4.1.3 build 0217 (z 2015/02/17) do build 0313 (z 2015/03/13) się zaczęło. Mam TS-431 i UPS PowerWalker 650 LCD.

Wcześniej były pojedyncze przypadki kiedy UPS znikał i po chwili pojawiał się ponownie. Raz (nie pamiętam przy jakim firmware) zniknął i trzeba było przekładać kabelki. Przy poprzednim buildzie (0217) problem zniknął, a teraz pojawił się i nasilił. Dziś w nocy od 3:00 przez jakąś godzinę UPS znikał i pojawiał się z 10 razy... i potem znowu spokój.

Przed poprzednim buildem, kiedy to problem występował sporadycznie, najczęściej zdarzał się właśnie o godzinie 3 w nocy....

Dwa dyski USB które mam podpięte do tego samego portu przez huba razem z UPSem (tak, tak to wszystko działa ;) ) cały czas są widoczne i nie ma z nimi problemów.

Właśnie wycofuję się do builda 0217 bo mnie wkurzają logi zapchane komunikatami o wypinaniu i wpinaniu się UPSa.
 
Witam,

Mój qnap zachowuje się identycznie jak wasz, tzn. dostaje logi ze UPS ma brak zasilania i po paru sekundach powrót... i czasami, ze kabel USB odłączony.

QNAP TS-421
Firmware 4.1.2 , 26.01.2015
UPS APC Back-ups RS 550G
 
U mnie gdy mam podłączoną tylko drukarkę pod port usb 2.0 i ups'a pod drugie usb 2.0 to wszystko jest ok.
W sytuacji gdy podłącze dyski pod usb 3.0 to po jakims czasie nastepują rozłączenia ups'a. np. dzis przez noc bylo 10 rozłączeń i podłączeń.

QNAP TS-470 Pro
Firmware 4.1.3 , 2015/02/17
UPS Cyber Power DX800E
 

Użytkownicy znaleźli tą stronę używając tych słów:

  1. insmod
  2. udevadm
  3. oscam