cmd test.battery.start.deep was not tested yet.

cmd test.battery.start.quick works as expected.
cmd test.battery.start 120 works as expected.
cmd test.battery.stop works as expected.
cmd beeper.toggle works as expected.
cmd shutdown.return works as expected.
cmd shutdown.reboot does not work entirely. After a minute, UPS is shut
down but didn't come back. (Issuing shutdown.stop power up it again)

Some details I found:

After shutdown.return and shutdown.reboot, usb port (/dev/ttyUSB0) is still
open and working.
Powering down from ups button disables communication.

Power up from ups button issues power-on self test (pop, crack and clicking
sounds) whereas shutdown.return and shutdown.stop just bring it on without
post. I think this is normal.

Also, from ups button power up, power up from shutdown.return or
shutdown.stop, the smsbrasil sets ups.status as OL BYPASS. Since this ups
is line interactive, what is this bypass bit? I didn't review the driver
yet but it is a bug from the driver or hardware?
Also related, after returning from a test, the driver sets ups.status as OL
_without_ BYPASS.

There is also (I suppose) wrong values on reestabilishing connection.
input.voltage 3892.0
input.frequency 0.2
output.voltage 3892.0
battery.charge 2252.8
ups.temp 3072.0
ups.load 3891.2
battery.runtime 180
ups.status ALARM OL BOOST OVER FSD
Could this be related to pu.BatOnOff ?

There is also another point, after issuing shutdown.reboot or
shutdown.return, the ups.load, output.voltage and battery.runtime values
goes to 0, but ups.status is "OL BYPASS". Is this ok?

driver debug log is attached. (smsbrasil -qqqqqq -DDDDDD -i 5)

Rodrigo
TURNED OFF via ups main button
- communication is lost.
- upsc sms always returns "Error: Data stale" 

3096.067419     smsBR_RecAnswer: Started
3098.069531     smsBR_RecAnswer: Exiting by timeout (2 seconds)
3098.069592     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
3098.069617     send_to_all: DATASTALE
3098.069699     send_to_one: PONG
3101.070466     smsBR_RecAnswer: Started
3103.072605     smsBR_RecAnswer: Exiting by timeout (2 seconds)
3103.072686     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
3106.073475     smsBR_RecAnswer: Started
3108.075605     smsBR_RecAnswer: Exiting by timeout (2 seconds)
3108.075686     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
3111.076076     smsBR_RecAnswer: Started
3113.078197     smsBR_RecAnswer: Exiting by timeout (2 seconds)
3113.078257     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
3116.078210     smsBR_RecAnswer: Started
3118.080324     smsBR_RecAnswer: Exiting by timeout (2 seconds)
3118.080383     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
ISSUED cmd shutdown.reboot (ups powers[B off)
POWERED UP via ups main button.
 - OK: after a few seconds, it powers up.
 - returns as OL,BYPASS.

2991.969202     send_to_one: PONG
2995.983147     smsBR_RecAnswer: Started
2997.529898     smsBR_RecAnswer: Finished
2998.019372     send_to_one: PONG
3000.986221     smsBR_RecAnswer: Started
3001.101895     smsBR_RecAnswer: Finished
3001.101968     send_to_all: SETINFO output.voltage "114.0"
3005.987327     smsBR_RecAnswer: Started
3006.102942     smsBR_RecAnswer: Finished
3006.102987     send_to_all: SETINFO output.voltage "115.0"
3006.103009     send_to_all: SETINFO ups.load "9.0"
3006.103024     send_to_all: SETINFO battery.runtime "4020"
3010.992345     smsBR_RecAnswer: Started
3011.107999     smsBR_RecAnswer: Finished
3011.108071     send_to_all: SETINFO output.voltage "114.0"
3011.108122     send_to_all: SETINFO ups.load "12.0"
3011.108154     send_to_all: SETINFO battery.runtime "3060"
3015.993547     smsBR_RecAnswer: Started
3016.108933     smsBR_RecAnswer: Finished
3016.109008     send_to_all: SETINFO ups.load "13.0"
3016.109052     send_to_all: SETINFO battery.runtime "2820"
3020.997869     smsBR_RecAnswer: Started
3021.117924     smsBR_RecAnswer: Finished
3021.117994     send_to_all: SETINFO input.voltage "228.0"
3021.118047     send_to_all: SETINFO ups.load "15.0"
3021.118080     send_to_all: SETINFO battery.runtime "2400"
ISSUED cmd shutdown.reboot
 - OK: shutdown ups.
 - FAILED: after a minute it is still powered off.
 - attempting to power up via ups button works, power-on self test is executed 
and it returns as OL,BYPASS.

2430.556827     smsBR_RecAnswer: Started
2430.672842     smsBR_RecAnswer: Finished
2432.019188     send_to_one: PONG
2434.428696     instcmd: command [shutdown.reboot] handled
2435.558033     smsBR_RecAnswer: Started
2435.673902     smsBR_RecAnswer: Finished
2435.673999     send_to_all: SETINFO ups.alarm "UPS under SHUTDOWN mode!"
2435.674042     send_to_all: SETINFO ups.status "ALARM OL BYPASS FSD"
2440.563059     smsBR_RecAnswer: Started
2440.678883     smsBR_RecAnswer: Finished
2442.111280     send_to_one: PONG
2445.566594     smsBR_RecAnswer: Started
2445.681823     smsBR_RecAnswer: Finished
2448.174522     send_to_one: PONG
2450.569001     smsBR_RecAnswer: Started
2450.684810     smsBR_RecAnswer: Finished
2450.684884     send_to_all: SETINFO output.voltage "0.0"
2450.684946     send_to_all: DELINFO ups.alarm
2450.684976     send_to_all: SETINFO ups.status "OL BYPASS"
2455.571353     smsBR_RecAnswer: Started
2455.686801     smsBR_RecAnswer: Finished
2455.686885     send_to_all: SETINFO ups.load "0.0"
2455.686931     send_to_all: SETINFO battery.runtime "0"
2460.576291     smsBR_RecAnswer: Started
2460.691822     smsBR_RecAnswer: Finished
2460.691890     send_to_all: SETINFO input.voltage "228.0"
2465.581234     smsBR_RecAnswer: Started
2465.696827     smsBR_RecAnswer: Finished
2465.696895     send_to_all: SETINFO input.voltage "230.0"
2470.586203     smsBR_RecAnswer: Started
2470.701823     smsBR_RecAnswer: Finished
2471.387767     send_to_one: PONG
2475.590461     smsBR_RecAnswer: Started
2475.705773     smsBR_RecAnswer: Finished
2477.440340     send_to_one: PONG
2480.593682     smsBR_RecAnswer: Started
2480.708823     smsBR_RecAnswer: Finished
2480.708891     send_to_all: SETINFO input.voltage "228.0"

deu


- desligando no botao:
perde conexao ttyusb0 timeout

- ligando no botao:
post

 801.445746     smsBR_RecAnswer: Exiting by timeout (2 seconds)
 801.445806     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
 804.446713     smsBR_RecAnswer: Started
 804.446755     smsBR_RecAnswer: Finished
 804.446775     send_to_all: SETINFO output.voltage "115.0"
 804.446804     send_to_all: DATAOK
 809.451780     smsBR_RecAnswer: Started
 809.451858     smsBR_RecAnswer: Finished
 809.451895     send_to_all: SETINFO input.voltage "230.0"
 814.456905     smsBR_RecAnswer: Started
 814.456979     smsBR_RecAnswer: Finished
 814.457020     send_to_all: SETINFO output.voltage "114.0"
 814.457069     send_to_all: SETINFO ups.temperature "27.0"
 814.457097     send_to_all: SETINFO ups.load "4.0"
 814.457128     send_to_all: SETINFO battery.runtime "9180"
 819.461994     smsBR_RecAnswer: Started
 819.462069     smsBR_RecAnswer: Finished
 819.462103     send_to_all: SETINFO input.voltage "228.0"
 819.462175     send_to_all: SETINFO ups.temperature "35.0"
 819.462206     send_to_all: SETINFO ups.load "10.0"
 819.462236     send_to_all: SETINFO battery.runtime "3660"
 824.467081     smsBR_RecAnswer: Started
 824.467182     smsBR_RecAnswer: Finished
 824.467219     send_to_all: SETINFO input.voltage "230.0"
 824.467271     send_to_all: SETINFO ups.load "16.0"
 824.467304     send_to_all: SETINFO battery.runtime "2280"
 829.468666     smsBR_RecAnswer: Started
 829.468749     smsBR_RecAnswer: Finished
 829.923706     send_to_one: PONG


FSD?

-- test quick
- volta como online apenas

 456.942856     instcmd: command [test.battery.start.quick] handled
 459.166328     smsBR_RecAnswer: Started
 459.282400     smsBR_RecAnswer: Finished
 459.282482     send_to_all: SETINFO output.voltage "113.0"
 459.282549     send_to_all: SETINFO ups.alarm "UPS under Battery Test Mode!"
 459.282580     send_to_all: SETINFO ups.status "ALARM OB DISCHRG"
 464.167063     smsBR_RecAnswer: Started
 464.282398     smsBR_RecAnswer: Finished
 464.282443     send_to_all: SETINFO output.voltage "111.0"
 464.282465     send_to_all: SETINFO ups.temperature "35.0"
 469.170223     smsBR_RecAnswer: Started
 469.285426     smsBR_RecAnswer: Finished
 469.285508     send_to_all: SETINFO output.voltage "107.0"
 469.285557     send_to_all: SETINFO battery.charge "76.0"
 469.285589     send_to_all: SETINFO ups.load "9.0"
 469.285620     send_to_all: SETINFO battery.runtime "3060"
 469.285652     send_to_all: DELINFO ups.alarm
 469.285703     send_to_all: SETINFO ups.status "OL"
 474.175170     smsBR_RecAnswer: Started
 474.290443     smsBR_RecAnswer: Finished
 474.290478     send_to_all: DATASTALE
 479.176141     smsBR_RecAnswer: Started
 479.291387     smsBR_RecAnswer: Finished
 479.291438     send_to_all: SETINFO battery.charge "87.0"
 479.291461     send_to_all: SETINFO ups.temperature "34.0"
 479.291476     send_to_all: SETINFO ups.load "8.0"
 479.291491     send_to_all: SETINFO battery.runtime "3960"
 479.291506     send_to_all: DATAOK

ISSUED cmd shutdown.return
 - OK: shutdown ups
 - OK: power up on AC voltage presence.
 - power up without power-on self test.
 - returns as OL, BYPASS.
 - bogus/wrong values at 319.101601-319.101923

 287.521507     instcmd: command [shutdown.return] handled
 289.080847     smsBR_RecAnswer: Started
 289.196576     smsBR_RecAnswer: Finished
 289.196645     send_to_all: SETINFO output.voltage "110.0"
 289.196699     send_to_all: SETINFO ups.load "17.0"
 289.196731     send_to_all: SETINFO battery.runtime "2100"
 289.196767     send_to_all: SETINFO ups.alarm "UPS under SHUTDOWN mode!"
 289.196798     send_to_all: SETINFO ups.status "ALARM OB DISCHRG"
 294.085840     smsBR_RecAnswer: Started
 296.087984     smsBR_RecAnswer: Exiting by timeout (2 seconds)
 296.088043     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
 296.088066     send_to_all: DATASTALE
 296.088127     send_to_one: PONG
 299.087368     smsBR_RecAnswer: Started
 301.087525     smsBR_RecAnswer: Exiting by timeout (2 seconds)
 301.087589     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
 304.090471     smsBR_RecAnswer: Started
 306.092596     smsBR_RecAnswer: Exiting by timeout (2 seconds)
 306.092658     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
 309.093541     smsBR_RecAnswer: Started
 311.085731     smsBR_RecAnswer: after 3 retries the number of bytes was 
insuficient. Waited >15: received: 1
 311.085792     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is not replying requests...
 314.096593     smsBR_RecAnswer: Started
 314.336963     smsBR_RecAnswer: after 3 retries the number of bytes was 
insuficient. Waited >15: received: 1
 314.337024     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is not replying requests...
 319.101469     smsBR_RecAnswer: Started
 319.101543     smsBR_RecAnswer: Finished
 319.101564     Communications with UPS re-established
 319.101601     send_to_all: SETINFO input.voltage "3892.0"
 319.101642     send_to_all: SETINFO input.frequency "0.2"
 319.101674     send_to_all: SETINFO output.voltage "3892.0"
 319.101703     send_to_all: SETINFO output.frequency "0.2"
 319.101733     send_to_all: SETINFO battery.charge "2252.8"
 319.101763     send_to_all: SETINFO ups.temperature "3072.0"
 319.101793     send_to_all: SETINFO ups.load "3891.2"
 319.101848     send_to_all: SETINFO battery.runtime "180"
 319.101888     send_to_all: SETINFO ups.alarm "UPS selftest failed! UPS under 
SHUTDOWN mode! UPS under Battery Test Mode!"
 319.101923     send_to_all: SETINFO ups.status "ALARM OL BOOST OVER FSD"
 319.101949     send_to_all: DATAOK
 324.106570     smsBR_RecAnswer: Started
 324.106641     smsBR_RecAnswer: Finished
 324.106665     send_to_all: DATASTALE
 329.111650     smsBR_RecAnswer: Started
 329.111723     smsBR_RecAnswer: Finished
 329.111760     send_to_all: SETINFO input.voltage "228.0"
 329.111800     send_to_all: SETINFO input.frequency "60.0"
 329.111830     send_to_all: SETINFO output.voltage "114.0"
 329.111859     send_to_all: SETINFO output.frequency "60.0"
 329.111888     send_to_all: SETINFO battery.charge "92.0"
 329.111915     send_to_all: SETINFO ups.temperature "35.0"
 329.111942     send_to_all: SETINFO ups.load "10.0"
 329.111992     send_to_all: SETINFO battery.runtime "3360"
 329.112031     send_to_all: DELINFO ups.alarm
 329.112059     send_to_all: SETINFO ups.status "OL BYPASS"
ISSUED cmd shutdown.reboot (ups powers[B off)
ISSUED cmd shutdown.stop

 - OK: after a few seconds, it powers up.
 - returns as OL,BYPASS.

2677.032464     instcmd: command [shutdown.stop] handled
2679.239243     send_to_one: PONG
2680.714296     smsBR_RecAnswer: Started
2680.829828     smsBR_RecAnswer: Finished
2680.829897     send_to_all: SETINFO input.voltage "228.0"
2685.719242     smsBR_RecAnswer: Started
2685.834859     smsBR_RecAnswer: Finished
2685.834929     send_to_all: SETINFO input.voltage "230.0"
2690.724324     smsBR_RecAnswer: Started
2690.839941     smsBR_RecAnswer: Finished
2690.840014     send_to_all: SETINFO output.voltage "115.0"
2695.729329     smsBR_RecAnswer: Started
2695.844934     smsBR_RecAnswer: Finished
2695.845018     send_to_all: SETINFO ups.load "6.0"
2695.845058     send_to_all: SETINFO battery.runtime "6120"
2700.731103     smsBR_RecAnswer: Started
2700.846939     smsBR_RecAnswer: Finished
2700.847014     send_to_all: SETINFO output.voltage "114.0"
2700.847066     send_to_all: SETINFO ups.load "10.0"
2700.847098     send_to_all: SETINFO battery.runtime "3660"
2705.736082     smsBR_RecAnswer: Started
2705.850942     smsBR_RecAnswer: Finished
2705.851025     send_to_all: SETINFO ups.load "12.0"
2705.851071     send_to_all: SETINFO battery.runtime "3060"
2710.741048     smsBR_RecAnswer: Started
2710.856951     smsBR_RecAnswer: Finished
2710.857035     send_to_all: SETINFO ups.load "14.0"
2710.857076     send_to_all: SETINFO battery.runtime "2580"
2715.746045     smsBR_RecAnswer: Started
2715.861871     smsBR_RecAnswer: Finished
2715.861941     send_to_all: SETINFO input.voltage "228.0"
2715.861988     send_to_all: SETINFO output.voltage "115.0"
2715.862027     send_to_all: SETINFO ups.load "16.0"
2715.862058     send_to_all: SETINFO battery.runtime "2280"
WRONG VALUES

 287.521507     instcmd: command [shutdown.return] handled
 289.080847     smsBR_RecAnswer: Started
 289.196576     smsBR_RecAnswer: Finished
 289.196645     send_to_all: SETINFO output.voltage "110.0"
 289.196699     send_to_all: SETINFO ups.load "17.0"
 289.196731     send_to_all: SETINFO battery.runtime "2100"
 289.196767     send_to_all: SETINFO ups.alarm "UPS under SHUTDOWN mode!"
 289.196798     send_to_all: SETINFO ups.status "ALARM OB DISCHRG"
 294.085840     smsBR_RecAnswer: Started
 296.087984     smsBR_RecAnswer: Exiting by timeout (2 seconds)
 296.088043     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
 296.088066     send_to_all: DATASTALE
 296.088127     send_to_one: PONG
 299.087368     smsBR_RecAnswer: Started
 301.087525     smsBR_RecAnswer: Exiting by timeout (2 seconds)
 301.087589     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
 304.090471     smsBR_RecAnswer: Started
 306.092596     smsBR_RecAnswer: Exiting by timeout (2 seconds)
 306.092658     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is returning by timeout...
 309.093541     smsBR_RecAnswer: Started
 311.085731     smsBR_RecAnswer: after 3 retries the number of bytes was 
insuficient. Waited >15: received: 1
 311.085792     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is not replying requests...
 314.096593     smsBR_RecAnswer: Started
 314.336963     smsBR_RecAnswer: after 3 retries the number of bytes was 
insuficient. Waited >15: received: 1
 314.337024     Communications with UPS lost: upsdrv_updateinfo: UPS at port 
/dev/ttyUSB0 is not replying requests...
 319.101469     smsBR_RecAnswer: Started
 319.101543     smsBR_RecAnswer: Finished
 319.101564     Communications with UPS re-established
 319.101601     send_to_all: SETINFO input.voltage "3892.0"
 319.101642     send_to_all: SETINFO input.frequency "0.2"
 319.101674     send_to_all: SETINFO output.voltage "3892.0"
 319.101703     send_to_all: SETINFO output.frequency "0.2"
 319.101733     send_to_all: SETINFO battery.charge "2252.8"
 319.101763     send_to_all: SETINFO ups.temperature "3072.0"
 319.101793     send_to_all: SETINFO ups.load "3891.2"
 319.101848     send_to_all: SETINFO battery.runtime "180"
 319.101888     send_to_all: SETINFO ups.alarm "UPS selftest failed! UPS under 
SHUTDOWN mode! UPS under Battery Test Mode!"
 319.101923     send_to_all: SETINFO ups.status "ALARM OL BOOST OVER FSD"
 319.101949     send_to_all: DATAOK
 324.106570     smsBR_RecAnswer: Started
 324.106641     smsBR_RecAnswer: Finished
 324.106665     send_to_all: DATASTALE
 329.111650     smsBR_RecAnswer: Started
 329.111723     smsBR_RecAnswer: Finished
 329.111760     send_to_all: SETINFO input.voltage "228.0"
 329.111800     send_to_all: SETINFO input.frequency "60.0"
 329.111830     send_to_all: SETINFO output.voltage "114.0"
 329.111859     send_to_all: SETINFO output.frequency "60.0"
 329.111888     send_to_all: SETINFO battery.charge "92.0"
 329.111915     send_to_all: SETINFO ups.temperature "35.0"
 329.111942     send_to_all: SETINFO ups.load "10.0"
 329.111992     send_to_all: SETINFO battery.runtime "3360"
 329.112031     send_to_all: DELINFO ups.alarm
 329.112059     send_to_all: SETINFO ups.status "OL BYPASS"
_______________________________________________
Nut-upsdev mailing list
[email protected]
http://lists.alioth.debian.org/cgi-bin/mailman/listinfo/nut-upsdev

Reply via email to