[+7.75s] DEBUG: scanner.vala:341: sane_get_devices () -> SANE_STATUS_GOOD [+7.75s] DEBUG: scanner.vala:353: Device: name="genesys:libusb:001:010" vendor="Canon" model="LiDE 35/40/50" type="flatbed scanner" [+16.68s] DEBUG: simple-scan.vala:1536: Requesting scan at 600 dpi from device 'genesys:libusb:001:010' [+16.68s] DEBUG: scanner.vala:1674: Scanner.scan ("genesys:libusb:001:010", dpi=600, scan_mode=ScanMode.GRAY, depth=2, type=single, paper_width=2159, paper_height=2794, brightness=-100, contrast=100, delay=3000ms) [+16.68s] DEBUG: scanner.vala:828: Processing request [+17.55s] DEBUG: scanner.vala:889: sane_open ("genesys:libusb:001:010") -> SANE_STATUS_GOOD [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (0) [+17.55s] DEBUG: scanner.vala:760: Option 0: title='Number of options' type=int size=4 cap=soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Read-only option that specifies how many options a specific device supports. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (1) [+17.55s] DEBUG: scanner.vala:760: Option 1: name='scanmode-group' title='Scan Mode' type=group size=0 [+17.55s] DEBUG: scanner.vala:763: Description: [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (2) [+17.55s] DEBUG: scanner.vala:760: Option 2: name='mode' title='Scan mode' type=string size=8 values=["Color", "Gray", "Lineart"] cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Selects the scan mode (e.g., lineart, monochrome, or color). [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (3) [+17.55s] DEBUG: scanner.vala:760: Option 3: name='source' title='Scan source' type=string size=7 values=["Flatbed"] cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Selects the scan source (such as a document-feeder). [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (4) [+17.55s] DEBUG: scanner.vala:760: Option 4: name='preview' title='Preview' type=bool size=4 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Request a preview-quality scan. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (5) [+17.55s] DEBUG: scanner.vala:760: Option 5: name='depth' title='Bit depth' type=int size=4 values=[16, 8] cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Number of bits per sample, typical values are 1 for "line-art" and 8 for multibit scans. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (6) [+17.55s] DEBUG: scanner.vala:760: Option 6: name='resolution' title='Scan resolution' type=int size=4 unit=dpi values=[2400, 1200, 600, 300, 200, 150, 75] cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Sets the resolution of the scanned image. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (7) [+17.55s] DEBUG: scanner.vala:760: Option 7: name='geometry' title='Geometry' type=group size=0 cap=advanced [+17.55s] DEBUG: scanner.vala:763: Description: [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (8) [+17.55s] DEBUG: scanner.vala:760: Option 8: name='tl-x' title='Top-left x' type=fixed size=4 unit=mm min=0.000000, max=218.000000, quant=0 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Top-left x position of scan area. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (9) [+17.55s] DEBUG: scanner.vala:760: Option 9: name='tl-y' title='Top-left y' type=fixed size=4 unit=mm min=0.000000, max=299.000000, quant=0 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Top-left y position of scan area. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (10) [+17.55s] DEBUG: scanner.vala:760: Option 10: name='br-x' title='Bottom-right x' type=fixed size=4 unit=mm min=0.000000, max=218.000000, quant=0 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Bottom-right x position of scan area. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (11) [+17.55s] DEBUG: scanner.vala:760: Option 11: name='br-y' title='Bottom-right y' type=fixed size=4 unit=mm min=0.000000, max=299.000000, quant=0 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Bottom-right y position of scan area. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (12) [+17.55s] DEBUG: scanner.vala:760: Option 12: name='enhancement' title='Enhancement' type=group size=0 cap=advanced [+17.55s] DEBUG: scanner.vala:763: Description: [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (13) [+17.55s] DEBUG: scanner.vala:760: Option 13: name='custom-gamma' title='Use custom gamma table' type=bool size=4 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Determines whether a builtin or a custom gamma-table should be used. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (14) [+17.55s] DEBUG: scanner.vala:760: Option 14: name='gamma-table' title='Image intensity' type=int size=1024 min=0, max=65535, quant=0 cap=soft-select,soft-detect,inactive,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Gamma-correction table. In color mode this option equally affects the red, green, and blue channels simultaneously (i.e., it is an intensity gamma table). [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (15) [+17.55s] DEBUG: scanner.vala:760: Option 15: name='red-gamma-table' title='Red intensity' type=int size=1024 min=0, max=65535, quant=0 cap=soft-select,soft-detect,inactive,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Gamma-correction table for the red band. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (16) [+17.55s] DEBUG: scanner.vala:760: Option 16: name='green-gamma-table' title='Green intensity' type=int size=1024 min=0, max=65535, quant=0 cap=soft-select,soft-detect,inactive,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Gamma-correction table for the green band. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (17) [+17.55s] DEBUG: scanner.vala:760: Option 17: name='blue-gamma-table' title='Blue intensity' type=int size=1024 min=0, max=65535, quant=0 cap=soft-select,soft-detect,inactive,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Gamma-correction table for the blue band. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (18) [+17.55s] DEBUG: scanner.vala:760: Option 18: name='swdeskew' title='Software deskew' type=bool size=4 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Request backend to rotate skewed pages digitally [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (19) [+17.55s] DEBUG: scanner.vala:760: Option 19: name='swcrop' title='Software crop' type=bool size=4 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Request backend to remove border from pages digitally [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (20) [+17.55s] DEBUG: scanner.vala:760: Option 20: name='swdespeck' title='Software despeck' type=bool size=4 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Request backend to remove lone dots digitally [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (21) [+17.55s] DEBUG: scanner.vala:760: Option 21: name='despeck' title='Software despeckle diameter' type=int size=4 min=1, max=9, quant=1 cap=soft-select,soft-detect,inactive,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Maximum diameter of lone dots to remove from scan [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (22) [+17.55s] DEBUG: scanner.vala:760: Option 22: name='swskip' title='Software blank skip percentage' type=fixed size=4 unit=percent min=0.000000, max=100.000000, quant=65536 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Request driver to discard pages with low numbers of dark pixels [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (23) [+17.55s] DEBUG: scanner.vala:760: Option 23: name='swderotate' title='Software derotate' type=bool size=4 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Request driver to detect and correct 90 degree image rotation [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (24) [+17.55s] DEBUG: scanner.vala:760: Option 24: name='brightness' title='Brightness' type=int size=4 min=-100, max=100, quant=1 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Controls the brightness of the acquired image. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (25) [+17.55s] DEBUG: scanner.vala:760: Option 25: name='contrast' title='Contrast' type=int size=4 min=-100, max=100, quant=1 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Controls the contrast of the acquired image. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (26) [+17.55s] DEBUG: scanner.vala:760: Option 26: name='extras-group' title='Extras' type=group size=0 cap=advanced [+17.55s] DEBUG: scanner.vala:763: Description: [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (27) [+17.55s] DEBUG: scanner.vala:760: Option 27: name='lamp-off-time' title='Lamp off time' type=int size=4 min=0, max=60, quant=0 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: The lamp will be turned off after the given time (in minutes). A value of 0 means, that the lamp won't be turned off. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (28) [+17.55s] DEBUG: scanner.vala:760: Option 28: name='lamp-off-scan' title='Lamp off during scan' type=bool size=4 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: The lamp will be turned off during scan. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (29) [+17.55s] DEBUG: scanner.vala:760: Option 29: name='threshold' title='Threshold' type=fixed size=4 unit=percent min=0.000000, max=100.000000, quant=65536 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Select minimum-brightness to get a white point [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (30) [+17.55s] DEBUG: scanner.vala:760: Option 30: name='threshold-curve' title='Threshold curve' type=int size=4 min=0, max=127, quant=1 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Dynamic threshold curve, from light to dark, normally 50-65 [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (31) [+17.55s] DEBUG: scanner.vala:760: Option 31: name='disable-interpolation' title='Disable interpolation' type=bool size=4 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: When using high resolutions where the horizontal resolution is smaller than the vertical resolution this disables horizontal interpolation. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (32) [+17.55s] DEBUG: scanner.vala:760: Option 32: name='color-filter' title='Color filter' type=string size=6 values=["Red", "Green", "Blue", "None"] cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: When using gray or lineart this option selects the used color. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (33) [+17.55s] DEBUG: scanner.vala:760: Option 33: name='calibration-file' title='Calibration file' type=string size=4096 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Specify the calibration file to use [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (34) [+17.55s] DEBUG: scanner.vala:760: Option 34: name='expiration-time' title='Calibration cache expiration time' type=int size=4 min=-1, max=30000, quant=1 cap=soft-select,soft-detect [+17.55s] DEBUG: scanner.vala:763: Description: Time (in minutes) before a cached calibration expires. A value of 0 means cache is not used. A negative value means cache never expires. [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (35) [+17.55s] DEBUG: scanner.vala:760: Option 35: name='sensors' title='Sensors' type=group size=0 cap=advanced [+17.55s] DEBUG: scanner.vala:763: Description: Scanner sensors and buttons [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (36) [+17.55s] DEBUG: scanner.vala:760: Option 36: name='scan' title='Scan button' type=bool size=4 cap=hard-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Scan button [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (37) [+17.55s] DEBUG: scanner.vala:760: Option 37: name='file' title='File button' type=bool size=4 cap=hard-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: File button [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (38) [+17.55s] DEBUG: scanner.vala:760: Option 38: name='email' title='Email button' type=bool size=4 cap=hard-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Email button [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (39) [+17.55s] DEBUG: scanner.vala:760: Option 39: name='copy' title='Copy button' type=bool size=4 cap=hard-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Copy button [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (40) [+17.55s] DEBUG: scanner.vala:760: Option 40: name='page-loaded' title='Page loaded' type=bool size=4 cap=inactive [+17.55s] DEBUG: scanner.vala:763: Description: Page loaded [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (41) [+17.55s] DEBUG: scanner.vala:760: Option 41: name='ocr' title='OCR button' type=bool size=4 cap=inactive [+17.55s] DEBUG: scanner.vala:763: Description: OCR button [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (42) [+17.55s] DEBUG: scanner.vala:760: Option 42: name='power' title='Power button' type=bool size=4 cap=inactive [+17.55s] DEBUG: scanner.vala:763: Description: Power button [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (43) [+17.55s] DEBUG: scanner.vala:760: Option 43: name='extra' title='Extra button' type=bool size=4 cap=inactive [+17.55s] DEBUG: scanner.vala:763: Description: Extra button [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (44) [+17.55s] DEBUG: scanner.vala:760: Option 44: name='need-calibration' title='Needs calibration' type=bool size=4 cap=inactive [+17.55s] DEBUG: scanner.vala:763: Description: The scanner needs calibration for the current settings [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (45) [+17.55s] DEBUG: scanner.vala:760: Option 45: name='buttons' title='Buttons' type=group size=0 cap=advanced [+17.55s] DEBUG: scanner.vala:763: Description: [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (46) [+17.55s] DEBUG: scanner.vala:760: Option 46: name='calibrate' title='Calibrate' type=button size=4 cap=inactive [+17.55s] DEBUG: scanner.vala:763: Description: Start calibration using special sheet [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (47) [+17.55s] DEBUG: scanner.vala:760: Option 47: name='clear-calibration' title='Clear calibration' type=button size=0 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Clear calibration cache [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (48) [+17.55s] DEBUG: scanner.vala:760: Option 48: name='force-calibration' title='Force calibration' type=button size=0 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Force calibration ignoring all and any calibration caches [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (49) [+17.55s] DEBUG: scanner.vala:760: Option 49: name='ignore-internal-offsets' title='Ignore internal offsets' type=button size=0 cap=soft-select,soft-detect,advanced [+17.55s] DEBUG: scanner.vala:763: Description: Acquires the image including the internal calibration areas of the scanner [+17.55s] DEBUG: scanner.vala:910: sane_get_option_descriptor (50) [+17.55s] DEBUG: scanner.vala:571: sane_control_option (3, SANE_ACTION_SET_VALUE, "Flatbed") -> (SANE_STATUS_GOOD, "Flatbed") [+17.55s] DEBUG: scanner.vala:571: sane_control_option (2, SANE_ACTION_SET_VALUE, "Gray") -> (SANE_STATUS_GOOD, "Gray") [+17.55s] DEBUG: scanner.vala:483: sane_control_option (6, SANE_ACTION_SET_VALUE, 600) -> (SANE_STATUS_GOOD, 600) [+17.55s] DEBUG: scanner.vala:483: sane_control_option (5, SANE_ACTION_SET_VALUE, 2) -> (SANE_STATUS_GOOD, 8) [+17.55s] DEBUG: scanner.vala:523: sane_control_option (10, SANE_ACTION_SET_VALUE, 215.900000) -> (SANE_STATUS_GOOD, 215.899994) [+17.55s] DEBUG: scanner.vala:523: sane_control_option (11, SANE_ACTION_SET_VALUE, 279.400000) -> (SANE_STATUS_GOOD, 279.399994) [+17.55s] DEBUG: scanner.vala:418: scale_int: scaling -100 [min: -100, max: 100] to -100 [min: -100, max: 100] [+17.55s] DEBUG: scanner.vala:483: sane_control_option (24, SANE_ACTION_SET_VALUE, -100) -> (SANE_STATUS_GOOD, -100) [+17.55s] DEBUG: scanner.vala:418: scale_int: scaling 100 [min: -100, max: 100] to 100 [min: -100, max: 100] [+17.55s] DEBUG: scanner.vala:483: sane_control_option (25, SANE_ACTION_SET_VALUE, 100) -> (SANE_STATUS_GOOD, 100) [+18.37s] DEBUG: scanner.vala:1285: sane_start (page=0, pass=0) -> SANE_STATUS_GOOD [+18.37s] DEBUG: scanner.vala:1312: sane_get_parameters () -> SANE_STATUS_GOOD [+18.37s] DEBUG: scanner.vala:1324: Parameters: format=SANE_FRAME_GRAY last_frame=SANE_TRUE bytes_per_line=5099 pixels_per_line=5099 lines=6599 depth=8 [+18.37s] DEBUG: simple-scan.vala:1431: Page is 5099 pixels wide, 6599 pixels high, 2 bits per pixel [+18.37s] DEBUG: simple-scan.vala:1365: Getting color profile for device genesys:libusb:001:010 [+18.38s] DEBUG: simple-scan.vala:1385: Unable to find colord device genesys:libusb:001:010: property match 'Serial'='sane:genesys:libusb:001:010' does not exist [+18.38s] DEBUG: scanner.vala:1399: sane_read (5100) -> (SANE_STATUS_GOOD, 5100) [+18.38s] DEBUG: scanner.vala:1399: sane_read (10198) -> (SANE_STATUS_GOOD, 10198) [+18.39s] DEBUG: scanner.vala:1399: sane_read (10198) -> (SANE_STATUS_GOOD, 10198) [+18.39s] DEBUG: scanner.vala:1399: sane_read (10198) -> (SANE_STATUS_GOOD, 10198) [+18.39s] DEBUG: scanner.vala:1399: sane_read (10198) -> (SANE_STATUS_GOOD, 10198) (...)