Ivo Karabojkov
2012-Dec-25 18:05 UTC
[Nut-upsuser] Blazer_usb Permissions problem: Input/output error
Merry Christmas to you all and best wishes! I ran into exactly the same problem as described. OS: FreeBSD 9.0-Rel UPS: Eaton E-Series NV 600H NUT: from Ports, nut-2.6.5_1 driver: blazer_usb I am sure the problem is not permission-related as it occurs even when the driver runs as root. My tested recipe for USB permissions is: 1. run usbconfig to find where the device is connected. In my case: ugen5.2: <USB to Serial INNO TECH> at usbus5, cfg=0 md=HOST spd=LOW (1.5Mbps) pwr=ON 2. edit /etc/devfs.rules and add: [nut_usb=10] add path 'ugen5.2' group wheel user uucp mode 0770 3. edit /etc/devfs.conf and add: perm ugen5.2 0770 own ugen5.2 uucp:wheel 4. Edit /etc/rc.conf and add: devfs_system_ruleset="nut_usb" 5. Now it's necessary to restart devfs (or the whole system if you prefer): /etc/rc.d/devfs restart So ls -l /dev/ug* shows: lrwxrwx--- 1 uucp wheel 9 Dec 24 23:36 /dev/ugen5.2 -> usb/5.2.0 and ls -l /dev/usb shows: crwxrwx--- 1 uucp wheel 0, 147 Dec 24 23:36 5.2.0 So I tried to debug but strange: export USB_DEBUG=3 does not have effect on the output from blazer_usb. Here are few results: # /usr/local/libexec/nut/blazer_usb -DDDD -a eaton -u uucp .... 2470.388082 send: Q1 2470.647096 read: (225.4 225.4 225.4 019 49.8 13.6 25.0 00001001 2472.389079 send: Q1 2472.631093 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 2474.390079 send: Q1 2474.647095 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 2476.391092 send: Q1 2476.631100 read: (225.4 225.4 225.4 019 49.8 13.6 25.0 00001001 2478.392095 send: Q1 2478.647095 read: (226.9 226.9 227.4 020 49.8 13.6 25.0 00001001 2480.393084 send: Q1 2480.631095 read: (225.4 225.0 225.4 020 49.8 13.6 25.0 00001001 2482.394085 send: Q1 2482.647097 read: (226.4 226.4 226.4 020 49.8 13.6 25.0 00001001 2484.395093 send: Q1 2484.631098 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 2486.396083 send: Q1 2486.647102 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 2488.397087 send: Q1 2488.631103 read: (225.0 225.4 225.4 020 49.8 13.6 25.0 00001001 2490.398087 send: Q1 2490.647098 read: (225.4 225.0 225.4 019 49.8 13.6 25.0 00001001 2492.399086 send: Q1 2492.663100 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 2494.400085 send: Q1 2494.647102 read: (225.4 225.4 225.4 019 49.8 13.6 25.0 00001001 2496.401088 send: Q1 2496.663104 read: (225.4 225.0 225.4 020 49.8 13.6 25.0 00001001 2498.402102 send: Q1 2498.647103 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 2500.403090 send: Q1 2500.663104 read: (226.4 226.4 226.4 020 49.8 13.6 25.0 00001001 2502.404087 send: Q1 2502.647101 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 2504.405093 send: Q1 2504.663104 read: (225.9 225.9 225.9 020 49.8 13.6 25.0 00001001 2506.406094 send: Q1 2506.647107 read: (225.9 225.9 225.9 020 49.8 13.6 25.0 00001001 2508.407092 send: Q1 2508.663106 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 2510.408092 send: Q1 2510.647105 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 2517.292407 send: Unknown error 2517.292518 Permissions problem: Input/output error # /usr/local/libexec/nut/blazer_usb -DDDDD -a eaton -u root ... 1451.821772 read: (221.5 221.0 221.0 019 49.8 13.6 25.0 00001001 1451.821797 send_to_all: SETINFO input.voltage "221.5" 1451.821805 send_to_all: SETINFO input.voltage.fault "221.0" 1451.821813 send_to_all: SETINFO ups.load "19" 1453.573762 send: Q1 1453.837774 read: (217.1 217.1 217.6 020 49.8 13.6 25.0 00001001 1453.837800 send_to_all: SETINFO input.voltage "217.1" 1453.837808 send_to_all: SETINFO input.voltage.fault "217.1" 1453.837814 send_to_all: SETINFO output.voltage "217.6" 1453.837821 send_to_all: SETINFO ups.load "20" 1455.575757 send: Q1 1455.821775 read: (221.5 221.0 221.0 019 49.8 13.6 25.0 00001001 1455.821801 send_to_all: SETINFO input.voltage "221.5" 1455.821809 send_to_all: SETINFO input.voltage.fault "221.0" 1455.821815 send_to_all: SETINFO output.voltage "221.0" 1455.821821 send_to_all: SETINFO ups.load "19" 1457.575760 send: Q1 1457.837777 read: (221.0 221.0 221.0 020 49.8 13.6 25.0 00001001 1457.837803 send_to_all: SETINFO input.voltage "221.0" 1457.837813 send_to_all: SETINFO ups.load "20" 1459.577762 send: Q1 1459.821777 read: (221.0 221.0 221.0 019 49.8 13.6 25.0 00001001 1459.821806 send_to_all: SETINFO ups.load "19" 1461.577772 send: Q1 1461.837778 read: (221.0 221.5 221.0 019 49.8 13.6 25.0 00001001 1461.837801 send_to_all: SETINFO input.voltage.fault "221.5" 1463.579761 send: Q1 1463.821777 read: (221.0 221.0 221.0 019 49.8 13.6 25.0 00001001 1463.821803 send_to_all: SETINFO input.voltage.fault "221.0" 1465.580764 send: Q1 1465.837778 read: (221.0 221.0 221.0 019 49.8 13.6 25.0 00001001 1471.992774 send: Q1 1472.971189 read: Unknown error 1472.971207 blazer_status: short reply 1472.971212 Communications with UPS lost: status read failed! 1472.973776 send: Q1 1473.229783 read: (221.0 221.0 221.0 020 49.8 13.6 25.0 00001001 1473.229813 send_to_all: SETINFO ups.load "20" 1474.973779 send: Q1 1475.213789 read: (221.0 221.0 221.0 019 49.8 13.6 25.0 00001001 1475.213817 send_to_all: SETINFO ups.load "19" 1476.974776 send: Q1 1477.229782 read: (217.6 217.1 217.6 019 49.8 13.6 25.0 00001001 1477.229808 send_to_all: SETINFO input.voltage "217.6" 1477.229816 send_to_all: SETINFO input.voltage.fault "217.1" 1477.229822 send_to_all: SETINFO output.voltage "217.6" 1478.975780 send: Q1 1479.213790 read: (221.0 221.5 221.0 020 49.8 13.6 25.0 00001001 1479.213814 send_to_all: SETINFO input.voltage "221.0" 1479.213822 send_to_all: SETINFO input.voltage.fault "221.5" 1479.213828 send_to_all: SETINFO output.voltage "221.0" 1479.213835 send_to_all: SETINFO ups.load "20" 1485.860174 send: Unknown error 1485.860289 Permissions problem: Input/output error # /usr/local/libexec/nut/blazer_usb -DDDDD -a eaton -u root ... 382.765433 send_to_all: SETINFO output.voltage "222.0" 384.528374 send: Q1 384.781388 read: (221.5 221.5 221.5 019 49.8 13.6 25.0 00001001 384.781415 send_to_all: SETINFO input.voltage "221.5" 384.781424 send_to_all: SETINFO input.voltage.fault "221.5" 384.781431 send_to_all: SETINFO output.voltage "221.5" 386.529381 send: Q1 386.765391 read: (222.0 222.0 222.0 019 49.8 13.6 25.0 00001001 386.765417 send_to_all: SETINFO input.voltage "222.0" 386.765425 send_to_all: SETINFO input.voltage.fault "222.0" 386.765434 send_to_all: SETINFO output.voltage "222.0" 388.530371 send: Q1 388.781391 read: (223.0 223.0 223.0 020 49.8 13.6 25.0 00001001 388.781417 send_to_all: SETINFO input.voltage "223.0" 388.781425 send_to_all: SETINFO input.voltage.fault "223.0" 388.781435 send_to_all: SETINFO output.voltage "223.0" 388.781443 send_to_all: SETINFO ups.load "20" 390.531391 send: Q1 390.765401 read: (223.5 223.0 223.5 019 49.8 13.6 25.0 00001001 390.765422 send_to_all: SETINFO input.voltage "223.5" 390.765431 send_to_all: SETINFO output.voltage "223.5" 390.765438 send_to_all: SETINFO ups.load "19" 392.532374 send: Q1 392.781401 read: (221.5 222.0 222.0 019 49.8 13.6 25.0 00001001 392.781427 send_to_all: SETINFO input.voltage "221.5" 392.781434 send_to_all: SETINFO input.voltage.fault "222.0" 392.781440 send_to_all: SETINFO output.voltage "222.0" 394.533371 send: Q1 394.797401 read: (223.0 223.0 223.0 020 49.8 13.6 25.0 00001001 394.797427 send_to_all: SETINFO input.voltage "223.0" 394.797434 send_to_all: SETINFO input.voltage.fault "223.0" 394.797441 send_to_all: SETINFO output.voltage "223.0" 394.797447 send_to_all: SETINFO ups.load "20" 396.534386 send: Q1 396.781400 read: (223.0 223.0 223.0 019 49.8 13.6 25.0 00001001 396.781434 send_to_all: SETINFO ups.load "19" 398.535388 send: Q1 398.797402 read: (223.0 223.0 223.0 020 49.8 13.6 25.0 00001001 398.797434 send_to_all: SETINFO ups.load "20" 400.536377 send: Q1 400.781400 read: (223.0 223.0 223.0 019 49.8 13.6 25.0 00001001 400.781431 send_to_all: SETINFO ups.load "19" 402.537378 send: Q1 402.797403 read: (223.0 223.0 223.0 019 49.8 13.6 25.0 00001001 404.538382 send: Q1 404.781406 read: (223.0 223.0 223.0 020 49.8 13.6 25.0 00001001 404.781434 send_to_all: SETINFO ups.load "20" 406.539378 send: Q1 406.797406 read: (223.5 223.0 223.5 018 49.8 13.6 25.0 00001001 406.797432 send_to_all: SETINFO input.voltage "223.5" 406.797440 send_to_all: SETINFO output.voltage "223.5" 406.797448 send_to_all: SETINFO ups.load "18" 408.540384 send: Q1 408.781404 read: (223.0 223.0 223.0 019 49.8 13.6 25.0 00001001 408.781430 send_to_all: SETINFO input.voltage "223.0" 408.781438 send_to_all: SETINFO output.voltage "223.0" 408.781446 send_to_all: SETINFO ups.load "19" 415.424218 send: Unknown error 415.424335 Permissions problem: Input/output error My /usr/local/etc/nut/ups.conf reads: [eaton] driver=blazer_usb port=/dev/ugen5.2 The error occurs at unpredictable time intervals. It happens even when driver runs as root so I think permissions are not involved here. Thanks in advance for your advices. Greetings, Ivo
Paul Barber
2013-Jan-24 02:35 UTC
[Nut-upsuser] Blazer_usb Permissions problem: Input/output error
Hi Ivo, All I can recommend is add a delay into how often the UPS is polled. To this by inserting /pollinterval =10/ into the ups.conf file and see how you go. For me this just prolonged the time until it failed but others have had success with this driver and the delay. Paul On 26/12/2012 4:05 AM, Ivo Karabojkov wrote:> Merry Christmas to you all and best wishes! > > I ran into exactly the same problem as described. > OS: FreeBSD 9.0-Rel > UPS: Eaton E-Series NV 600H > NUT: from Ports, nut-2.6.5_1 > driver: blazer_usb > > I am sure the problem is not permission-related as it occurs even when > the driver runs as root. > My tested recipe for USB permissions is: > > 1. run usbconfig to find where the device is connected. In my case: > ugen5.2: <USB to Serial INNO TECH> at usbus5, cfg=0 md=HOST spd=LOW > (1.5Mbps) pwr=ON > > 2. edit /etc/devfs.rules and add: > [nut_usb=10] > add path 'ugen5.2' group wheel user uucp mode 0770 > > 3. edit /etc/devfs.conf and add: > perm ugen5.2 0770 > own ugen5.2 uucp:wheel > > 4. Edit /etc/rc.conf and add: > devfs_system_ruleset="nut_usb" > > 5. Now it's necessary to restart devfs (or the whole system if you > prefer): > /etc/rc.d/devfs restart > > So ls -l /dev/ug* shows: > lrwxrwx--- 1 uucp wheel 9 Dec 24 23:36 /dev/ugen5.2 -> usb/5.2.0 > and ls -l /dev/usb shows: > crwxrwx--- 1 uucp wheel 0, 147 Dec 24 23:36 5.2.0 > > So I tried to debug but strange: > export USB_DEBUG=3 > does not have effect on the output from blazer_usb. > Here are few results: > > # /usr/local/libexec/nut/blazer_usb -DDDD -a eaton -u uucp > .... > 2470.388082 send: Q1 > 2470.647096 read: (225.4 225.4 225.4 019 49.8 13.6 25.0 00001001 > 2472.389079 send: Q1 > 2472.631093 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2474.390079 send: Q1 > 2474.647095 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2476.391092 send: Q1 > 2476.631100 read: (225.4 225.4 225.4 019 49.8 13.6 25.0 00001001 > 2478.392095 send: Q1 > 2478.647095 read: (226.9 226.9 227.4 020 49.8 13.6 25.0 00001001 > 2480.393084 send: Q1 > 2480.631095 read: (225.4 225.0 225.4 020 49.8 13.6 25.0 00001001 > 2482.394085 send: Q1 > 2482.647097 read: (226.4 226.4 226.4 020 49.8 13.6 25.0 00001001 > 2484.395093 send: Q1 > 2484.631098 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2486.396083 send: Q1 > 2486.647102 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2488.397087 send: Q1 > 2488.631103 read: (225.0 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2490.398087 send: Q1 > 2490.647098 read: (225.4 225.0 225.4 019 49.8 13.6 25.0 00001001 > 2492.399086 send: Q1 > 2492.663100 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2494.400085 send: Q1 > 2494.647102 read: (225.4 225.4 225.4 019 49.8 13.6 25.0 00001001 > 2496.401088 send: Q1 > 2496.663104 read: (225.4 225.0 225.4 020 49.8 13.6 25.0 00001001 > 2498.402102 send: Q1 > 2498.647103 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2500.403090 send: Q1 > 2500.663104 read: (226.4 226.4 226.4 020 49.8 13.6 25.0 00001001 > 2502.404087 send: Q1 > 2502.647101 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2504.405093 send: Q1 > 2504.663104 read: (225.9 225.9 225.9 020 49.8 13.6 25.0 00001001 > 2506.406094 send: Q1 > 2506.647107 read: (225.9 225.9 225.9 020 49.8 13.6 25.0 00001001 > 2508.407092 send: Q1 > 2508.663106 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2510.408092 send: Q1 > 2510.647105 read: (225.4 225.4 225.4 020 49.8 13.6 25.0 00001001 > 2517.292407 send: Unknown error > 2517.292518 Permissions problem: Input/output error > > # /usr/local/libexec/nut/blazer_usb -DDDDD -a eaton -u root > ... > 1451.821772 read: (221.5 221.0 221.0 019 49.8 13.6 25.0 00001001 > 1451.821797 send_to_all: SETINFO input.voltage "221.5" > 1451.821805 send_to_all: SETINFO input.voltage.fault "221.0" > 1451.821813 send_to_all: SETINFO ups.load "19" > 1453.573762 send: Q1 > 1453.837774 read: (217.1 217.1 217.6 020 49.8 13.6 25.0 00001001 > 1453.837800 send_to_all: SETINFO input.voltage "217.1" > 1453.837808 send_to_all: SETINFO input.voltage.fault "217.1" > 1453.837814 send_to_all: SETINFO output.voltage "217.6" > 1453.837821 send_to_all: SETINFO ups.load "20" > 1455.575757 send: Q1 > 1455.821775 read: (221.5 221.0 221.0 019 49.8 13.6 25.0 00001001 > 1455.821801 send_to_all: SETINFO input.voltage "221.5" > 1455.821809 send_to_all: SETINFO input.voltage.fault "221.0" > 1455.821815 send_to_all: SETINFO output.voltage "221.0" > 1455.821821 send_to_all: SETINFO ups.load "19" > 1457.575760 send: Q1 > 1457.837777 read: (221.0 221.0 221.0 020 49.8 13.6 25.0 00001001 > 1457.837803 send_to_all: SETINFO input.voltage "221.0" > 1457.837813 send_to_all: SETINFO ups.load "20" > 1459.577762 send: Q1 > 1459.821777 read: (221.0 221.0 221.0 019 49.8 13.6 25.0 00001001 > 1459.821806 send_to_all: SETINFO ups.load "19" > 1461.577772 send: Q1 > 1461.837778 read: (221.0 221.5 221.0 019 49.8 13.6 25.0 00001001 > 1461.837801 send_to_all: SETINFO input.voltage.fault "221.5" > 1463.579761 send: Q1 > 1463.821777 read: (221.0 221.0 221.0 019 49.8 13.6 25.0 00001001 > 1463.821803 send_to_all: SETINFO input.voltage.fault "221.0" > 1465.580764 send: Q1 > 1465.837778 read: (221.0 221.0 221.0 019 49.8 13.6 25.0 00001001 > 1471.992774 send: Q1 > 1472.971189 read: Unknown error > 1472.971207 blazer_status: short reply > 1472.971212 Communications with UPS lost: status read failed! > 1472.973776 send: Q1 > 1473.229783 read: (221.0 221.0 221.0 020 49.8 13.6 25.0 00001001 > 1473.229813 send_to_all: SETINFO ups.load "20" > 1474.973779 send: Q1 > 1475.213789 read: (221.0 221.0 221.0 019 49.8 13.6 25.0 00001001 > 1475.213817 send_to_all: SETINFO ups.load "19" > 1476.974776 send: Q1 > 1477.229782 read: (217.6 217.1 217.6 019 49.8 13.6 25.0 00001001 > 1477.229808 send_to_all: SETINFO input.voltage "217.6" > 1477.229816 send_to_all: SETINFO input.voltage.fault "217.1" > 1477.229822 send_to_all: SETINFO output.voltage "217.6" > 1478.975780 send: Q1 > 1479.213790 read: (221.0 221.5 221.0 020 49.8 13.6 25.0 00001001 > 1479.213814 send_to_all: SETINFO input.voltage "221.0" > 1479.213822 send_to_all: SETINFO input.voltage.fault "221.5" > 1479.213828 send_to_all: SETINFO output.voltage "221.0" > 1479.213835 send_to_all: SETINFO ups.load "20" > 1485.860174 send: Unknown error > 1485.860289 Permissions problem: Input/output error > > # /usr/local/libexec/nut/blazer_usb -DDDDD -a eaton -u root > ... > 382.765433 send_to_all: SETINFO output.voltage "222.0" > 384.528374 send: Q1 > 384.781388 read: (221.5 221.5 221.5 019 49.8 13.6 25.0 00001001 > 384.781415 send_to_all: SETINFO input.voltage "221.5" > 384.781424 send_to_all: SETINFO input.voltage.fault "221.5" > 384.781431 send_to_all: SETINFO output.voltage "221.5" > 386.529381 send: Q1 > 386.765391 read: (222.0 222.0 222.0 019 49.8 13.6 25.0 00001001 > 386.765417 send_to_all: SETINFO input.voltage "222.0" > 386.765425 send_to_all: SETINFO input.voltage.fault "222.0" > 386.765434 send_to_all: SETINFO output.voltage "222.0" > 388.530371 send: Q1 > 388.781391 read: (223.0 223.0 223.0 020 49.8 13.6 25.0 00001001 > 388.781417 send_to_all: SETINFO input.voltage "223.0" > 388.781425 send_to_all: SETINFO input.voltage.fault "223.0" > 388.781435 send_to_all: SETINFO output.voltage "223.0" > 388.781443 send_to_all: SETINFO ups.load "20" > 390.531391 send: Q1 > 390.765401 read: (223.5 223.0 223.5 019 49.8 13.6 25.0 00001001 > 390.765422 send_to_all: SETINFO input.voltage "223.5" > 390.765431 send_to_all: SETINFO output.voltage "223.5" > 390.765438 send_to_all: SETINFO ups.load "19" > 392.532374 send: Q1 > 392.781401 read: (221.5 222.0 222.0 019 49.8 13.6 25.0 00001001 > 392.781427 send_to_all: SETINFO input.voltage "221.5" > 392.781434 send_to_all: SETINFO input.voltage.fault "222.0" > 392.781440 send_to_all: SETINFO output.voltage "222.0" > 394.533371 send: Q1 > 394.797401 read: (223.0 223.0 223.0 020 49.8 13.6 25.0 00001001 > 394.797427 send_to_all: SETINFO input.voltage "223.0" > 394.797434 send_to_all: SETINFO input.voltage.fault "223.0" > 394.797441 send_to_all: SETINFO output.voltage "223.0" > 394.797447 send_to_all: SETINFO ups.load "20" > 396.534386 send: Q1 > 396.781400 read: (223.0 223.0 223.0 019 49.8 13.6 25.0 00001001 > 396.781434 send_to_all: SETINFO ups.load "19" > 398.535388 send: Q1 > 398.797402 read: (223.0 223.0 223.0 020 49.8 13.6 25.0 00001001 > 398.797434 send_to_all: SETINFO ups.load "20" > 400.536377 send: Q1 > 400.781400 read: (223.0 223.0 223.0 019 49.8 13.6 25.0 00001001 > 400.781431 send_to_all: SETINFO ups.load "19" > 402.537378 send: Q1 > 402.797403 read: (223.0 223.0 223.0 019 49.8 13.6 25.0 00001001 > 404.538382 send: Q1 > 404.781406 read: (223.0 223.0 223.0 020 49.8 13.6 25.0 00001001 > 404.781434 send_to_all: SETINFO ups.load "20" > 406.539378 send: Q1 > 406.797406 read: (223.5 223.0 223.5 018 49.8 13.6 25.0 00001001 > 406.797432 send_to_all: SETINFO input.voltage "223.5" > 406.797440 send_to_all: SETINFO output.voltage "223.5" > 406.797448 send_to_all: SETINFO ups.load "18" > 408.540384 send: Q1 > 408.781404 read: (223.0 223.0 223.0 019 49.8 13.6 25.0 00001001 > 408.781430 send_to_all: SETINFO input.voltage "223.0" > 408.781438 send_to_all: SETINFO output.voltage "223.0" > 408.781446 send_to_all: SETINFO ups.load "19" > 415.424218 send: Unknown error > 415.424335 Permissions problem: Input/output error > > My /usr/local/etc/nut/ups.conf reads: > [eaton] > driver=blazer_usb > port=/dev/ugen5.2 > > The error occurs at unpredictable time intervals. > It happens even when driver runs as root so I think permissions are > not involved here. > > Thanks in advance for your advices. > Greetings, > Ivo > > _______________________________________________ > Nut-upsuser mailing list > Nut-upsuser at lists.alioth.debian.org > http://lists.alioth.debian.org/cgi-bin/mailman/listinfo/nut-upsuser-------------- next part -------------- An HTML attachment was scrubbed... URL: <http://lists.alioth.debian.org/pipermail/nut-upsuser/attachments/20130124/2a66c037/attachment-0001.html>