Dotaz: Apcupsd - scripty onbattery a offbattery

[Petr Novotný]

Zdarvím zkušené uživatele Linuxu.

Přešel jsem z APC Back-UPS 550 na APC Smart-UPS 750VA připojenou přes USB a mám problém týkající se spuštění skriptu onbattery a offbatery (v /etc/apcupsd). V manuálu (www.apcupsd.org) je napsáno, že skripty s těmito názvy jsou volány skriptem /etc/apcupsd/apccontrol v případě výpadku/obnovení napájení.

Skripty jdou spustit ručně z konzole (sh onbattery), z čehož usuzuji, že problém s právy není:

(linux:/etc/apcupsd # ls -l onbattery -rwxrwxr-x 1 root root 443 29. dub 22.30 onbattery).

UPS jinak normálně komunikuje. Script /etc/apcupsd/apcccontrol je schodný s jinými (funkčními), které jsem našel na internetu.

Nebyl jsem schopen, ani po nemalé časové investici, najít relevantní řešení proto se obracím na Vás s prosbou o pomoc. Jsem "víkendový" uživatel OpenSuse 12.1.

Za náměty k řešení předem děkuji.

Odpovědi

[rastos]

Je niečo zaujímavé v logoch? Napr. /var/log/messages alebo /etc/apcupsd/apcupsd.events resp. /var/log/apcupsd.events ?

[Petr Novotný]

Děkuji za rychlý námět.

Dnes mě napadlo přepojit USB do jiného portu na základní desce PC a stalo se toto (ze souboru /var/log/messages), když to vrátím do původního USB portu potom se situace nezmění a stále to vypisuje toto:

Apr 30 11:59:24 linux-gare apcupsd[3576]: Starting apcupsd power management..done Apr 30 11:59:27 linux-gare apcupsd[3586]: apcupsd 3.14.8 (16 January 2010) suse startup succeeded Apr 30 11:59:29 linux-gare apcupsd[3586]: NIS server startup succeeded Apr 30 11:59:32 linux-gare apcupsd[3586]: Power failure. Apr 30 11:59:38 linux-gare apcupsd[3586]: Running on UPS batteries. Apr 30 11:59:44 linux-gare kernel: [ 551.833953] hub 3-0:1.0: port 2 disabled by hub (EMI?), re-enabling...

Apr 30 11:59:44 linux-gare kernel: [ 551.833963] usb 3-2: USB disconnect, device number 2

Apr 30 11:59:44 linux-gare kernel: [ 551.834933] usb 3-2: ctrl urb status -62 received

Apr 30 11:59:44 linux-gare kernel: [ 552.097028] usb 3-2: new low speed USB device number 3 using ohci_hcd

Apr 30 11:59:44 linux-gare apcupsd[3586]: Mains returned. No longer on UPS batteries.

Apr 30 11:59:44 linux-gare apcupsd[3586]: Power is back. UPS running on mains.

Apr 30 11:59:44 linux-gare kernel: [ 552.298951] usb 3-2: New USB device found, idVendor=051d, idProduct=0002

Apr 30 11:59:44 linux-gare kernel: [ 552.298958] usb 3-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2

Apr 30 11:59:44 linux-gare kernel: [ 552.298963] usb 3-2: Product: Smart-UPS 750 FW:651.18.I USB FW:7.3

Apr 30 11:59:44 linux-gare kernel: [ 552.298967] usb 3-2: Manufacturer: American Power Conversion

Apr 30 11:59:44 linux-gare kernel: [ 552.298971] usb 3-2: SerialNumber: AS0839124329

Apr 30 11:59:46 linux-gare kernel: [ 553.782977] generic-usb 0003:051D:0002.0008: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 750 FW:651.18.I USB FW:7.3] on usb-0000:00:03.1-2/input0

Apr 30 11:59:46 linux-gare udevd[3616]: failed to execute '/lib/udev/mtp-probe' 'mtp-probe /sys/devices/pci0000:00/0000:00:03.1/usb3/3-2 3 3': No such file o r directory

Apr 30 11:59:50 linux-gare kernel: [ 558.080170] hub 3-0:1.0: port 2 disabled by hub (EMI?), re-enabling...

Apr 30 11:59:50 linux-gare kernel: [ 558.080179] usb 3-2: USB disconnect, device number 3

Apr 30 11:59:50 linux-gare kernel: [ 558.081135] usb 3-2: ctrl urb status -62 received

Apr 30 11:59:50 linux-gare kernel: [ 558.344025] usb 3-2: new low speed USB device number 4 using ohci_hcd

Apr 30 11:59:50 linux-gare kernel: [ 558.544161] usb 3-2: New USB device found, idVendor=051d, idProduct=0002

Apr 30 11:59:50 linux-gare kernel: [ 558.544168] usb 3-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2

Apr 30 11:59:50 linux-gare kernel: [ 558.544173] usb 3-2: Product: Smart-UPS 750 FW:651.18.I USB FW:7.3

Apr 30 11:59:50 linux-gare kernel: [ 558.544177] usb 3-2: Manufacturer: American Power Conversion

Apr 30 11:59:50 linux-gare kernel: [ 558.544180] usb 3-2: SerialNumber: AS0839124329

Apr 30 11:59:51 linux-gare kernel: [ 558.762156] usb 3-2: ctrl urb status -62 received

Apr 30 11:59:51 linux-gare kernel: [ 558.763155] usb 3-2: ctrl urb status -62 received

Apr 30 11:59:51 linux-gare kernel: [ 558.764160] usb 3-2: ctrl urb status -62 received

Apr 30 11:59:51 linux-gare kernel: [ 558.765159] usb 3-2: ctrl urb status -62 received

Apr 30 11:59:51 linux-gare kernel: [ 558.766159] usb 3-2: ctrl urb status -62 received

Apr 30 11:59:51 linux-gare kernel: [ 558.831554] hub 3-0:1.0: port 2 disabled by hub (EMI?), re-enabling...

Apr 30 11:59:51 linux-gare kernel: [ 558.831561] usb 3-2: USB disconnect, device number 4

Apr 30 11:59:51 linux-gare apcupsd[3586]: Communications with UPS restored.

Apr 30 11:59:51 linux-gare kernel: [ 559.094031] usb 3-2: new low speed USB device number 5 using ohci_hcd

Apr 30 11:59:51 linux-gare kernel: [ 559.295180] usb 3-2: New USB device found, idVendor=051d, idProduct=0002

Apr 30 11:59:51 linux-gare kernel: [ 559.295187] usb 3-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2

Apr 30 11:59:51 linux-gare kernel: [ 559.295192] usb 3-2: Product: Smart-UPS 750 FW:651.18.I USB FW:7.3

Apr 30 11:59:51 linux-gare kernel: [ 559.295196] usb 3-2: Manufacturer: American Power Conversion

Apr 30 11:59:51 linux-gare kernel: [ 559.295200] usb 3-2: SerialNumber: AS0839124329

Apr 30 11:59:53 linux-gare kernel: [ 560.857542] generic-usb 0003:051D:0002.000A:

Apr 30 11:59:53 linux-gare udevd[3633]: failed to execute '/lib/udev/mtp-probe' 'mtp-probe /sys/devices/pci0000:00/0000:00:03.1/usb3/3-2 3 5': No such file o r directory

Apr 30 11:59:59 linux-gare kernel: [ 566.747450] hub 3-0:1.0: port 2 disabled by hub (EMI?), re-enabling...

Apr 30 11:59:59 linux-gare kernel: [ 566.747460] usb 3-2: USB disconnect, device number 5

Apr 30 11:59:59 linux-gare kernel: [ 567.011061] usb 3-2: new low speed USB device number 6 using ohci_hcd

Apr 30 11:59:59 linux-gare kernel: [ 567.211444] usb 3-2: New USB device found, idVendor=051d, idProduct=0002

Apr 30 11:59:59 linux-gare kernel: [ 567.211452] usb 3-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2

Apr 30 11:59:59 linux-gare kernel: [ 567.211457] usb 3-2: Product: Smart-UPS 750 FW:651.18.I USB FW:7.3

Apr 30 11:59:59 linux-gare kernel: [ 567.211461] usb 3-2: Manufacturer: American Power Conversion

Apr 30 11:59:59 linux-gare kernel: [ 567.211465] usb 3-2: SerialNumber: AS0839124329

Apr 30 11:59:59 linux-gare apcupsd[3586]: Communications with UPS restored.

Apr 30 11:59:59 linux-gare kernel: [ 567.298454] generic-usb: probe of 0003:051D:0002.000B failed with error -62

Apr 30 11:59:59 linux-gare kernel: [ 567.298589] hub 3-0:1.0: port 2 disabled by hub (EMI?), re-enabling...

Apr 30 11:59:59 linux-gare kernel: [ 567.298596] usb 3-2: USB disconnect, device number 6

Apr 30 11:59:59 linux-gare kernel: [ 567.561052] usb 3-2: new low speed USB device number 7 using ohci_hcd

Apr 30 12:00:00 linux-gare kernel: [ 567.762460] usb 3-2: New USB device found, idVendor=051d, idProduct=0002

Apr 30 12:00:00 linux-gare kernel: [ 567.762469] usb 3-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2

Apr 30 12:00:00 linux-gare kernel: [ 567.762474] usb 3-2: Product: Smart-UPS 750 FW:651.18.I USB FW:7.3

Apr 30 12:00:00 linux-gare kernel: [ 567.762478] usb 3-2: Manufacturer: American Power Conversion

Apr 30 12:00:00 linux-gare kernel: [ 567.762482] usb 3-2: SerialNumber: AS0839124329

Apr 30 12:00:00 linux-gare apcupsd[3586]: Power failure

.

Apr 30 12:00:00 linux-gare apcupsd[3586]: Power is back. UPS running on mains.

Apr 30 12:00:01 linux-gare kernel: [ 569.316453] generic-usb 0003:051D:0002.000C: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 750 FW:651.18.I USB FW:7.3] on usb-0000:00:03.1-2/input0

Apr 30 12:00:01 linux-gare udevd[3672]: failed to execute '/lib/udev/mtp-probe' 'mtp-probe /sys/devices/pci0000:00/0000:00:03.1/usb3/3-2 3 7': No such file o r directory

Apr 30 12:00:08 linux-gare apcupsd[3586]: Communications with UPS restored.

 

 

Před tím přepojením to nic zajímavé nevypisovalo.

Pro doplněnní /var/log/apcupsd.events

2012-04-30 11:59:27 +0200 apcupsd 3.14.8 (16 January 2010) suse startup succeeded

2012-04-30 11:59:32 +0200 Power failure.

2012-04-30 11:59:38 +0200 Running on UPS batteries.

2012-04-30 11:59:44 +0200 Mains returned. No longer on UPS batteries.

2012-04-30 11:59:44 +0200 Power is back. UPS running on mains.

2012-04-30 11:59:51 +0200 Communications with UPS restored.

2012-04-30 11:59:59 +0200 Communications with UPS restored.

2012-04-30 12:00:00 +0200 Power failure.

2012-04-30 12:00:00 +0200 Power is back. UPS running on mains.

2012-04-30 12:00:08 +0200 Communications with UPS restored./code>

 

 

[Jooky (inactive)]

Tato hlaska nevesti nic dobre:

[ 566.747450] hub 3-0:1.0: port 2 disabled by hub (EMI?), re-enabling...

Inak povedane odchadza port, je zly kabel, prilis silne rusenie, pretazenie zariadenim ... spolu s tymi dalsimi hlaskami by som povedal, ze nie je uplne v poriadku ten jeden konkretny port. Ked UPS funguje v inom porte bez poblemov, t.j. kernel najde UPS a nestazuje sa, tak s tym portom isto nieco je v poriadku. Na vyskusanie doporucujem pripojit ine zariadenie a sledovat co sa deje.

a teraz k samotnym scriptom. Nemam tu dokumentaciu, ale ked ma pamat neklame tak script onbattery sa vola az po vyprsani ONBATTERYDELAY. Ja tu hodnotu nastavujem na 60 (1 minuta), aby kratke vypadky negenerovali upozornenia cez SMS. Offbattery sa samozrejme zavola len v pripade ak sa volal onbattery script

problem s komunikaciou s UPS moze sposobit, ze ten timer nikdy nevyprsi a tym padom sa nikdy nezavolaju scripty

[Petr Novotný]

Problém byl v USB kabelu. Toto to nyní vypisuje při odpojení napájení do /var/log/messages

May 3 23:31:47 linux-gare apcupsd[3805]: Running on UPS batteries.

May 3 23:32:12 linux-gare apcupsd[3805]: Mains returned. No longer on UPS batteries.

May 3 23:32:12 linux-gare apcupsd[3805]: Power is back. UPS running on mains.

 

 

Ano, máte naprostou pravdu v manuálu i configuračním souboru apcupsd.conf se píše, že ONBATTERY je časový interval mezi dobou, co UPS zaznamená výpadek sítového napětí do okamžiku do akce (informování uživatelů apod.). ONBATTERY je nastavena na 6.

Provedl jsem ještě jeden test (vycházející z toho, že apccontrol je shell script), jehož výsledek mě dost zaskočil. Editovat jsem soubor /etc/apcupsd/apccontrol takto:

onbattery)

<------>echo "Power failure on UPS ${2}. Running on batteries." | ${WALL}

<------>${SCRIPTSHELL} onbattery

;;

 

 

Výsledek byl, že se při odpojení napájení vypisala pouze zpráva na zeď (skript se nespustil). Když ho spustím samostatně potom funkguje vytečně. Když místo

${SCRIPTSHELL} onbattery

napíší třeba

echo "ZKOUSKA" | ${WALL}

a odpojím napájení potom se zpráva normálně vypíše, z čeho usuzuju, že skript funguje srprávně, jenom z nějakého důvodu nespustí ten skript.

 

I přesto, že se mi to zdá nepravděpodbné přesto se raději "laicky" zeptám. Není potřeba něják spouštění těch skriptů povolit? U Back-up modelu, to tak nebylo, ale jsem opravdu v koncích s nápaday, proto se raději ptám. Díky

[Petr Novotný]

Problem vyřešen !

Problem byl, jak se říká, mezi "židlí a klávesnicí". Problem byl v tom, ze prikazy pro vykonani se musi do těch scriptů zapisovat ve formatu (o cemz mimochodem v manualu neni ani slovo...):

prikaz | cim_ho_vykonat

Potom vse funguje bezvadne i kdyz to volá apcupsd.

Snad tato informace, která mě stála několik bezesných nocí, pomůže i dalším "víkendovým" uživatelů.

Děkuji za pomoc - vážím si jí !