Arch Linux

fortuna

Member

Registered: 2021-02-09

Posts: 84

[SOLVED] simple-scan stopped working

So at some moment in the last three weeks simple-scan stopped working.

After hitting the scan button the scanner starts making the usual noises and simple-scan opens an area for the scan to appear. This area increases in size as the scanning progresses but.... stays completely empty.

When it finishes the app continues to consume 100% CPU until you manually close simple-scan.

Here is the debug output generated by simple-scan -d:

[+0,00s] DEBUG: simple-scan.vala:2016: Starting simple-scan 46.0, PID=2038
[+0,11s] DEBUG: Using cross-namespace EXTERNAL authentication (this will deadlock if server is GDBus < 2.73.3)
[+0,13s] DEBUG: _g_io_module_get_default: Found default implementation gvfs (GDaemonVfs) for ‘gio-vfs’
[+0,19s] DEBUG: Portal doesn't provide settings: GDBus.Error:org.freedesktop.DBus.Error.UnknownMethod: No such interface “org.freedesktop.portal.Settings” on object at path /org/freedesktop/portal/desktop
[+0,19s] DEBUG: Portal doesn't provide settings: GDBus.Error:org.freedesktop.DBus.Error.UnknownMethod: No such interface “org.freedesktop.portal.Settings” on object at path /org/freedesktop/portal/desktop
[+0,19s] DEBUG: Portal doesn't provide settings: GDBus.Error:org.freedesktop.DBus.Error.UnknownMethod: No such interface “org.freedesktop.portal.Settings” on object at path /org/freedesktop/portal/desktop
[+0,20s] DEBUG: Portal doesn't provide settings: GDBus.Error:org.freedesktop.DBus.Error.UnknownMethod: No such interface “org.freedesktop.portal.Settings” on object at path /org/freedesktop/portal/desktop
[+0,20s] DEBUG: _g_io_module_get_default: Found default implementation dconf (DConfSettingsBackend) for ‘gsettings-backend’
[+0,41s] DEBUG: app-window.vala:1436: Loading state from /home/sil/.config/simple-scan/state
[+0,41s] DEBUG: app-window.vala:1415: Restoring window to 671x470 pixels
[+0,41s] DEBUG: app-window.vala:1424: Restoring window to fullscreen
[+0,66s] DEBUG: scanner.vala:1619: sane_init () -> SANE_STATUS_GOOD
[+0,66s] DEBUG: scanner.vala:1625: SANE version 1.3.1
[+0,66s] DEBUG: scanner.vala:1686: Requesting redetection of scan devices
[+0,67s] DEBUG: scanner.vala:863: Processing request
[+8,24s] DEBUG: scanner.vala:348: sane_get_devices () -> SANE_STATUS_GOOD
[+8,24s] DEBUG: scanner.vala:374: Device: name="pixma:04A91913_4BD907" vendor="CANON" model="CanoScan LiDE 300" type="multi-function peripheral"
[+8,24s] DEBUG: scanner.vala:374: Device: name="escl:http://localhost:60000" vendor="Canon" model="LiDE 300 (USB)" type="platen scanner"
[+8,24s] DEBUG: scanner.vala:374: Device: name="airscan:e0:Canon LiDE 300 (USB)" vendor="eSCL" model="Canon LiDE 300 (USB)" type="ip=127.0.0.1, ::1"
[+27,86s] DEBUG: simple-scan.vala:1822: Requesting scan at 300 dpi from device 'pixma:04A91913_4BD907'
[+27,86s] DEBUG: scanner.vala:1777: Scanner.scan ("pixma:04A91913_4BD907", dpi=300, scan_mode=ScanMode.COLOR, depth=8, type=single, side=front, paper_width=0, paper_height=0, brightness=0, contrast=0, delay=0ms)
[+27,86s] DEBUG: scanner.vala:863: Processing request
[+28,38s] DEBUG: scanner.vala:924: sane_open ("pixma:04A91913_4BD907") -> SANE_STATUS_GOOD
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (0)
[+28,38s] DEBUG: scanner.vala:795: Option 0: title='Number of options' type=int size=4 cap=soft-detect
[+28,38s] DEBUG: scanner.vala:798:   Description: Read-only option that specifies how many options a specific device supports.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (1)
[+28,38s] DEBUG: scanner.vala:795: Option 1: name='(null)' title='Scan mode' type=group size=0
[+28,38s] DEBUG: scanner.vala:798:   Description: Scan mode
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (2)
[+28,38s] DEBUG: scanner.vala:795: Option 2: name='resolution' title='Scan resolution' type=int size=4 unit=dpi values=[75, 150, 300, 600, 1200, 2400] cap=soft-select,soft-detect,automatic
[+28,38s] DEBUG: scanner.vala:798:   Description: Sets the resolution of the scanned image.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (3)
[+28,38s] DEBUG: scanner.vala:795: Option 3: name='mode' title='Scan mode' type=string size=31 values=["Color", "Gray", "Lineart"] cap=soft-select,soft-detect,automatic
[+28,38s] DEBUG: scanner.vala:798:   Description: Selects the scan mode (e.g., lineart, monochrome, or color).
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (4)
[+28,38s] DEBUG: scanner.vala:795: Option 4: name='source' title='Scan source' type=string size=31 values=["Flatbed"] cap=soft-select,soft-detect
[+28,38s] DEBUG: scanner.vala:798:   Description: Selects the scan source (such as a document-feeder). Set source before mode and resolution. Resets mode and resolution to auto values.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (5)
[+28,38s] DEBUG: scanner.vala:795: Option 5: name='button-controlled' title='Button-controlled scan' type=bool size=4 cap=soft-select,soft-detect
[+28,38s] DEBUG: scanner.vala:798:   Description: 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.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (6)
[+28,38s] DEBUG: scanner.vala:795: Option 6: name='(null)' title='Gamma' type=group size=0
[+28,38s] DEBUG: scanner.vala:798:   Description: Gamma
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (7)
[+28,38s] DEBUG: scanner.vala:795: Option 7: name='custom-gamma' title='Use custom gamma table' type=bool size=4 cap=soft-select,soft-detect,automatic
[+28,38s] DEBUG: scanner.vala:798:   Description: Determines whether a builtin or a custom gamma-table should be used.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (8)
[+28,38s] DEBUG: scanner.vala:795: Option 8: name='gamma-table' title='Image intensity' type=int size=4096 min=0, max=65535, quant=0 cap=soft-select,soft-detect,automatic,inactive
[+28,38s] DEBUG: scanner.vala:798:   Description: Gamma-correction table with 1024 entries. In color mode this option equally affects the red, green, and blue channels simultaneously (i.e., it is an intensity gamma table).
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (9)
[+28,38s] DEBUG: scanner.vala:795: Option 9: name='gamma' title='Gamma function exponent' type=fixed size=4 min=0,299988, max=5,000000, quant=0 cap=soft-select,soft-detect,automatic
[+28,38s] DEBUG: scanner.vala:798:   Description: Changes intensity of midtones
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (10)
[+28,38s] DEBUG: scanner.vala:795: Option 10: name='(null)' title='Geometry' type=group size=0
[+28,38s] DEBUG: scanner.vala:798:   Description: Geometry
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (11)
[+28,38s] DEBUG: scanner.vala:795: Option 11: name='tl-x' title='Top-left x' type=fixed size=4 unit=mm min=0,000000, max=216,069321, quant=0 cap=soft-select,soft-detect,automatic
[+28,38s] DEBUG: scanner.vala:798:   Description: Top-left x position of scan area.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (12)
[+28,38s] DEBUG: scanner.vala:795: Option 12: name='tl-y' title='Top-left y' type=fixed size=4 unit=mm min=0,000000, max=297,010666, quant=0 cap=soft-select,soft-detect,automatic
[+28,38s] DEBUG: scanner.vala:798:   Description: Top-left y position of scan area.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (13)
[+28,38s] DEBUG: scanner.vala:795: Option 13: name='br-x' title='Bottom-right x' type=fixed size=4 unit=mm min=0,000000, max=216,069321, quant=0 cap=soft-select,soft-detect,automatic
[+28,38s] DEBUG: scanner.vala:798:   Description: Bottom-right x position of scan area.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (14)
[+28,38s] DEBUG: scanner.vala:795: Option 14: name='br-y' title='Bottom-right y' type=fixed size=4 unit=mm min=0,000000, max=297,010666, quant=0 cap=soft-select,soft-detect,automatic
[+28,38s] DEBUG: scanner.vala:798:   Description: Bottom-right y position of scan area.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (15)
[+28,38s] DEBUG: scanner.vala:795: Option 15: name='(null)' title='Buttons' type=group size=0
[+28,38s] DEBUG: scanner.vala:798:   Description: Buttons
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (16)
[+28,38s] DEBUG: scanner.vala:795: Option 16: name='button-update' title='Update button state' type=button size=0 cap=soft-select,soft-detect,advanced
[+28,38s] DEBUG: scanner.vala:798:   Description: Update button state
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (17)
[+28,38s] DEBUG: scanner.vala:795: Option 17: name='button-1' title='Button 1' type=int size=4 cap=soft-detect,advanced
[+28,38s] DEBUG: scanner.vala:798:   Description: Button 1
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (18)
[+28,38s] DEBUG: scanner.vala:795: Option 18: name='button-2' title='Button 2' type=int size=4 cap=soft-detect,advanced
[+28,38s] DEBUG: scanner.vala:798:   Description: Button 2
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (19)
[+28,38s] DEBUG: scanner.vala:795: Option 19: name='original' title='Type of original to scan' type=int size=4 cap=soft-detect,advanced
[+28,38s] DEBUG: scanner.vala:798:   Description: Type of original to scan
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (20)
[+28,38s] DEBUG: scanner.vala:795: Option 20: name='target' title='Target operation type' type=int size=4 cap=soft-detect,advanced
[+28,38s] DEBUG: scanner.vala:798:   Description: Target operation type
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (21)
[+28,38s] DEBUG: scanner.vala:795: Option 21: name='scan-resolution' title='Scan resolution' type=int size=4 cap=soft-detect,advanced
[+28,38s] DEBUG: scanner.vala:798:   Description: Scan resolution
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (22)
[+28,38s] DEBUG: scanner.vala:795: Option 22: name='document-type' title='Document type' type=int size=4 cap=soft-detect,advanced
[+28,38s] DEBUG: scanner.vala:798:   Description: Document type
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (23)
[+28,38s] DEBUG: scanner.vala:795: Option 23: name='adf-status' title='ADF status' type=int size=4 cap=soft-detect,advanced
[+28,38s] DEBUG: scanner.vala:798:   Description: ADF status
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (24)
[+28,38s] DEBUG: scanner.vala:795: Option 24: name='adf-orientation' title='ADF orientation' type=int size=4 cap=soft-detect,advanced
[+28,38s] DEBUG: scanner.vala:798:   Description: ADF orientation
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (25)
[+28,38s] DEBUG: scanner.vala:795: Option 25: name='(null)' title='Extras' type=group size=0
[+28,38s] DEBUG: scanner.vala:798:   Description: Extras
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (26)
[+28,38s] DEBUG: scanner.vala:795: Option 26: name='threshold' title='Threshold' type=int size=4 unit=percent min=0, max=100, quant=1 cap=soft-select,soft-detect,automatic,inactive
[+28,38s] DEBUG: scanner.vala:798:   Description: Select minimum-brightness to get a white point
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (27)
[+28,38s] DEBUG: scanner.vala:795: Option 27: name='threshold-curve' title='Threshold curve' type=int size=4 min=0, max=127, quant=1 cap=soft-select,soft-detect,automatic,inactive
[+28,38s] DEBUG: scanner.vala:798:   Description: Dynamic threshold curve, from light to dark, normally 50-65
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (28)
[+28,38s] DEBUG: scanner.vala:795: Option 28: name='adf-wait' title='ADF Waiting Time' type=int size=4 min=0, max=3600, quant=1 cap=soft-select,soft-detect,automatic,inactive
[+28,38s] DEBUG: scanner.vala:798:   Description: When set, the scanner waits up to the specified time in seconds for a new document inserted into the automatic document feeder.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (29)
[+28,38s] DEBUG: scanner.vala:795: Option 29: name='calibrate' title='Calibration' type=string size=31 values=["Once", "Always", "Never"] cap=soft-select,soft-detect,automatic
[+28,38s] DEBUG: scanner.vala:798:   Description: When to perform scanner calibration. If you choose "Once" it will be performed a single time per driver init for single page scans, and for the first page for each ADF scan.
[+28,38s] DEBUG: scanner.vala:1002: sane_get_option_descriptor (30)
[+28,38s] DEBUG: scanner.vala:602: sane_control_option (4, SANE_ACTION_SET_VALUE, source="Flatbed") -> (SANE_STATUS_GOOD, "Flatbed")
[+28,38s] DEBUG: scanner.vala:602: sane_control_option (3, SANE_ACTION_SET_VALUE, mode="Color") -> (SANE_STATUS_GOOD, "Color")
[+28,38s] DEBUG: scanner.vala:514: sane_control_option (2, SANE_ACTION_SET_VALUE, resolution=300) -> (SANE_STATUS_GOOD, 300)
[+28,38s] DEBUG: scanner.vala:584: sane_control_option (13, SANE_ACTION_SET_VALUE, br-x=option.range.max=216,069321) -> (SANE_STATUS_GOOD)
[+28,38s] DEBUG: scanner.vala:584: sane_control_option (14, SANE_ACTION_SET_VALUE, br-y=option.range.max=297,010666) -> (SANE_STATUS_GOOD)
[+28,38s] DEBUG: scanner.vala:1352: sane_start (page=0, pass=0) -> SANE_STATUS_GOOD
[+28,38s] DEBUG: scanner.vala:1389: sane_get_parameters () -> SANE_STATUS_GOOD
[+28,38s] DEBUG: scanner.vala:1401: Parameters: format=SANE_FRAME_RGB last_frame=SANE_TRUE bytes_per_line=7656 pixels_per_line=2552 lines=3508 depth=8
[+28,43s] DEBUG: simple-scan.vala:1717: Page is 2552 pixels wide, 3508 pixels high, 8 bits per pixel
[+28,48s] DEBUG: simple-scan.vala:1651: Getting color profile for device pixma:04A91913_4BD907
[+28,48s] DEBUG: Using cross-namespace EXTERNAL authentication (this will deadlock if server is GDBus < 2.73.3)
[+29,42s] DEBUG: simple-scan.vala:1671: Unable to find colord device pixma:04A91913_4BD907: property match 'Serial'='sane:pixma:04A91913_4BD907' does not exist
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,92s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7656)
[+32,94s] DEBUG: scanner.vala:1475: sane_read (7657) -> (SANE_STATUS_GOOD, 7657)
[+32,94s] DEBUG: scanner.vala:1475: sane_read (15312) -> (SANE_STATUS_GOOD, 15312)
[+32,94s] DEBUG: scanner.vala:1475: sane_read (15312) -> (SANE_STATUS_GOOD, 15312)
[+32,94s] DEBUG: scanner.vala:1475: sane_read (15312) -> (SANE_STATUS_GOOD, 15312)
[+32,94s] DEBUG: scanner.vala:1475: sane_read (15312) -> (SANE_STATUS_GOOD, 7655)
[+32,94s] DEBUG: scanner.vala:1475: sane_read (15313) -> (SANE_STATUS_GOOD, 15313)
[+32,94s] DEBUG: scanner.vala:1475: sane_read (22968) -> (SANE_STATUS_GOOD, 22967)
[+32,97s] DEBUG: scanner.vala:1475: sane_read (22969) -> (SANE_STATUS_GOOD, 22969)
[+32,97s] DEBUG: scanner.vala:1475: sane_read (30624) -> (SANE_STATUS_GOOD, 30624)
[+32,97s] DEBUG: scanner.vala:1475: sane_read (30624) -> (SANE_STATUS_GOOD, 7655)
[+32,97s] DEBUG: scanner.vala:1475: sane_read (30625) -> (SANE_STATUS_GOOD, 22968)
[+33,00s] DEBUG: scanner.vala:1475: sane_read (30625) -> (SANE_STATUS_GOOD, 30625)
[+33,00s] DEBUG: scanner.vala:1475: sane_read (38280) -> (SANE_STATUS_GOOD, 30623)
[+33,00s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 30624)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,02s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 7656)
[+33,05s] DEBUG: scanner.vala:1475: sane_read (38281) -> (SANE_STATUS_GOOD, 38281)
[+33,05s] DEBUG: scanner.vala:1475: sane_read (45936) -> (SANE_STATUS_GOOD, 22967)
[+33,05s] DEBUG: scanner.vala:1475: sane_read (45937) -> (SANE_STATUS_GOOD, 22968)
[+33,08s] DEBUG: scanner.vala:1475: sane_read (45937) -> (SANE_STATUS_GOOD, 45937)
[+33,08s] DEBUG: scanner.vala:1475: sane_read (53592) -> (SANE_STATUS_GOOD, 15311)
[+33,08s] DEBUG: scanner.vala:1475: sane_read (53593) -> (SANE_STATUS_GOOD, 38280)
[+33,10s] DEBUG: scanner.vala:1475: sane_read (53593) -> (SANE_STATUS_GOOD, 53593)
[+33,10s] DEBUG: scanner.vala:1475: sane_read (61248) -> (SANE_STATUS_GOOD, 7655)
[+33,10s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+33,13s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,13s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,15s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,15s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,21s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,26s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,26s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+33,29s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,29s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,31s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,31s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,31s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,31s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 53592)
[+33,34s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,34s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,37s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,37s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,37s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,37s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,37s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,37s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,37s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,39s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,42s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,42s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 30624)
[+33,44s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,44s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,48s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,48s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,48s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,48s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,48s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,48s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,48s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,50s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,50s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,58s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,58s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,60s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,60s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,66s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,66s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,71s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,71s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,74s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,74s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+33,77s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,77s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,79s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,79s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,82s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,82s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+33,84s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,84s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,84s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,84s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,84s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,87s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,87s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,90s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,90s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+33,92s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,92s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+33,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+33,98s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+33,98s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+33,98s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 30624)
[+34,01s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,01s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,03s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,03s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,05s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,09s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,09s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,10s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,10s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,14s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,16s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,16s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+34,19s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,19s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,22s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,22s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,24s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,24s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,27s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,27s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 30624)
[+34,29s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,29s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,35s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,35s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,40s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,40s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,43s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,43s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,46s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,46s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,48s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,48s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 30624)
[+34,51s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,51s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,51s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,51s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,51s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,51s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,51s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 53592)
[+34,54s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,54s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,56s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,56s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,59s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,62s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,62s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,64s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,67s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,67s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,69s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,72s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 30624)
[+34,74s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,74s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,78s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,78s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,80s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,80s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+34,83s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,83s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,83s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 30624)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,88s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,88s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,88s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,88s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,91s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,91s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,91s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,94s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,94s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+34,96s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,96s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+34,98s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,98s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,98s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,98s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+34,98s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+34,98s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,01s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,01s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+35,04s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,04s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,07s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,07s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,10s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,10s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+35,12s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,12s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,12s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,12s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,12s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,12s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,12s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,12s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,15s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,15s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,18s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,20s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,23s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+35,26s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,26s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,28s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,28s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,30s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,30s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,33s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,36s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 45936)
[+35,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,38s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+35,41s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,41s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,44s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,44s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+35,47s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,47s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,47s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 30624)
[+35,50s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,50s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,52s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,55s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 30624)
[+35,58s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,58s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,60s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,60s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+35,63s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,63s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,65s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,65s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+35,67s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,67s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,68s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+35,70s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,70s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,73s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,73s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+35,76s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,76s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 30624)
[+35,78s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,78s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,81s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,81s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 22968)
[+35,83s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,83s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,83s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,83s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,83s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 15312)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,86s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,90s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,90s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,91s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+35,91s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,95s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+35,97s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+36,00s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 61248)
[+36,00s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 38280)
[+36,02s] DEBUG: scanner.vala:1475: sane_read (61249) -> (SANE_STATUS_GOOD, 7656)
[+36,02s] DEBUG: scanner.vala:863: Processing request
[+36,03s] DEBUG: scanner.vala:825: sane_cancel ()
[+36,03s] DEBUG: scanner.vala:828: sane_close ()
[+54,76s] DEBUG: app-window.vala:1512: Saving state to /home/sil/.config/simple-scan/state
[+54,78s] DEBUG: autosave-manager.vala:209: Deleting autosave records
[+54,78s] DEBUG: scanner.vala:1807: Stopping scan thread
[+54,78s] DEBUG: scanner.vala:863: Processing request
[+54,81s] DEBUG: scanner.vala:1818: sane_exit ()

So the scanner has broken down, right? No, it hasn't because scanimage does produce an image:

scanimage --format=png --output-file test.png --progress

I suspect the problem must be related to an update to one of the dependencies, but which?

Last edited by fortuna (2025-03-20 21:58:12)

fortuna

Member

Registered: 2021-02-09

Posts: 84

Re: [SOLVED] simple-scan stopped working

After checking all recent upgrades this could be the culprit:

upgraded gtk4 (1:4.16.6-1 -> 1:4.16.7-1)

fortuna

Member

Registered: 2021-02-09

Posts: 84

Re: [SOLVED] simple-scan stopped working

This issue is still unresolved but there is a workaround to create a lightweight pdf file from text using scanimage.

As for simple-scan, compiling from the source has the same result.

bulletmark

Member

From: Brisbane, Australia

Registered: 2013-10-22

Posts: 700

Re: [SOLVED] simple-scan stopped working

FYI, I use simple-scan reasonably often and it still works fine for me (on GNOME). My system is up to date, including that gtk4 1:4.16.7.

It used to progressively update the image as it scanned but (since about 6+ months ago?) it now only displays the image when the scan completes.

fortuna

Member

Registered: 2021-02-09

Posts: 84

Re: [SOLVED] simple-scan stopped working

Thanks for your sharing your experience.

I am on LXDE and I just tried to leave simple-scan open for more than a minute after finishing scanning just in case but nothing shows up while frying the CPU.

The mystery continues..

seth

Member

Registered: 2012-09-03

Posts: 65,687

Re: [SOLVED] simple-scan stopped working

wayland or X11?
The system is completely updated and you're not running an old sane version?

GSK_RENDERER dependant?

GSK_RENDERER=gl simple-scan

Also

/home/sil/.config/simple-scan/state

try the behavior w/ a fresh config/user account.

You'd otherwise have to valgrind or at least gdb simple-scan to see where it's hanging out though debugging js for performance sucks big time

---

How to upload text · How to boot w/o GUI · Disable Windows Fast-Start! · Fix your xinitrc

fortuna

Member

Registered: 2021-02-09

Posts: 84

Re: [SOLVED] simple-scan stopped working

wayland or X11?

X11

The system is completely updated

Yes. Except for wine:
multilib/wine 9.22-1 [installed: 7.15-1]

you're not running an old sane version?

No.
extra/sane 1.3.1-1 [installed]

GSK_RENDERER dependant?

GSK_RENDERER=gl simple-scan

Same.

Also

/home/sil/.config/simple-scan/state

sil@laptop:~$ cat /home/sil/.config/simple-scan/state
[window]
width=1270
height=760
is-maximized=true
is-fullscreen=false

[scanner]
scan-type=single

try the behavior w/ a fresh config/user account.

Did that. Same.

You'd otherwise have to valgrind or at least gdb simple-scan to see where it's hanging out though debugging js for performance sucks big time

Ok. To be continued.

fortuna

Member

Registered: 2021-02-09

Posts: 84

Re: [SOLVED] simple-scan stopped working

Good news. Simple-scan is working again. I decided to give it a try after solving a different problem.

That problem was that arch crashed every time the Screen Saver kicked in. Display Power Management Signaling turned out to crash arch even when called manually.

Reverting recent software updates one by one showed that the mesa upgrade (1:24.3.4-1 -> 1:25.0.1-2) was responsible for this behavior.

After studying the alternatives I decided to give mesa-amber a try on this vintage laptop. That solved the DPMS issue.

I hadn't tried simple-scan for a while so it's not 100% sure replacing mesa with mesa-amber fixed simple-scan as well but it is now working again.

Maybe this helps if someone bumps into the same issue.