[simple-scan] Add logs from HP_OfficeJet_Pro_9010 scanner

[Bartosz <bkosiorek src gnome org>]

commit e0f64bbccf5f7688eac961485886df804520b232
Author: Bartosz Kosiorek <gang65 poczta onet pl>
Date:   Sat Jan 4 23:40:03 2020 +0100

    Add logs from HP_OfficeJet_Pro_9010 scanner

 ...ewlett-Packard_HP_OfficeJet_Pro_9010_series.log | 1033 ++++++++++++++++++++
 1 file changed, 1033 insertions(+)
---
diff --git a/data/logs/Hewlett-Packard_HP_OfficeJet_Pro_9010_series.log 
b/data/logs/Hewlett-Packard_HP_OfficeJet_Pro_9010_series.log
new file mode 100644
index 0000000..9132e5c
--- /dev/null
+++ b/data/logs/Hewlett-Packard_HP_OfficeJet_Pro_9010_series.log
@@ -0,0 +1,1033 @@
+[+0,00s] DEBUG: simple-scan.vala:638: Starting simple-scan 3.34.2, PID=9529
+[+0,01s] DEBUG: _g_io_module_get_default: Found default implementation dconf (DConfSettingsBackend) for 
‘gsettings-backend’
+[+0,04s] DEBUG: app-window.vala:1670: Restoring window to 600x400 pixels
+[+0,04s] DEBUG: app-window.vala:1674: Restoring window to maximized
+[+0,04s] DEBUG: autosave-manager.vala:64: Loading autosave information
+[+0,04s] DEBUG: autosave-manager.vala:259: Waiting to autosave...
+[+0,09s] DEBUG: scanner.vala:1485: sane_init () -> SANE_STATUS_GOOD
+[+0,09s] DEBUG: scanner.vala:1491: SANE version 1.0.28
+[+0,09s] DEBUG: scanner.vala:1552: Requesting redetection of scan devices
+[+0,09s] DEBUG: scanner.vala:806: Processing request
+[dll] sane_get_devices: found 2 devices
+[+6,22s] DEBUG: scanner.vala:341: sane_get_devices () -> SANE_STATUS_GOOD
+[+6,22s] DEBUG: scanner.vala:353: Device: name="v4l:/dev/video0" vendor="Noname" 
model="Integrated_Webcam_HD: Integrate" type="virtual device"
+[+6,22s] DEBUG: scanner.vala:353: Device: name="hpaio:/net/HP_OfficeJet_Pro_9010_series?ip=192.168.1.18" 
vendor="Hewlett-Packard" model="HP_OfficeJet_Pro_9010_series" type="all-in-one"
+[+31,26s] DEBUG: simple-scan.vala:455: Requesting scan at 150 dpi from device 
'hpaio:/net/HP_OfficeJet_Pro_9010_series?ip=192.168.1.18'
+[+31,27s] DEBUG: scanner.vala:1600: Scanner.scan ("hpaio:/net/HP_OfficeJet_Pro_9010_series?ip=192.168.1.18", 
dpi=150, scan_mode=ScanMode.GRAY, depth=2, type=ScanType.ADF_BOTH, paper_width=2100, paper_height=2970, 
brightness=0, contrast=0, delay=3000ms)
+[+31,27s] DEBUG: scanner.vala:806: Processing request
+[dll] sane_open: trying to open `hpaio:/net/HP_OfficeJet_Pro_9010_series?ip=192.168.1.18'
+[dll] sane_open: open successful
+[+31,43s] DEBUG: scanner.vala:867: sane_open ("hpaio:/net/HP_OfficeJet_Pro_9010_series?ip=192.168.1.18") -> 
SANE_STATUS_GOOD
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (0)
+[+31,43s] DEBUG: scanner.vala:738: Option 0: name='option-cnt' title='Number of options' type=int size=4 
cap=soft-detect
+[+31,43s] DEBUG: scanner.vala:741:   Description: Read-only option that specifies how many options a 
specific devices supports.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (1)
+[+31,43s] DEBUG: scanner.vala:738: Option 1: name='mode-group' title='Scan mode' type=group size=0
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (2)
+[+31,43s] DEBUG: scanner.vala:738: Option 2: name='mode' title='Scan mode' type=string size=32 
values=["Lineart", "Gray", "Color"] cap=soft-select,soft-detect
+[+31,43s] DEBUG: scanner.vala:741:   Description: Selects the scan mode (e.g., lineart, monochrome, or 
color).
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (3)
+[+31,43s] DEBUG: scanner.vala:738: Option 3: name='resolution' title='Scan resolution' type=int size=4 
unit=dpi values=[75, 100, 150, 200, 300] cap=soft-select,soft-detect
+[+31,43s] DEBUG: scanner.vala:741:   Description: Sets the resolution of the scanned image.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (4)
+[+31,43s] DEBUG: scanner.vala:738: Option 4: name='source' title='Scan source' type=string size=32 
values=["Flatbed", "ADF", "Duplex"] cap=soft-select,soft-detect
+[+31,43s] DEBUG: scanner.vala:741:   Description: Selects the scan source (such as a document-feeder).
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (5)
+[+31,43s] DEBUG: scanner.vala:738: Option 5: name='advanced-group' title='Advanced' type=group size=0 
cap=advanced
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (6)
+[+31,43s] DEBUG: scanner.vala:738: Option 6: name='brightness' title='Brightness' type=int size=4 min=0, 
max=2000, quant=0 cap=soft-select,soft-detect,advanced
+[+31,43s] DEBUG: scanner.vala:741:   Description: Controls the brightness of the acquired image.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (7)
+[+31,43s] DEBUG: scanner.vala:738: Option 7: name='contrast' title='Contrast' type=int size=4 min=0, 
max=2000, quant=0 cap=soft-select,soft-detect,advanced
+[+31,43s] DEBUG: scanner.vala:741:   Description: Controls the contrast of the acquired image.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (8)
+[+31,43s] DEBUG: scanner.vala:738: Option 8: name='compression' title='Compression' type=string size=32 
values=["JPEG"] cap=soft-select,soft-detect,advanced
+[+31,43s] DEBUG: scanner.vala:741:   Description: Selects the scanner compression method for faster scans, 
possibly at the expense of image quality.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (9)
+[+31,43s] DEBUG: scanner.vala:738: Option 9: name='jpeg-quality' title='JPEG compression factor' type=int 
size=4 min=0, max=100, quant=0 cap=soft-select,soft-detect,inactive,advanced
+[+31,43s] DEBUG: scanner.vala:741:   Description: Sets the scanner JPEG compression factor. Larger numbers 
mean better compression, and smaller numbers mean better image quality.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (10)
+[+31,43s] DEBUG: scanner.vala:738: Option 10: name='geometry-group' title='Geometry' type=group size=0 
cap=advanced
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (11)
+[+31,43s] DEBUG: scanner.vala:738: Option 11: name='tl-x' title='Top-left x' type=fixed size=4 unit=mm 
min=0,000000, max=215,900009, quant=0 cap=soft-select,soft-detect
+[+31,43s] DEBUG: scanner.vala:741:   Description: Top-left x position of scan area.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (12)
+[+31,43s] DEBUG: scanner.vala:738: Option 12: name='tl-y' title='Top-left y' type=fixed size=4 unit=mm 
min=0,000000, max=299,212006, quant=0 cap=soft-select,soft-detect
+[+31,43s] DEBUG: scanner.vala:741:   Description: Top-left y position of scan area.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (13)
+[+31,43s] DEBUG: scanner.vala:738: Option 13: name='br-x' title='Bottom-right x' type=fixed size=4 unit=mm 
min=0,000000, max=215,900009, quant=0 cap=soft-select,soft-detect
+[+31,43s] DEBUG: scanner.vala:741:   Description: Bottom-right x position of scan area.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (14)
+[+31,43s] DEBUG: scanner.vala:738: Option 14: name='br-y' title='Bottom-right y' type=fixed size=4 unit=mm 
min=0,000000, max=299,212006, quant=0 cap=soft-select,soft-detect
+[+31,43s] DEBUG: scanner.vala:741:   Description: Bottom-right y position of scan area.
+[+31,43s] DEBUG: scanner.vala:888: sane_get_option_descriptor (15)
+[dll] sane_control_option(handle=0x7f854c147790,option=4,action=1,value=0x7f854c126e60,info=(nil))
+[+31,43s] DEBUG: scanner.vala:549: sane_control_option (4, SANE_ACTION_SET_VALUE, "Duplex") -> 
(SANE_STATUS_GOOD, "Duplex")
+[dll] sane_control_option(handle=0x7f854c147790,option=2,action=1,value=0x7f854c16b650,info=(nil))
+[+31,43s] DEBUG: scanner.vala:549: sane_control_option (2, SANE_ACTION_SET_VALUE, "Gray") -> 
(SANE_STATUS_GOOD, "Gray")
+[+31,43s] WARNING: scanner.vala:1087: Unable to disable compression, please file a bug
+[dll] sane_control_option(handle=0x7f854c147790,option=3,action=1,value=0x7f8559884ad4,info=(nil))
+[+31,43s] DEBUG: scanner.vala:465: sane_control_option (3, SANE_ACTION_SET_VALUE, 150) -> (SANE_STATUS_GOOD, 
150)
+[dll] sane_control_option(handle=0x7f854c147790,option=13,action=1,value=0x7f8559884b24,info=(nil))
+[+31,43s] DEBUG: scanner.vala:505: sane_control_option (13, SANE_ACTION_SET_VALUE, 210,000000) -> 
(SANE_STATUS_GOOD, 210,000000)
+[dll] sane_control_option(handle=0x7f854c147790,option=14,action=1,value=0x7f8559884b24,info=(nil))
+[+31,43s] DEBUG: scanner.vala:505: sane_control_option (14, SANE_ACTION_SET_VALUE, 297,000000) -> 
(SANE_STATUS_GOOD, 297,000000)
+[dll] sane_start(handle=0x7f854c147790)
+[+40,17s] DEBUG: scanner.vala:1241: sane_start (page=0, pass=0) -> SANE_STATUS_GOOD
+[dll] sane_get_parameters(handle=0x7f854c147790,params=0x7f8559884c40)
+[+40,17s] DEBUG: scanner.vala:1258: sane_get_parameters () -> SANE_STATUS_GOOD
+[+40,17s] DEBUG: scanner.vala:1270: Parameters: format=SANE_FRAME_GRAY last_frame=SANE_TRUE 
bytes_per_line=1240 pixels_per_line=1240 lines=1753 depth=8
+[+40,17s] DEBUG: scanner.vala:1345: sane_read (1241) -> (SANE_STATUS_GOOD, 1241)
+[+40,17s] DEBUG: simple-scan.vala:350: Page is 1240 pixels wide, 1753 pixels high, 2 bits per pixel
+[+40,17s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+40,17s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+40,17s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+40,17s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+...
+[+66,52s] DEBUG: scanner.vala:1345: sane_read (8680) -> (SANE_STATUS_GOOD, 8680)
+[+66,52s] DEBUG: scanner.vala:1345: sane_read (8680) -> (SANE_STATUS_GOOD, 8680)
+[+66,52s] DEBUG: scanner.vala:1345: sane_read (8680) -> (SANE_STATUS_GOOD, 8680)
+[+66,52s] DEBUG: scanner.vala:1345: sane_read (8680) -> (SANE_STATUS_GOOD, 8680)
+[+66,52s] DEBUG: scanner.vala:1345: sane_read (8680) -> (SANE_STATUS_GOOD, 4959)
+[+66,62s] DEBUG: scanner.vala:1345: sane_read (8681) -> (SANE_STATUS_EOF, 0)
+[+66,62s] WARNING: scanner.vala:1351: Scan completed with 1752 lines, expected 1753 lines
+[dll] sane_start(handle=0x7f854c147790)
+[+66,62s] DEBUG: autosave-manager.vala:281: Autosaving book information
+[+66,62s] DEBUG: autosave-manager.vala:298: Autosaving page page-0
+[+66,62s] DEBUG: autosave-manager.vala:298: Autosaving page page-1
+[+66,62s] CRITICAL: page_finish: assertion 'self != NULL' failed
+[+67,40s] DEBUG: scanner.vala:1241: sane_start (page=2, pass=0) -> SANE_STATUS_GOOD
+[dll] sane_get_parameters(handle=0x7f854c147790,params=0x7f8559884c40)
+[+67,40s] DEBUG: scanner.vala:1258: sane_get_parameters () -> SANE_STATUS_GOOD
+[+67,40s] DEBUG: scanner.vala:1270: Parameters: format=SANE_FRAME_GRAY last_frame=SANE_TRUE 
bytes_per_line=1240 pixels_per_line=1240 lines=1753 depth=8
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (1241) -> (SANE_STATUS_GOOD, 1241)
+[+67,40s] DEBUG: simple-scan.vala:350: Page is 1240 pixels wide, 1753 pixels high, 2 bits per pixel
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: simple-scan.vala:284: Getting color profile for device 
hpaio:/net/HP_OfficeJet_Pro_9010_series?ip=192.168.1.18
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+67,40s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+...
+[+79,44s] DEBUG: scanner.vala:1345: sane_read (3720) -> (SANE_STATUS_GOOD, 3720)
+[+79,44s] DEBUG: scanner.vala:1345: sane_read (3720) -> (SANE_STATUS_GOOD, 3720)
+[+79,44s] DEBUG: scanner.vala:1345: sane_read (3720) -> (SANE_STATUS_GOOD, 3720)
+[+79,44s] DEBUG: scanner.vala:1345: sane_read (3720) -> (SANE_STATUS_GOOD, 3720)
+[+79,44s] DEBUG: scanner.vala:1345: sane_read (3720) -> (SANE_STATUS_GOOD, 3720)
+[+79,44s] DEBUG: scanner.vala:1345: sane_read (3720) -> (SANE_STATUS_GOOD, 3720)
+[+79,44s] DEBUG: scanner.vala:1345: sane_read (3720) -> (SANE_STATUS_GOOD, 3720)
+[+79,44s] DEBUG: scanner.vala:1345: sane_read (3720) -> (SANE_STATUS_GOOD, 3720)
+[+79,44s] DEBUG: page.vala:267: Extending image from 1753 lines to 2373 lines
+[+79,44s] DEBUG: scanner.vala:1345: sane_read (3720) -> (SANE_STATUS_GOOD, 2479)
+[+79,55s] DEBUG: scanner.vala:1345: sane_read (3721) -> (SANE_STATUS_EOF, 0)
+[+79,55s] WARNING: scanner.vala:1351: Scan completed with 1760 lines, expected 1753 lines
+[dll] sane_start(handle=0x7f854c147790)
+[+79,55s] DEBUG: autosave-manager.vala:281: Autosaving book information
+[+79,55s] DEBUG: autosave-manager.vala:298: Autosaving page page-0
+[+79,55s] DEBUG: autosave-manager.vala:298: Autosaving page page-1
+[+79,55s] DEBUG: autosave-manager.vala:298: Autosaving page page-2
+[+79,55s] CRITICAL: page_finish: assertion 'self != NULL' failed
+[+80,70s] DEBUG: scanner.vala:1241: sane_start (page=3, pass=0) -> SANE_STATUS_GOOD
+[dll] sane_get_parameters(handle=0x7f854c147790,params=0x7f8559884c40)
+[+80,70s] DEBUG: scanner.vala:1258: sane_get_parameters () -> SANE_STATUS_GOOD
+[+80,70s] DEBUG: scanner.vala:1270: Parameters: format=SANE_FRAME_GRAY last_frame=SANE_TRUE 
bytes_per_line=1240 pixels_per_line=1240 lines=1753 depth=8
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (1241) -> (SANE_STATUS_GOOD, 1241)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: simple-scan.vala:350: Page is 1240 pixels wide, 1753 pixels high, 2 bits per pixel
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: simple-scan.vala:284: Getting color profile for device 
hpaio:/net/HP_OfficeJet_Pro_9010_series?ip=192.168.1.18
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,70s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,71s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,72s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,73s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+80,74s] DEBUG: simple-scan.vala:304: Unable to find colord device 
hpaio:/net/HP_OfficeJet_Pro_9010_series?ip=192.168.1.18: property match 
'Serial'='sane:hpaio:/net/HP_OfficeJet_Pro_9010_series?ip=192.168.1.18' does not exist
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,12s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,13s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 2480)
+[+92,14s] DEBUG: scanner.vala:1345: sane_read (2480) -> (SANE_STATUS_GOOD, 1239)
+[+92,24s] DEBUG: scanner.vala:1345: sane_read (2481) -> (SANE_STATUS_EOF, 0)
+[+92,24s] WARNING: scanner.vala:1351: Scan completed with 1752 lines, expected 1753 lines
+[dll] sane_start(handle=0x7f854c147790)
+[+92,24s] DEBUG: autosave-manager.vala:281: Autosaving book information
+[+92,24s] DEBUG: autosave-manager.vala:298: Autosaving page page-0
+[+92,24s] DEBUG: autosave-manager.vala:298: Autosaving page page-1
+[+92,24s] DEBUG: autosave-manager.vala:298: Autosaving page page-2
+[+92,24s] DEBUG: autosave-manager.vala:298: Autosaving page page-3
+[+92,25s] CRITICAL: page_finish: assertion 'self != NULL' failed
+[+92,46s] DEBUG: scanner.vala:1241: sane_start (page=4, pass=0) -> SANE_STATUS_NO_DOCS
+[dll] sane_cancel(handle=0x7f854c147790)
+[+92,46s] DEBUG: scanner.vala:1214: sane_cancel ()