[Nut-upsuser] freenas USB connection error

J Neethling jneethling at webmail.co.za
Sat Feb 14 19:43:47 UTC 2015


Hi all,

I'm a new user trying to get a Proline UPS I1000 UPS to work with freenas 9.3
over USB. When running upsdrvctl I get a permission denied error.

Required debug info:

    OS name and version,

# uname -a
FreeBSD freenas.local 9.3-RELEASE-p5 FreeBSD 9.3-RELEASE-p5 #2
r275790+f84e770: Tue Dec 23 23:35:33 PST 2014    
root at build3.ixsystems.com:/tank/home/jkh/build/93/FN/objs/os-base/amd64/fusion/jkh/93/FN/FreeBSD/src/sys/FREENAS.amd64
 amd64

    exact NUT version,

Network UPS Tools - UPS driver controller 2.7.2

    NUT installation method: from source tarball, package or Subversion,

package

    exact device name and related information (manufacturing date, web
pointers, …),

Proline UPS I1000 UPS, purchased mid 2014. rebranded something, not been able
to discover what. http://www.pinnacle.co.za/#!/product/1685

    complete problem description, with any relevant traces, like system log
excerpts, and driver debug output. You can obtain the latter using the
following command, as root and after having stopped NUT:

When trying to start nut, get an error for permission denied;
# upsdrvctl -DD start

   0.000130	Starting UPS: ups
   0.000159	3 remaining attempts
   0.000171	exec:  /usr/local/libexec/nut/blazer_usb -a ups
Network UPS Tools - Megatec/Q1 protocol USB driver 0.11 (2.7.2)
Supported UPS detected with megatec protocol
Permissions problem: Input/output error
   1.373820	Driver failed to start (exit status=1)
   6.374337	2 remaining attempts
   6.374378	exec:  /usr/local/libexec/nut/blazer_usb -a ups
Network UPS Tools - Megatec/Q1 protocol USB driver 0.11 (2.7.2)
Supported UPS detected with megatec protocol
Permissions problem: Input/output error
   7.749816	Driver failed to start (exit status=1)
  12.750339	1 remaining attempts
  12.750381	exec:  /usr/local/libexec/nut/blazer_usb -a ups
Network UPS Tools - Megatec/Q1 protocol USB driver 0.11 (2.7.2)
Supported UPS detected with megatec protocol
Permissions problem: Input/output error
  14.124787	Driver failed to start (exit status=1)

Snippet from Output of ktrace when running : 
# ktrace /usr/local/libexec/nut/blazer_usb -D -D -D -D -a ups
 ...
 67611 blazer_usb RET   read 0
 67611 blazer_usb CALL  stat(0x800f8e498,0x7fffffffe2d0)
 67611 blazer_usb NAMI  "/etc/nsswitch.conf"
 67611 blazer_usb STRU  struct stat {dev=2264989441, ino=703, mode=-rw-r--r--
, nlink=1, uid=0, gid=0, rdev=4294967295, atime=1423937499.241504491,
stime=1423498232.822474644, ctime=1423498232.822474644,
birthtime=1418850888.497355000, size=133, blksize=4096, blocks=8, flags=0x800
}
 67611 blazer_usb RET   stat 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  setgroups(0x2,0x80149c000)
 67611 blazer_usb RET   setgroups 0
 67611 blazer_usb CALL  madvise(0x80149b000,0x3000,MADV_FREE)
 67611 blazer_usb RET   madvise 0
 67611 blazer_usb CALL  setgid(0x42)
 67611 blazer_usb RET   setgid 0
 67611 blazer_usb CALL  setuid(0x42)
 67611 blazer_usb RET   setuid 0
 67611 blazer_usb CALL  chdir(0x40e1bc)
 67611 blazer_usb NAMI  "/var/db/nut"
 67611 blazer_usb RET   chdir 0
 67611 blazer_usb CALL  open(0x8008383a1,0<O_RDONLY>,<unused>0)
 67611 blazer_usb NAMI  "/dev/usbctl"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  ioctl(0x4,USB_READ_DIR,0x7fffffffca60)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  open(0x7fffffffcba0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen0.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICE_DESC,0x7fffffffcbe0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICEINFO,0x7fffffffc8f0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcba0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen1.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICE_DESC,0x7fffffffcbe0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICEINFO,0x7fffffffc8f0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcba0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen2.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICE_DESC,0x7fffffffcbe0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICEINFO,0x7fffffffc8f0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcba0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen3.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICE_DESC,0x7fffffffcbe0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICEINFO,0x7fffffffc8f0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcba0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen4.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICE_DESC,0x7fffffffcbe0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICEINFO,0x7fffffffc8f0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcba0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen5.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICE_DESC,0x7fffffffcbe0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICEINFO,0x7fffffffc8f0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcba0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen3.2"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICE_DESC,0x7fffffffcbe0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICEINFO,0x7fffffffc8f0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcba0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen0.2"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICE_DESC,0x7fffffffcbe0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_DEVICEINFO,0x7fffffffc8f0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  ioctl(0x4,USB_READ_DIR,0x7fffffffca60)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen0.1"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen0.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen1.1"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen1.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen2.1"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen2.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen3.1"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen3.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen4.1"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen4.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen5.1"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen5.1"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen3.2"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen3.2"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen0.2"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  open(0x7fffffffcbc0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen0.2"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc0c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_GET_FULL_DESC,0x7fffffffcbc0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close 0
 67611 blazer_usb CALL  gettimeofday(0x7fffffffcb80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.002761     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0x34)
 67611 blazer_usb GIO   fd 2 wrote 52 bytes
       "Checking device (06DA/0201) (/dev/usb//dev/ugen0.2)
       "
 67611 blazer_usb RET   write 52/0x34
 67611 blazer_usb CALL  open(0x7fffffffcbe0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen0.2"
 67611 blazer_usb RET   open 4
 67611 blazer_usb CALL  open(0x7fffffffcbe0,0x2<O_RDWR>,<unused>0)
 67611 blazer_usb NAMI  "/dev/ugen0.2"
 67611 blazer_usb RET   open 5
 67611 blazer_usb CALL  ioctl(0x5,USB_GET_PLUGTIME,0x7fffffffcc2c)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_INIT,0x7fffffffcbb0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffcab0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffcab0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffcab0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffcab0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffcab0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffcab0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffcab0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffcab0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  gettimeofday(0x7fffffffcb80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.035678     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0x11)
 67611 blazer_usb GIO   fd 2 wrote 17 bytes
       "- VendorID: 06da
       "
 67611 blazer_usb RET   write 17/0x11
 67611 blazer_usb CALL  gettimeofday(0x7fffffffcb80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.035731     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0x12)
 67611 blazer_usb GIO   fd 2 wrote 18 bytes
       "- ProductID: 0201
       "
 67611 blazer_usb RET   write 18/0x12
 67611 blazer_usb CALL  gettimeofday(0x7fffffffcb80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.035763     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0x14)
 67611 blazer_usb GIO   fd 2 wrote 20 bytes
       "- Manufacturer: PPC
       "
 67611 blazer_usb RET   write 20/0x14
 67611 blazer_usb CALL  gettimeofday(0x7fffffffcb80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.035793     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0x14)
 67611 blazer_usb GIO   fd 2 wrote 20 bytes
       "- Product: USB Card
       "
 67611 blazer_usb RET   write 20/0x14
 67611 blazer_usb CALL  gettimeofday(0x7fffffffcb80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.035821     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0x19)
 67611 blazer_usb GIO   fd 2 wrote 25 bytes
       "- Serial Number: unknown
       "
 67611 blazer_usb RET   write 25/0x19
 67611 blazer_usb CALL  gettimeofday(0x7fffffffcb80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.035854     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0x10)
 67611 blazer_usb GIO   fd 2 wrote 16 bytes
       "- Bus: /dev/usb
       "
 67611 blazer_usb RET   write 16/0x10
 67611 blazer_usb CALL  gettimeofday(0x7fffffffcb80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.035884     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0x17)
 67611 blazer_usb GIO   fd 2 wrote 23 bytes
       "Trying to match device
       "
 67611 blazer_usb RET   write 23/0x17
 67611 blazer_usb CALL  gettimeofday(0x7fffffffcb80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.035919     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffc0f0,0xf)
 67611 blazer_usb GIO   fd 2 wrote 15 bytes
       "Device matches
       "
 67611 blazer_usb RET   write 15/0xf
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_UNINIT,0x7fffffffcc57)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x4,USB_SET_ALTINTERFACE,0x7fffffffcc60)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_INIT,0x7fffffffcc30)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  gettimeofday(0x7fffffffe1f0,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffd760,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.036021     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffd760,0x1b)
 67611 blazer_usb GIO   fd 2 wrote 27 bytes
       "Trying megatec protocol...
       "
 67611 blazer_usb RET   write 27/0x1b
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffdde0)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  gettimeofday(0x7fffffffdd30,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffd2a0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.039685     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffd2a0,0x9)
 67611 blazer_usb GIO   fd 2 wrote 9 bytes
       "send: Q1
       "
 67611 blazer_usb RET   write 9
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_OPEN,0x7fffffffdd50)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_START,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  poll(0x7fffffffdde0,0x1,0xffffffff)
 67611 blazer_usb RET   poll 1
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_START,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  poll(0x7fffffffdde0,0x1,0xffffffff)
 67611 blazer_usb RET   poll 1
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_START,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  poll(0x7fffffffdde0,0x1,0xffffffff)
 67611 blazer_usb RET   poll 1
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_START,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  poll(0x7fffffffdde0,0x1,0xffffffff)
 67611 blazer_usb RET   poll 1
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_START,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  poll(0x7fffffffdde0,0x1,0xffffffff)
 67611 blazer_usb RET   poll 1
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_START,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  poll(0x7fffffffdde0,0x1,0xffffffff)
 67611 blazer_usb RET   poll 1
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl 0
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_COMPLETE,0x7fffffffdde7)
 67611 blazer_usb RET   ioctl -1 errno 16 Device busy
 67611 blazer_usb CALL  gettimeofday(0x7fffffffdd30,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffd2a0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.280697     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffd2a0,0x35)
 67611 blazer_usb GIO   fd 2 wrote 53 bytes
       "read: (229.6 219.5 220.0 021 49.7 2.25 18.5 00000001
       "
 67611 blazer_usb RET   write 53/0x35
 67611 blazer_usb CALL  gettimeofday(0x7fffffffe1f0,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffd760,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.280825     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffd760,0x17)
 67611 blazer_usb GIO   fd 2 wrote 23 bytes
       "Status read in 1 tries
       "
 67611 blazer_usb RET   write 23/0x17
 67611 blazer_usb CALL  gettimeofday(0x7fffffffe1f0,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffd760,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   0.280856     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffd760,0x2d)
 67611 blazer_usb GIO   fd 2 wrote 45 bytes
       "Supported UPS detected with megatec protocol
       "
 67611 blazer_usb RET   write 45/0x2d
 67611 blazer_usb CALL  ioctl(0x4,USB_DO_REQUEST,0x7fffffffe030)
 67611 blazer_usb RET   ioctl -1 errno 5 Input/output error
 67611 blazer_usb CALL  gettimeofday(0x7fffffffdf80,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffd4f0,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   1.368549     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffd4f0,0x14)
 67611 blazer_usb GIO   fd 2 wrote 20 bytes
       "send: Unknown error
       "
 67611 blazer_usb RET   write 20/0x14
 67611 blazer_usb CALL  stat(0x7fffffffd880,0x7fffffffdc80)
 67611 blazer_usb NAMI  "/usr/share/nls/C/libc.cat"
 67611 blazer_usb RET   stat -1 errno 2 No such file or directory
 67611 blazer_usb CALL  stat(0x7fffffffd880,0x7fffffffdc80)
 67611 blazer_usb NAMI  "/usr/share/nls/libc/C"
 67611 blazer_usb RET   stat -1 errno 2 No such file or directory
 67611 blazer_usb CALL  stat(0x7fffffffd880,0x7fffffffdc80)
 67611 blazer_usb NAMI  "/usr/local/share/nls/C/libc.cat"
 67611 blazer_usb RET   stat -1 errno 2 No such file or directory
 67611 blazer_usb CALL  stat(0x7fffffffd880,0x7fffffffdc80)
 67611 blazer_usb NAMI  "/usr/local/share/nls/libc/C"
 67611 blazer_usb RET   stat -1 errno 2 No such file or directory
 67611 blazer_usb CALL  gettimeofday(0x7fffffffe1b0,0)
 67611 blazer_usb RET   gettimeofday 0
 67611 blazer_usb CALL  write(0x2,0x7fffffffd720,0xc)
 67611 blazer_usb GIO   fd 2 wrote 12 bytes
       "   1.368772     "
 67611 blazer_usb RET   write 12/0xc
 67611 blazer_usb CALL  write(0x2,0x7fffffffd720,0x28)
 67611 blazer_usb GIO   fd 2 wrote 40 bytes
       "Permissions problem: Input/output error
       "
 67611 blazer_usb RET   write 40/0x28
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_CLOSE,0x7fffffffe0b7)
 67611 blazer_usb RET   ioctl -1 errno 6 Device not configured
 67611 blazer_usb CALL  ioctl(0x5,USB_FS_UNINIT,0x7fffffffe0cf)
 67611 blazer_usb RET   ioctl -1 errno 6 Device not configured
 67611 blazer_usb CALL  madvise(0x80149f000,0x2000,MADV_FREE)
 67611 blazer_usb RET   madvise 0
 67611 blazer_usb CALL  madvise(0x80147e000,0x1000,MADV_FREE)
 67611 blazer_usb RET   madvise 0
 67611 blazer_usb CALL  close(0x5)
 67611 blazer_usb RET   close -1 errno 6 Device not configured
 67611 blazer_usb CALL  close(0x4)
 67611 blazer_usb RET   close -1 errno 6 Device not configured
 67611 blazer_usb CALL  madvise(0x801495000,0x1000,MADV_FREE)
 67611 blazer_usb RET   madvise 0
 67611 blazer_usb CALL  madvise(0x80148d000,0x1000,MADV_FREE)
 67611 blazer_usb RET   madvise 0
 67611 blazer_usb CALL  madvise(0x801460000,0x1000,MADV_FREE)
 67611 blazer_usb RET   madvise 0
 67611 blazer_usb CALL  sigprocmask(SIG_BLOCK,0x800829720,0x7fffffffe050)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_SETMASK,0x800829730,0)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_BLOCK,0x800829720,0x7fffffffe000)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_SETMASK,0x800829730,0)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_BLOCK,0x800829720,0x7fffffffe000)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_SETMASK,0x800829730,0)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_BLOCK,0x800829720,0x7fffffffe000)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_SETMASK,0x800829730,0)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_BLOCK,0x800829720,0x7fffffffe000)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_SETMASK,0x800829730,0)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_BLOCK,0x800829720,0x7fffffffe000)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  sigprocmask(SIG_SETMASK,0x800829730,0)
 67611 blazer_usb RET   sigprocmask 0
 67611 blazer_usb CALL  exit(0x1)



It appears that there is a problem with reading/writing to the usb for this
ups.

NOTE: I tried the UPS with my laptop running mint linux and nut 2.7.1 and
there were no problems with the USB interface.


Any ideas?




____________________________________________________________
South Africas premier free email service - www.webmail.co.za





More information about the Nut-upsuser mailing list