INFO   2018-03-07 19:59:01,417 ironscanner.main Initializing pyinsane2 ...
DEBUG  2018-03-07 19:59:01,418 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:init()@87[TraceThread(<function init at 0x7f03cb0d3e18>)]
INFO   2018-03-07 19:59:01,418 pyinsane2.sane.abstract_proc Starting Pyinsane subprocess
INFO   2018-03-07 19:59:01,420 pyinsane2.sane.abstract_proc Pyinsane pipes: /tmp/pyinsane_4fa_eslm/pipe_c2s | /tmp/pyinsane_4fa_eslm/pipe_s2c
INFO   2018-03-07 19:59:01,611 pyinsane2.sane.abstract_proc Connected to Pyinsane subprocess
INFO   2018-03-07 19:59:01,612 ironscanner.main Pyinsane2 ready
DEBUG  2018-03-07 19:59:01,628 ironscanner.util For filename 'mainform.glade' got file '/home/ruffy/.cache/Python-Eggs/ironscanner-1.1.0-py3.6.egg-tmp/ironscanner/mainform.glade'
DEBUG  2018-03-07 19:59:02,370 ironscanner.util For filename 'version.txt' got file '/home/ruffy/.cache/Python-Eggs/ironscanner-1.1.0-py3.6.egg-tmp/ironscanner/version.txt'
DEBUG  2018-03-07 19:59:02,375 ironscanner.util For filename 'logo.png' got file '/home/ruffy/.cache/Python-Eggs/ironscanner-1.1.0-py3.6.egg-tmp/ironscanner/logo.png'
INFO   2018-03-07 19:59:09,323 ironscanner.main Looking for scanners ...
DEBUG  2018-03-07 19:59:09,323 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:get_devices()@275[TraceThread(<function get_devices at 0x7f03cb0d3f28>)]
INFO   2018-03-07 19:59:16,831 ironscanner.main 1 scanners found
INFO   2018-03-07 19:59:16,831 ironscanner.main pixma:MX520_canon -> CANON Canon PIXMA MX520 Series (pixma:MX520_canon)
INFO   2018-03-07 19:59:16,836 ironscanner.main Selected scanner: pixma:MX520_canon
INFO   2018-03-07 19:59:17,379 ironscanner.main   Option: resolution
INFO   2018-03-07 19:59:17,380 ironscanner.main     Title: Scan resolution
INFO   2018-03-07 19:59:17,380 ironscanner.main     Desc: Sets the resolution of the scanned image.
INFO   2018-03-07 19:59:17,380 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 19:59:17,380 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Dpi (4)
INFO   2018-03-07 19:59:17,380 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,381 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 19:59:17,381 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Word list (2)
INFO   2018-03-07 19:59:17,381 ironscanner.main     Constraint: [75, 150, 300, 600, 1200]
INFO   2018-03-07 19:59:17,383 ironscanner.main     Value: 75
INFO   2018-03-07 19:59:17,383 ironscanner.main   Option: mode
INFO   2018-03-07 19:59:17,383 ironscanner.main     Title: Scan mode
INFO   2018-03-07 19:59:17,383 ironscanner.main     Desc: Selects the scan mode (e.g., lineart, monochrome, or color).
INFO   2018-03-07 19:59:17,384 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO   2018-03-07 19:59:17,384 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,384 ironscanner.main     Size: 31
INFO   2018-03-07 19:59:17,384 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 19:59:17,384 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO   2018-03-07 19:59:17,384 ironscanner.main     Constraint: ['Color', 'Gray', 'Lineart']
INFO   2018-03-07 19:59:17,385 ironscanner.main     Value: Color
INFO   2018-03-07 19:59:17,385 ironscanner.main   Option: source
INFO   2018-03-07 19:59:17,385 ironscanner.main     Title: Scan source
INFO   2018-03-07 19:59:17,386 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-03-07 19:59:17,386 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO   2018-03-07 19:59:17,386 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,386 ironscanner.main     Size: 31
INFO   2018-03-07 19:59:17,387 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO   2018-03-07 19:59:17,387 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO   2018-03-07 19:59:17,387 ironscanner.main     Constraint: ['Flatbed', 'Automatic Document Feeder']
INFO   2018-03-07 19:59:17,388 ironscanner.main     Value: Flatbed
INFO   2018-03-07 19:59:17,388 ironscanner.main   Option: button-controlled
INFO   2018-03-07 19:59:17,388 ironscanner.main     Title: Button-controlled scan
INFO   2018-03-07 19:59:17,388 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-03-07 19:59:17,388 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO   2018-03-07 19:59:17,388 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,389 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,390 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO   2018-03-07 19:59:17,390 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 19:59:17,390 ironscanner.main     Constraint: None
INFO   2018-03-07 19:59:17,390 ironscanner.main     Value: 0
INFO   2018-03-07 19:59:17,390 ironscanner.main   Option: custom-gamma
INFO   2018-03-07 19:59:17,391 ironscanner.main     Title: Use custom gamma table
INFO   2018-03-07 19:59:17,391 ironscanner.main     Desc: Determines whether a builtin or a custom gamma-table should be used.
INFO   2018-03-07 19:59:17,391 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO   2018-03-07 19:59:17,391 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,391 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,391 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 19:59:17,391 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 19:59:17,391 ironscanner.main     Constraint: None
INFO   2018-03-07 19:59:17,392 ironscanner.main     Value: 1
INFO   2018-03-07 19:59:17,392 ironscanner.main   Option: gamma-table
INFO   2018-03-07 19:59:17,392 ironscanner.main     Title: Image intensity
INFO   2018-03-07 19:59:17,392 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-03-07 19:59:17,392 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 19:59:17,392 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,393 ironscanner.main     Size: 16384
INFO   2018-03-07 19:59:17,393 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 19:59:17,393 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 19:59:17,393 ironscanner.main     Constraint: (0, 255, 0)
INFO   2018-03-07 19:59:17,394 ironscanner.main     Value: 0
INFO   2018-03-07 19:59:17,394 ironscanner.main   Option: gamma
INFO   2018-03-07 19:59:17,395 ironscanner.main     Title: Gamma function exponent
INFO   2018-03-07 19:59:17,395 ironscanner.main     Desc: Changes intensity of midtones
INFO   2018-03-07 19:59:17,395 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 19:59:17,395 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,395 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,395 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 19:59:17,395 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 19:59:17,396 ironscanner.main     Constraint: (19660, 327680, 0)
INFO   2018-03-07 19:59:17,396 ironscanner.main     Value: 144179
INFO   2018-03-07 19:59:17,396 ironscanner.main   Option: tl-x
INFO   2018-03-07 19:59:17,397 ironscanner.main     Title: Top-left x
INFO   2018-03-07 19:59:17,397 ironscanner.main     Desc: Top-left x position of scan area.
INFO   2018-03-07 19:59:17,397 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 19:59:17,397 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 19:59:17,397 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,397 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 19:59:17,397 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 19:59:17,398 ironscanner.main     Constraint: (0, 14160319, 0)
INFO   2018-03-07 19:59:17,398 ironscanner.main     Value: 0
INFO   2018-03-07 19:59:17,398 ironscanner.main   Option: tl-y
INFO   2018-03-07 19:59:17,399 ironscanner.main     Title: Top-left y
INFO   2018-03-07 19:59:17,399 ironscanner.main     Desc: Top-left y position of scan area.
INFO   2018-03-07 19:59:17,399 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 19:59:17,399 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 19:59:17,400 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,400 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 19:59:17,400 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 19:59:17,400 ironscanner.main     Constraint: (0, 23304601, 0)
INFO   2018-03-07 19:59:17,400 ironscanner.main     Value: 0
INFO   2018-03-07 19:59:17,401 ironscanner.main   Option: br-x
INFO   2018-03-07 19:59:17,401 ironscanner.main     Title: Bottom-right x
INFO   2018-03-07 19:59:17,401 ironscanner.main     Desc: Bottom-right x position of scan area.
INFO   2018-03-07 19:59:17,401 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 19:59:17,401 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 19:59:17,402 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,402 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 19:59:17,402 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 19:59:17,402 ironscanner.main     Constraint: (0, 14160319, 0)
INFO   2018-03-07 19:59:17,403 ironscanner.main     Value: 14160319
INFO   2018-03-07 19:59:17,403 ironscanner.main   Option: br-y
INFO   2018-03-07 19:59:17,403 ironscanner.main     Title: Bottom-right y
INFO   2018-03-07 19:59:17,403 ironscanner.main     Desc: Bottom-right y position of scan area.
INFO   2018-03-07 19:59:17,403 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 19:59:17,404 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 19:59:17,404 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,404 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 19:59:17,404 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 19:59:17,404 ironscanner.main     Constraint: (0, 23304601, 0)
INFO   2018-03-07 19:59:17,404 ironscanner.main     Value: 23304601
INFO   2018-03-07 19:59:17,405 ironscanner.main   Option: button-1
INFO   2018-03-07 19:59:17,405 ironscanner.main     Title: Button 1
INFO   2018-03-07 19:59:17,405 ironscanner.main     Desc: Button 1
INFO   2018-03-07 19:59:17,405 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 19:59:17,405 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,405 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,406 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 19:59:17,406 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 19:59:17,406 ironscanner.main     Constraint: None
INFO   2018-03-07 19:59:17,433 ironscanner.main     Value: 0
INFO   2018-03-07 19:59:17,434 ironscanner.main   Option: button-2
INFO   2018-03-07 19:59:17,434 ironscanner.main     Title: Button 2
INFO   2018-03-07 19:59:17,434 ironscanner.main     Desc: Button 2
INFO   2018-03-07 19:59:17,435 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 19:59:17,435 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,435 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,435 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 19:59:17,435 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 19:59:17,436 ironscanner.main     Constraint: None
INFO   2018-03-07 19:59:17,438 ironscanner.main     Value: 0
INFO   2018-03-07 19:59:17,440 ironscanner.main   Option: original
INFO   2018-03-07 19:59:17,440 ironscanner.main     Title: Type of original to scan
INFO   2018-03-07 19:59:17,440 ironscanner.main     Desc: Type of original to scan
INFO   2018-03-07 19:59:17,441 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 19:59:17,441 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,441 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,442 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 19:59:17,442 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 19:59:17,443 ironscanner.main     Constraint: None
INFO   2018-03-07 19:59:17,444 ironscanner.main     Value: 0
INFO   2018-03-07 19:59:17,444 ironscanner.main   Option: target
INFO   2018-03-07 19:59:17,444 ironscanner.main     Title: Target operation type
INFO   2018-03-07 19:59:17,444 ironscanner.main     Desc: Target operation type
INFO   2018-03-07 19:59:17,444 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 19:59:17,444 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,445 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,445 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 19:59:17,445 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 19:59:17,445 ironscanner.main     Constraint: None
INFO   2018-03-07 19:59:17,446 ironscanner.main     Value: 0
INFO   2018-03-07 19:59:17,446 ironscanner.main   Option: scan-resolution
INFO   2018-03-07 19:59:17,446 ironscanner.main     Title: Scan resolution
INFO   2018-03-07 19:59:17,446 ironscanner.main     Desc: Scan resolution
INFO   2018-03-07 19:59:17,446 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 19:59:17,447 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,447 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,447 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 19:59:17,447 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 19:59:17,447 ironscanner.main     Constraint: None
INFO   2018-03-07 19:59:17,447 ironscanner.main     Value: 0
INFO   2018-03-07 19:59:17,448 ironscanner.main   Option: threshold
INFO   2018-03-07 19:59:17,449 ironscanner.main     Title: Threshold
INFO   2018-03-07 19:59:17,453 ironscanner.main     Desc: Select minimum-brightness to get a white point
INFO   2018-03-07 19:59:17,453 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 19:59:17,453 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Percent (5)
INFO   2018-03-07 19:59:17,453 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,453 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic, Inactive,]
INFO   2018-03-07 19:59:17,453 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 19:59:17,454 ironscanner.main     Constraint: (0, 100, 1)
INFO   2018-03-07 19:59:17,457 ironscanner.main     Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO   2018-03-07 19:59:17,457 ironscanner.main   Option: threshold-curve
INFO   2018-03-07 19:59:17,458 ironscanner.main     Title: Threshold curve
INFO   2018-03-07 19:59:17,458 ironscanner.main     Desc: Dynamic threshold curve, from light to dark, normally 50-65
INFO   2018-03-07 19:59:17,458 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 19:59:17,458 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 19:59:17,458 ironscanner.main     Size: 4
INFO   2018-03-07 19:59:17,458 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic, Inactive,]
INFO   2018-03-07 19:59:17,459 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 19:59:17,459 ironscanner.main     Constraint: (0, 127, 1)
INFO   2018-03-07 19:59:17,461 ironscanner.main     Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
DEBUG  2018-03-07 19:59:17,554 ironscanner.util For filename 'flatbed_and_feeder.png' got file '/home/ruffy/.cache/Python-Eggs/ironscanner-1.1.0-py3.6.egg-tmp/ironscanner/flatbed_and_feeder.png'
INFO   2018-03-07 20:00:07,914 ironscanner.main Preparing summary
INFO   2018-03-07 20:00:08,090 ironscanner.main Summary ready
INFO   2018-03-07 20:00:08,090 ironscanner.main Summary of the test:
- Scanner: CANON Canon PIXMA MX520 Series (pixma:MX520_canon)
- Type: flatbed_adf
- Source: Flatbed
- Resolutions: 150
- Mode: Color

Personal information that will be attached to the report:
- Name: Oumph

System informations that will be attached to the report:
- arch: ('64bit', 'ELF')
- cpu_freq: 2128
- machine: x86_64
- mem: 2885484544
- nb_cpus: 2
- os_uname: posix.uname_result(sysname='Linux', nodename='anthra', release='4.7.0-1-amd64', version='#1 SMP Debian 4.7.8-1 (2016-10-19)', machine='x86_64')
- platform_detailed: Linux-4.7.0-1-amd64-x86_64-with-debian-buster-sid
- platform_short: linux
- platform_uname: uname_result(system='Linux', node='anthra', release='4.7.0-1-amd64', version='#1 SMP Debian 4.7.8-1 (2016-10-19)', machine='x86_64', processor='')
- proc: 
- python: 3.6.4+ (default, Feb 12 2018, 08:25:03) 
[GCC 7.3.0]
- release: 4.7.0-1-amd64
- swap: 10179571712
- system: Linux
- type: posix
INFO   2018-03-07 20:02:00,183 ironscanner.main Looking for scanners ...
DEBUG  2018-03-07 20:02:00,184 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:get_devices()@275[TraceThread(<function get_devices at 0x7f03cb0d3f28>)]
DEBUG  2018-03-07 20:02:00,187 ironscanner.util For filename 'flatbed_and_feeder.png' got file '/home/ruffy/.cache/Python-Eggs/ironscanner-1.1.0-py3.6.egg-tmp/ironscanner/flatbed_and_feeder.png'
INFO   2018-03-07 20:02:03,196 ironscanner.main Preparing summary
INFO   2018-03-07 20:02:03,207 ironscanner.main Summary ready
INFO   2018-03-07 20:02:03,208 ironscanner.main Summary of the test:
- Scanner: CANON Canon PIXMA MX520 Series (pixma:MX520_canon)
- Type: flatbed_adf
- Source: Flatbed
- Resolutions: 150
- Mode: Color

Personal information that will be attached to the report:
- Name: Oumph
- Email: oumph@linuxfr.org

System informations that will be attached to the report:
- arch: ('64bit', 'ELF')
- cpu_freq: 2128
- machine: x86_64
- mem: 2885484544
- nb_cpus: 2
- os_uname: posix.uname_result(sysname='Linux', nodename='anthra', release='4.7.0-1-amd64', version='#1 SMP Debian 4.7.8-1 (2016-10-19)', machine='x86_64')
- platform_detailed: Linux-4.7.0-1-amd64-x86_64-with-debian-buster-sid
- platform_short: linux
- platform_uname: uname_result(system='Linux', node='anthra', release='4.7.0-1-amd64', version='#1 SMP Debian 4.7.8-1 (2016-10-19)', machine='x86_64', processor='')
- proc: 
- python: 3.6.4+ (default, Feb 12 2018, 08:25:03) 
[GCC 7.3.0]
- release: 4.7.0-1-amd64
- swap: 10179571712
- system: Linux
- type: posix
INFO   2018-03-07 20:02:05,228 ironscanner.main 1 scanners found
ERROR  2018-03-07 20:02:05,229 ironscanner.log === UNCATCHED EXCEPTION ===
Traceback (most recent call last):
  File "/home/ruffy/ironscanner/venv/lib/python3.6/site-packages/ironscanner-1.1.0-py3.6.egg/ironscanner/main.py", line 316, in _on_scanner_selected
    scanner = self.get_scanner()
  File "/home/ruffy/ironscanner/venv/lib/python3.6/site-packages/ironscanner-1.1.0-py3.6.egg/ironscanner/main.py", line 454, in get_scanner
    scanner = self.scanners[devid]
KeyError: <ironscanner.dummy.DummyScanner object at 0x7f03b0219908>
ERROR  2018-03-07 20:02:05,230 ironscanner.log ===========================
ERROR  2018-03-07 20:02:05,231 ironscanner.log === UNCATCHED EXCEPTION ===
Traceback (most recent call last):
  File "/home/ruffy/ironscanner/venv/lib/python3.6/site-packages/ironscanner-1.1.0-py3.6.egg/ironscanner/main.py", line 316, in _on_scanner_selected
    scanner = self.get_scanner()
  File "/home/ruffy/ironscanner/venv/lib/python3.6/site-packages/ironscanner-1.1.0-py3.6.egg/ironscanner/main.py", line 454, in get_scanner
    scanner = self.scanners[devid]
KeyError: <ironscanner.dummy.DummyScanner object at 0x7f03c00f07b8>
ERROR  2018-03-07 20:02:05,231 ironscanner.log ===========================
INFO   2018-03-07 20:02:05,231 ironscanner.main pixma:MX520_canon -> CANON Canon PIXMA MX520 Series (pixma:MX520_canon)
INFO   2018-03-07 20:02:05,233 ironscanner.main Selected scanner: pixma:MX520_canon
INFO   2018-03-07 20:02:05,235 ironscanner.main   Option: resolution
INFO   2018-03-07 20:02:05,236 ironscanner.main     Title: Scan resolution
INFO   2018-03-07 20:02:05,236 ironscanner.main     Desc: Sets the resolution of the scanned image.
INFO   2018-03-07 20:02:05,236 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:05,236 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Dpi (4)
INFO   2018-03-07 20:02:05,236 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,237 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:05,237 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Word list (2)
INFO   2018-03-07 20:02:05,237 ironscanner.main     Constraint: [75, 150, 300, 600, 1200]
INFO   2018-03-07 20:02:05,238 ironscanner.main     Value: 75
INFO   2018-03-07 20:02:05,238 ironscanner.main   Option: mode
INFO   2018-03-07 20:02:05,238 ironscanner.main     Title: Scan mode
INFO   2018-03-07 20:02:05,238 ironscanner.main     Desc: Selects the scan mode (e.g., lineart, monochrome, or color).
INFO   2018-03-07 20:02:05,238 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO   2018-03-07 20:02:05,249 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,249 ironscanner.main     Size: 31
INFO   2018-03-07 20:02:05,249 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:05,249 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO   2018-03-07 20:02:05,250 ironscanner.main     Constraint: ['Color', 'Gray', 'Lineart']
INFO   2018-03-07 20:02:05,250 ironscanner.main     Value: Color
INFO   2018-03-07 20:02:05,251 ironscanner.main   Option: source
INFO   2018-03-07 20:02:05,251 ironscanner.main     Title: Scan source
INFO   2018-03-07 20:02:05,255 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-03-07 20:02:05,255 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO   2018-03-07 20:02:05,255 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,255 ironscanner.main     Size: 31
INFO   2018-03-07 20:02:05,255 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO   2018-03-07 20:02:05,255 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO   2018-03-07 20:02:05,256 ironscanner.main     Constraint: ['Flatbed', 'Automatic Document Feeder']
INFO   2018-03-07 20:02:05,258 ironscanner.main     Value: Flatbed
INFO   2018-03-07 20:02:05,259 ironscanner.main   Option: button-controlled
INFO   2018-03-07 20:02:05,259 ironscanner.main     Title: Button-controlled scan
INFO   2018-03-07 20:02:05,259 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-03-07 20:02:05,259 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO   2018-03-07 20:02:05,259 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,259 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,259 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO   2018-03-07 20:02:05,260 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:05,260 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:05,263 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:05,264 ironscanner.main   Option: custom-gamma
INFO   2018-03-07 20:02:05,264 ironscanner.main     Title: Use custom gamma table
INFO   2018-03-07 20:02:05,264 ironscanner.main     Desc: Determines whether a builtin or a custom gamma-table should be used.
INFO   2018-03-07 20:02:05,264 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO   2018-03-07 20:02:05,264 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,265 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,265 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:05,265 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:05,265 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:05,266 ironscanner.main     Value: 1
INFO   2018-03-07 20:02:05,266 ironscanner.main   Option: gamma-table
INFO   2018-03-07 20:02:05,266 ironscanner.main     Title: Image intensity
INFO   2018-03-07 20:02:05,266 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-03-07 20:02:05,266 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:05,266 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,266 ironscanner.main     Size: 16384
INFO   2018-03-07 20:02:05,267 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:05,267 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:05,267 ironscanner.main     Constraint: (0, 255, 0)
INFO   2018-03-07 20:02:05,268 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:05,268 ironscanner.main   Option: gamma
INFO   2018-03-07 20:02:05,268 ironscanner.main     Title: Gamma function exponent
INFO   2018-03-07 20:02:05,268 ironscanner.main     Desc: Changes intensity of midtones
INFO   2018-03-07 20:02:05,268 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:05,268 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,268 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,269 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:05,269 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:05,269 ironscanner.main     Constraint: (19660, 327680, 0)
INFO   2018-03-07 20:02:05,269 ironscanner.main     Value: 144179
INFO   2018-03-07 20:02:05,269 ironscanner.main   Option: tl-x
INFO   2018-03-07 20:02:05,269 ironscanner.main     Title: Top-left x
INFO   2018-03-07 20:02:05,270 ironscanner.main     Desc: Top-left x position of scan area.
INFO   2018-03-07 20:02:05,270 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:05,270 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 20:02:05,270 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,270 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:05,270 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:05,270 ironscanner.main     Constraint: (0, 14160319, 0)
INFO   2018-03-07 20:02:05,272 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:05,272 ironscanner.main   Option: tl-y
INFO   2018-03-07 20:02:05,272 ironscanner.main     Title: Top-left y
INFO   2018-03-07 20:02:05,273 ironscanner.main     Desc: Top-left y position of scan area.
INFO   2018-03-07 20:02:05,273 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:05,273 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 20:02:05,273 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,273 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:05,273 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:05,274 ironscanner.main     Constraint: (0, 23304601, 0)
INFO   2018-03-07 20:02:05,274 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:05,274 ironscanner.main   Option: br-x
INFO   2018-03-07 20:02:05,274 ironscanner.main     Title: Bottom-right x
INFO   2018-03-07 20:02:05,274 ironscanner.main     Desc: Bottom-right x position of scan area.
INFO   2018-03-07 20:02:05,274 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:05,275 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 20:02:05,275 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,275 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:05,275 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:05,275 ironscanner.main     Constraint: (0, 14160319, 0)
INFO   2018-03-07 20:02:05,275 ironscanner.main     Value: 14160319
INFO   2018-03-07 20:02:05,276 ironscanner.main   Option: br-y
INFO   2018-03-07 20:02:05,276 ironscanner.main     Title: Bottom-right y
INFO   2018-03-07 20:02:05,276 ironscanner.main     Desc: Bottom-right y position of scan area.
INFO   2018-03-07 20:02:05,276 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:05,276 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 20:02:05,276 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,276 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:05,276 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:05,277 ironscanner.main     Constraint: (0, 23304601, 0)
INFO   2018-03-07 20:02:05,277 ironscanner.main     Value: 23304601
INFO   2018-03-07 20:02:05,277 ironscanner.main   Option: button-1
INFO   2018-03-07 20:02:05,277 ironscanner.main     Title: Button 1
INFO   2018-03-07 20:02:05,277 ironscanner.main     Desc: Button 1
INFO   2018-03-07 20:02:05,277 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:05,278 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,278 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,278 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:05,278 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:05,278 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:05,295 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:05,295 ironscanner.main   Option: button-2
INFO   2018-03-07 20:02:05,295 ironscanner.main     Title: Button 2
INFO   2018-03-07 20:02:05,296 ironscanner.main     Desc: Button 2
INFO   2018-03-07 20:02:05,296 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:05,296 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,296 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,296 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:05,296 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:05,296 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:05,297 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:05,298 ironscanner.main   Option: original
INFO   2018-03-07 20:02:05,298 ironscanner.main     Title: Type of original to scan
INFO   2018-03-07 20:02:05,298 ironscanner.main     Desc: Type of original to scan
INFO   2018-03-07 20:02:05,298 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:05,298 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,299 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,299 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:05,299 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:05,299 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:05,299 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:05,300 ironscanner.main   Option: target
INFO   2018-03-07 20:02:05,300 ironscanner.main     Title: Target operation type
INFO   2018-03-07 20:02:05,300 ironscanner.main     Desc: Target operation type
INFO   2018-03-07 20:02:05,300 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:05,300 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,300 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,301 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:05,301 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:05,301 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:05,302 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:05,303 ironscanner.main   Option: scan-resolution
INFO   2018-03-07 20:02:05,303 ironscanner.main     Title: Scan resolution
INFO   2018-03-07 20:02:05,303 ironscanner.main     Desc: Scan resolution
INFO   2018-03-07 20:02:05,304 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:05,304 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,304 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,304 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:05,304 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:05,304 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:05,305 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:05,305 ironscanner.main   Option: threshold
INFO   2018-03-07 20:02:05,305 ironscanner.main     Title: Threshold
INFO   2018-03-07 20:02:05,305 ironscanner.main     Desc: Select minimum-brightness to get a white point
INFO   2018-03-07 20:02:05,305 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:05,306 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Percent (5)
INFO   2018-03-07 20:02:05,306 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,306 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic, Inactive,]
INFO   2018-03-07 20:02:05,306 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:05,306 ironscanner.main     Constraint: (0, 100, 1)
INFO   2018-03-07 20:02:05,307 ironscanner.main     Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO   2018-03-07 20:02:05,307 ironscanner.main   Option: threshold-curve
INFO   2018-03-07 20:02:05,307 ironscanner.main     Title: Threshold curve
INFO   2018-03-07 20:02:05,307 ironscanner.main     Desc: Dynamic threshold curve, from light to dark, normally 50-65
INFO   2018-03-07 20:02:05,308 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:05,308 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:05,308 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:05,308 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic, Inactive,]
INFO   2018-03-07 20:02:05,308 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:05,308 ironscanner.main     Constraint: (0, 127, 1)
INFO   2018-03-07 20:02:05,309 ironscanner.main     Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO   2018-03-07 20:02:06,892 ironscanner.main Looking for scanners ...
DEBUG  2018-03-07 20:02:06,893 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:get_devices()@275[TraceThread(<function get_devices at 0x7f03cb0d3f28>)]
DEBUG  2018-03-07 20:02:06,896 ironscanner.util For filename 'flatbed_and_feeder.png' got file '/home/ruffy/.cache/Python-Eggs/ironscanner-1.1.0-py3.6.egg-tmp/ironscanner/flatbed_and_feeder.png'
INFO   2018-03-07 20:02:11,912 ironscanner.main 1 scanners found
ERROR  2018-03-07 20:02:11,913 ironscanner.log === UNCATCHED EXCEPTION ===
Traceback (most recent call last):
  File "/home/ruffy/ironscanner/venv/lib/python3.6/site-packages/ironscanner-1.1.0-py3.6.egg/ironscanner/main.py", line 316, in _on_scanner_selected
    scanner = self.get_scanner()
  File "/home/ruffy/ironscanner/venv/lib/python3.6/site-packages/ironscanner-1.1.0-py3.6.egg/ironscanner/main.py", line 454, in get_scanner
    scanner = self.scanners[devid]
KeyError: <ironscanner.dummy.DummyScanner object at 0x7f03cdbf9cc0>
ERROR  2018-03-07 20:02:11,913 ironscanner.log ===========================
ERROR  2018-03-07 20:02:11,914 ironscanner.log === UNCATCHED EXCEPTION ===
Traceback (most recent call last):
  File "/home/ruffy/ironscanner/venv/lib/python3.6/site-packages/ironscanner-1.1.0-py3.6.egg/ironscanner/main.py", line 316, in _on_scanner_selected
    scanner = self.get_scanner()
  File "/home/ruffy/ironscanner/venv/lib/python3.6/site-packages/ironscanner-1.1.0-py3.6.egg/ironscanner/main.py", line 454, in get_scanner
    scanner = self.scanners[devid]
KeyError: <ironscanner.dummy.DummyScanner object at 0x7f03c00f07b8>
ERROR  2018-03-07 20:02:11,914 ironscanner.log ===========================
INFO   2018-03-07 20:02:11,914 ironscanner.main pixma:MX520_canon -> CANON Canon PIXMA MX520 Series (pixma:MX520_canon)
INFO   2018-03-07 20:02:11,915 ironscanner.main Selected scanner: pixma:MX520_canon
INFO   2018-03-07 20:02:11,917 ironscanner.main   Option: resolution
INFO   2018-03-07 20:02:11,918 ironscanner.main     Title: Scan resolution
INFO   2018-03-07 20:02:11,918 ironscanner.main     Desc: Sets the resolution of the scanned image.
INFO   2018-03-07 20:02:11,918 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:11,918 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Dpi (4)
INFO   2018-03-07 20:02:11,918 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,919 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:11,919 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Word list (2)
INFO   2018-03-07 20:02:11,919 ironscanner.main     Constraint: [75, 150, 300, 600, 1200]
INFO   2018-03-07 20:02:11,921 ironscanner.main     Value: 75
INFO   2018-03-07 20:02:11,922 ironscanner.main   Option: mode
INFO   2018-03-07 20:02:11,922 ironscanner.main     Title: Scan mode
INFO   2018-03-07 20:02:11,922 ironscanner.main     Desc: Selects the scan mode (e.g., lineart, monochrome, or color).
INFO   2018-03-07 20:02:11,922 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO   2018-03-07 20:02:11,922 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,922 ironscanner.main     Size: 31
INFO   2018-03-07 20:02:11,923 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:11,923 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO   2018-03-07 20:02:11,923 ironscanner.main     Constraint: ['Color', 'Gray', 'Lineart']
INFO   2018-03-07 20:02:11,930 ironscanner.main     Value: Color
INFO   2018-03-07 20:02:11,930 ironscanner.main   Option: source
INFO   2018-03-07 20:02:11,930 ironscanner.main     Title: Scan source
INFO   2018-03-07 20:02:11,931 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-03-07 20:02:11,931 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : String (3)
INFO   2018-03-07 20:02:11,931 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,931 ironscanner.main     Size: 31
INFO   2018-03-07 20:02:11,931 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO   2018-03-07 20:02:11,931 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : String list (3)
INFO   2018-03-07 20:02:11,931 ironscanner.main     Constraint: ['Flatbed', 'Automatic Document Feeder']
INFO   2018-03-07 20:02:11,932 ironscanner.main     Value: Flatbed
INFO   2018-03-07 20:02:11,932 ironscanner.main   Option: button-controlled
INFO   2018-03-07 20:02:11,933 ironscanner.main     Title: Button-controlled scan
INFO   2018-03-07 20:02:11,933 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-03-07 20:02:11,933 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO   2018-03-07 20:02:11,933 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,933 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,933 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect,]
INFO   2018-03-07 20:02:11,934 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:11,934 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:11,934 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:11,935 ironscanner.main   Option: custom-gamma
INFO   2018-03-07 20:02:11,935 ironscanner.main     Title: Use custom gamma table
INFO   2018-03-07 20:02:11,935 ironscanner.main     Desc: Determines whether a builtin or a custom gamma-table should be used.
INFO   2018-03-07 20:02:11,935 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Boolean (0)
INFO   2018-03-07 20:02:11,935 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,935 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,936 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:11,936 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:11,936 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:11,936 ironscanner.main     Value: 1
INFO   2018-03-07 20:02:11,937 ironscanner.main   Option: gamma-table
INFO   2018-03-07 20:02:11,937 ironscanner.main     Title: Image intensity
INFO   2018-03-07 20:02:11,937 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-03-07 20:02:11,937 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:11,938 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,938 ironscanner.main     Size: 16384
INFO   2018-03-07 20:02:11,938 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:11,938 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:11,938 ironscanner.main     Constraint: (0, 255, 0)
INFO   2018-03-07 20:02:11,939 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:11,939 ironscanner.main   Option: gamma
INFO   2018-03-07 20:02:11,939 ironscanner.main     Title: Gamma function exponent
INFO   2018-03-07 20:02:11,939 ironscanner.main     Desc: Changes intensity of midtones
INFO   2018-03-07 20:02:11,940 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:11,940 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,940 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,940 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:11,940 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:11,941 ironscanner.main     Constraint: (19660, 327680, 0)
INFO   2018-03-07 20:02:11,942 ironscanner.main     Value: 144179
INFO   2018-03-07 20:02:11,942 ironscanner.main   Option: tl-x
INFO   2018-03-07 20:02:11,942 ironscanner.main     Title: Top-left x
INFO   2018-03-07 20:02:11,942 ironscanner.main     Desc: Top-left x position of scan area.
INFO   2018-03-07 20:02:11,943 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:11,943 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 20:02:11,943 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,943 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:11,943 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:11,944 ironscanner.main     Constraint: (0, 14160319, 0)
INFO   2018-03-07 20:02:11,944 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:11,945 ironscanner.main   Option: tl-y
INFO   2018-03-07 20:02:11,945 ironscanner.main     Title: Top-left y
INFO   2018-03-07 20:02:11,945 ironscanner.main     Desc: Top-left y position of scan area.
INFO   2018-03-07 20:02:11,945 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:11,945 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 20:02:11,946 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,946 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:11,946 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:11,946 ironscanner.main     Constraint: (0, 23304601, 0)
INFO   2018-03-07 20:02:11,946 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:11,947 ironscanner.main   Option: br-x
INFO   2018-03-07 20:02:11,947 ironscanner.main     Title: Bottom-right x
INFO   2018-03-07 20:02:11,947 ironscanner.main     Desc: Bottom-right x position of scan area.
INFO   2018-03-07 20:02:11,947 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:11,947 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 20:02:11,947 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,947 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:11,947 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:11,948 ironscanner.main     Constraint: (0, 14160319, 0)
INFO   2018-03-07 20:02:11,948 ironscanner.main     Value: 14160319
INFO   2018-03-07 20:02:11,948 ironscanner.main   Option: br-y
INFO   2018-03-07 20:02:11,948 ironscanner.main     Title: Bottom-right y
INFO   2018-03-07 20:02:11,949 ironscanner.main     Desc: Bottom-right y position of scan area.
INFO   2018-03-07 20:02:11,949 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Fixed (2)
INFO   2018-03-07 20:02:11,949 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Mm (3)
INFO   2018-03-07 20:02:11,949 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,949 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic,]
INFO   2018-03-07 20:02:11,950 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:11,950 ironscanner.main     Constraint: (0, 23304601, 0)
INFO   2018-03-07 20:02:11,950 ironscanner.main     Value: 23304601
INFO   2018-03-07 20:02:11,950 ironscanner.main   Option: button-1
INFO   2018-03-07 20:02:11,950 ironscanner.main     Title: Button 1
INFO   2018-03-07 20:02:11,950 ironscanner.main     Desc: Button 1
INFO   2018-03-07 20:02:11,951 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:11,951 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,951 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,951 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:11,951 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:11,951 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:11,967 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:11,968 ironscanner.main   Option: button-2
INFO   2018-03-07 20:02:11,968 ironscanner.main     Title: Button 2
INFO   2018-03-07 20:02:11,968 ironscanner.main     Desc: Button 2
INFO   2018-03-07 20:02:11,968 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:11,968 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,969 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,969 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:11,969 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:11,969 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:11,969 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:11,970 ironscanner.main   Option: original
INFO   2018-03-07 20:02:11,970 ironscanner.main     Title: Type of original to scan
INFO   2018-03-07 20:02:11,970 ironscanner.main     Desc: Type of original to scan
INFO   2018-03-07 20:02:11,970 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:11,970 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,970 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,970 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:11,970 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:11,971 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:11,971 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:11,971 ironscanner.main   Option: target
INFO   2018-03-07 20:02:11,971 ironscanner.main     Title: Target operation type
INFO   2018-03-07 20:02:11,971 ironscanner.main     Desc: Target operation type
INFO   2018-03-07 20:02:11,972 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:11,972 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,973 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,973 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:11,973 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:11,973 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:11,974 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:11,975 ironscanner.main   Option: scan-resolution
INFO   2018-03-07 20:02:11,978 ironscanner.main     Title: Scan resolution
INFO   2018-03-07 20:02:11,979 ironscanner.main     Desc: Scan resolution
INFO   2018-03-07 20:02:11,979 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:11,979 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,979 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,980 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_detect, Advanced,]
INFO   2018-03-07 20:02:11,980 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : None (0)
INFO   2018-03-07 20:02:11,980 ironscanner.main     Constraint: None
INFO   2018-03-07 20:02:11,981 ironscanner.main     Value: 0
INFO   2018-03-07 20:02:11,981 ironscanner.main   Option: threshold
INFO   2018-03-07 20:02:11,981 ironscanner.main     Title: Threshold
INFO   2018-03-07 20:02:11,981 ironscanner.main     Desc: Select minimum-brightness to get a white point
INFO   2018-03-07 20:02:11,982 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:11,982 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : Percent (5)
INFO   2018-03-07 20:02:11,982 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,982 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic, Inactive,]
INFO   2018-03-07 20:02:11,982 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:11,982 ironscanner.main     Constraint: (0, 100, 1)
INFO   2018-03-07 20:02:11,983 ironscanner.main     Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO   2018-03-07 20:02:11,983 ironscanner.main   Option: threshold-curve
INFO   2018-03-07 20:02:11,983 ironscanner.main     Title: Threshold curve
INFO   2018-03-07 20:02:11,984 ironscanner.main     Desc: Dynamic threshold curve, from light to dark, normally 50-65
INFO   2018-03-07 20:02:11,984 ironscanner.main     Type: <class 'pyinsane2.sane.rawapi.SaneValueType'> : Integer (1)
INFO   2018-03-07 20:02:11,984 ironscanner.main     Unit: <class 'pyinsane2.sane.rawapi.SaneUnit'> : None (0)
INFO   2018-03-07 20:02:11,984 ironscanner.main     Size: 4
INFO   2018-03-07 20:02:11,984 ironscanner.main     Capabilities: <class 'pyinsane2.sane.rawapi.SaneCapabilities'> :[ Soft_select, Soft_detect, Automatic, Inactive,]
INFO   2018-03-07 20:02:11,984 ironscanner.main     Constraint type: <class 'pyinsane2.sane.rawapi.SaneConstraintType'> : Range (1)
INFO   2018-03-07 20:02:11,984 ironscanner.main     Constraint: (0, 127, 1)
INFO   2018-03-07 20:02:11,985 ironscanner.main     Value: (Exception: <class 'pyinsane2.sane.rawapi.SaneStatus'> : Data is invalid (4))
INFO   2018-03-07 20:02:17,083 ironscanner.main Preparing summary
INFO   2018-03-07 20:02:17,099 ironscanner.main Summary ready
INFO   2018-03-07 20:02:17,099 ironscanner.main Summary of the test:
- Scanner: CANON Canon PIXMA MX520 Series (pixma:MX520_canon)
- Type: flatbed_adf
- Source: Flatbed
- Resolutions: 150
- Mode: Color

Personal information that will be attached to the report:
- Name: Oumph
- Email: oumph@linuxfr.org

System informations that will be attached to the report:
- arch: ('64bit', 'ELF')
- cpu_freq: 2128
- machine: x86_64
- mem: 2885484544
- nb_cpus: 2
- os_uname: posix.uname_result(sysname='Linux', nodename='anthra', release='4.7.0-1-amd64', version='#1 SMP Debian 4.7.8-1 (2016-10-19)', machine='x86_64')
- platform_detailed: Linux-4.7.0-1-amd64-x86_64-with-debian-buster-sid
- platform_short: linux
- platform_uname: uname_result(system='Linux', node='anthra', release='4.7.0-1-amd64', version='#1 SMP Debian 4.7.8-1 (2016-10-19)', machine='x86_64', processor='')
- proc: 
- python: 3.6.4+ (default, Feb 12 2018, 08:25:03) 
[GCC 7.3.0]
- release: 4.7.0-1-amd64
- swap: 10179571712
- system: Linux
- type: posix
INFO   2018-03-07 20:02:21,330 ironscanner.main ### SCAN TEST ###
INFO   2018-03-07 20:02:21,330 ironscanner.main Configuring scanner: source = Flatbed
DEBUG  2018-03-07 20:02:21,331 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/__init__.py:set_scanner_opt()@41[TraceThread(<function set_scanner_opt at 0x7f03cbadcae8>)]
INFO   2018-03-07 20:02:21,357 pyinsane2  [source] set to [Flatbed]
INFO   2018-03-07 20:02:21,358 ironscanner.main Configuring scanner: resolution = 150
DEBUG  2018-03-07 20:02:21,381 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/__init__.py:set_scanner_opt()@41[TraceThread(<function set_scanner_opt at 0x7f03cbadcae8>)]
INFO   2018-03-07 20:02:21,390 pyinsane2  [resolution] set to [150]
INFO   2018-03-07 20:02:21,390 ironscanner.main Configuring scanner: mode = Color
DEBUG  2018-03-07 20:02:21,400 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/__init__.py:set_scanner_opt()@41[TraceThread(<function set_scanner_opt at 0x7f03cbadcae8>)]
INFO   2018-03-07 20:02:21,413 pyinsane2  [mode] set to [Color]
INFO   2018-03-07 20:02:21,416 ironscanner.main Maximizing scan area ...
DEBUG  2018-03-07 20:02:21,419 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/__init__.py:maximize_scan_area()@142[TraceThread(<function maximize_scan_area at 0x7f03cbadcbf8>)]
INFO   2018-03-07 20:02:21,423 ironscanner.main Starting scan session ...
DEBUG  2018-03-07 20:02:21,430 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:scan()@267[TraceThread(<bound method Scanner.scan of <pyinsane2.sane.abstract_proc.Scanner object at 0x7f03b021d240>>)]
INFO   2018-03-07 20:02:21,435 ironscanner.main Expected image size: (1276, 1754)
INFO   2018-03-07 20:02:21,435 ironscanner.main Scanning page 0
DEBUG  2018-03-07 20:02:21,438 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:29,572 ironscanner.main Available lines: (0, 1)
DEBUG  2018-03-07 20:02:29,805 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:29,807 ironscanner.main Available lines: (0, 29)
DEBUG  2018-03-07 20:02:29,832 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:29,875 ironscanner.main Available lines: (0, 31)
DEBUG  2018-03-07 20:02:29,885 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:29,891 ironscanner.main Available lines: (0, 48)
DEBUG  2018-03-07 20:02:29,897 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:29,898 ironscanner.main Available lines: (0, 65)
DEBUG  2018-03-07 20:02:29,905 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:29,906 ironscanner.main Available lines: (0, 76)
DEBUG  2018-03-07 20:02:29,932 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:29,948 ironscanner.main Available lines: (0, 78)
DEBUG  2018-03-07 20:02:29,968 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:29,970 ironscanner.main Available lines: (0, 95)
DEBUG  2018-03-07 20:02:30,013 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,022 ironscanner.main Available lines: (0, 123)
DEBUG  2018-03-07 20:02:30,045 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,046 ironscanner.main Available lines: (0, 140)
DEBUG  2018-03-07 20:02:30,068 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,085 ironscanner.main Available lines: (0, 157)
DEBUG  2018-03-07 20:02:30,162 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,165 ironscanner.main Available lines: (0, 174)
DEBUG  2018-03-07 20:02:30,193 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,196 ironscanner.main Available lines: (0, 187)
DEBUG  2018-03-07 20:02:30,244 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,251 ironscanner.main Available lines: (0, 204)
DEBUG  2018-03-07 20:02:30,272 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,305 ironscanner.main Available lines: (0, 221)
DEBUG  2018-03-07 20:02:30,333 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,369 ironscanner.main Available lines: (0, 222)
DEBUG  2018-03-07 20:02:30,417 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,424 ironscanner.main Available lines: (0, 239)
DEBUG  2018-03-07 20:02:30,489 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,491 ironscanner.main Available lines: (0, 256)
DEBUG  2018-03-07 20:02:30,547 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,548 ironscanner.main Available lines: (0, 285)
DEBUG  2018-03-07 20:02:30,573 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,576 ironscanner.main Available lines: (0, 302)
DEBUG  2018-03-07 20:02:30,641 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,642 ironscanner.main Available lines: (0, 315)
DEBUG  2018-03-07 20:02:30,699 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,702 ironscanner.main Available lines: (0, 332)
DEBUG  2018-03-07 20:02:30,721 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,747 ironscanner.main Available lines: (0, 349)
DEBUG  2018-03-07 20:02:30,777 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,799 ironscanner.main Available lines: (0, 366)
DEBUG  2018-03-07 20:02:30,853 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,858 ironscanner.main Available lines: (0, 379)
DEBUG  2018-03-07 20:02:30,915 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,917 ironscanner.main Available lines: (0, 396)
DEBUG  2018-03-07 20:02:30,973 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:30,974 ironscanner.main Available lines: (0, 413)
DEBUG  2018-03-07 20:02:31,029 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,031 ironscanner.main Available lines: (0, 430)
DEBUG  2018-03-07 20:02:31,115 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,116 ironscanner.main Available lines: (0, 443)
DEBUG  2018-03-07 20:02:31,184 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,185 ironscanner.main Available lines: (0, 460)
DEBUG  2018-03-07 20:02:31,253 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,254 ironscanner.main Available lines: (0, 477)
DEBUG  2018-03-07 20:02:31,333 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,335 ironscanner.main Available lines: (0, 494)
DEBUG  2018-03-07 20:02:31,436 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,441 ironscanner.main Available lines: (0, 524)
DEBUG  2018-03-07 20:02:31,502 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,510 ironscanner.main Available lines: (0, 558)
DEBUG  2018-03-07 20:02:31,588 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,589 ironscanner.main Available lines: (0, 571)
DEBUG  2018-03-07 20:02:31,661 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,664 ironscanner.main Available lines: (0, 588)
DEBUG  2018-03-07 20:02:31,731 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,744 ironscanner.main Available lines: (0, 590)
DEBUG  2018-03-07 20:02:31,829 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,831 ironscanner.main Available lines: (0, 607)
DEBUG  2018-03-07 20:02:31,911 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,914 ironscanner.main Available lines: (0, 669)
DEBUG  2018-03-07 20:02:31,995 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:31,997 ironscanner.main Available lines: (0, 686)
DEBUG  2018-03-07 20:02:32,100 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:32,103 ironscanner.main Available lines: (0, 716)
DEBUG  2018-03-07 20:02:32,196 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:32,197 ironscanner.main Available lines: (0, 738)
DEBUG  2018-03-07 20:02:32,299 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:32,303 ironscanner.main Available lines: (0, 763)
DEBUG  2018-03-07 20:02:32,413 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:32,422 ironscanner.main Available lines: (0, 797)
DEBUG  2018-03-07 20:02:32,526 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:32,529 ironscanner.main Available lines: (0, 814)
DEBUG  2018-03-07 20:02:32,634 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:32,646 ironscanner.main Available lines: (0, 861)
DEBUG  2018-03-07 20:02:32,754 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:32,756 ironscanner.main Available lines: (0, 891)
DEBUG  2018-03-07 20:02:32,873 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:32,876 ironscanner.main Available lines: (0, 925)
DEBUG  2018-03-07 20:02:32,992 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:32,994 ironscanner.main Available lines: (0, 972)
DEBUG  2018-03-07 20:02:33,112 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:33,113 ironscanner.main Available lines: (0, 1006)
DEBUG  2018-03-07 20:02:33,213 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:33,215 ironscanner.main Available lines: (0, 1036)
DEBUG  2018-03-07 20:02:33,308 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:33,310 ironscanner.main Available lines: (0, 1070)
DEBUG  2018-03-07 20:02:33,456 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:33,460 ironscanner.main Available lines: (0, 1100)
DEBUG  2018-03-07 20:02:33,613 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:33,615 ironscanner.main Available lines: (0, 1134)
DEBUG  2018-03-07 20:02:33,741 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:33,744 ironscanner.main Available lines: (0, 1181)
DEBUG  2018-03-07 20:02:33,872 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:33,875 ironscanner.main Available lines: (0, 1211)
DEBUG  2018-03-07 20:02:34,009 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:34,012 ironscanner.main Available lines: (0, 1262)
DEBUG  2018-03-07 20:02:34,144 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:34,145 ironscanner.main Available lines: (0, 1279)
DEBUG  2018-03-07 20:02:34,274 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:34,275 ironscanner.main Available lines: (0, 1296)
DEBUG  2018-03-07 20:02:34,412 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:34,413 ironscanner.main Available lines: (0, 1326)
DEBUG  2018-03-07 20:02:34,555 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:34,558 ironscanner.main Available lines: (0, 1403)
DEBUG  2018-03-07 20:02:34,672 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:34,674 ironscanner.main Available lines: (0, 1424)
DEBUG  2018-03-07 20:02:34,875 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:34,880 ironscanner.main Available lines: (0, 1454)
DEBUG  2018-03-07 20:02:35,044 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:35,045 ironscanner.main Available lines: (0, 1471)
DEBUG  2018-03-07 20:02:35,230 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:35,231 ironscanner.main Available lines: (0, 1488)
DEBUG  2018-03-07 20:02:35,406 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:35,410 ironscanner.main Available lines: (0, 1548)
DEBUG  2018-03-07 20:02:35,550 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:35,581 ironscanner.main Available lines: (0, 1654)
DEBUG  2018-03-07 20:02:35,731 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:35,732 ironscanner.main Available lines: (0, 1681)
DEBUG  2018-03-07 20:02:35,925 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:35,926 ironscanner.main Available lines: (0, 1698)
DEBUG  2018-03-07 20:02:36,089 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:36,093 ironscanner.main Available lines: (0, 1726)
DEBUG  2018-03-07 20:02:36,237 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:36,238 ironscanner.main Available lines: (0, 1753)
DEBUG  2018-03-07 20:02:36,391 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:36,393 ironscanner.main Available lines: (0, 1754)
DEBUG  2018-03-07 20:02:36,565 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:36,592 ironscanner.main End of page. Available lines: (0, 1754)
INFO   2018-03-07 20:02:36,810 ironscanner.main Scanning page 1
DEBUG  2018-03-07 20:02:36,813 ironscanner.trace /home/ruffy/ironscanner/venv/lib/python3.6/site-packages/pyinsane2-2.0.12-py3.6.egg/pyinsane2/sane/abstract_proc.py:read()@182[TraceThread(<bound method Scan.read of <pyinsane2.sane.abstract_proc.Scan object at 0x7f03b02199b0>>)]
INFO   2018-03-07 20:02:36,817 ironscanner.main Got StopIteration
INFO   2018-03-07 20:02:36,940 ironscanner.main Scanned 1 images
INFO   2018-03-07 20:02:36,944 ironscanner.main ### SCAN TEST SUCCESSFUL ###
INFO   2018-03-07 20:03:07,413 ironscanner.main Building report ...
INFO   2018-03-07 20:03:07,413 ironscanner.main * User info
INFO   2018-03-07 20:03:07,414 ironscanner.main * Scanner settings
INFO   2018-03-07 20:03:07,416 ironscanner.main No image attached to report
INFO   2018-03-07 20:03:07,416 ironscanner.main * System configuration
INFO   2018-03-07 20:03:07,462 ironscanner.main * Scan test result
INFO   2018-03-07 20:03:08,806 ironscanner.main * User comment
INFO   2018-03-07 20:03:08,807 ironscanner.main * Traces
INFO   2018-03-07 20:03:08,867 ironscanner.main Report ready: 5477 Kbytes to send
INFO   2018-03-07 20:03:08,867 ironscanner.main Connecting to openpaper.work
INFO   2018-03-07 20:03:08,868 ironscanner.main Posting report...
INFO   2018-03-07 20:03:08,868 ironscanner.main Please wait, this may take a while...
ERROR  2018-03-07 20:04:08,627 ironscanner.main Error from server: 500 - Internal Server Error

INFO   2018-03-07 20:06:45,307 ironscanner.main Building report ...
INFO   2018-03-07 20:06:45,307 ironscanner.main * User info
INFO   2018-03-07 20:06:45,308 ironscanner.main * Scanner settings
INFO   2018-03-07 20:06:45,308 ironscanner.main No image attached to report
INFO   2018-03-07 20:06:45,309 ironscanner.main * System configuration
INFO   2018-03-07 20:06:45,352 ironscanner.main * Scan test result
INFO   2018-03-07 20:06:46,716 ironscanner.main * User comment
INFO   2018-03-07 20:06:46,717 ironscanner.main * Traces