Scan traces 131 -

INFO 2018-04-18 21:59:42,923 ironscanner.main Initializing pyinsane2 ...

PYDEV DEBUGGER WARNING:
sys.settrace() should not be used when the debugger is being used.
This may cause the debugger to stop working correctly.
If this is needed, please check:
http://pydev.blogspot.com/2007/06/why-cant-pydev-debugger-work-with.html
to see how to restore the debug tracing back correctly.
Call Location:
File "/home/konrad/Projekte/Paperwork/debug/ironscanner/src/ironscanner/trace.py", line 33, in run
sys.settrace(self._trace)


PYDEV DEBUGGER WARNING:
sys.settrace() should not be used when the debugger is being used.
This may cause the debugger to stop working correctly.
If this is needed, please check:
http://pydev.blogspot.com/2007/06/why-cant-pydev-debugger-work-with.html
to see how to restore the debug tracing back correctly.
Call Location:
File "/home/konrad/Projekte/Paperwork/debug/ironscanner/src/ironscanner/trace.py", line 22, in _trace
sys.settrace(None)

DEBUG 2018-04-18 21:59:42,934 ironscanner.trace /home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract_proc.py:init()@87[TraceThread(<function init at 0x7f2fa33a1c80>)]
INFO 2018-04-18 21:59:42,934 pyinsane2.sane.abstract_proc Starting Pyinsane subprocess
INFO 2018-04-18 21:59:42,934 pyinsane2.sane.abstract_proc Pyinsane pipes: /tmp/pyinsane_5pcfore7/pipe_c2s | /tmp/pyinsane_5pcfore7/pipe_s2c
pydev debugger: process 7872 is connecting

[sanei_debug] Setting debug level of dll to 255.
[dll] sane_init: SANE dll backend version 1.0.13 from sane-backends 1.0.27
[dll] sane_init/read_dlld: attempting to open directory `./dll.d'
[dll] sane_init/read_dlld: attempting to open directory `/etc/sane.d/dll.d'
[dll] sane_init/read_dlld: using config directory `/etc/sane.d/dll.d'
[dll] sane_init/read_dlld: considering /etc/sane.d/dll.d/hplip
[dll] sane_init/read_config: reading dll.d/hplip
[dll] add_backend: adding backend `hpaio'
[dll] sane_init/read_dlld: done.
[dll] sane_init/read_config: reading dll.conf
[dll] add_backend: adding backend `net'
[dll] add_backend: adding backend `abaton'
[dll] add_backend: adding backend `agfafocus'
[dll] add_backend: adding backend `apple'
[dll] add_backend: adding backend `avision'
[dll] add_backend: adding backend `artec'
[dll] add_backend: adding backend `artec_eplus48u'
[dll] add_backend: adding backend `as6e'
[dll] add_backend: adding backend `bh'
[dll] add_backend: adding backend `canon'
[dll] add_backend: adding backend `canon630u'
[dll] add_backend: adding backend `canon_dr'
[dll] add_backend: adding backend `cardscan'
[dll] add_backend: adding backend `coolscan'
[dll] add_backend: adding backend `coolscan3'
[dll] add_backend: adding backend `dell1600n_net'
[dll] add_backend: adding backend `dmc'
[dll] add_backend: adding backend `epjitsu'
[dll] add_backend: adding backend `epson2'
[dll] add_backend: adding backend `epsonds'
[dll] add_backend: adding backend `fujitsu'
[dll] add_backend: adding backend `genesys'
[dll] add_backend: adding backend `gt68xx'
[dll] add_backend: adding backend `hp'
[dll] add_backend: adding backend `hp3900'
[dll] add_backend: adding backend `hpsj5s'
[dll] add_backend: adding backend `hp3500'
[dll] add_backend: adding backend `hp4200'
[dll] add_backend: adding backend `hp5400'
[dll] add_backend: adding backend `hp5590'
[dll] add_backend: adding backend `hpljm1005'
[dll] add_backend: adding backend `hs2p'
[dll] add_backend: adding backend `ibm'
[dll] add_backend: adding backend `kodak'
[dll] add_backend: adding backend `kodakaio'
[dll] add_backend: adding backend `kvs1025'
[dll] add_backend: adding backend `kvs20xx'
[dll] add_backend: adding backend `leo'
[dll] add_backend: adding backend `lexmark'
[dll] add_backend: adding backend `ma1509'
[dll] add_backend: adding backend `magicolor'
[dll] add_backend: adding backend `matsushita'
[dll] add_backend: adding backend `microtek'
[dll] add_backend: adding backend `microtek2'
[dll] add_backend: adding backend `mustek'
[dll] add_backend: adding backend `mustek_usb'
[dll] add_backend: adding backend `mustek_usb2'
[dll] add_backend: adding backend `nec'
[dll] add_backend: adding backend `niash'
[dll] add_backend: adding backend `pie'
[dll] add_backend: adding backend `pixma'
[dll] add_backend: adding backend `plustek'
[dll] add_backend: adding backend `qcam'
[dll] add_backend: adding backend `ricoh'
[dll] add_backend: adding backend `rts8891'
[dll] add_backend: adding backend `s9036'
[dll] add_backend: adding backend `sceptre'
[dll] add_backend: adding backend `sharp'
[dll] add_backend: adding backend `sm3600'
[dll] add_backend: adding backend `sm3840'
[dll] add_backend: adding backend `snapscan'
[dll] add_backend: adding backend `sp15c'
[dll] add_backend: adding backend `tamarack'
[dll] add_backend: adding backend `teco1'
[dll] add_backend: adding backend `teco2'
[dll] add_backend: adding backend `teco3'
[dll] add_backend: adding backend `u12'
[dll] add_backend: adding backend `umax'
[dll] add_backend: adding backend `umax1220u'
[dll] add_backend: adding backend `v4l'
[dll] add_backend: adding backend `xerox_mfp'
[dll] add_backend: adding backend `brother3'
INFO 2018-04-18 21:59:43,954 pyinsane2.sane.abstract_proc Connected to Pyinsane subprocess

PYDEV DEBUGGER WARNING:
sys.settrace() should not be used when the debugger is being used.
This may cause the debugger to stop working correctly.
If this is needed, please check:
http://pydev.blogspot.com/2007/06/why-cant-pydev-debugger-work-with.html
to see how to restore the debug tracing back correctly.
Call Location:
File "/home/konrad/Projekte/Paperwork/debug/ironscanner/src/ironscanner/trace.py", line 35, in run
self.ret = self.func(*self.args, **self.kwargs)

INFO Pyinsane_daemon Ready
INFO 2018-04-18 21:59:43,955 ironscanner.main Pyinsane2 ready
DEBUG 2018-04-18 21:59:43,960 ironscanner.util For filename 'mainform.glade' got file '/home/konrad/Projekte/Paperwork/debug/ironscanner/src/ironscanner/mainform.glade'
/home/konrad/Projekte/Paperwork/debug/ironscanner/src/ironscanner/util.py:75: Warning: g_value_type_transformable: assertion 'G_TYPE_IS_VALUE (src_type)' failed
widget_tree.add_from_file(ui_file)

(launcher.py:7867): Gtk-WARNING **: /build/gtk+3.0-wTY3BU/gtk+3.0-3.22.25/./gtk/gtkliststore.c:836: Unable to convert from (null) to gchararray

(launcher.py:7867): Gtk-CRITICAL **: gtk_assistant_set_page_has_padding: assertion 'child != NULL' failed
WARNING 2018-04-18 21:59:44,204 ironscanner.main version.txt file is missing
WARNING 2018-04-18 21:59:44,204 ironscanner.main Please run 'make' first
DEBUG 2018-04-18 21:59:44,209 ironscanner.util For filename 'logo.png' got file '/home/konrad/Projekte/Paperwork/debug/ironscanner/src/ironscanner/logo.png'
INFO 2018-04-18 22:00:23,885 ironscanner.main Looking for scanners ...
DEBUG 2018-04-18 22:00:23,888 ironscanner.trace /home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract_proc.py:get_devices()@275[TraceThread(<function get_devices at 0x7f2fa33a1d90>)]
[dll] sane_get_devices
[dll] load: searching backend `brother3' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-brother3.so.1'
[dll] load: couldn't open `/usr/lib/x86_64-linux-gnu/sane/libsane-brother3.so.1' (No such file or directory)
[dll] load: couldn't find backend `brother3' (No such file or directory)
[dll] load: searching backend `xerox_mfp' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-xerox_mfp.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-xerox_mfp.so.1'
[dll] init: initializing backend `xerox_mfp'
[dll] init: backend `xerox_mfp' is version 1.0.13
[dll] load: searching backend `v4l' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-v4l.so.1'
[dll] load: couldn't open `/usr/lib/x86_64-linux-gnu/sane/libsane-v4l.so.1' (No such file or directory)
[dll] load: couldn't find backend `v4l' (No such file or directory)
[dll] load: searching backend `umax1220u' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-umax1220u.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-umax1220u.so.1'
[dll] init: initializing backend `umax1220u'
[dll] init: backend `umax1220u' is version 1.0.2
[dll] load: searching backend `umax' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-umax.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-umax.so.1'
[dll] init: initializing backend `umax'
[dll] init: backend `umax' is version 1.0.45
[dll] load: searching backend `u12' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-u12.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-u12.so.1'
[dll] init: initializing backend `u12'
[dll] init: backend `u12' is version 1.0.0
[dll] load: searching backend `teco3' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-teco3.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-teco3.so.1'
[dll] init: initializing backend `teco3'
[dll] init: backend `teco3' is version 1.0.1
[dll] load: searching backend `teco2' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-teco2.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-teco2.so.1'
[dll] init: initializing backend `teco2'
[dll] init: backend `teco2' is version 1.0.10
[dll] load: searching backend `teco1' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-teco1.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-teco1.so.1'
[dll] init: initializing backend `teco1'
[dll] init: backend `teco1' is version 1.0.10
[dll] load: searching backend `tamarack' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-tamarack.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-tamarack.so.1'
[dll] init: initializing backend `tamarack'
[dll] init: backend `tamarack' is version 1.0.0
[dll] load: searching backend `sp15c' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-sp15c.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-sp15c.so.1'
[dll] init: initializing backend `sp15c'
[dll] init: backend `sp15c' is version 1.0.0
[dll] load: searching backend `snapscan' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-snapscan.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-snapscan.so.1'
[dll] init: initializing backend `snapscan'
[dll] init: backend `snapscan' is version 1.4.53
[dll] load: searching backend `sm3840' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-sm3840.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-sm3840.so.1'
[dll] init: initializing backend `sm3840'
[dll] init: backend `sm3840' is version 1.0.0
[dll] load: searching backend `sm3600' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-sm3600.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-sm3600.so.1'
[dll] init: initializing backend `sm3600'
[dll] init: backend `sm3600' is version 1.0.6
[dll] load: searching backend `sharp' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-sharp.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-sharp.so.1'
[dll] init: initializing backend `sharp'
[dll] init: backend `sharp' is version 1.0.0
[dll] load: searching backend `sceptre' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-sceptre.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-sceptre.so.1'
[dll] init: initializing backend `sceptre'
[dll] init: backend `sceptre' is version 1.0.10
[dll] load: searching backend `s9036' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-s9036.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-s9036.so.1'
[dll] init: initializing backend `s9036'
[dll] init: backend `s9036' is version 1.0.0
[dll] load: searching backend `rts8891' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-rts8891.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-rts8891.so.1'
[dll] init: initializing backend `rts8891'
[dll] init: backend `rts8891' is version 1.0.2401
[dll] load: searching backend `ricoh' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-ricoh.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-ricoh.so.1'
[dll] init: initializing backend `ricoh'
[dll] init: backend `ricoh' is version 1.0.0
[dll] load: searching backend `qcam' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-qcam.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-qcam.so.1'
[dll] init: initializing backend `qcam'
[dll] init: backend `qcam' is version 1.0.0
[dll] load: searching backend `plustek' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-plustek.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-plustek.so.1'
[dll] init: initializing backend `plustek'
[dll] init: backend `plustek' is version 1.0.0
[dll] load: searching backend `pixma' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-pixma.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-pixma.so.1'
[dll] init: initializing backend `pixma'
[dll] init: backend `pixma' is version 1.0.17
[dll] load: searching backend `pie' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-pie.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-pie.so.1'
[dll] init: initializing backend `pie'
[dll] init: backend `pie' is version 1.0.9
[dll] load: searching backend `niash' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-niash.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-niash.so.1'
[dll] init: initializing backend `niash'
[dll] init: backend `niash' is version 1.0.1
[dll] load: searching backend `nec' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-nec.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-nec.so.1'
[dll] init: initializing backend `nec'
[dll] init: backend `nec' is version 1.0.0
[dll] load: searching backend `mustek_usb2' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-mustek_usb2.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-mustek_usb2.so.1'
[dll] init: initializing backend `mustek_usb2'
[dll] init: backend `mustek_usb2' is version 1.0.10
[dll] load: searching backend `mustek_usb' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-mustek_usb.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-mustek_usb.so.1'
[dll] init: initializing backend `mustek_usb'
[dll] init: backend `mustek_usb' is version 1.0.18
[dll] load: searching backend `mustek' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-mustek.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-mustek.so.1'
[dll] init: initializing backend `mustek'
[dll] init: backend `mustek' is version 1.0.138
[dll] load: searching backend `microtek2' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-microtek2.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-microtek2.so.1'
[dll] init: initializing backend `microtek2'
[dll] init: backend `microtek2' is version 1.0.0
[dll] load: searching backend `microtek' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-microtek.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-microtek.so.1'
[dll] init: initializing backend `microtek'
[dll] init: backend `microtek' is version 1.0.0
[dll] load: searching backend `matsushita' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-matsushita.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-matsushita.so.1'
[dll] init: initializing backend `matsushita'
[dll] init: backend `matsushita' is version 1.0.7
[dll] load: searching backend `magicolor' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-magicolor.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-magicolor.so.1'
[dll] init: initializing backend `magicolor'
[dll] init: backend `magicolor' is version 1.0.1
[dll] load: searching backend `ma1509' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-ma1509.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-ma1509.so.1'
[dll] init: initializing backend `ma1509'
[dll] init: backend `ma1509' is version 1.0.3
[dll] load: searching backend `lexmark' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-lexmark.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-lexmark.so.1'
[dll] init: initializing backend `lexmark'
[sanei_debug] Setting debug level of lexmark to 255.
[lexmark] SANE Lexmark backend version 1.0.32-devel
[lexmark] sane_init: version_code=0x7ffc8a7bf6d4
[dll] init: backend `lexmark' is version 1.0.32
[lexmark] sane_get_devices: device_list=0x7ffc8a7bf740, local_only=0
[dll] load: searching backend `leo' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-leo.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-leo.so.1'
[dll] init: initializing backend `leo'
[dll] init: backend `leo' is version 1.0.11
[dll] load: searching backend `kvs20xx' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-kvs20xx.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-kvs20xx.so.1'
[dll] init: initializing backend `kvs20xx'
[dll] init: backend `kvs20xx' is version 1.0.2
[dll] load: searching backend `kvs1025' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-kvs1025.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-kvs1025.so.1'
[dll] init: initializing backend `kvs1025'
[dll] init: backend `kvs1025' is version 1.0.5
[dll] load: searching backend `kodakaio' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-kodakaio.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-kodakaio.so.1'
[dll] init: initializing backend `kodakaio'
[dll] init: backend `kodakaio' is version 1.0.3
[dll] load: searching backend `kodak' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-kodak.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-kodak.so.1'
[dll] init: initializing backend `kodak'
[dll] init: backend `kodak' is version 1.0.7
[dll] load: searching backend `ibm' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-ibm.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-ibm.so.1'
[dll] init: initializing backend `ibm'
[dll] init: backend `ibm' is version 1.0.0
[dll] load: searching backend `hs2p' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hs2p.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hs2p.so.1'
[dll] init: initializing backend `hs2p'
[dll] init: backend `hs2p' is version 1.0.0
[dll] load: searching backend `hpljm1005' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hpljm1005.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hpljm1005.so.1'
[dll] init: initializing backend `hpljm1005'
[dll] init: backend `hpljm1005' is version 1.0.1
[dll] load: searching backend `hp5590' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hp5590.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hp5590.so.1'
[dll] init: initializing backend `hp5590'
[dll] init: backend `hp5590' is version 1.0.7
[dll] load: searching backend `hp5400' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hp5400.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hp5400.so.1'
[dll] init: initializing backend `hp5400'
[dll] init: backend `hp5400' is version 1.0.3
[dll] load: searching backend `hp4200' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hp4200.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hp4200.so.1'
[dll] init: initializing backend `hp4200'
[dll] init: backend `hp4200' is version 1.0.0
[dll] load: searching backend `hp3500' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hp3500.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hp3500.so.1'
[dll] init: initializing backend `hp3500'
[dll] init: backend `hp3500' is version 1.0.0
[dll] load: searching backend `hpsj5s' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hpsj5s.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hpsj5s.so.1'
[dll] init: initializing backend `hpsj5s'
[dll] init: backend `hpsj5s' is version 1.0.3
[dll] load: searching backend `hp3900' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hp3900.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hp3900.so.1'
[dll] init: initializing backend `hp3900'
[dll] init: backend `hp3900' is version 1.0.0
[dll] load: searching backend `hp' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hp.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hp.so.1'
[dll] init: initializing backend `hp'
[dll] init: backend `hp' is version 1.0.8
[dll] load: searching backend `gt68xx' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-gt68xx.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-gt68xx.so.1'
[dll] init: initializing backend `gt68xx'
[dll] init: backend `gt68xx' is version 1.0.84
[dll] load: searching backend `genesys' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-genesys.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-genesys.so.1'
[dll] init: initializing backend `genesys'
[dll] init: backend `genesys' is version 1.0.2511
[dll] load: searching backend `fujitsu' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-fujitsu.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-fujitsu.so.1'
[dll] init: initializing backend `fujitsu'
[sanei_debug] Setting debug level of fujitsu to 20.
[fujitsu] sane_init: start
[fujitsu] sane_init: fujitsu backend 1.0.133, from sane-backends 1.0.27
[fujitsu] sane_init: finish
[dll] init: backend `fujitsu' is version 1.0.133
[fujitsu] sane_get_devices: start
[fujitsu] sane_get_devices: reading config file fujitsu.conf
[fujitsu] sane_get_devices: setting "buffer-size" to 65536
[fujitsu] sane_get_devices: looking for 'scsi FUJITSU'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1041'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1042'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1078'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1095'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1096'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1097'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10ad'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10ae'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10af'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10cf'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10e0'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10e1'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10e2'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10e6'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10e7'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10f2'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x10fe'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1135'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x114a'
[fujitsu] sane_get_devices: config option "buffer-size" (262144) is > 65536, warning!
[fujitsu] sane_get_devices: setting "buffer-size" to 262144
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x114d'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x114e'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x114f'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1150'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1155'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x116f'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1174'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1175'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1176'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1177'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1178'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x119d'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x119e'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x11a2'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x11ee'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x11ef'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x11f1'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x11f2'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x11f3'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x11f4'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x11fc'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1213'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x128e'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x132b'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x132c'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x132d'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x132e'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x132f'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x13f3'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x13f4'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1409'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x140a'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x140c'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x145f'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1460'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1461'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1462'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1463'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1464'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x146b'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x146c'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x146d'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x146e'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x146f'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14ac'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14b8'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14bd'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14be'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14df'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14e0'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14e1'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14e2'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14e3'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14e4'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14e5'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14e6'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14e7'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x14e8'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x151e'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x151f'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1520'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1521'
[fujitsu] sane_get_devices: looking for 'usb 0x04c5 0x1522'
[fujitsu] sane_get_devices: found 0 scanner(s)
[fujitsu] sane_get_devices: finish
[dll] load: searching backend `epsonds' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-epsonds.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-epsonds.so.1'
[dll] init: initializing backend `epsonds'
[dll] init: backend `epsonds' is version 1.0.0
[dll] load: searching backend `epson2' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-epson2.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-epson2.so.1'
[dll] init: initializing backend `epson2'
[sanei_debug] Setting debug level of epson2 to 64.
[epson2] sane_epson2_init: sane-backends 1.0.27
[epson2] epson2 backend, version 1.0.124
[dll] init: backend `epson2' is version 1.0.124
[epson2] sane_epson2_get_devices
[epson2] probe_devices
[epson2] free_devices
[epson2] attach_one_config: len = 10, line = scsi EPSON
[epson2] attach_one_config: len = 3, line = usb
[epson2] attach_one_config: len = 17, line = net autodiscovery
[epson2] e2_network_discovery, sent discovery packet
[epson2] e2_network_discovery, end
[epson2] sane_epson2_get_devices - results:
[dll] load: searching backend `epjitsu' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-epjitsu.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-epjitsu.so.1'
[dll] init: initializing backend `epjitsu'
[sanei_debug] Setting debug level of epjitsu to 20.
[epjitsu] sane_init: start
[epjitsu] sane_init: epjitsu backend 1.0.31, from sane-backends 1.0.27
[epjitsu] sane_init: finish
[dll] init: backend `epjitsu' is version 1.0.31
[epjitsu] sane_get_devices: start
[epjitsu] sane_get_devices: reading config file epjitsu.conf
[epjitsu] sane_get_devices: firmware '/usr/local/lib/epjitsu-firmware/1300i_0D12.nal'
[epjitsu] sane_get_devices: looking for 'usb 0x04c5 0x128d'
[epjitsu] attach_one: start 'libusb:003:008'
[epjitsu] attach_one: init struct
[epjitsu] attach_one: connect fd
[epjitsu] connect_fd: start
[epjitsu] connect_fd: opening USB device
[epjitsu] connect_fd: finish
[epjitsu] load_fw: start
[epjitsu] get_stat: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] load_fw: firmware already loaded?
[epjitsu] get_ident: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] get_ident: finish
[epjitsu] attach_one: Found FUJITSU scanner ScanSnap S1300i at libusb:003:008
[epjitsu] attach_one: Found S1300i
[epjitsu] get_stat: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] attach_one: on USB power?
[epjitsu] attach_one: init options
[epjitsu] attach_one: init settings
[epjitsu] change_params: start
[epjitsu] change_params: finish
[epjitsu] disconnect_fd: start
[epjitsu] disconnecting usb device
[epjitsu] disconnect_fd: finish
[epjitsu] attach_one: finish
[epjitsu] sane_get_devices: found scanner libusb:003:008
[epjitsu] sane_get_devices: found 1 scanner(s)
[epjitsu] sane_get_devices: finish
[dll] load: searching backend `dmc' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-dmc.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-dmc.so.1'
[dll] init: initializing backend `dmc'
[dll] init: backend `dmc' is version 1.0.0
[dll] load: searching backend `dell1600n_net' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-dell1600n_net.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-dell1600n_net.so.1'
[dll] init: initializing backend `dell1600n_net'
[dll] init: backend `dell1600n_net' is version 1.0.0
[dll] load: searching backend `coolscan3' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-coolscan3.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-coolscan3.so.1'
[dll] init: initializing backend `coolscan3'
[dll] init: backend `coolscan3' is version 1.0.0
[dll] load: searching backend `coolscan' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-coolscan.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-coolscan.so.1'
[dll] init: initializing backend `coolscan'
[dll] init: backend `coolscan' is version 1.0.0
[dll] load: searching backend `cardscan' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-cardscan.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-cardscan.so.1'
[dll] init: initializing backend `cardscan'
[dll] init: backend `cardscan' is version 1.0.3
[dll] load: searching backend `canon_dr' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-canon_dr.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-canon_dr.so.1'
[dll] init: initializing backend `canon_dr'
[dll] init: backend `canon_dr' is version 1.0.56
[dll] load: searching backend `canon630u' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-canon630u.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-canon630u.so.1'
[dll] init: initializing backend `canon630u'
[dll] init: backend `canon630u' is version 1.0.1
[dll] load: searching backend `canon' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-canon.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-canon.so.1'
[dll] init: initializing backend `canon'
[sanei_debug] Setting debug level of canon to 4.
[canon] >> sane_init
[canon] sane_init: sane-backends 1.0.27
[canon] << sane_init
[dll] init: backend `canon' is version 1.0.0
[canon] >> sane_get_devices
[canon] << sane_get_devices
[dll] load: searching backend `bh' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-bh.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-bh.so.1'
[dll] init: initializing backend `bh'
[dll] init: backend `bh' is version 1.0.4
[dll] load: searching backend `as6e' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-as6e.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-as6e.so.1'
[dll] init: initializing backend `as6e'
[dll] load: searching backend `artec_eplus48u' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-artec_eplus48u.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-artec_eplus48u.so.1'
[dll] init: initializing backend `artec_eplus48u'
[dll] init: backend `artec_eplus48u' is version 1.0.0
[dll] load: searching backend `artec' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-artec.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-artec.so.1'
[dll] init: initializing backend `artec'
[dll] init: backend `artec' is version 1.0.0
[dll] load: searching backend `avision' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-avision.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-avision.so.1'
[dll] init: initializing backend `avision'
[dll] init: backend `avision' is version 1.0.297
[dll] load: searching backend `apple' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-apple.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-apple.so.1'
[dll] init: initializing backend `apple'
[dll] init: backend `apple' is version 1.0.0
[dll] load: searching backend `agfafocus' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-agfafocus.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-agfafocus.so.1'
[dll] init: initializing backend `agfafocus'
[dll] init: backend `agfafocus' is version 1.0.0
[dll] load: searching backend `abaton' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-abaton.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-abaton.so.1'
[dll] init: initializing backend `abaton'
[dll] init: backend `abaton' is version 1.0.0
[dll] load: searching backend `net' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-net.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-net.so.1'
[dll] init: initializing backend `net'
[dll] init: backend `net' is version 1.0.27
[dll] load: searching backend `hpaio' in `/usr/lib/x86_64-linux-gnu/sane'
[dll] load: trying to load `/usr/lib/x86_64-linux-gnu/sane/libsane-hpaio.so.1'
[dll] load: dlopen()ing `/usr/lib/x86_64-linux-gnu/sane/libsane-hpaio.so.1'
[dll] init: initializing backend `hpaio'
[dll] init: backend `hpaio' is version 1.0.0
[dll] sane_get_devices: found 2 devices

PYDEV DEBUGGER WARNING:
sys.settrace() should not be used when the debugger is being used.
This may cause the debugger to stop working correctly.
If this is needed, please check:
http://pydev.blogspot.com/2007/06/why-cant-pydev-debugger-work-with.html
to see how to restore the debug tracing back correctly.
Call Location:
File "/home/konrad/Projekte/Paperwork/debug/ironscanner/src/ironscanner/trace.py", line 48, in run
sys.settrace(None)

INFO 2018-04-18 22:00:30,261 ironscanner.main 2 scanners found
INFO 2018-04-18 22:00:30,263 ironscanner.main epjitsu:libusb:003:008 -> FUJITSU ScanSnap S1300i (epjitsu:libusb:003:008)
INFO 2018-04-18 22:00:30,264 ironscanner.main hpaio:/net/HP_Officejet_Pro_8610?zc=HPFC15B49FB935 -> Hewlett-Packard HP_Officejet_Pro_8610 (hpaio:/net/HP_Officejet_Pro_8610?zc=HPFC15B49FB935)
INFO 2018-04-18 22:00:30,269 ironscanner.main Selected scanner: epjitsu:libusb:003:008
[dll] sane_open: trying to open `epjitsu:libusb:003:008'
[epjitsu] sane_open: start
[epjitsu] sane_open: searching currently attached scanners
[epjitsu] sane_open: device libusb:003:008 requested, attaching
[epjitsu] sane_open: device libusb:003:008 found
[epjitsu] connect_fd: start
[epjitsu] connect_fd: opening USB device
[epjitsu] connect_fd: finish
[epjitsu] sane_open: finish
[dll] sane_open: open successful
[dll] sane_get_option_descriptor(handle=0x2caf450,option=0)
[epjitsu] sane_get_option_descriptor: 0
[dll] sane_control_option(handle=0x2caf450,option=0,action=0,value=0x7fc9644b4bc0,info=0x7fc9644b4cd0)
[epjitsu] sane_control_option: get value for '' (0)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=1)
[epjitsu] sane_get_option_descriptor: 1
[dll] sane_get_option_descriptor(handle=0x2caf450,option=2)
[epjitsu] sane_get_option_descriptor: 2
[dll] sane_get_option_descriptor(handle=0x2caf450,option=3)
[epjitsu] sane_get_option_descriptor: 3
[dll] sane_get_option_descriptor(handle=0x2caf450,option=4)
[epjitsu] sane_get_option_descriptor: 4
[dll] sane_get_option_descriptor(handle=0x2caf450,option=5)
[epjitsu] sane_get_option_descriptor: 5
[dll] sane_get_option_descriptor(handle=0x2caf450,option=6)
[epjitsu] sane_get_option_descriptor: 6
[dll] sane_get_option_descriptor(handle=0x2caf450,option=7)
[epjitsu] sane_get_option_descriptor: 7
[dll] sane_get_option_descriptor(handle=0x2caf450,option=8)
[epjitsu] sane_get_option_descriptor: 8
[dll] sane_get_option_descriptor(handle=0x2caf450,option=9)
[epjitsu] sane_get_option_descriptor: 9
[dll] sane_get_option_descriptor(handle=0x2caf450,option=10)
[epjitsu] sane_get_option_descriptor: 10
[dll] sane_get_option_descriptor(handle=0x2caf450,option=11)
[epjitsu] sane_get_option_descriptor: 11
[dll] sane_get_option_descriptor(handle=0x2caf450,option=12)
[epjitsu] sane_get_option_descriptor: 12
[dll] sane_get_option_descriptor(handle=0x2caf450,option=13)
[epjitsu] sane_get_option_descriptor: 13
[dll] sane_get_option_descriptor(handle=0x2caf450,option=14)
[epjitsu] sane_get_option_descriptor: 14
[dll] sane_get_option_descriptor(handle=0x2caf450,option=15)
[epjitsu] sane_get_option_descriptor: 15
[dll] sane_get_option_descriptor(handle=0x2caf450,option=16)
[epjitsu] sane_get_option_descriptor: 16
[dll] sane_get_option_descriptor(handle=0x2caf450,option=17)
[epjitsu] sane_get_option_descriptor: 17
[dll] sane_get_option_descriptor(handle=0x2caf450,option=18)
[epjitsu] sane_get_option_descriptor: 18
[dll] sane_get_option_descriptor(handle=0x2caf450,option=19)
[epjitsu] sane_get_option_descriptor: 19
[dll] sane_get_option_descriptor(handle=0x2caf450,option=20)
[epjitsu] sane_get_option_descriptor: 20
[dll] sane_get_option_descriptor(handle=0x2caf450,option=21)
[epjitsu] sane_get_option_descriptor: 21
[dll] sane_get_option_descriptor(handle=0x2caf450,option=22)
[epjitsu] sane_get_option_descriptor: 22
[dll] sane_get_option_descriptor(handle=0x2caf450,option=23)
[epjitsu] sane_get_option_descriptor: 23
INFO 2018-04-18 22:00:30,276 ironscanner.main Option: source
INFO 2018-04-18 22:00:30,278 ironscanner.main Title: Scan source
INFO 2018-04-18 22:00:30,278 ironscanner.main Desc: Selects the scan source (such as a document-feeder).
INFO 2018-04-18 22:00:30,279 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO 2018-04-18 22:00:30,279 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,279 ironscanner.main Size: 11
INFO 2018-04-18 22:00:30,280 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,280 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO 2018-04-18 22:00:30,280 ironscanner.main Constraint: ['ADF Front', 'ADF Back', 'ADF Duplex']
[dll] sane_get_option_descriptor(handle=0x2caf450,option=2)
[epjitsu] sane_get_option_descriptor: 2
[dll] sane_control_option(handle=0x2caf450,option=2,action=0,value=0x7fc9644b4de0,info=0x7fc9644b4e68)
[epjitsu] sane_control_option: get value for 'source' (2)
INFO 2018-04-18 22:00:30,281 ironscanner.main Value: ADF Front
INFO 2018-04-18 22:00:30,282 ironscanner.main Option: mode
INFO 2018-04-18 22:00:30,282 ironscanner.main Title: Scan mode
INFO 2018-04-18 22:00:30,282 ironscanner.main Desc: Selects the scan mode (e.g., lineart, monochrome, or color).
INFO 2018-04-18 22:00:30,282 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO 2018-04-18 22:00:30,282 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,283 ironscanner.main Size: 8
INFO 2018-04-18 22:00:30,283 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,283 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO 2018-04-18 22:00:30,283 ironscanner.main Constraint: ['Lineart', 'Gray', 'Color']
[dll] sane_get_option_descriptor(handle=0x2caf450,option=3)
[epjitsu] sane_get_option_descriptor: 3
[dll] sane_control_option(handle=0x2caf450,option=3,action=0,value=0x7fc9644b4d58,info=0x7fc9644b4bc0)
[epjitsu] sane_control_option: get value for 'mode' (3)
INFO 2018-04-18 22:00:30,284 ironscanner.main Value: Lineart
INFO 2018-04-18 22:00:30,284 ironscanner.main Option: resolution
INFO 2018-04-18 22:00:30,285 ironscanner.main Title: Scan resolution
INFO 2018-04-18 22:00:30,285 ironscanner.main Desc: Sets the resolution of the scanned image.
INFO 2018-04-18 22:00:30,285 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO 2018-04-18 22:00:30,285 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Dpi (4)
INFO 2018-04-18 22:00:30,286 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,286 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,286 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,286 ironscanner.main Constraint: (50, 600, 1)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=4)
[epjitsu] sane_get_option_descriptor: 4
[dll] sane_control_option(handle=0x2caf450,option=4,action=0,value=0x7fc9644b4e68,info=0x7fc9644b4de0)
[epjitsu] sane_control_option: get value for 'resolution' (4)
INFO 2018-04-18 22:00:30,287 ironscanner.main Value: 300
INFO 2018-04-18 22:00:30,287 ironscanner.main Option: tl-x
INFO 2018-04-18 22:00:30,287 ironscanner.main Title: Top-left x
INFO 2018-04-18 22:00:30,287 ironscanner.main Desc: Top-left x position of scan area.
INFO 2018-04-18 22:00:30,288 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO 2018-04-18 22:00:30,288 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO 2018-04-18 22:00:30,288 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,289 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Inactive,]
INFO 2018-04-18 22:00:30,289 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,289 ironscanner.main Constraint: (0, 13969864, 1387)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=6)
[epjitsu] sane_get_option_descriptor: 6
[dll] sane_control_option(handle=0x2caf450,option=6,action=0,value=0x7fc9644b4bc0,info=0x7fc9644b4d58)
[epjitsu] sane_control_option: 6 inactive
WARNING Pyinsane_daemon Exception
Traceback (most recent call last):
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 136, in main_loop
result['out'] = f(*cmd['args'], **cmd['kwargs'])
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 41, in get_option_value
return get_device(scanner_name).options[option_name].value
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract.py", line 92, in _get_value
val = rawapi.sane_get_option_value(sane_dev_handle[1], self.idx)
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/rawapi.py", line 630, in sane_get_option_value
raise SaneException(SaneStatus(status))
pyinsane2.sane.rawapi.SaneException: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4)
INFO 2018-04-18 22:00:30,292 ironscanner.main Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO 2018-04-18 22:00:30,292 ironscanner.main Option: tl-y
INFO 2018-04-18 22:00:30,293 ironscanner.main Title: Top-left y
INFO 2018-04-18 22:00:30,293 ironscanner.main Desc: Top-left y position of scan area.
INFO 2018-04-18 22:00:30,293 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO 2018-04-18 22:00:30,293 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO 2018-04-18 22:00:30,293 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,293 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,294 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,294 ironscanner.main Constraint: (0, 18963064, 1387)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=7)
[epjitsu] sane_get_option_descriptor: 7
[dll] sane_control_option(handle=0x2caf450,option=7,action=0,value=0x7fc9644b4de0,info=0x7fc9644b4e68)
[epjitsu] sane_control_option: get value for 'tl-y' (7)
INFO 2018-04-18 22:00:30,294 ironscanner.main Value: 0
INFO 2018-04-18 22:00:30,295 ironscanner.main Option: br-x
INFO 2018-04-18 22:00:30,295 ironscanner.main Title: Bottom-right x
INFO 2018-04-18 22:00:30,295 ironscanner.main Desc: Bottom-right x position of scan area.
INFO 2018-04-18 22:00:30,295 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO 2018-04-18 22:00:30,296 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO 2018-04-18 22:00:30,296 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,296 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Inactive,]
INFO 2018-04-18 22:00:30,296 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,297 ironscanner.main Constraint: (177536, 14147400, 1387)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=8)
[epjitsu] sane_get_option_descriptor: 8
[dll] sane_control_option(handle=0x2caf450,option=8,action=0,value=0x7fc9644b4d58,info=0x7fc9644b4bc0)
[epjitsu] sane_control_option: 8 inactive
WARNING Pyinsane_daemon Exception
Traceback (most recent call last):
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 136, in main_loop
result['out'] = f(*cmd['args'], **cmd['kwargs'])
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 41, in get_option_value
return get_device(scanner_name).options[option_name].value
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract.py", line 92, in _get_value
val = rawapi.sane_get_option_value(sane_dev_handle[1], self.idx)
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/rawapi.py", line 630, in sane_get_option_value
raise SaneException(SaneStatus(status))
pyinsane2.sane.rawapi.SaneException: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4)
INFO 2018-04-18 22:00:30,298 ironscanner.main Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO 2018-04-18 22:00:30,298 ironscanner.main Option: br-y
INFO 2018-04-18 22:00:30,299 ironscanner.main Title: Bottom-right y
INFO 2018-04-18 22:00:30,299 ironscanner.main Desc: Bottom-right y position of scan area.
INFO 2018-04-18 22:00:30,299 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO 2018-04-18 22:00:30,299 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO 2018-04-18 22:00:30,299 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,299 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Inactive,]
INFO 2018-04-18 22:00:30,300 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,300 ironscanner.main Constraint: (177536, 19140600, 1387)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=9)
[epjitsu] sane_get_option_descriptor: 9
[dll] sane_control_option(handle=0x2caf450,option=9,action=0,value=0x7fc9644b4e68,info=0x7fc9644b4de0)
[epjitsu] sane_control_option: 9 inactive
WARNING Pyinsane_daemon Exception
Traceback (most recent call last):
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 136, in main_loop
result['out'] = f(*cmd['args'], **cmd['kwargs'])
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 41, in get_option_value
return get_device(scanner_name).options[option_name].value
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract.py", line 92, in _get_value
val = rawapi.sane_get_option_value(sane_dev_handle[1], self.idx)
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/rawapi.py", line 630, in sane_get_option_value
raise SaneException(SaneStatus(status))
pyinsane2.sane.rawapi.SaneException: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4)
INFO 2018-04-18 22:00:30,301 ironscanner.main Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO 2018-04-18 22:00:30,301 ironscanner.main Option: page-width
INFO 2018-04-18 22:00:30,302 ironscanner.main Title: Page width
INFO 2018-04-18 22:00:30,302 ironscanner.main Desc: Specifies the width of the media. Required for automatic centering of sheet-fed scans.
INFO 2018-04-18 22:00:30,302 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO 2018-04-18 22:00:30,302 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO 2018-04-18 22:00:30,302 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,303 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,303 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,303 ironscanner.main Constraint: (177536, 14380416, 1387)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=10)
[epjitsu] sane_get_option_descriptor: 10
[dll] sane_control_option(handle=0x2caf450,option=10,action=0,value=0x7fc9644b4bc0,info=0x7fc9644b4d58)
[epjitsu] sane_control_option: get value for 'page-width' (10)
INFO 2018-04-18 22:00:30,303 ironscanner.main Value: 14147400
INFO 2018-04-18 22:00:30,304 ironscanner.main Option: page-height
INFO 2018-04-18 22:00:30,304 ironscanner.main Title: Page height
INFO 2018-04-18 22:00:30,304 ironscanner.main Desc: Specifies the height of the media, 0 will auto-detect.
INFO 2018-04-18 22:00:30,304 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO 2018-04-18 22:00:30,304 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO 2018-04-18 22:00:30,305 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,305 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,305 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,305 ironscanner.main Constraint: (0, 29537552, 1387)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=11)
[epjitsu] sane_get_option_descriptor: 11
[dll] sane_control_option(handle=0x2caf450,option=11,action=0,value=0x7fc9644b4de0,info=0x7fc9644b4e68)
[epjitsu] sane_control_option: get value for 'page-height' (11)
INFO 2018-04-18 22:00:30,306 ironscanner.main Value: 19140600
INFO 2018-04-18 22:00:30,306 ironscanner.main Option: brightness
INFO 2018-04-18 22:00:30,306 ironscanner.main Title: Brightness
INFO 2018-04-18 22:00:30,307 ironscanner.main Desc: Controls the brightness of the acquired image.
INFO 2018-04-18 22:00:30,307 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO 2018-04-18 22:00:30,307 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,307 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,307 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,308 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,308 ironscanner.main Constraint: (-127, 127, 1)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=13)
[epjitsu] sane_get_option_descriptor: 13
[dll] sane_control_option(handle=0x2caf450,option=13,action=0,value=0x7fc9644b4d58,info=0x7fc9644b4bc0)
[epjitsu] sane_control_option: get value for 'brightness' (13)
INFO 2018-04-18 22:00:30,308 ironscanner.main Value: 0
INFO 2018-04-18 22:00:30,309 ironscanner.main Option: contrast
INFO 2018-04-18 22:00:30,309 ironscanner.main Title: Contrast
INFO 2018-04-18 22:00:30,309 ironscanner.main Desc: Controls the contrast of the acquired image.
INFO 2018-04-18 22:00:30,309 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO 2018-04-18 22:00:30,309 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,309 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,310 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,310 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,310 ironscanner.main Constraint: (-127, 127, 1)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=14)
[epjitsu] sane_get_option_descriptor: 14
[dll] sane_control_option(handle=0x2caf450,option=14,action=0,value=0x7fc9644b4e68,info=0x7fc9644b4de0)
[epjitsu] sane_control_option: get value for 'contrast' (14)
INFO 2018-04-18 22:00:30,311 ironscanner.main Value: 0
INFO 2018-04-18 22:00:30,311 ironscanner.main Option: gamma
INFO 2018-04-18 22:00:30,311 ironscanner.main Title: Gamma function exponent
INFO 2018-04-18 22:00:30,311 ironscanner.main Desc: Changes intensity of midtones
INFO 2018-04-18 22:00:30,311 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO 2018-04-18 22:00:30,312 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,312 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,312 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Inactive,]
INFO 2018-04-18 22:00:30,312 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,312 ironscanner.main Constraint: (19660, 327680, 655)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=15)
[epjitsu] sane_get_option_descriptor: 15
[dll] sane_control_option(handle=0x2caf450,option=15,action=0,value=0x7fc9644b4bc0,info=0x7fc9644b4d58)
[epjitsu] sane_control_option: 15 inactive
WARNING Pyinsane_daemon Exception
Traceback (most recent call last):
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 136, in main_loop
result['out'] = f(*cmd['args'], **cmd['kwargs'])
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 41, in get_option_value
return get_device(scanner_name).options[option_name].value
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract.py", line 92, in _get_value
val = rawapi.sane_get_option_value(sane_dev_handle[1], self.idx)
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/rawapi.py", line 630, in sane_get_option_value
raise SaneException(SaneStatus(status))
pyinsane2.sane.rawapi.SaneException: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4)
INFO 2018-04-18 22:00:30,314 ironscanner.main Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO 2018-04-18 22:00:30,314 ironscanner.main Option: threshold
INFO 2018-04-18 22:00:30,315 ironscanner.main Title: Threshold
INFO 2018-04-18 22:00:30,315 ironscanner.main Desc: Select minimum-brightness to get a white point
INFO 2018-04-18 22:00:30,315 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO 2018-04-18 22:00:30,315 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,315 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,315 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,316 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,316 ironscanner.main Constraint: (0, 255, 1)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=16)
[epjitsu] sane_get_option_descriptor: 16
[dll] sane_control_option(handle=0x2caf450,option=16,action=0,value=0x7fc9644b4de0,info=0x7fc9644b4e68)
[epjitsu] sane_control_option: get value for 'threshold' (16)
INFO 2018-04-18 22:00:30,316 ironscanner.main Value: 120
INFO 2018-04-18 22:00:30,317 ironscanner.main Option: threshold-curve
INFO 2018-04-18 22:00:30,317 ironscanner.main Title: Threshold curve
INFO 2018-04-18 22:00:30,317 ironscanner.main Desc: Dynamic threshold curve, from light to dark, normally 50-65
INFO 2018-04-18 22:00:30,317 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO 2018-04-18 22:00:30,317 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,317 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,318 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO 2018-04-18 22:00:30,318 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO 2018-04-18 22:00:30,318 ironscanner.main Constraint: (0, 127, 1)
[dll] sane_get_option_descriptor(handle=0x2caf450,option=17)
[epjitsu] sane_get_option_descriptor: 17
[dll] sane_control_option(handle=0x2caf450,option=17,action=0,value=0x7fc9644b4d58,info=0x7fc9644b4bc0)
[epjitsu] sane_control_option: get value for 'threshold-curve' (17)
INFO 2018-04-18 22:00:30,319 ironscanner.main Value: 55
INFO 2018-04-18 22:00:30,319 ironscanner.main Option: scan
INFO 2018-04-18 22:00:30,319 ironscanner.main Title: Scan button
INFO 2018-04-18 22:00:30,319 ironscanner.main Desc: Scan button
INFO 2018-04-18 22:00:30,319 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO 2018-04-18 22:00:30,319 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,320 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,320 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Hard_select, Soft_detect, Advanced,]
INFO 2018-04-18 22:00:30,320 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO 2018-04-18 22:00:30,320 ironscanner.main Constraint: None
[dll] sane_get_option_descriptor(handle=0x2caf450,option=19)
[epjitsu] sane_get_option_descriptor: 19
[dll] sane_control_option(handle=0x2caf450,option=19,action=0,value=0x7fc9644b4e68,info=0x7fc9644b4de0)
[epjitsu] sane_control_option: get value for 'scan' (19)
[epjitsu] get_hardware_status: start
[epjitsu] get_hardware_status: running
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] ghspayload:
[epjitsu] 000: 00 f0 00 00
[epjitsu] get_hardware_status: finish
INFO 2018-04-18 22:00:30,322 ironscanner.main Value: 0
INFO 2018-04-18 22:00:30,322 ironscanner.main Option: page-loaded
INFO 2018-04-18 22:00:30,323 ironscanner.main Title: Page loaded
INFO 2018-04-18 22:00:30,323 ironscanner.main Desc: Page loaded
INFO 2018-04-18 22:00:30,323 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO 2018-04-18 22:00:30,323 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,323 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,324 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Hard_select, Soft_detect, Advanced,]
INFO 2018-04-18 22:00:30,324 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO 2018-04-18 22:00:30,324 ironscanner.main Constraint: None
[dll] sane_get_option_descriptor(handle=0x2caf450,option=20)
[epjitsu] sane_get_option_descriptor: 20
[dll] sane_control_option(handle=0x2caf450,option=20,action=0,value=0x7fc9644b4bc0,info=0x7fc9644b4d58)
[epjitsu] sane_control_option: get value for 'page-loaded' (20)
[epjitsu] get_hardware_status: start
[epjitsu] get_hardware_status: finish
INFO 2018-04-18 22:00:30,325 ironscanner.main Value: 1
INFO 2018-04-18 22:00:30,325 ironscanner.main Option: top-edge
INFO 2018-04-18 22:00:30,325 ironscanner.main Title: Top edge
INFO 2018-04-18 22:00:30,325 ironscanner.main Desc: Paper is pulled partly into adf
INFO 2018-04-18 22:00:30,325 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO 2018-04-18 22:00:30,326 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,326 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,326 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Hard_select, Soft_detect, Advanced,]
INFO 2018-04-18 22:00:30,326 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO 2018-04-18 22:00:30,326 ironscanner.main Constraint: None
[dll] sane_get_option_descriptor(handle=0x2caf450,option=21)
[epjitsu] sane_get_option_descriptor: 21
[dll] sane_control_option(handle=0x2caf450,option=21,action=0,value=0x7fc9644b4de0,info=0x7fc9644b4e68)
[epjitsu] sane_control_option: get value for 'top-edge' (21)
[epjitsu] get_hardware_status: start
[epjitsu] get_hardware_status: finish
INFO 2018-04-18 22:00:30,327 ironscanner.main Value: 0
INFO 2018-04-18 22:00:30,327 ironscanner.main Option: cover-open
INFO 2018-04-18 22:00:30,327 ironscanner.main Title: Cover open
INFO 2018-04-18 22:00:30,327 ironscanner.main Desc: Cover open
INFO 2018-04-18 22:00:30,328 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO 2018-04-18 22:00:30,328 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,328 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,328 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Hard_select, Soft_detect, Advanced,]
INFO 2018-04-18 22:00:30,328 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO 2018-04-18 22:00:30,328 ironscanner.main Constraint: None
[dll] sane_get_option_descriptor(handle=0x2caf450,option=22)
[epjitsu] sane_get_option_descriptor: 22
[dll] sane_control_option(handle=0x2caf450,option=22,action=0,value=0x7fc9644b4d58,info=0x7fc9644b4bc0)
[epjitsu] sane_control_option: get value for 'cover-open' (22)
[epjitsu] get_hardware_status: start
[epjitsu] get_hardware_status: finish
INFO 2018-04-18 22:00:30,329 ironscanner.main Value: 0
INFO 2018-04-18 22:00:30,329 ironscanner.main Option: power-save
INFO 2018-04-18 22:00:30,330 ironscanner.main Title: Power saving
INFO 2018-04-18 22:00:30,330 ironscanner.main Desc: Scanner in power saving mode
INFO 2018-04-18 22:00:30,330 ironscanner.main Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO 2018-04-18 22:00:30,330 ironscanner.main Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO 2018-04-18 22:00:30,331 ironscanner.main Size: 4
INFO 2018-04-18 22:00:30,331 ironscanner.main Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Hard_select, Soft_detect, Advanced,]
INFO 2018-04-18 22:00:30,331 ironscanner.main Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO 2018-04-18 22:00:30,331 ironscanner.main Constraint: None
[dll] sane_get_option_descriptor(handle=0x2caf450,option=23)
[epjitsu] sane_get_option_descriptor: 23
[dll] sane_control_option(handle=0x2caf450,option=23,action=0,value=0x7fc9644b4e68,info=0x7fc9644b4de0)
[epjitsu] sane_control_option: get value for 'power-save' (23)
[epjitsu] get_hardware_status: start
[epjitsu] get_hardware_status: finish
INFO 2018-04-18 22:00:30,332 ironscanner.main Value: 1
DEBUG 2018-04-18 22:00:36,100 ironscanner.util For filename 'adf.png' got file '/home/konrad/Projekte/Paperwork/debug/ironscanner/src/ironscanner/adf.png'
INFO 2018-04-18 22:00:39,637 ironscanner.main Preparing summary
INFO 2018-04-18 22:00:39,745 ironscanner.main Summary ready
INFO 2018-04-18 22:00:39,746 ironscanner.main Summary of the test:
- Scanner: FUJITSU ScanSnap S1300i (epjitsu:libusb:003:008)
- Type: adf_duplex
- Source: ADF Front
- Resolutions: 150
- Mode: Color

Personal information that will be attached to the report:
- Name: Konrad Anton
- Email: xxxxxx

System informations that will be attached to the report:
- arch: ('64bit', 'ELF')
- cpu_freq: 3100
- machine: x86_64
- mem: 8175382528
- nb_cpus: 4
- os_uname: posix.uname_result(sysname='Linux', nodename='alvarez', release='4.13.0-38-generic', version='#43-Ubuntu SMP Wed Mar 14 15:20:44 UTC 2018', machine='x86_64')
- platform_detailed: Linux-4.13.0-38-generic-x86_64-with-Ubuntu-17.10-artful
- platform_short: linux
- platform_uname: uname_result(system='Linux', node='alvarez', release='4.13.0-38-generic', version='#43-Ubuntu SMP Wed Mar 14 15:20:44 UTC 2018', machine='x86_64', processor='x86_64')
- proc: x86_64
- python: 3.6.3 (default, Oct 3 2017, 21:45:48)
[GCC 7.2.0]
- release: 4.13.0-38-generic
- swap: 0
- system: Linux
- type: posix
INFO 2018-04-18 22:00:43,186 ironscanner.main ### SCAN TEST ###
INFO 2018-04-18 22:00:43,187 ironscanner.main Configuring scanner: source = ADF Front
DEBUG 2018-04-18 22:00:43,189 ironscanner.trace /home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/__init__.py:set_scanner_opt()@41[TraceThread(<function set_scanner_opt at 0x7f2fa338b950>)]
[dll] sane_get_option_descriptor(handle=0x2caf450,option=2)
[epjitsu] sane_get_option_descriptor: 2
[dll] sane_control_option(handle=0x2caf450,option=2,action=1,value=0x7fc9644b4bc0,info=0x7fc9644b4d58)
[epjitsu] sane_control_option: set value for 'source' (2)
INFO 2018-04-18 22:00:43,199 pyinsane2 [source] set to [ADF Front]
INFO 2018-04-18 22:00:43,200 ironscanner.main Configuring scanner: resolution = 150
DEBUG 2018-04-18 22:00:43,201 ironscanner.trace /home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/__init__.py:set_scanner_opt()@41[TraceThread(<function set_scanner_opt at 0x7f2fa338b950>)]
[dll] sane_get_option_descriptor(handle=0x2caf450,option=4)
[epjitsu] sane_get_option_descriptor: 4
[dll] sane_control_option(handle=0x2caf450,option=4,action=1,value=0x7fc9644b4de0,info=0x7fc9644b4e68)
[epjitsu] sane_control_option: set value for 'resolution' (4)
INFO 2018-04-18 22:00:43,205 pyinsane2 [resolution] set to [150]
INFO 2018-04-18 22:00:43,205 ironscanner.main Configuring scanner: mode = Color
DEBUG 2018-04-18 22:00:43,206 ironscanner.trace /home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/__init__.py:set_scanner_opt()@41[TraceThread(<function set_scanner_opt at 0x7f2fa338b950>)]
[dll] sane_get_option_descriptor(handle=0x2caf450,option=3)
[epjitsu] sane_get_option_descriptor: 3
[dll] sane_control_option(handle=0x2caf450,option=3,action=1,value=0x7fc9644b4d58,info=0x7fc9644b4bc0)
[epjitsu] sane_control_option: set value for 'mode' (3)
INFO 2018-04-18 22:00:43,213 pyinsane2 [mode] set to [Color]
INFO 2018-04-18 22:00:43,213 ironscanner.main Maximizing scan area ...
DEBUG 2018-04-18 22:00:43,214 ironscanner.trace /home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/__init__.py:maximize_scan_area()@148[TraceThread(<function maximize_scan_area at 0x7f2fa338ba60>)]
WARNING 2018-04-18 22:00:43,215 pyinsane2 Unable to set scanner option [tl-x]: Option is not active
[dll] sane_get_option_descriptor(handle=0x2caf450,option=7)
[epjitsu] sane_get_option_descriptor: 7
[dll] sane_control_option(handle=0x2caf450,option=7,action=1,value=0x7fc9644b4e68,info=0x7fc9644b4de0)
[epjitsu] sane_control_option: set value for 'tl-y' (7)
WARNING 2018-04-18 22:00:43,215 pyinsane2 Unable to set scanner option [br-x]: Option is not active
WARNING 2018-04-18 22:00:43,216 pyinsane2 Unable to set scanner option [br-y]: Option is not active
[dll] sane_get_option_descriptor(handle=0x2caf450,option=11)
[epjitsu] sane_get_option_descriptor: 11
[dll] sane_control_option(handle=0x2caf450,option=11,action=1,value=0x7fc9644b4bc0,info=0x7fc9644b4d58)
[epjitsu] sane_control_option: set value for 'page-height' (11)
[epjitsu] change_params: start
[epjitsu] change_params: finish
[dll] sane_get_option_descriptor(handle=0x2caf450,option=10)
[epjitsu] sane_get_option_descriptor: 10
[dll] sane_control_option(handle=0x2caf450,option=10,action=1,value=0x7fc9644b4de0,info=0x7fc9644b4e68)
[epjitsu] sane_control_option: set value for 'page-width' (10)
[epjitsu] change_params: start
[epjitsu] change_params: finish
INFO 2018-04-18 22:00:43,216 ironscanner.main Starting scan session ...
DEBUG 2018-04-18 22:00:43,217 ironscanner.trace /home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract_proc.py:scan()@267[TraceThread(<bound method Scanner.scan of <pyinsane2.sane.abstract_proc.Scanner object at 0x7f2f89baebe0>>)]
[dll] sane_get_option_descriptor(handle=0x2caf450,option=2)
[epjitsu] sane_get_option_descriptor: 2
[dll] sane_control_option(handle=0x2caf450,option=2,action=0,value=0x7fc9644b4d58,info=0x7fc9644b4bc0)
[epjitsu] sane_control_option: get value for 'source' (2)
[dll] sane_start(handle=0x2caf450)
[epjitsu] sane_start: start
[epjitsu] get_hardware_status: start
[epjitsu] get_hardware_status: running
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] ghspayload:
[epjitsu] 000: 00 f0 00 00
[epjitsu] get_hardware_status: finish
[epjitsu] object_position: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] object_position: found paper?
[epjitsu] object_position: finish
[epjitsu] sane_start: first page
[epjitsu] teardown_buffers: start
[epjitsu] teardown_buffers: finish
[epjitsu] change_params: start
[epjitsu] change_params: finish
[epjitsu] setup_buffers: start
[epjitsu] setup_buffers: finish
[epjitsu] load_lut: start
[epjitsu] load_lut:
[epjitsu] 000: 32 32 32 32 32 32 32 32 32 32 32 32 32 32 32 32
[epjitsu] 010: 32 32 32 32 32 32 32 32 32 32 32 32 32 32 32 32
[epjitsu] 020: 32 32 32 32 32 32 32 32 32 32 33 34 34 35 36 37
[epjitsu] 030: 38 38 39 3a 3b 3c 3d 3d 3e 3f 40 41 41 42 43 44
[epjitsu] 040: 45 45 46 47 48 49 49 4a 4b 4c 4d 4d 4e 4f 50 51
[epjitsu] 050: 52 52 53 54 55 56 56 57 58 59 5a 5a 5b 5c 5d 5e
[epjitsu] 060: 5e 5f 60 61 62 63 63 64 65 66 67 67 68 69 6a 6b
[epjitsu] 070: 6b 6c 6d 6e 6f 6f 70 71 72 73 74 74 75 76 77 78
[epjitsu] 080: 78 79 7a 7b 7c 7c 7d 7e 7f 80 80 81 82 83 84 85
[epjitsu] 090: 85 86 87 88 89 89 8a 8b 8c 8d 8d 8e 8f 90 91 91
[epjitsu] 0a0: 92 93 94 95 96 96 97 98 99 9a 9a 9b 9c 9d 9e 9e
[epjitsu] 0b0: 9f a0 a1 a2 a2 a3 a4 a5 a6 a6 a7 a8 a9 aa ab ab
[epjitsu] 0c0: ac ad ae af af b0 b1 b2 b3 b3 b4 b5 b6 b7 b7 b8
[epjitsu] 0d0: b9 ba bb bc bc bd be bf c0 c0 c1 c2 c3 c4 c4 c5
[epjitsu] 0e0: c6 c7 c8 c8 c9 ca cb cc cd cd cd cd cd cd cd cd
[epjitsu] 0f0: cd cd cd cd cd cd cd cd cd cd cd cd cd cd cd cd
[epjitsu] load_lut: finish
[epjitsu] coarsecal: start
[epjitsu] set_window: start, window 0
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] coarsecal_dark: start
[epjitsu] lamp: start (0)
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] lamp: finish
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_dark offset: parameter front: 63 back: 63
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_dark offset: average pixel values front: 65 back: 58
[epjitsu] coarsecal_dark offset: maximum pixel values front: 79 back: 83
[epjitsu] coarsecal_dark offset: 0-valued pixel count front: 0.000000% back: 0.000000%
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_dark offset: parameter front: 0 back: 0
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_dark offset: average pixel values front: 4 back: 0
[epjitsu] coarsecal_dark offset: maximum pixel values front: 17 back: 13
[epjitsu] coarsecal_dark offset: 0-valued pixel count front: 12.700000% back: 95.400002%
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_dark offset: parameter front: 31 back: 31
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_dark offset: average pixel values front: 34 back: 24
[epjitsu] coarsecal_dark offset: maximum pixel values front: 47 back: 47
[epjitsu] coarsecal_dark offset: 0-valued pixel count front: 0.000000% back: 0.000000%
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_dark offset: parameter front: 15 back: 15
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_dark offset: average pixel values front: 18 back: 8
[epjitsu] coarsecal_dark offset: maximum pixel values front: 32 back: 31
[epjitsu] coarsecal_dark offset: 0-valued pixel count front: 0.000000% back: 3.600000%
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_dark offset: parameter front: 7 back: 23
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_dark offset: average pixel values front: 11 back: 16
[epjitsu] coarsecal_dark offset: maximum pixel values front: 23 back: 41
[epjitsu] coarsecal_dark offset: 0-valued pixel count front: 0.000000% back: 0.000000%
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_dark offset: parameter front: 11 back: 19
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_dark offset: average pixel values front: 16 back: 13
[epjitsu] coarsecal_dark offset: maximum pixel values front: 37 back: 33
[epjitsu] coarsecal_dark offset: 0-valued pixel count front: 0.000000% back: 0.100000%
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_dark offset: parameter front: 9 back: 21
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_dark offset: average pixel values front: 13 back: 14
[epjitsu] coarsecal_dark offset: maximum pixel values front: 25 back: 36
[epjitsu] coarsecal_dark offset: 0-valued pixel count front: 0.000000% back: 0.000000%
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_dark offset: parameter front: 10 back: 22
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_dark offset: average pixel values front: 14 back: 15
[epjitsu] coarsecal_dark offset: maximum pixel values front: 26 back: 39
[epjitsu] coarsecal_dark offset: 0-valued pixel count front: 0.000000% back: 0.000000%
[epjitsu] coarsecal_dark: finish
[epjitsu] coarsecal_light: start
[epjitsu] lamp: start (1)
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] lamp: finish
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_light gain: parameter front: 36 back: 40
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_light gain: average RGB values front: (188,177,188) back: (194,173,227)
[epjitsu] coarsecal_light gain: 255-valued pixel count front: (0,0,0) back: (0,0,0)
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_light gain: parameter front: 18 back: 20
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_light gain: average RGB values front: (118,112,118) back: (120,107,148)
[epjitsu] coarsecal_light gain: 255-valued pixel count front: (0,0,0) back: (0,0,0)
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_light gain: parameter front: 9 back: 10
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_light gain: average RGB values front: (82,77,82) back: (82,73,101)
[epjitsu] coarsecal_light gain: 255-valued pixel count front: (0,0,0) back: (0,0,0)
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_light gain: parameter front: 13 back: 5
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_light gain: average RGB values front: (96,92,98) back: (61,55,76)
[epjitsu] coarsecal_light gain: 255-valued pixel count front: (0,0,0) back: (0,0,0)
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_light gain: parameter front: 11 back: 7
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_light gain: average RGB values front: (88,85,90) back: (69,63,86)
[epjitsu] coarsecal_light gain: 255-valued pixel count front: (0,0,0) back: (0,0,0)
[epjitsu] coarsecal_send_cal: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] coarsecal_send_cal: finish
[epjitsu] coarsecal_light gain: parameter front: 11 back: 8
[epjitsu] coarsecal_get_line: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:43304 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/43304
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (43304)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:43296
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] coarsecal_get_line: finish
[epjitsu] coarsecal_light gain: average RGB values front: (89,85,90) back: (73,66,91)
[epjitsu] coarsecal_light gain: 255-valued pixel count front: (0,0,0) back: (0,0,0)
[epjitsu] coarsecal_light: finish
[epjitsu] coarsecal: finish
[epjitsu] finecal: start
[epjitsu] set_window: start, window 2
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] lamp: start (1)
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] lamp: finish
[epjitsu] set_window: start, window 1
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:692744 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:627208 len:65536
[epjitsu] read_from_scanner: start rB:627208 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:561672 len:65536
[epjitsu] read_from_scanner: start rB:561672 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:496136 len:65536
[epjitsu] read_from_scanner: start rB:496136 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:430600 len:65536
[epjitsu] read_from_scanner: start rB:430600 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:365064 len:65536
[epjitsu] read_from_scanner: start rB:365064 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:299528 len:65536
[epjitsu] read_from_scanner: start rB:299528 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:233992 len:65536
[epjitsu] read_from_scanner: start rB:233992 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:168456 len:65536
[epjitsu] read_from_scanner: start rB:168456 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:102920 len:65536
[epjitsu] read_from_scanner: start rB:102920 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:37384 len:65536
[epjitsu] read_from_scanner: start rB:37384 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/37384
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (37384)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:37376
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] set_window: start, window 2
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: start, window 1
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:692744 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:627208 len:65536
[epjitsu] read_from_scanner: start rB:627208 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:561672 len:65536
[epjitsu] read_from_scanner: start rB:561672 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:496136 len:65536
[epjitsu] read_from_scanner: start rB:496136 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:430600 len:65536
[epjitsu] read_from_scanner: start rB:430600 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:365064 len:65536
[epjitsu] read_from_scanner: start rB:365064 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:299528 len:65536
[epjitsu] read_from_scanner: start rB:299528 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:233992 len:65536
[epjitsu] read_from_scanner: start rB:233992 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:168456 len:65536
[epjitsu] read_from_scanner: start rB:168456 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:102920 len:65536
[epjitsu] read_from_scanner: start rB:102920 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:37384 len:65536
[epjitsu] read_from_scanner: start rB:37384 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/37384
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (37384)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:37376
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] finecal: -------------------- Gain
[epjitsu] finecal: RGB Average Error - Front: (53.2,35.2,43.3) - Back: (43.2,35.1,8.0)
[epjitsu] finecal: RGB Maximum - Front: (187,184,191) - Back: (145,135,185)
[epjitsu] finecal: RGB Minimum - Front: (84,86,85) - Back: (69,64,86)
[epjitsu] finecal: Variance - Front: (421.3,321.7,422.1) - Back: (173.5,103.6,281.2)
[epjitsu] finecal: Pegged gain parameters - High (0xff): 0 - Low (0): 0
[epjitsu] set_window: start, window 2
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: start, window 1
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:692744 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:627208 len:65536
[epjitsu] read_from_scanner: start rB:627208 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:561672 len:65536
[epjitsu] read_from_scanner: start rB:561672 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:496136 len:65536
[epjitsu] read_from_scanner: start rB:496136 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:430600 len:65536
[epjitsu] read_from_scanner: start rB:430600 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:365064 len:65536
[epjitsu] read_from_scanner: start rB:365064 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:299528 len:65536
[epjitsu] read_from_scanner: start rB:299528 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:233992 len:65536
[epjitsu] read_from_scanner: start rB:233992 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:168456 len:65536
[epjitsu] read_from_scanner: start rB:168456 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:102920 len:65536
[epjitsu] read_from_scanner: start rB:102920 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:37384 len:65536
[epjitsu] read_from_scanner: start rB:37384 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/37384
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (37384)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:37376
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] finecal: -------------------- Gain
[epjitsu] finecal: RGB Average Error - Front: (27.7,18.9,22.7) - Back: (26.8,22.3,4.9)
[epjitsu] finecal: RGB Maximum - Front: (185,178,186) - Back: (147,136,166)
[epjitsu] finecal: RGB Minimum - Front: (125,118,122) - Back: (94,83,105)
[epjitsu] finecal: Variance - Front: (139.4,102.5,132.4) - Back: (82.6,51.7,87.0)
[epjitsu] finecal: Pegged gain parameters - High (0xff): 0 - Low (0): 0
[epjitsu] set_window: start, window 2
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: start, window 1
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:692744 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:627208 len:65536
[epjitsu] read_from_scanner: start rB:627208 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:561672 len:65536
[epjitsu] read_from_scanner: start rB:561672 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:496136 len:65536
[epjitsu] read_from_scanner: start rB:496136 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:430600 len:65536
[epjitsu] read_from_scanner: start rB:430600 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:365064 len:65536
[epjitsu] read_from_scanner: start rB:365064 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:299528 len:65536
[epjitsu] read_from_scanner: start rB:299528 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:233992 len:65536
[epjitsu] read_from_scanner: start rB:233992 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:168456 len:65536
[epjitsu] read_from_scanner: start rB:168456 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:102920 len:65536
[epjitsu] read_from_scanner: start rB:102920 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:37384 len:65536
[epjitsu] read_from_scanner: start rB:37384 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/37384
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (37384)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:37376
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] finecal: -------------------- Gain
[epjitsu] finecal: RGB Average Error - Front: (8.6,7.8,8.3) - Back: (13.5,12.0,2.5)
[epjitsu] finecal: RGB Maximum - Front: (186,176,184) - Back: (149,139,157)
[epjitsu] finecal: RGB Minimum - Front: (169,153,164) - Back: (121,108,128)
[epjitsu] finecal: Variance - Front: (11.7,16.3,14.8) - Back: (20.8,15.6,25.2)
[epjitsu] finecal: Pegged gain parameters - High (0xff): 4 - Low (0): 0
[epjitsu] set_window: start, window 2
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: start, window 1
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:692744 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:627208 len:65536
[epjitsu] read_from_scanner: start rB:627208 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:561672 len:65536
[epjitsu] read_from_scanner: start rB:561672 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:496136 len:65536
[epjitsu] read_from_scanner: start rB:496136 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:430600 len:65536
[epjitsu] read_from_scanner: start rB:430600 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:365064 len:65536
[epjitsu] read_from_scanner: start rB:365064 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:299528 len:65536
[epjitsu] read_from_scanner: start rB:299528 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:233992 len:65536
[epjitsu] read_from_scanner: start rB:233992 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:168456 len:65536
[epjitsu] read_from_scanner: start rB:168456 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:102920 len:65536
[epjitsu] read_from_scanner: start rB:102920 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:37384 len:65536
[epjitsu] read_from_scanner: start rB:37384 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/37384
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (37384)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:37376
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] finecal: -------------------- Gain
[epjitsu] finecal: RGB Average Error - Front: (1.6,2.6,2.2) - Back: (5.4,5.6,1.1)
[epjitsu] finecal: RGB Maximum - Front: (190,175,185) - Back: (150,139,155)
[epjitsu] finecal: RGB Minimum - Front: (179,165,175) - Back: (140,128,137)
[epjitsu] finecal: Variance - Front: (1.7,2.4,1.8) - Back: (2.8,3.2,7.1)
[epjitsu] finecal: Pegged gain parameters - High (0xff): 11 - Low (0): 0
[epjitsu] set_window: start, window 2
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: start, window 1
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:692744 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:627208 len:65536
[epjitsu] read_from_scanner: start rB:627208 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:561672 len:65536
[epjitsu] read_from_scanner: start rB:561672 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:496136 len:65536
[epjitsu] read_from_scanner: start rB:496136 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:430600 len:65536
[epjitsu] read_from_scanner: start rB:430600 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:365064 len:65536
[epjitsu] read_from_scanner: start rB:365064 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:299528 len:65536
[epjitsu] read_from_scanner: start rB:299528 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:233992 len:65536
[epjitsu] read_from_scanner: start rB:233992 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:168456 len:65536
[epjitsu] read_from_scanner: start rB:168456 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:102920 len:65536
[epjitsu] read_from_scanner: start rB:102920 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:37384 len:65536
[epjitsu] read_from_scanner: start rB:37384 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/37384
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (37384)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:37376
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] finecal: -------------------- Gain
[epjitsu] finecal: RGB Average Error - Front: (0.5,0.7,0.7) - Back: (1.8,2.1,0.5)
[epjitsu] finecal: RGB Maximum - Front: (190,175,186) - Back: (153,141,154)
[epjitsu] finecal: RGB Minimum - Front: (180,167,177) - Back: (145,134,142)
[epjitsu] finecal: Variance - Front: (1.7,1.2,1.4) - Back: (1.1,1.1,2.5)
[epjitsu] finecal: Pegged gain parameters - High (0xff): 24 - Low (0): 0
[epjitsu] set_window: start, window 2
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: start, window 1
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:692744 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:627208 len:65536
[epjitsu] read_from_scanner: start rB:627208 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:561672 len:65536
[epjitsu] read_from_scanner: start rB:561672 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:496136 len:65536
[epjitsu] read_from_scanner: start rB:496136 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:430600 len:65536
[epjitsu] read_from_scanner: start rB:430600 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:365064 len:65536
[epjitsu] read_from_scanner: start rB:365064 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:299528 len:65536
[epjitsu] read_from_scanner: start rB:299528 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:233992 len:65536
[epjitsu] read_from_scanner: start rB:233992 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:168456 len:65536
[epjitsu] read_from_scanner: start rB:168456 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:102920 len:65536
[epjitsu] read_from_scanner: start rB:102920 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:37384 len:65536
[epjitsu] read_from_scanner: start rB:37384 len:65536
[epjitsu] do_cmd: start
[epjitsu] in: short read 65536/37384
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (37384)
[epjitsu] read_from_scanner: block done, ignoring trailer
[epjitsu] read_from_scanner: finish rB:8 len:37376
[epjitsu] descramble_raw: start
[epjitsu] descramble_raw: finish 0
[epjitsu] finecal: -------------------- Gain
[epjitsu] finecal: RGB Average Error - Front: (-0.0,0.2,0.5) - Back: (0.6,0.6,0.2)
[epjitsu] finecal: RGB Maximum - Front: (189,175,185) - Back: (153,142,155)
[epjitsu] finecal: RGB Minimum - Front: (181,167,177) - Back: (145,136,144)
[epjitsu] finecal: Variance - Front: (1.6,1.1,1.3) - Back: (1.1,0.9,1.3)
[epjitsu] finecal: Pegged gain parameters - High (0xff): 33 - Low (0): 0
[epjitsu] finecal: finish
[epjitsu] send_lut: start
[epjitsu] send_lut: 0 0.000000 0 1.000000 0.000000
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] send_lut: finish
[epjitsu] lamp: start (1)
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] lamp: finish
[epjitsu] set_window: start, window 3
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] set_window: finish
[epjitsu] sane_start: reset counters
[epjitsu] scan: start
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] scan: finish
[epjitsu] sane_start: finish
[dll] sane_get_parameters(handle=0x2caf450,params=0x7fc967356408)
[epjitsu] sane_get_parameters: start
[epjitsu] depth 8
[epjitsu] lines 2587
[epjitsu] pixels_per_line 1296
[epjitsu] bytes_per_line 3888
[epjitsu] sane_get_parameters: finish
INFO 2018-04-18 22:00:46,989 ironscanner.main Expected image size: (1296, 2587)
INFO 2018-04-18 22:00:46,990 ironscanner.main Scanning page 0
DEBUG 2018-04-18 22:00:46,992 ironscanner.trace /home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f2f803011d0>>)]
[dll] sane_read(handle=0x2caf450,data=0x7fc9480dc010,maxlen=524288,lenp=0x7fc9644b4e68)
[epjitsu] sane_read: start si:0 len:0 max:524288
[epjitsu] sane_read: d3
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: start rB:519560 len:65536
[epjitsu] do_cmd: start
[epjitsu] do_cmd: finish
[epjitsu] read_from_scanner: got GOOD/EOF (65536)
[epjitsu] read_from_scanner: finish rB:454024 len:65536
[epjitsu] sane_read: finish si:0 len:0 max:524288
INFO 2018-04-18 22:00:47,349 ironscanner.main Available lines: (0, 0)
WARNING Pyinsane_daemon Exception
Traceback (most recent call last):
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 136, in main_loop
result['out'] = f(*cmd['args'], **cmd['kwargs'])
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/daemon.py", line 80, in get_image
img = scan_sessions[scanner_name].scan.get_image(start_line, end_line)
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract.py", line 267, in get_image
return ImgUtil.raw_to_img(lines, self.parameters)
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract.py", line 171, in raw_to_img
mode, 0, 1)
File "/usr/lib/python3/dist-packages/PIL/Image.py", line 2266, in frombuffer
return frombytes(mode, size, data, decoder_name, args)
File "/usr/lib/python3/dist-packages/PIL/Image.py", line 2199, in frombytes
im.frombytes(data, decoder_name, args)
File "/usr/lib/python3/dist-packages/PIL/Image.py", line 751, in frombytes
d.setimage(self.im)
ValueError: tile cannot extend outside image
INFO 2018-04-18 22:00:47,355 ironscanner.main ### SCAN TEST FAILED ###
Traceback (most recent call last):
File "/home/konrad/Projekte/Paperwork/debug/ironscanner/src/ironscanner/main.py", line 747, in run
scan_session.scan.get_image(),
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract_proc.py", line 197, in get_image
'scan_get_image', self._scanner_name, start_line, end_line
File "/home/konrad/Projekte/Paperwork/debug/pyinsane/pyinsane2/sane/abstract_proc.py", line 74, in remote_do
raise exc_class(*result['exception_args'])
ValueError: tile cannot extend outside image
INFO 2018-04-18 22:02:55,551 ironscanner.main Building report ...
INFO 2018-04-18 22:02:55,552 ironscanner.main * User info
INFO 2018-04-18 22:02:55,553 ironscanner.main * Scanner settings
INFO 2018-04-18 22:02:55,560 ironscanner.main No image attached to report
INFO 2018-04-18 22:02:55,561 ironscanner.main * System configuration
INFO 2018-04-18 22:02:55,646 ironscanner.main * Scan test result
INFO 2018-04-18 22:02:55,647 ironscanner.main * User comment
INFO 2018-04-18 22:02:55,648 ironscanner.main * Traces