INFO 2019-09-21 18:26:41,948 7F7ADC977700 ironscanner.main 2 scanners found INFO 2019-09-21 18:26:41,950 7F7AE3C52740 ironscanner.main sane:hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F -> HP ENVY 4500 series INFO 2019-09-21 18:26:41,951 7F7AE3C52740 ironscanner.main sane:hpaio:/net/envy_4500_series?ip=192.168.1.12&queue=false -> HP envy 4500 series
DEBUG 2019-09-21 18:26:41,971 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/libinsane-api.c:L236(libinsane_api_get_device): enter
INFO 2019-09-21 18:26:41,971 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L378(lis_sane_get_device): Sane: get_device(hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F) ...
INFO 2019-09-21 18:26:42,080 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L397(lis_sane_get_device): Sane: get_device(hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F): OK
DEBUG 2019-09-21 18:26:42,080 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_names.c:L191(item_filter): Source 'hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F': root -> no name normalization
DEBUG 2019-09-21 18:26:42,091 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,092 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,092 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,092 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,092 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:26:42,092 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L190(set_str): Setting option 'mode' to 'Color'
DEBUG 2019-09-21 18:26:42,100 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L860(lis_sane_item_get_options): Option: hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->br-y(14) (Bottom-right y, Bottom-right y position of scan area.) DEBUG 2019-09-21 18:26:42,101 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L303(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options() returned 11 options DEBUG 2019-09-21 18:26:42,101 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,101 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,101 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,101 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,102 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:26:42,102 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(preview): Option not found INFO 2019-09-21 18:26:42,102 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(resolution) ... INFO 2019-09-21 18:26:42,102 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L291(set_int): Setting option 'resolution' (1) to '300'
INFO 2019-09-21 18:26:42,105 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,105 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-x'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,105 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): OK INFO 2019-09-21 18:26:42,105 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-y) ... INFO 2019-09-21 18:26:42,105 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-y' to min
INFO 2019-09-21 18:26:42,106 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,106 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-y'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,106 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-y): OK INFO 2019-09-21 18:26:42,107 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-x) ... INFO 2019-09-21 18:26:42,107 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-x' to max
INFO 2019-09-21 18:26:42,107 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,108 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-x'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,108 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-x): OK INFO 2019-09-21 18:26:42,108 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-y) ... INFO 2019-09-21 18:26:42,108 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-y' to max
INFO 2019-09-21 18:26:42,112 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): compression->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,112 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'compression'='none': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,112 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(compression): OK INFO 2019-09-21 18:26:42,112 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism) ... INFO 2019-09-21 18:26:42,113 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism): Option not found INFO 2019-09-21 18:26:42,113 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format) ... INFO 2019-09-21 18:26:42,113 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format): Option not found INFO 2019-09-21 18:26:42,113 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth) ... INFO 2019-09-21 18:26:42,113 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth): Option not found INFO 2019-09-21 18:26:42,114 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(indicators) ... INFO 2019-09-21 18:26:42,114 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(indicators): Option not found INFO 2019-09-21 18:26:42,114 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes) ... INFO 2019-09-21 18:26:42,114 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes): Option not found
INFO 2019-09-21 18:26:42,119 7F7AE3C52740 ironscanner.main Selected scanner: HP ENVY 4500 series (all-in-one ; sane:hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F)
DEBUG 2019-09-21 18:26:42,120 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/item.c:L155(libinsane_item_get_children): enter
INFO 2019-09-21 18:26:42,128 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,128 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:26:42,129 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,129 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,129 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,129 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,129 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,130 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,130 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,130 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,130 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,130 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,131 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:26:42,131 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,131 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,131 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,131 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,132 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_types.c:L100(item_filter): Item 'flatbed': type = 1 (regex 0) INFO 2019-09-21 18:26:42,132 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L449(item_filter): Setting default values on item 'flatbed' INFO 2019-09-21 18:26:42,132 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(mode) ...
DEBUG 2019-09-21 18:26:42,132 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L365(set_default_values): normalizers_safe_defaults: set_default_value(mode): Must first: Reload option list of item 'flatbed'...
INFO 2019-09-21 18:26:42,132 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,133 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L280(set_source): Setting source to 'Flatbed' INFO 2019-09-21 18:26:42,133 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,133 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value INFO 2019-09-21 18:26:42,133 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,133 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:26:42,133 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,134 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,134 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,134 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,134 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,134 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,135 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,135 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,135 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,135 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,135 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:26:42,135 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,136 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,136 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,136 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,136 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:26:42,136 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L190(set_str): Setting option 'mode' to 'Color'
INFO 2019-09-21 18:26:42,137 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): mode->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,137 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'mode'='Color': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,137 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(mode): OK INFO 2019-09-21 18:26:42,138 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(preview) ... INFO 2019-09-21 18:26:42,138 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(preview): Option not found INFO 2019-09-21 18:26:42,138 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(resolution) ... INFO 2019-09-21 18:26:42,138 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L291(set_int): Setting option 'resolution' (1) to '300'
INFO 2019-09-21 18:26:42,139 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): resolution->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,139 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L328(set_int): 'resolution'='300': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,139 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(resolution): OK INFO 2019-09-21 18:26:42,139 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-x) ... INFO 2019-09-21 18:26:42,139 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-x' to min
INFO 2019-09-21 18:26:42,140 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,140 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-x'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,140 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): OK INFO 2019-09-21 18:26:42,141 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-y) ... INFO 2019-09-21 18:26:42,141 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-y' to min
INFO 2019-09-21 18:26:42,141 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,142 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-y'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,142 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-y): OK INFO 2019-09-21 18:26:42,142 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-x) ... INFO 2019-09-21 18:26:42,142 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-x' to max
INFO 2019-09-21 18:26:42,143 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,143 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-x'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,143 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-x): OK INFO 2019-09-21 18:26:42,143 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-y) ... INFO 2019-09-21 18:26:42,143 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-y' to max
INFO 2019-09-21 18:26:42,147 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): compression->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,148 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'compression'='none': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,148 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(compression): OK INFO 2019-09-21 18:26:42,148 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism) ... INFO 2019-09-21 18:26:42,148 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism): Option not found INFO 2019-09-21 18:26:42,148 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format) ... INFO 2019-09-21 18:26:42,148 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format): Option not found INFO 2019-09-21 18:26:42,149 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth) ... INFO 2019-09-21 18:26:42,149 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth): Option not found INFO 2019-09-21 18:26:42,149 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(indicators) ... INFO 2019-09-21 18:26:42,149 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(indicators): Option not found INFO 2019-09-21 18:26:42,149 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes) ... INFO 2019-09-21 18:26:42,150 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes): Option not found
INFO 2019-09-21 18:26:42,263 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L397(lis_sane_get_device): Sane: get_device(hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F): OK
DEBUG 2019-09-21 18:26:42,264 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_names.c:L191(item_filter): Source 'hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F': root -> no name normalization
DEBUG 2019-09-21 18:26:42,273 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,273 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,274 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,274 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,274 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:26:42,274 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L190(set_str): Setting option 'mode' to 'Color'
DEBUG 2019-09-21 18:26:42,282 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L860(lis_sane_item_get_options): Option: hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->br-y(14) (Bottom-right y, Bottom-right y position of scan area.) DEBUG 2019-09-21 18:26:42,282 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L303(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options() returned 11 options DEBUG 2019-09-21 18:26:42,283 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,283 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,283 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,283 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,283 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:26:42,284 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(preview): Option not found INFO 2019-09-21 18:26:42,284 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(resolution) ... INFO 2019-09-21 18:26:42,284 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L291(set_int): Setting option 'resolution' (1) to '300'
INFO 2019-09-21 18:26:42,286 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,286 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-x'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,286 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): OK INFO 2019-09-21 18:26:42,287 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-y) ... INFO 2019-09-21 18:26:42,287 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-y' to min
INFO 2019-09-21 18:26:42,287 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,288 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-y'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,288 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-y): OK INFO 2019-09-21 18:26:42,288 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-x) ... INFO 2019-09-21 18:26:42,288 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-x' to max
INFO 2019-09-21 18:26:42,289 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,289 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-x'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,289 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-x): OK INFO 2019-09-21 18:26:42,289 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-y) ... INFO 2019-09-21 18:26:42,289 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-y' to max
INFO 2019-09-21 18:26:42,293 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): compression->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,293 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'compression'='none': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,294 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(compression): OK INFO 2019-09-21 18:26:42,294 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism) ... INFO 2019-09-21 18:26:42,294 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism): Option not found INFO 2019-09-21 18:26:42,294 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format) ... INFO 2019-09-21 18:26:42,294 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format): Option not found INFO 2019-09-21 18:26:42,294 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth) ... INFO 2019-09-21 18:26:42,295 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth): Option not found INFO 2019-09-21 18:26:42,295 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(indicators) ... INFO 2019-09-21 18:26:42,295 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(indicators): Option not found INFO 2019-09-21 18:26:42,295 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes) ... INFO 2019-09-21 18:26:42,295 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes): Option not found
INFO 2019-09-21 18:26:42,305 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,306 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:26:42,306 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,306 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,306 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,306 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,307 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,307 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,307 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,307 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,307 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,307 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,308 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:26:42,308 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,308 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,308 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,308 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,309 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_types.c:L100(item_filter): Item 'flatbed': type = 1 (regex 0) INFO 2019-09-21 18:26:42,309 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L449(item_filter): Setting default values on item 'flatbed' INFO 2019-09-21 18:26:42,309 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(mode) ...
DEBUG 2019-09-21 18:26:42,309 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L365(set_default_values): normalizers_safe_defaults: set_default_value(mode): Must first: Reload option list of item 'flatbed'...
INFO 2019-09-21 18:26:42,309 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,309 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L280(set_source): Setting source to 'Flatbed' INFO 2019-09-21 18:26:42,310 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,310 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value INFO 2019-09-21 18:26:42,310 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,310 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:26:42,310 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,311 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,311 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,311 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,311 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,311 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,311 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,312 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,312 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,312 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,312 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:26:42,312 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,313 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,313 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,313 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,313 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:26:42,313 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L190(set_str): Setting option 'mode' to 'Color'
INFO 2019-09-21 18:26:42,314 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): mode->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,314 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'mode'='Color': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,314 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(mode): OK INFO 2019-09-21 18:26:42,314 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(preview) ... INFO 2019-09-21 18:26:42,315 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(preview): Option not found INFO 2019-09-21 18:26:42,315 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(resolution) ... INFO 2019-09-21 18:26:42,315 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L291(set_int): Setting option 'resolution' (1) to '300'
INFO 2019-09-21 18:26:42,316 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): resolution->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,316 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L328(set_int): 'resolution'='300': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,316 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(resolution): OK INFO 2019-09-21 18:26:42,316 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-x) ... INFO 2019-09-21 18:26:42,316 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-x' to min
INFO 2019-09-21 18:26:42,317 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,317 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-x'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,317 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): OK INFO 2019-09-21 18:26:42,317 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-y) ... INFO 2019-09-21 18:26:42,318 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-y' to min
INFO 2019-09-21 18:26:42,318 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,318 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-y'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,319 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-y): OK INFO 2019-09-21 18:26:42,319 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-x) ... INFO 2019-09-21 18:26:42,319 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-x' to max
INFO 2019-09-21 18:26:42,319 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,320 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-x'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,320 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-x): OK INFO 2019-09-21 18:26:42,320 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-y) ... INFO 2019-09-21 18:26:42,320 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-y' to max
INFO 2019-09-21 18:26:42,324 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): compression->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,324 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'compression'='none': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,324 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(compression): OK INFO 2019-09-21 18:26:42,324 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism) ... INFO 2019-09-21 18:26:42,325 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism): Option not found INFO 2019-09-21 18:26:42,325 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format) ... INFO 2019-09-21 18:26:42,325 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format): Option not found INFO 2019-09-21 18:26:42,325 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth) ... INFO 2019-09-21 18:26:42,325 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth): Option not found INFO 2019-09-21 18:26:42,325 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(indicators) ... INFO 2019-09-21 18:26:42,326 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(indicators): Option not found INFO 2019-09-21 18:26:42,326 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes) ... INFO 2019-09-21 18:26:42,326 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes): Option not found
INFO 2019-09-21 18:26:42,328 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,329 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L280(set_source): Setting source to 'Flatbed' INFO 2019-09-21 18:26:42,329 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,329 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value INFO 2019-09-21 18:26:42,329 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,329 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:26:42,330 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,330 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,330 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,330 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,330 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,331 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,331 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,331 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,331 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,331 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,331 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:26:42,332 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,332 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,332 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,332 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,332 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution'
INFO 2019-09-21 18:26:42,339 7F7AE3C52740 ironscanner.main Option: mode INFO 2019-09-21 18:26:42,340 7F7AE3C52740 ironscanner.main Title: Scan mode INFO 2019-09-21 18:26:42,340 7F7AE3C52740 ironscanner.main Desc: Selects the scan mode (e.g., lineart, monochrome, or color). INFO 2019-09-21 18:26:42,340 7F7AE3C52740 ironscanner.main Type: <GType gchararray (64)> INFO 2019-09-21 18:26:42,341 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,341 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,342 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_LIST of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,342 7F7AE3C52740 ironscanner.main Constraint: ['Lineart', 'Gray', 'Color']
DEBUG 2019-09-21 18:26:42,342 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,343 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): mode->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,343 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,344 7F7AE3C52740 ironscanner.main Value: Color INFO 2019-09-21 18:26:42,344 7F7AE3C52740 ironscanner.main Option: resolution INFO 2019-09-21 18:26:42,344 7F7AE3C52740 ironscanner.main Title: Scan resolution INFO 2019-09-21 18:26:42,344 7F7AE3C52740 ironscanner.main Desc: Sets the resolution of the scanned image. INFO 2019-09-21 18:26:42,344 7F7AE3C52740 ironscanner.main Type: <GType gint (24)> INFO 2019-09-21 18:26:42,345 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_DPI of type Libinsane.Unit> INFO 2019-09-21 18:26:42,345 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,345 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_LIST of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,345 7F7AE3C52740 ironscanner.main Constraint: [75, 100, 200, 300, 600, 1200]
DEBUG 2019-09-21 18:26:42,345 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,346 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): resolution->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,346 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,347 7F7AE3C52740 ironscanner.main Value: 300 INFO 2019-09-21 18:26:42,347 7F7AE3C52740 ironscanner.main Option: source INFO 2019-09-21 18:26:42,347 7F7AE3C52740 ironscanner.main Title: Scan source INFO 2019-09-21 18:26:42,347 7F7AE3C52740 ironscanner.main Desc: Selects the scan source (such as a document-feeder). INFO 2019-09-21 18:26:42,347 7F7AE3C52740 ironscanner.main Type: <GType gchararray (64)> INFO 2019-09-21 18:26:42,348 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,348 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,348 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_LIST of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,348 7F7AE3C52740 ironscanner.main Constraint: ['Flatbed']
DEBUG 2019-09-21 18:26:42,348 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,349 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,349 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,349 7F7AE3C52740 ironscanner.main Value: Flatbed INFO 2019-09-21 18:26:42,350 7F7AE3C52740 ironscanner.main Option: brightness INFO 2019-09-21 18:26:42,350 7F7AE3C52740 ironscanner.main Title: Brightness INFO 2019-09-21 18:26:42,350 7F7AE3C52740 ironscanner.main Desc: Controls the brightness of the acquired image. INFO 2019-09-21 18:26:42,350 7F7AE3C52740 ironscanner.main Type: <GType gint (24)> INFO 2019-09-21 18:26:42,351 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,351 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,351 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,351 7F7AE3C52740 ironscanner.main Constraint: [0, 2000, 0]
INFO 2019-09-21 18:26:42,353 7F7AE3C52740 ironscanner.main Value: 1000 INFO 2019-09-21 18:26:42,353 7F7AE3C52740 ironscanner.main Option: contrast INFO 2019-09-21 18:26:42,353 7F7AE3C52740 ironscanner.main Title: Contrast INFO 2019-09-21 18:26:42,354 7F7AE3C52740 ironscanner.main Desc: Controls the contrast of the acquired image. INFO 2019-09-21 18:26:42,354 7F7AE3C52740 ironscanner.main Type: <GType gint (24)> INFO 2019-09-21 18:26:42,354 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,354 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,354 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,354 7F7AE3C52740 ironscanner.main Constraint: [0, 2000, 0]
INFO 2019-09-21 18:26:42,356 7F7AE3C52740 ironscanner.main Value: 1000 INFO 2019-09-21 18:26:42,356 7F7AE3C52740 ironscanner.main Option: compression INFO 2019-09-21 18:26:42,357 7F7AE3C52740 ironscanner.main Title: Compression INFO 2019-09-21 18:26:42,357 7F7AE3C52740 ironscanner.main Desc: Selects the scanner compression method for faster scans, possibly at the expense of image quality. INFO 2019-09-21 18:26:42,357 7F7AE3C52740 ironscanner.main Type: <GType gchararray (64)> INFO 2019-09-21 18:26:42,357 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,357 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,358 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_LIST of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,358 7F7AE3C52740 ironscanner.main Constraint: ['None', 'JPEG']
DEBUG 2019-09-21 18:26:42,358 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,358 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): compression->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,359 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,359 7F7AE3C52740 ironscanner.main Value: None INFO 2019-09-21 18:26:42,359 7F7AE3C52740 ironscanner.main Option: jpeg-quality INFO 2019-09-21 18:26:42,359 7F7AE3C52740 ironscanner.main Title: JPEG compression factor INFO 2019-09-21 18:26:42,360 7F7AE3C52740 ironscanner.main Desc: Sets the scanner JPEG compression factor. Larger numbers mean better compression, and smaller numbers mean better image quality. INFO 2019-09-21 18:26:42,360 7F7AE3C52740 ironscanner.main Type: <GType gint (24)> INFO 2019-09-21 18:26:42,360 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,360 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT | LIBINSANE_CAPABILITY_INACTIVE of type Libinsane.Capability> INFO 2019-09-21 18:26:42,360 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,361 7F7AE3C52740 ironscanner.main Constraint: [0, 100, 0]
DEBUG 2019-09-21 18:26:42,361 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,362 7F7AE3C52740 ironscanner.main Value: (Exception: libinsane-quark: Libinsane opt[jpeg-quality]->get_value() error: 0x40000008, Access denied (9)) INFO 2019-09-21 18:26:42,363 7F7AE3C52740 ironscanner.main Option: tl-x INFO 2019-09-21 18:26:42,363 7F7AE3C52740 ironscanner.main Title: Top-left x INFO 2019-09-21 18:26:42,363 7F7AE3C52740 ironscanner.main Desc: Top-left x position of scan area. INFO 2019-09-21 18:26:42,363 7F7AE3C52740 ironscanner.main Type: <GType gdouble (60)> INFO 2019-09-21 18:26:42,363 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_MM of type Libinsane.Unit> INFO 2019-09-21 18:26:42,364 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,364 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,364 7F7AE3C52740 ironscanner.main Constraint: [0.0, 215.90000915527344, 0.0]
DEBUG 2019-09-21 18:26:42,364 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,364 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): tl-x->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,365 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,365 7F7AE3C52740 ironscanner.main Value: 0.0 INFO 2019-09-21 18:26:42,366 7F7AE3C52740 ironscanner.main Option: tl-y INFO 2019-09-21 18:26:42,366 7F7AE3C52740 ironscanner.main Title: Top-left y INFO 2019-09-21 18:26:42,366 7F7AE3C52740 ironscanner.main Desc: Top-left y position of scan area. INFO 2019-09-21 18:26:42,366 7F7AE3C52740 ironscanner.main Type: <GType gdouble (60)> INFO 2019-09-21 18:26:42,366 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_MM of type Libinsane.Unit> INFO 2019-09-21 18:26:42,366 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,367 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,367 7F7AE3C52740 ironscanner.main Constraint: [0.0, 297.01068115234375, 0.0]
DEBUG 2019-09-21 18:26:42,367 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,367 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): tl-y->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,368 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,368 7F7AE3C52740 ironscanner.main Value: 0.0 INFO 2019-09-21 18:26:42,368 7F7AE3C52740 ironscanner.main Option: br-x INFO 2019-09-21 18:26:42,369 7F7AE3C52740 ironscanner.main Title: Bottom-right x INFO 2019-09-21 18:26:42,369 7F7AE3C52740 ironscanner.main Desc: Bottom-right x position of scan area. INFO 2019-09-21 18:26:42,369 7F7AE3C52740 ironscanner.main Type: <GType gdouble (60)> INFO 2019-09-21 18:26:42,369 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_MM of type Libinsane.Unit> INFO 2019-09-21 18:26:42,369 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,370 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,370 7F7AE3C52740 ironscanner.main Constraint: [0.0, 215.90000915527344, 0.0]
DEBUG 2019-09-21 18:26:42,370 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,370 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): br-x->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,371 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,371 7F7AE3C52740 ironscanner.main Value: 215.90000915527344 INFO 2019-09-21 18:26:42,371 7F7AE3C52740 ironscanner.main Option: br-y INFO 2019-09-21 18:26:42,372 7F7AE3C52740 ironscanner.main Title: Bottom-right y INFO 2019-09-21 18:26:42,372 7F7AE3C52740 ironscanner.main Desc: Bottom-right y position of scan area. INFO 2019-09-21 18:26:42,372 7F7AE3C52740 ironscanner.main Type: <GType gdouble (60)> INFO 2019-09-21 18:26:42,372 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_MM of type Libinsane.Unit> INFO 2019-09-21 18:26:42,372 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,373 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,373 7F7AE3C52740 ironscanner.main Constraint: [0.0, 297.01068115234375, 0.0]
DEBUG 2019-09-21 18:26:42,373 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,373 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): br-y->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,374 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,374 7F7AE3C52740 ironscanner.main Value: 297.01068115234375
INFO 2019-09-21 18:26:42,580 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L397(lis_sane_get_device): Sane: get_device(hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F): OK
DEBUG 2019-09-21 18:26:42,580 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_names.c:L191(item_filter): Source 'hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F': root -> no name normalization
DEBUG 2019-09-21 18:26:42,590 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,590 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,590 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,590 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,590 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:26:42,591 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L190(set_str): Setting option 'mode' to 'Color'
DEBUG 2019-09-21 18:26:42,599 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L860(lis_sane_item_get_options): Option: hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->br-y(14) (Bottom-right y, Bottom-right y position of scan area.) DEBUG 2019-09-21 18:26:42,599 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L303(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options() returned 11 options DEBUG 2019-09-21 18:26:42,599 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,599 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,600 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,600 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,600 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:26:42,600 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(preview): Option not found INFO 2019-09-21 18:26:42,600 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(resolution) ... INFO 2019-09-21 18:26:42,600 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L291(set_int): Setting option 'resolution' (1) to '300'
INFO 2019-09-21 18:26:42,603 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,603 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-x'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,603 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): OK INFO 2019-09-21 18:26:42,603 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-y) ... INFO 2019-09-21 18:26:42,603 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-y' to min
INFO 2019-09-21 18:26:42,604 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,604 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-y'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,604 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-y): OK INFO 2019-09-21 18:26:42,604 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-x) ... INFO 2019-09-21 18:26:42,605 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-x' to max
INFO 2019-09-21 18:26:42,605 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,605 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-x'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,606 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-x): OK INFO 2019-09-21 18:26:42,606 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-y) ... INFO 2019-09-21 18:26:42,606 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-y' to max
INFO 2019-09-21 18:26:42,610 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): compression->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,610 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'compression'='none': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,610 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(compression): OK INFO 2019-09-21 18:26:42,610 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism) ... INFO 2019-09-21 18:26:42,610 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism): Option not found INFO 2019-09-21 18:26:42,611 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format) ... INFO 2019-09-21 18:26:42,611 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format): Option not found INFO 2019-09-21 18:26:42,611 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth) ... INFO 2019-09-21 18:26:42,611 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth): Option not found INFO 2019-09-21 18:26:42,611 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(indicators) ... INFO 2019-09-21 18:26:42,612 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(indicators): Option not found INFO 2019-09-21 18:26:42,612 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes) ... INFO 2019-09-21 18:26:42,612 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes): Option not found
INFO 2019-09-21 18:26:42,622 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,622 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:26:42,622 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,623 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,623 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,623 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,623 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,623 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,624 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,624 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,624 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,624 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,624 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:26:42,624 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,625 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,625 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,625 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,625 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_types.c:L100(item_filter): Item 'flatbed': type = 1 (regex 0) INFO 2019-09-21 18:26:42,625 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L449(item_filter): Setting default values on item 'flatbed' INFO 2019-09-21 18:26:42,626 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(mode) ...
DEBUG 2019-09-21 18:26:42,626 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L365(set_default_values): normalizers_safe_defaults: set_default_value(mode): Must first: Reload option list of item 'flatbed'...
INFO 2019-09-21 18:26:42,626 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,626 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L280(set_source): Setting source to 'Flatbed' INFO 2019-09-21 18:26:42,626 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,626 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value INFO 2019-09-21 18:26:42,627 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,627 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:26:42,627 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,627 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,627 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,628 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,628 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,628 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,628 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,628 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,628 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,629 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,629 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:26:42,629 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,629 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,629 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,630 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,630 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:26:42,630 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L190(set_str): Setting option 'mode' to 'Color'
INFO 2019-09-21 18:26:42,631 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): mode->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,631 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'mode'='Color': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,631 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(mode): OK INFO 2019-09-21 18:26:42,631 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(preview) ... INFO 2019-09-21 18:26:42,631 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(preview): Option not found INFO 2019-09-21 18:26:42,631 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(resolution) ... INFO 2019-09-21 18:26:42,632 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L291(set_int): Setting option 'resolution' (1) to '300'
INFO 2019-09-21 18:26:42,632 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): resolution->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,632 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L328(set_int): 'resolution'='300': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,633 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(resolution): OK INFO 2019-09-21 18:26:42,633 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-x) ... INFO 2019-09-21 18:26:42,633 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-x' to min
INFO 2019-09-21 18:26:42,634 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,634 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-x'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,634 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): OK INFO 2019-09-21 18:26:42,634 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-y) ... INFO 2019-09-21 18:26:42,634 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-y' to min
INFO 2019-09-21 18:26:42,635 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,635 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-y'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,635 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-y): OK INFO 2019-09-21 18:26:42,635 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-x) ... INFO 2019-09-21 18:26:42,636 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-x' to max
INFO 2019-09-21 18:26:42,636 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,636 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-x'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,637 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-x): OK INFO 2019-09-21 18:26:42,637 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-y) ... INFO 2019-09-21 18:26:42,637 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-y' to max
INFO 2019-09-21 18:26:42,641 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): compression->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,641 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'compression'='none': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:26:42,641 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(compression): OK INFO 2019-09-21 18:26:42,641 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism) ... INFO 2019-09-21 18:26:42,641 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism): Option not found INFO 2019-09-21 18:26:42,642 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format) ... INFO 2019-09-21 18:26:42,642 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format): Option not found INFO 2019-09-21 18:26:42,642 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth) ... INFO 2019-09-21 18:26:42,642 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth): Option not found INFO 2019-09-21 18:26:42,642 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(indicators) ... INFO 2019-09-21 18:26:42,642 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(indicators): Option not found INFO 2019-09-21 18:26:42,643 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes) ... INFO 2019-09-21 18:26:42,643 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes): Option not found
INFO 2019-09-21 18:26:42,644 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,645 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L280(set_source): Setting source to 'Flatbed' INFO 2019-09-21 18:26:42,645 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:26:42,645 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value INFO 2019-09-21 18:26:42,645 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:26:42,645 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:26:42,646 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,646 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,646 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,646 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,646 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,647 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,647 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,647 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,647 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,647 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:26:42,648 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:26:42,648 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,648 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,648 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:26:42,648 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:26:42,648 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution'
INFO 2019-09-21 18:26:42,655 7F7AE3C52740 ironscanner.main Option: mode INFO 2019-09-21 18:26:42,656 7F7AE3C52740 ironscanner.main Title: Scan mode INFO 2019-09-21 18:26:42,656 7F7AE3C52740 ironscanner.main Desc: Selects the scan mode (e.g., lineart, monochrome, or color). INFO 2019-09-21 18:26:42,656 7F7AE3C52740 ironscanner.main Type: <GType gchararray (64)> INFO 2019-09-21 18:26:42,656 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,656 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,657 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_LIST of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,657 7F7AE3C52740 ironscanner.main Constraint: ['Lineart', 'Gray', 'Color']
DEBUG 2019-09-21 18:26:42,657 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,657 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): mode->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,658 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,658 7F7AE3C52740 ironscanner.main Value: Color INFO 2019-09-21 18:26:42,658 7F7AE3C52740 ironscanner.main Option: resolution INFO 2019-09-21 18:26:42,659 7F7AE3C52740 ironscanner.main Title: Scan resolution INFO 2019-09-21 18:26:42,659 7F7AE3C52740 ironscanner.main Desc: Sets the resolution of the scanned image. INFO 2019-09-21 18:26:42,659 7F7AE3C52740 ironscanner.main Type: <GType gint (24)> INFO 2019-09-21 18:26:42,659 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_DPI of type Libinsane.Unit> INFO 2019-09-21 18:26:42,659 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,659 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_LIST of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,660 7F7AE3C52740 ironscanner.main Constraint: [75, 100, 200, 300, 600, 1200]
DEBUG 2019-09-21 18:26:42,660 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,660 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): resolution->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,661 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,661 7F7AE3C52740 ironscanner.main Value: 300 INFO 2019-09-21 18:26:42,661 7F7AE3C52740 ironscanner.main Option: source INFO 2019-09-21 18:26:42,661 7F7AE3C52740 ironscanner.main Title: Scan source INFO 2019-09-21 18:26:42,662 7F7AE3C52740 ironscanner.main Desc: Selects the scan source (such as a document-feeder). INFO 2019-09-21 18:26:42,662 7F7AE3C52740 ironscanner.main Type: <GType gchararray (64)> INFO 2019-09-21 18:26:42,662 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,662 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,662 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_LIST of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,663 7F7AE3C52740 ironscanner.main Constraint: ['Flatbed']
DEBUG 2019-09-21 18:26:42,663 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,663 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,664 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,664 7F7AE3C52740 ironscanner.main Value: Flatbed INFO 2019-09-21 18:26:42,664 7F7AE3C52740 ironscanner.main Option: brightness INFO 2019-09-21 18:26:42,664 7F7AE3C52740 ironscanner.main Title: Brightness INFO 2019-09-21 18:26:42,665 7F7AE3C52740 ironscanner.main Desc: Controls the brightness of the acquired image. INFO 2019-09-21 18:26:42,665 7F7AE3C52740 ironscanner.main Type: <GType gint (24)> INFO 2019-09-21 18:26:42,665 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,665 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,665 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,666 7F7AE3C52740 ironscanner.main Constraint: [0, 2000, 0]
INFO 2019-09-21 18:26:42,667 7F7AE3C52740 ironscanner.main Value: 1000 INFO 2019-09-21 18:26:42,667 7F7AE3C52740 ironscanner.main Option: contrast INFO 2019-09-21 18:26:42,668 7F7AE3C52740 ironscanner.main Title: Contrast INFO 2019-09-21 18:26:42,668 7F7AE3C52740 ironscanner.main Desc: Controls the contrast of the acquired image. INFO 2019-09-21 18:26:42,668 7F7AE3C52740 ironscanner.main Type: <GType gint (24)> INFO 2019-09-21 18:26:42,668 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,668 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,669 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,669 7F7AE3C52740 ironscanner.main Constraint: [0, 2000, 0]
INFO 2019-09-21 18:26:42,670 7F7AE3C52740 ironscanner.main Value: 1000 INFO 2019-09-21 18:26:42,671 7F7AE3C52740 ironscanner.main Option: compression INFO 2019-09-21 18:26:42,671 7F7AE3C52740 ironscanner.main Title: Compression INFO 2019-09-21 18:26:42,671 7F7AE3C52740 ironscanner.main Desc: Selects the scanner compression method for faster scans, possibly at the expense of image quality. INFO 2019-09-21 18:26:42,671 7F7AE3C52740 ironscanner.main Type: <GType gchararray (64)> INFO 2019-09-21 18:26:42,671 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,672 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,672 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_LIST of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,672 7F7AE3C52740 ironscanner.main Constraint: ['None', 'JPEG']
DEBUG 2019-09-21 18:26:42,672 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,672 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): compression->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,673 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,673 7F7AE3C52740 ironscanner.main Value: None INFO 2019-09-21 18:26:42,674 7F7AE3C52740 ironscanner.main Option: jpeg-quality INFO 2019-09-21 18:26:42,674 7F7AE3C52740 ironscanner.main Title: JPEG compression factor INFO 2019-09-21 18:26:42,674 7F7AE3C52740 ironscanner.main Desc: Sets the scanner JPEG compression factor. Larger numbers mean better compression, and smaller numbers mean better image quality. INFO 2019-09-21 18:26:42,674 7F7AE3C52740 ironscanner.main Type: <GType gint (24)> INFO 2019-09-21 18:26:42,674 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_NONE of type Libinsane.Unit> INFO 2019-09-21 18:26:42,675 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT | LIBINSANE_CAPABILITY_INACTIVE of type Libinsane.Capability> INFO 2019-09-21 18:26:42,675 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,675 7F7AE3C52740 ironscanner.main Constraint: [0, 100, 0]
DEBUG 2019-09-21 18:26:42,675 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,676 7F7AE3C52740 ironscanner.main Value: (Exception: libinsane-quark: Libinsane opt[jpeg-quality]->get_value() error: 0x40000008, Access denied (9)) INFO 2019-09-21 18:26:42,677 7F7AE3C52740 ironscanner.main Option: tl-x INFO 2019-09-21 18:26:42,677 7F7AE3C52740 ironscanner.main Title: Top-left x INFO 2019-09-21 18:26:42,677 7F7AE3C52740 ironscanner.main Desc: Top-left x position of scan area. INFO 2019-09-21 18:26:42,677 7F7AE3C52740 ironscanner.main Type: <GType gdouble (60)> INFO 2019-09-21 18:26:42,678 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_MM of type Libinsane.Unit> INFO 2019-09-21 18:26:42,678 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,678 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,678 7F7AE3C52740 ironscanner.main Constraint: [0.0, 215.90000915527344, 0.0]
DEBUG 2019-09-21 18:26:42,678 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,679 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): tl-x->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,679 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,679 7F7AE3C52740 ironscanner.main Value: 0.0 INFO 2019-09-21 18:26:42,680 7F7AE3C52740 ironscanner.main Option: tl-y INFO 2019-09-21 18:26:42,680 7F7AE3C52740 ironscanner.main Title: Top-left y INFO 2019-09-21 18:26:42,680 7F7AE3C52740 ironscanner.main Desc: Top-left y position of scan area. INFO 2019-09-21 18:26:42,680 7F7AE3C52740 ironscanner.main Type: <GType gdouble (60)> INFO 2019-09-21 18:26:42,680 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_MM of type Libinsane.Unit> INFO 2019-09-21 18:26:42,681 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,681 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,681 7F7AE3C52740 ironscanner.main Constraint: [0.0, 297.01068115234375, 0.0]
DEBUG 2019-09-21 18:26:42,681 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,682 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): tl-y->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,682 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,682 7F7AE3C52740 ironscanner.main Value: 0.0 INFO 2019-09-21 18:26:42,683 7F7AE3C52740 ironscanner.main Option: br-x INFO 2019-09-21 18:26:42,683 7F7AE3C52740 ironscanner.main Title: Bottom-right x INFO 2019-09-21 18:26:42,683 7F7AE3C52740 ironscanner.main Desc: Bottom-right x position of scan area. INFO 2019-09-21 18:26:42,683 7F7AE3C52740 ironscanner.main Type: <GType gdouble (60)> INFO 2019-09-21 18:26:42,683 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_MM of type Libinsane.Unit> INFO 2019-09-21 18:26:42,684 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,684 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,684 7F7AE3C52740 ironscanner.main Constraint: [0.0, 215.90000915527344, 0.0]
DEBUG 2019-09-21 18:26:42,684 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,685 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): br-x->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,685 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,685 7F7AE3C52740 ironscanner.main Value: 215.90000915527344 INFO 2019-09-21 18:26:42,686 7F7AE3C52740 ironscanner.main Option: br-y INFO 2019-09-21 18:26:42,686 7F7AE3C52740 ironscanner.main Title: Bottom-right y INFO 2019-09-21 18:26:42,686 7F7AE3C52740 ironscanner.main Desc: Bottom-right y position of scan area. INFO 2019-09-21 18:26:42,686 7F7AE3C52740 ironscanner.main Type: <GType gdouble (60)> INFO 2019-09-21 18:26:42,686 7F7AE3C52740 ironscanner.main Unit: <enum LIBINSANE_UNIT_MM of type Libinsane.Unit> INFO 2019-09-21 18:26:42,687 7F7AE3C52740 ironscanner.main Capabilities: <flags LIBINSANE_CAPABILITY_SW_SELECT of type Libinsane.Capability> INFO 2019-09-21 18:26:42,687 7F7AE3C52740 ironscanner.main Constraint type: <enum LIBINSANE_CONSTRAINT_TYPE_RANGE of type Libinsane.ConstraintType> INFO 2019-09-21 18:26:42,687 7F7AE3C52740 ironscanner.main Constraint: [0.0, 297.01068115234375, 0.0]
DEBUG 2019-09-21 18:26:42,687 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L347(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,688 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): br-y->get_value(): Using cached value
DEBUG 2019-09-21 18:26:42,688 7F7AE3C52740 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L359(libinsane_option_descriptor_get_value): enter
INFO 2019-09-21 18:26:42,688 7F7AE3C52740 ironscanner.main Value: 297.01068115234375
INFO 2019-09-21 18:27:02,845 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L397(lis_sane_get_device): Sane: get_device(hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F): OK
DEBUG 2019-09-21 18:27:02,846 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_names.c:L191(item_filter): Source 'hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F': root -> no name normalization
DEBUG 2019-09-21 18:27:02,856 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,856 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,857 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,857 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:27:02,857 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:27:02,857 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L190(set_str): Setting option 'mode' to 'Color'
DEBUG 2019-09-21 18:27:02,866 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L860(lis_sane_item_get_options): Option: hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->br-y(14) (Bottom-right y, Bottom-right y position of scan area.) DEBUG 2019-09-21 18:27:02,867 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L303(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options() returned 11 options DEBUG 2019-09-21 18:27:02,867 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,867 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,867 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,867 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:27:02,868 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:27:02,868 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(preview): Option not found INFO 2019-09-21 18:27:02,868 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(resolution) ... INFO 2019-09-21 18:27:02,868 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L291(set_int): Setting option 'resolution' (1) to '300'
INFO 2019-09-21 18:27:02,871 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,871 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-x'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,871 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): OK INFO 2019-09-21 18:27:02,872 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-y) ... INFO 2019-09-21 18:27:02,872 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-y' to min
INFO 2019-09-21 18:27:02,873 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,873 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-y'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,873 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-y): OK INFO 2019-09-21 18:27:02,873 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-x) ... INFO 2019-09-21 18:27:02,873 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-x' to max
INFO 2019-09-21 18:27:02,874 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,874 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-x'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,875 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-x): OK INFO 2019-09-21 18:27:02,875 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-y) ... INFO 2019-09-21 18:27:02,875 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-y' to max
INFO 2019-09-21 18:27:02,880 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): compression->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,880 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'compression'='none': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,880 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(compression): OK INFO 2019-09-21 18:27:02,881 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism) ... INFO 2019-09-21 18:27:02,881 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism): Option not found INFO 2019-09-21 18:27:02,881 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format) ... INFO 2019-09-21 18:27:02,881 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format): Option not found INFO 2019-09-21 18:27:02,882 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth) ... INFO 2019-09-21 18:27:02,882 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth): Option not found INFO 2019-09-21 18:27:02,882 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(indicators) ... INFO 2019-09-21 18:27:02,882 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(indicators): Option not found INFO 2019-09-21 18:27:02,883 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes) ... INFO 2019-09-21 18:27:02,883 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes): Option not found
INFO 2019-09-21 18:27:02,903 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,904 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:27:02,904 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,905 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,905 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,906 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,906 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,907 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,907 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,908 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,908 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,909 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,909 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:27:02,910 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,910 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,910 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,911 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:27:02,911 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_types.c:L100(item_filter): Item 'flatbed': type = 1 (regex 0) INFO 2019-09-21 18:27:02,911 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L449(item_filter): Setting default values on item 'flatbed' INFO 2019-09-21 18:27:02,912 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(mode) ...
DEBUG 2019-09-21 18:27:02,912 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L365(set_default_values): normalizers_safe_defaults: set_default_value(mode): Must first: Reload option list of item 'flatbed'...
INFO 2019-09-21 18:27:02,913 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:27:02,913 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L280(set_source): Setting source to 'Flatbed' INFO 2019-09-21 18:27:02,913 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:27:02,914 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value INFO 2019-09-21 18:27:02,914 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,914 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:27:02,915 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,915 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,915 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,916 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,916 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,916 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,917 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,917 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,918 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,918 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,918 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:27:02,919 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,919 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,919 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,920 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:27:02,920 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:27:02,920 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L190(set_str): Setting option 'mode' to 'Color'
INFO 2019-09-21 18:27:02,921 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): mode->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,922 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'mode'='Color': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,922 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(mode): OK INFO 2019-09-21 18:27:02,923 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(preview) ... INFO 2019-09-21 18:27:02,923 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(preview): Option not found INFO 2019-09-21 18:27:02,923 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(resolution) ... INFO 2019-09-21 18:27:02,924 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L291(set_int): Setting option 'resolution' (1) to '300'
INFO 2019-09-21 18:27:02,925 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): resolution->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,925 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L328(set_int): 'resolution'='300': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,925 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(resolution): OK INFO 2019-09-21 18:27:02,926 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-x) ... INFO 2019-09-21 18:27:02,926 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-x' to min
INFO 2019-09-21 18:27:02,927 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,927 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-x'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,928 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): OK INFO 2019-09-21 18:27:02,928 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-y) ... INFO 2019-09-21 18:27:02,929 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-y' to min
INFO 2019-09-21 18:27:02,930 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,930 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-y'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,930 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-y): OK INFO 2019-09-21 18:27:02,931 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-x) ... INFO 2019-09-21 18:27:02,931 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-x' to max
INFO 2019-09-21 18:27:02,932 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,933 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-x'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,933 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-x): OK INFO 2019-09-21 18:27:02,933 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-y) ... INFO 2019-09-21 18:27:02,934 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-y' to max
INFO 2019-09-21 18:27:02,941 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): compression->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,941 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L201(set_str): 'compression'='none': 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,941 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(compression): OK INFO 2019-09-21 18:27:02,942 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism) ... INFO 2019-09-21 18:27:02,942 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(transfer_mechanism): Option not found INFO 2019-09-21 18:27:02,943 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format) ... INFO 2019-09-21 18:27:02,943 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(image_file_format): Option not found INFO 2019-09-21 18:27:02,943 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth) ... INFO 2019-09-21 18:27:02,944 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(bit_depth): Option not found INFO 2019-09-21 18:27:02,944 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(indicators) ... INFO 2019-09-21 18:27:02,944 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(indicators): Option not found INFO 2019-09-21 18:27:02,945 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes) ... INFO 2019-09-21 18:27:02,945 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(supported_sizes): Option not found
INFO 2019-09-21 18:27:02,947 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:27:02,947 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L280(set_source): Setting source to 'Flatbed' INFO 2019-09-21 18:27:02,948 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:27:02,948 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value INFO 2019-09-21 18:27:02,948 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,949 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:27:02,949 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,950 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,950 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,950 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,951 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,951 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,951 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,952 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,952 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,952 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,953 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:27:02,953 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,953 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,954 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,954 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:27:02,954 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution'
INFO 2019-09-21 18:27:02,963 7F7ADC977700 ironscanner.main Configuring scanner: resolution = 75
DEBUG 2019-09-21 18:27:02,963 7F7ADC977700 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L429(libinsane_option_descriptor_set_value): enter
INFO 2019-09-21 18:27:02,964 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): resolution->get_value(): Using cached value
INFO 2019-09-21 18:27:02,965 7F7ADC977700 ironscanner.main Configuring scanner: mode = Color
DEBUG 2019-09-21 18:27:02,966 7F7ADC977700 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/option_descriptor.c:L429(libinsane_option_descriptor_set_value): enter
INFO 2019-09-21 18:27:02,966 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): mode->get_value(): Using cached value INFO 2019-09-21 18:27:02,966 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): mode->set_value(): attempting to set what is already the current value --> ignored
INFO 2019-09-21 18:27:02,967 7F7ADC977700 ironscanner.main Starting scan session ...
DEBUG 2019-09-21 18:27:02,969 7F7AB2085700 ironscanner.log [LibInsane] ../subprojects/libinsane-gobject/src/item.c:L238(libinsane_item_scan_start): enter
INFO 2019-09-21 18:27:02,970 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L432(scan_start): Scan start requested. Setting some late default values INFO 2019-09-21 18:27:02,970 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-x) ...
DEBUG 2019-09-21 18:27:02,970 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L365(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): Must first: Reload option list of item 'flatbed'...
INFO 2019-09-21 18:27:02,971 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:27:02,971 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L280(set_source): Setting source to 'Flatbed' INFO 2019-09-21 18:27:02,972 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:27:02,972 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value INFO 2019-09-21 18:27:02,972 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,973 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:27:02,973 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'mode' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,974 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'resolution' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,974 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'source' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,974 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'brightness' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,975 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'contrast' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,975 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'compression' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,975 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'jpeg-quality' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,976 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,976 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'tl-y' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,976 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-x' from root item to child item 'Flatbed' INFO 2019-09-21 18:27:02,977 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/all_opts_on_all_sources.c:L300(opts_source_get_options): Adding option 'br-y' from root item to child item 'Flatbed'
DEBUG 2019-09-21 18:27:02,977 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,977 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,978 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'mode' DEBUG 2019-09-21 18:27:02,978 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/opt_values.c:L77(get_opt_mapping): Mapping found for option 'source'
INFO 2019-09-21 18:27:02,978 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/resolution.c:L231(opt_desc_filter): No change to do on option 'resolution' INFO 2019-09-21 18:27:02,979 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-x' to min INFO 2019-09-21 18:27:02,979 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): tl-x->get_value(): Using cached value INFO 2019-09-21 18:27:02,979 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,980 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-x'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,980 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-x): OK INFO 2019-09-21 18:27:02,981 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(tl-y) ... INFO 2019-09-21 18:27:02,981 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'tl-y' to min INFO 2019-09-21 18:27:02,981 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): tl-y->get_value(): Using cached value INFO 2019-09-21 18:27:02,982 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): tl-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,982 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'tl-y'=min: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,982 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(tl-y): OK INFO 2019-09-21 18:27:02,983 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-x) ... INFO 2019-09-21 18:27:02,983 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-x' to max INFO 2019-09-21 18:27:02,983 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): br-x->get_value(): Using cached value INFO 2019-09-21 18:27:02,984 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-x->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,984 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-x'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,984 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-x): OK INFO 2019-09-21 18:27:02,985 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(br-y) ... INFO 2019-09-21 18:27:02,985 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L170(set_to_limit): Setting option 'br-y' to max INFO 2019-09-21 18:27:02,986 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): br-y->get_value(): Using cached value INFO 2019-09-21 18:27:02,986 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): br-y->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,986 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L174(set_to_limit): 'br-y'=max: 0x0, Success (set_flags=0x0) INFO 2019-09-21 18:27:02,987 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L410(set_default_values): normalizers_safe_defaults: set_default_value(br-y): OK INFO 2019-09-21 18:27:02,987 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(page-width) ... INFO 2019-09-21 18:27:02,987 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(page-width): Option not found INFO 2019-09-21 18:27:02,988 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L358(set_default_values): normalizers_safe_defaults: set_default_value(page-height) ... INFO 2019-09-21 18:27:02,988 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/safe_defaults.c:L389(set_default_values): normalizers_safe_defaults: set_default_value(page-height): Option not found INFO 2019-09-21 18:27:02,988 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L280(set_source): Setting source to 'Flatbed' INFO 2019-09-21 18:27:02,989 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L282(cache_get_options): hpaio:/usb/ENVY_4500_series?serial=CN41E2T721060F->get_options(): returning cached options INFO 2019-09-21 18:27:02,989 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L151(cache_get_value): source->get_value(): Using cached value INFO 2019-09-21 18:27:02,989 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/workarounds/cache.c:L219(cache_set_value): source->set_value(): attempting to set what is already the current value --> ignored INFO 2019-09-21 18:27:02,990 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/normalizers/source_nodes.c:L306(set_source): Source set to 'Flatbed' INFO 2019-09-21 18:27:02,990 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L1107(lis_sane_scan_start): Sane: scan_start() ...
INFO 2019-09-21 18:27:19,704 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L1126(lis_sane_scan_start): Sane: scan_start() OK
INFO 2019-09-21 18:27:22,862 7F7ADC977700 ironscanner.main Read: 1675947/1675947 INFO 2019-09-21 18:27:22,863 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L1151(lis_sane_end_of_page): Sane: end of page INFO 2019-09-21 18:27:23,044 7F7ADC977700 ironscanner.main End of page. Available: 1675947 B INFO 2019-09-21 18:27:23,218 7F7AE3C52740 ironscanner.util Mode: RGB : Size: 637x877 INFO 2019-09-21 18:27:23,229 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L1151(lis_sane_end_of_page): Sane: end of page INFO 2019-09-21 18:27:23,230 7F7AC7FFF700 ironscanner.log [LibInsane] ../subprojects/libinsane/src/bases/sane.c:L1221(lis_sane_cancel): Sane: session->cancel() (1) INFO 2019-09-21 18:27:23,230 7F7ADC977700 ironscanner.main End of feed INFO 2019-09-21 18:27:23,230 7F7ADC977700 ironscanner.main Scanned 1 images INFO 2019-09-21 18:27:23,231 7F7ADC977700 ironscanner.main ### SCAN TEST SUCCESSFUL ###
INFO 2019-09-21 18:27:35,072 7F7ADC977700 ironscanner.main Building report ... INFO 2019-09-21 18:27:35,073 7F7ADC977700 ironscanner.main * User info INFO 2019-09-21 18:27:35,073 7F7ADC977700 ironscanner.main * Scanner settings INFO 2019-09-21 18:27:35,078 7F7ADC977700 ironscanner.main No image attached to report INFO 2019-09-21 18:27:35,079 7F7ADC977700 ironscanner.main * System configuration INFO 2019-09-21 18:27:35,176 7F7ADC977700 ironscanner.main * Scan test result INFO 2019-09-21 18:27:35,328 7F7ADC977700 ironscanner.main * User comment INFO 2019-09-21 18:27:35,329 7F7ADC977700 ironscanner.main * Traces