INFO   2018-07-29 01:39:33,164 801E16000 ironscanner.main Initializing pyinsane2 ...
DEBUG  2018-07-29 01:39:33,165 805717000 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract_proc.py:init()@87[TraceThread(<function init at 0x807ff3620>)]
INFO   2018-07-29 01:39:33,165 805717000 pyinsane2.sane.abstract_proc Starting Pyinsane subprocess
INFO   2018-07-29 01:39:33,165 805717000 pyinsane2.sane.abstract_proc Pyinsane pipes: /tmp/pyinsane_iplloghm/pipe_c2s | /tmp/pyinsane_iplloghm/pipe_s2c
[sanei_debug] Setting debug level of dll to 255.
[dll] sane_init: SANE dll backend version 1.0.13 from sane-backends 1.0.25
[dll] sane_init/read_dlld: attempting to open directory `./dll.d'
[dll] sane_init/read_dlld: attempting to open directory `/usr/local/etc/sane.d/dll.d'
[dll] sane_init/read_dlld: using config directory `/usr/local/etc/sane.d/dll.d'
[dll] sane_init/read_dlld: done.
[dll] sane_init/read_config: reading dll.conf
[dll] add_backend: adding backend `pixma'
INFO   Pyinsane_daemon Ready
INFO   2018-07-29 01:39:33,262 805717000 pyinsane2.sane.abstract_proc Connected to Pyinsane subprocess
INFO   2018-07-29 01:39:33,262 801E16000 ironscanner.main Pyinsane2 ready
DEBUG  2018-07-29 01:39:33,269 801E16000 ironscanner.util For filename 'mainform.glade' got file '/usr/local/lib/python3.6/site-packages/ironscanner/mainform.glade'
/usr/local/lib/python3.6/site-packages/ironscanner/util.py:75: Warning: g_value_type_transformable: assertion 'G_TYPE_IS_VALUE (src_type)' failed
  widget_tree.add_from_file(ui_file)

(ironscanner:37388): Gtk-WARNING **: gtkliststore.c:834: Unable to convert from (null) to gchararray

(ironscanner:37388): Gtk-CRITICAL **: gtk_assistant_set_page_has_padding: assertion 'child != NULL' failed
WARNING 2018-07-29 01:39:33,499 801E16000 ironscanner.main version.txt file is missing
WARNING 2018-07-29 01:39:33,499 801E16000 ironscanner.main Please run 'make' first
DEBUG  2018-07-29 01:39:33,502 801E16000 ironscanner.util For filename 'logo.png' got file '/usr/local/lib/python3.6/site-packages/ironscanner/logo.png'
INFO   2018-07-29 01:39:35,609 81630CE00 ironscanner.main Looking for scanners ...
DEBUG  2018-07-29 01:39:35,610 815A39000 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract_proc.py:get_devices()@275[TraceThread(<function get_devices at 0x807ff3730>)]
[dll] sane_get_devices
[dll] load: searching backend `pixma' in `/usr/local/lib/sane'
[dll] load: trying to load `/usr/local/lib/sane/libsane-pixma.so.1'
[dll] load: dlopen()ing `/usr/local/lib/sane/libsane-pixma.so.1'
[dll] init: initializing backend `pixma'
[dll] init: backend `pixma' is version 1.0.17
[dll] sane_get_devices: found 1 devices
INFO   2018-07-29 01:39:36,155 81630CE00 ironscanner.main 1 scanners found
INFO   2018-07-29 01:39:36,155 801E16000 ironscanner.main pixma:MX340_192.168.5.6 -> CANON Canon PIXMA MX340 (pixma:MX340_192.168.5.6)
INFO   2018-07-29 01:39:36,158 801E16000 ironscanner.main Selected scanner: pixma:MX340_192.168.5.6
[dll] sane_open: trying to open `pixma:MX340_192.168.5.6'
[dll] sane_open: open successful
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=0)
[dll] sane_control_option(handle=0x801e3a160,option=0,action=0,value=0x803d251a8,info=0x803d25230)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=1)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=2)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=3)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=4)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=5)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=6)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=7)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=8)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=9)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=10)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=11)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=12)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=13)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=14)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=15)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=16)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=17)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=18)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=19)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=20)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=21)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=22)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=23)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=24)
INFO   2018-07-29 01:39:36,715 801E16000 ironscanner.main   Option: resolution
INFO   2018-07-29 01:39:36,716 801E16000 ironscanner.main     Title: Scan resolution
INFO   2018-07-29 01:39:36,716 801E16000 ironscanner.main     Desc: Sets the resolution of the scanned image.
INFO   2018-07-29 01:39:36,716 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-07-29 01:39:36,716 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Dpi (4)
INFO   2018-07-29 01:39:36,716 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,717 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-07-29 01:39:36,717 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Word list (2)
INFO   2018-07-29 01:39:36,717 801E16000 ironscanner.main     Constraint: [75, 150, 300, 600, 1200]
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=2)
[dll] sane_control_option(handle=0x801e3a160,option=2,action=0,value=0x803d2e1a8,info=0x803d2e230)
INFO   2018-07-29 01:39:36,717 801E16000 ironscanner.main     Value: 75
INFO   2018-07-29 01:39:36,717 801E16000 ironscanner.main   Option: mode
INFO   2018-07-29 01:39:36,717 801E16000 ironscanner.main     Title: Scan mode
INFO   2018-07-29 01:39:36,717 801E16000 ironscanner.main     Desc: Selects the scan mode (e.g., lineart, monochrome, or color).
INFO   2018-07-29 01:39:36,717 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO   2018-07-29 01:39:36,717 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,718 801E16000 ironscanner.main     Size: 31
INFO   2018-07-29 01:39:36,718 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-07-29 01:39:36,718 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO   2018-07-29 01:39:36,718 801E16000 ironscanner.main     Constraint: ['Color', 'Gray', 'Lineart']
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=3)
[dll] sane_control_option(handle=0x801e3a160,option=3,action=0,value=0x803d29150,info=0x803d2e120)
INFO   2018-07-29 01:39:36,718 801E16000 ironscanner.main     Value: Color
INFO   2018-07-29 01:39:36,718 801E16000 ironscanner.main   Option: source
INFO   2018-07-29 01:39:36,718 801E16000 ironscanner.main     Title: Scan source
INFO   2018-07-29 01:39:36,718 801E16000 ironscanner.main     Desc: Selects the scan source (such as a document-feeder). Set source before mode and resolution. Resets mode and resolution to auto values.
INFO   2018-07-29 01:39:36,719 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO   2018-07-29 01:39:36,719 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,719 801E16000 ironscanner.main     Size: 31
INFO   2018-07-29 01:39:36,719 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO   2018-07-29 01:39:36,719 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO   2018-07-29 01:39:36,719 801E16000 ironscanner.main     Constraint: ['Flatbed', 'Automatic Document Feeder']
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=4)
[dll] sane_control_option(handle=0x801e3a160,option=4,action=0,value=0x803d29150,info=0x803d2e1a8)
INFO   2018-07-29 01:39:36,719 801E16000 ironscanner.main     Value: Flatbed
INFO   2018-07-29 01:39:36,719 801E16000 ironscanner.main   Option: button-controlled
INFO   2018-07-29 01:39:36,719 801E16000 ironscanner.main     Title: Button-controlled scan
INFO   2018-07-29 01:39:36,720 801E16000 ironscanner.main     Desc: When enabled, scan process will not start immediately. To proceed, press "SCAN" button (for MP150) or "COLOR" button (for other models). To cancel, press "GRAY" button.
INFO   2018-07-29 01:39:36,720 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO   2018-07-29 01:39:36,720 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,720 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,720 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO   2018-07-29 01:39:36,720 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-07-29 01:39:36,720 801E16000 ironscanner.main     Constraint: None
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=5)
[dll] sane_control_option(handle=0x801e3a160,option=5,action=0,value=0x803d2e120,info=0x803d2e098)
INFO   2018-07-29 01:39:36,720 801E16000 ironscanner.main     Value: 0
INFO   2018-07-29 01:39:36,720 801E16000 ironscanner.main   Option: custom-gamma
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main     Title: Use custom gamma table
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main     Desc: Determines whether a builtin or a custom gamma-table should be used.
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main     Constraint: None
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=7)
[dll] sane_control_option(handle=0x801e3a160,option=7,action=0,value=0x803d2e1a8,info=0x803d2e230)
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main     Value: 1
INFO   2018-07-29 01:39:36,721 801E16000 ironscanner.main   Option: gamma-table
INFO   2018-07-29 01:39:36,722 801E16000 ironscanner.main     Title: Image intensity
INFO   2018-07-29 01:39:36,722 801E16000 ironscanner.main     Desc: Gamma-correction table.  In color mode this option equally affects the red, green, and blue channels simultaneously (i.e., it is an intensity gamma table).
INFO   2018-07-29 01:39:36,722 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-07-29 01:39:36,722 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,722 801E16000 ironscanner.main     Size: 16384
INFO   2018-07-29 01:39:36,722 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-07-29 01:39:36,722 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-07-29 01:39:36,722 801E16000 ironscanner.main     Constraint: (0, 255, 0)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=8)
[dll] sane_control_option(handle=0x801e3a160,option=8,action=0,value=0x80210abc0,info=0x803d2e120)
INFO   2018-07-29 01:39:36,722 801E16000 ironscanner.main     Value: 0
INFO   2018-07-29 01:39:36,723 801E16000 ironscanner.main   Option: gamma
INFO   2018-07-29 01:39:36,723 801E16000 ironscanner.main     Title: Gamma function exponent
INFO   2018-07-29 01:39:36,723 801E16000 ironscanner.main     Desc: Changes intensity of midtones
INFO   2018-07-29 01:39:36,723 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-07-29 01:39:36,723 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,723 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,723 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-07-29 01:39:36,723 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-07-29 01:39:36,723 801E16000 ironscanner.main     Constraint: (19660, 327680, 0)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=9)
[dll] sane_control_option(handle=0x801e3a160,option=9,action=0,value=0x803d2e230,info=0x803d2e1a8)
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main     Value: 144179
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main   Option: tl-x
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main     Title: Top-left x
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main     Desc: Top-left x position of scan area.
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-07-29 01:39:36,724 801E16000 ironscanner.main     Constraint: (0, 14160319, 0)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=11)
[dll] sane_control_option(handle=0x801e3a160,option=11,action=0,value=0x803d2e120,info=0x803d2e098)
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main     Value: 0
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main   Option: tl-y
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main     Title: Top-left y
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main     Desc: Top-left y position of scan area.
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-07-29 01:39:36,725 801E16000 ironscanner.main     Constraint: (0, 23304601, 0)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=12)
[dll] sane_control_option(handle=0x801e3a160,option=12,action=0,value=0x803d2e1a8,info=0x803d2e230)
INFO   2018-07-29 01:39:36,726 801E16000 ironscanner.main     Value: 0
INFO   2018-07-29 01:39:36,726 801E16000 ironscanner.main   Option: br-x
INFO   2018-07-29 01:39:36,726 801E16000 ironscanner.main     Title: Bottom-right x
INFO   2018-07-29 01:39:36,726 801E16000 ironscanner.main     Desc: Bottom-right x position of scan area.
INFO   2018-07-29 01:39:36,726 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-07-29 01:39:36,726 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-07-29 01:39:36,726 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,726 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-07-29 01:39:36,726 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-07-29 01:39:36,727 801E16000 ironscanner.main     Constraint: (0, 14160319, 0)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=13)
[dll] sane_control_option(handle=0x801e3a160,option=13,action=0,value=0x803d2e098,info=0x803d2e120)
INFO   2018-07-29 01:39:36,727 801E16000 ironscanner.main     Value: 14160319
INFO   2018-07-29 01:39:36,727 801E16000 ironscanner.main   Option: br-y
INFO   2018-07-29 01:39:36,727 801E16000 ironscanner.main     Title: Bottom-right y
INFO   2018-07-29 01:39:36,727 801E16000 ironscanner.main     Desc: Bottom-right y position of scan area.
INFO   2018-07-29 01:39:36,727 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-07-29 01:39:36,727 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-07-29 01:39:36,727 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,727 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main     Constraint: (0, 23304601, 0)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=14)
[dll] sane_control_option(handle=0x801e3a160,option=14,action=0,value=0x803d2e230,info=0x803d2e1a8)
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main     Value: 23304601
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main   Option: button-1
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main     Title: Button 1
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main     Desc: Button 1
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,728 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-07-29 01:39:36,729 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-07-29 01:39:36,729 801E16000 ironscanner.main     Constraint: None
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=17)
[dll] sane_control_option(handle=0x801e3a160,option=17,action=0,value=0x803d2e120,info=0x803d2e098)
INFO   2018-07-29 01:39:36,750 801E16000 ironscanner.main     Value: 0
INFO   2018-07-29 01:39:36,750 801E16000 ironscanner.main   Option: button-2
INFO   2018-07-29 01:39:36,750 801E16000 ironscanner.main     Title: Button 2
INFO   2018-07-29 01:39:36,750 801E16000 ironscanner.main     Desc: Button 2
INFO   2018-07-29 01:39:36,750 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-07-29 01:39:36,750 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,750 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,751 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-07-29 01:39:36,751 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-07-29 01:39:36,751 801E16000 ironscanner.main     Constraint: None
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=18)
[dll] sane_control_option(handle=0x801e3a160,option=18,action=0,value=0x803d2e1a8,info=0x803d2e230)
INFO   2018-07-29 01:39:36,751 801E16000 ironscanner.main     Value: 0
INFO   2018-07-29 01:39:36,751 801E16000 ironscanner.main   Option: original
INFO   2018-07-29 01:39:36,751 801E16000 ironscanner.main     Title: Type of original to scan
INFO   2018-07-29 01:39:36,751 801E16000 ironscanner.main     Desc: Type of original to scan
INFO   2018-07-29 01:39:36,751 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-07-29 01:39:36,751 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,752 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,752 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-07-29 01:39:36,752 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-07-29 01:39:36,752 801E16000 ironscanner.main     Constraint: None
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=19)
[dll] sane_control_option(handle=0x801e3a160,option=19,action=0,value=0x803d2e098,info=0x803d2e120)
INFO   2018-07-29 01:39:36,752 801E16000 ironscanner.main     Value: 0
INFO   2018-07-29 01:39:36,752 801E16000 ironscanner.main   Option: target
INFO   2018-07-29 01:39:36,752 801E16000 ironscanner.main     Title: Target operation type
INFO   2018-07-29 01:39:36,752 801E16000 ironscanner.main     Desc: Target operation type
INFO   2018-07-29 01:39:36,752 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main     Constraint: None
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=20)
[dll] sane_control_option(handle=0x801e3a160,option=20,action=0,value=0x803d2e230,info=0x803d2e1a8)
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main     Value: 0
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main   Option: scan-resolution
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main     Title: Scan resolution
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main     Desc: Scan resolution
INFO   2018-07-29 01:39:36,753 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-07-29 01:39:36,754 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,754 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,754 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-07-29 01:39:36,754 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-07-29 01:39:36,754 801E16000 ironscanner.main     Constraint: None
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=21)
[dll] sane_control_option(handle=0x801e3a160,option=21,action=0,value=0x803d2e120,info=0x803d2e098)
INFO   2018-07-29 01:39:36,754 801E16000 ironscanner.main     Value: 0
INFO   2018-07-29 01:39:36,754 801E16000 ironscanner.main   Option: threshold
INFO   2018-07-29 01:39:36,754 801E16000 ironscanner.main     Title: Threshold
INFO   2018-07-29 01:39:36,754 801E16000 ironscanner.main     Desc: Select minimum-brightness to get a white point
INFO   2018-07-29 01:39:36,755 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-07-29 01:39:36,755 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Percent (5)
INFO   2018-07-29 01:39:36,755 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,755 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic, Inactive,]
INFO   2018-07-29 01:39:36,755 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-07-29 01:39:36,755 801E16000 ironscanner.main     Constraint: (0, 100, 1)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=23)
[dll] sane_control_option(handle=0x801e3a160,option=23,action=0,value=0x803d2e1a8,info=0x803d2e230)
WARNING Pyinsane_daemon Exception
Traceback (most recent call last):
  File "/usr/local/lib/python3.6/site-packages/pyinsane2/sane/daemon.py", line 136, in main_loop
    result['out'] = f(*cmd['args'], **cmd['kwargs'])
  File "/usr/local/lib/python3.6/site-packages/pyinsane2/sane/daemon.py", line 41, in get_option_value
    return get_device(scanner_name).options[option_name].value
  File "/usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract.py", line 92, in _get_value
    val = rawapi.sane_get_option_value(sane_dev_handle[1], self.idx)
  File "/usr/local/lib/python3.6/site-packages/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-07-29 01:39:36,756 801E16000 ironscanner.main     Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO   2018-07-29 01:39:36,756 801E16000 ironscanner.main   Option: threshold-curve
INFO   2018-07-29 01:39:36,757 801E16000 ironscanner.main     Title: Threshold curve
INFO   2018-07-29 01:39:36,757 801E16000 ironscanner.main     Desc: Dynamic threshold curve, from light to dark, normally 50-65
INFO   2018-07-29 01:39:36,757 801E16000 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-07-29 01:39:36,757 801E16000 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-07-29 01:39:36,757 801E16000 ironscanner.main     Size: 4
INFO   2018-07-29 01:39:36,757 801E16000 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic, Inactive,]
INFO   2018-07-29 01:39:36,757 801E16000 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-07-29 01:39:36,757 801E16000 ironscanner.main     Constraint: (0, 127, 1)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=24)
[dll] sane_control_option(handle=0x801e3a160,option=24,action=0,value=0x803d2e098,info=0x803d2e120)
WARNING Pyinsane_daemon Exception
Traceback (most recent call last):
  File "/usr/local/lib/python3.6/site-packages/pyinsane2/sane/daemon.py", line 136, in main_loop
    result['out'] = f(*cmd['args'], **cmd['kwargs'])
  File "/usr/local/lib/python3.6/site-packages/pyinsane2/sane/daemon.py", line 41, in get_option_value
    return get_device(scanner_name).options[option_name].value
  File "/usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract.py", line 92, in _get_value
    val = rawapi.sane_get_option_value(sane_dev_handle[1], self.idx)
  File "/usr/local/lib/python3.6/site-packages/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-07-29 01:39:36,758 801E16000 ironscanner.main     Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
DEBUG  2018-07-29 01:39:36,779 801E16000 ironscanner.util For filename 'flatbed_and_feeder.png' got file '/usr/local/lib/python3.6/site-packages/ironscanner/flatbed_and_feeder.png'
INFO   2018-07-29 01:39:45,788 801E16000 ironscanner.main Preparing summary
INFO   2018-07-29 01:39:45,862 801E16000 ironscanner.main Summary ready
INFO   2018-07-29 01:39:45,863 801E16000 ironscanner.main Summary of the test:
- Scanner: CANON Canon PIXMA MX340 (pixma:MX340_192.168.5.6)
- Type: flatbed_adf
- Source: Flatbed
- Resolutions: 150
- Mode: Color

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

System informations that will be attached to the report:
- arch: ('64bit', 'ELF')
- cpu_freq: 0
- machine: amd64
- mem: 25697497088
- nb_cpus: 8
- os_uname: posix.uname_result(sysname='FreeBSD', nodename='yv.noip.me', release='11.2-STABLE', version='FreeBSD 11.2-STABLE #0 r336657M: Mon Jul 23 16:13:08 PDT 2018     unknown@nohost.com:/oldie/obj/usr/src/sys/GENERIC', machine='amd64')
- platform_detailed: FreeBSD-11.2-STABLE-amd64-64bit-ELF
- platform_short: freebsd11
- platform_uname: uname_result(system='FreeBSD', node='yv.noip.me', release='11.2-STABLE', version='FreeBSD 11.2-STABLE #0 r336657M: Mon Jul 23 16:13:08 PDT 2018     unknown@nohost.com:/oldie/obj/usr/src/sys/GENERIC', machine='amd64', processor='amd64')
- proc: amd64
- python: 3.6.5 (default, Apr  5 2018, 01:15:08) 
[GCC 4.2.1 Compatible FreeBSD Clang 4.0.0 (tags/RELEASE_400/final 297347)]
- release: 11.2-STABLE
- swap: 4294836224
- system: FreeBSD
- type: posix
INFO   2018-07-29 01:39:52,504 814853200 ironscanner.main ### SCAN TEST ###
INFO   2018-07-29 01:39:52,505 814853200 ironscanner.main Configuring scanner: source = Flatbed
DEBUG  2018-07-29 01:39:52,505 814852800 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/__init__.py:set_scanner_opt()@41[TraceThread(<function set_scanner_opt at 0x807ff42f0>)]
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=4)
[dll] sane_control_option(handle=0x801e3a160,option=4,action=1,value=0x803d2e230,info=0x803d2e1a8)
INFO   2018-07-29 01:39:52,511 814852800 pyinsane2  [source] set to [Flatbed]
INFO   2018-07-29 01:39:52,512 814853200 ironscanner.main Configuring scanner: resolution = 150
DEBUG  2018-07-29 01:39:52,512 81630CE00 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/__init__.py:set_scanner_opt()@41[TraceThread(<function set_scanner_opt at 0x807ff42f0>)]
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=2)
[dll] sane_control_option(handle=0x801e3a160,option=2,action=1,value=0x803d2e120,info=0x803d2e098)
INFO   2018-07-29 01:39:52,517 81630CE00 pyinsane2  [resolution] set to [150]
INFO   2018-07-29 01:39:52,517 814853200 ironscanner.main Configuring scanner: mode = Color
DEBUG  2018-07-29 01:39:52,518 815A39500 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/__init__.py:set_scanner_opt()@41[TraceThread(<function set_scanner_opt at 0x807ff42f0>)]
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=3)
[dll] sane_control_option(handle=0x801e3a160,option=3,action=1,value=0x803d2e1a8,info=0x803d2e230)
INFO   2018-07-29 01:39:52,522 815A39500 pyinsane2  [mode] set to [Color]
INFO   2018-07-29 01:39:52,522 814853200 ironscanner.main Maximizing scan area ...
DEBUG  2018-07-29 01:39:52,522 815A39A00 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/__init__.py:maximize_scan_area()@148[TraceThread(<function maximize_scan_area at 0x807ff4400>)]
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=11)
[dll] sane_control_option(handle=0x801e3a160,option=11,action=1,value=0x803d2e098,info=0x803d2e120)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=12)
[dll] sane_control_option(handle=0x801e3a160,option=12,action=1,value=0x803d2e230,info=0x803d2e1a8)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=13)
[dll] sane_control_option(handle=0x801e3a160,option=13,action=1,value=0x803d2e120,info=0x803d2e098)
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=14)
[dll] sane_control_option(handle=0x801e3a160,option=14,action=1,value=0x803d2e1a8,info=0x803d2e230)
INFO   2018-07-29 01:39:52,524 814853200 ironscanner.main Starting scan session ...
DEBUG  2018-07-29 01:39:52,524 805717000 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract_proc.py:scan()@267[TraceThread(<bound method Scanner.scan of <pyinsane2.sane.abstract_proc.Scanner object at 0x810ae4fd0>>)]
[dll] sane_get_option_descriptor(handle=0x801e3a160,option=4)
[dll] sane_control_option(handle=0x801e3a160,option=4,action=0,value=0x803d293f0,info=0x803d2e120)
[dll] sane_start(handle=0x801e3a160)
[dll] sane_get_parameters(handle=0x801e3a160,params=0x8006a39c0)
INFO   2018-07-29 01:39:52,525 814853200 ironscanner.main Expected image size: (1276, 1754)
INFO   2018-07-29 01:39:52,526 814853200 ironscanner.main Scanning page 0
DEBUG  2018-07-29 01:39:52,526 814852800 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x8144a2b38>>)]
[dll] sane_read(handle=0x801e3a160,data=0x8066ae380,maxlen=524288,lenp=0x803d2e230)
INFO   2018-07-29 01:39:58,146 814853200 ironscanner.main Available lines: (0, 2)

(ironscanner:37388): GdkPixbuf-CRITICAL **: gdk_pixbuf_scale_simple: assertion 'dest_height > 0' failed
DEBUG  2018-07-29 01:39:58,168 81630CE00 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x8144a2b38>>)]
[dll] sane_read(handle=0x801e3a160,data=0x80672fa40,maxlen=524288,lenp=0x803d2e098)
INFO   2018-07-29 01:39:58,168 814853200 ironscanner.main Available lines: (0, 8)
DEBUG  2018-07-29 01:39:58,170 815A39500 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x8144a2b38>>)]
[dll] sane_read(handle=0x801e3a160,data=0x8066ae600,maxlen=524288,lenp=0x803d2e230)
INFO   2018-07-29 01:39:58,210 814853200 ironscanner.main Available lines: (0, 10)
DEBUG  2018-07-29 01:39:58,214 815A39A00 ironscanner.trace /usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x8144a2b38>>)]
[dll] sane_read(handle=0x801e3a160,data=0x8066ae040,maxlen=524288,lenp=0x803d2e098)
INFO   2018-07-29 01:39:58,214 814853200 ironscanner.main Available lines: (0, 21)
INFO   2018-07-29 01:39:58,215 814853200 ironscanner.main ### SCAN TEST FAILED ###
Traceback (most recent call last):
  File "/usr/local/lib/python3.6/site-packages/ironscanner/main.py", line 756, in run
    scan_session.scan.get_image(),
  File "/usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract_proc.py", line 197, in get_image
    'scan_get_image', self._scanner_name, start_line, end_line
  File "/usr/local/lib/python3.6/site-packages/pyinsane2/sane/abstract_proc.py", line 70, in remote_do
    assert(len(result) == length)
AssertionError
INFO   2018-07-29 01:40:08,889 8140C9200 ironscanner.main Building report ...
INFO   2018-07-29 01:40:08,889 8140C9200 ironscanner.main * User info
INFO   2018-07-29 01:40:08,889 8140C9200 ironscanner.main * Scanner settings
INFO   2018-07-29 01:40:08,891 8140C9200 ironscanner.main No image attached to report
INFO   2018-07-29 01:40:08,891 8140C9200 ironscanner.main * System configuration
INFO   2018-07-29 01:40:08,926 8140C9200 ironscanner.main * Scan test result
INFO   2018-07-29 01:40:08,934 8140C9200 ironscanner.main * User comment
INFO   2018-07-29 01:40:08,934 8140C9200 ironscanner.main * Traces