[sane-devel] Canon MX430 / MX510 / MX925 - does not recover when ADF out of paper

Matthias Peter Walther MatthiasPeterW at aol.com
Thu Mar 20 23:16:01 UTC 2014


Hello,

I'm not sure if I did this right. I installed the two patches shipped
with your last email and used this command:

$ export SANE_DEBUG_PIXMA=11
$ scanimage -x 100 -y 100 > test.png 2>
Scanimage_Debug_11_patch1+2+3new+4+Pressed_cancel_after_device_started.txt

After the scanner started, I pressed cancel on the device. Is this what
you need?

Bye
Matthias


Am 20.03.2014 18:05, schrieb Rolf Bensch:
> Hi Matthias,
>
> Please don't mix different testings in one log file and at the same
> time. Please keep them in mind and let us go step by step.
>
> I assume that "normal" ADF scanning works with new patch 3.
>
> Am 19.03.2014 19:46, schrieb Matthias Peter Walther:
>> Standard debug level 4 scan, the last 1 mm is still missing. As this
>> seems to be firmware related, I think sane won't be able to change this.
>> The linux binary has the same problem. And I tested it in windows with
>> IrfanView. The last mm is still missing under windows, too. I think this
>> is a firmware issue?
>>
> I guess the ADF hardware needs the last 1mm for the paper detector.
>
>> Maybe you just set the maximum height of an adf page to that last line
>> it scans. That is 870 pixels @75 dpi.
>>
> I won't do so. What's when you want to scan a 14" sheet or A5 format?
> Please set the used paper size in the frontend. Then you can also crop
> left and right ADF frame.
>
>> And in the debug level 11 Iog I stopped the 2nd paper by hand. Scanner
>> and sane aborts. But after removing the paper and pressing ok on the
>> device, nothing happens anymore.
>>
> I see this error in the log file: "cancelled by hardware". The problem
> is that the scan process has not been closed and the scanner cannot be
> initialised for a new scan session because the previous is still active
> in the scanner.
>
> To fix this I need the exact position in the code where "cancelled by
> hardware" is detected. Please create a new log file with usb messages
> with attached patch "pixma_mp150.c.patch4".
>
> And please scan a small area @ 75 dpi, not a whole page. This reduces
> log file size.
>
>> The same bug comes, if you interrupt the scan with ctrl + C (scanimage).
>> The printer continues pulling pages, but does not recover after it has
>> finished. That works correctly with the binary. If I recover the scanner
>> with the binary driver, that requires up to three attempts. During the
>> first and often the second, it searches the scanner for 2 minuites and
>> aborts then. After that the second failure the scanner works prefectly
>> again. Maybe it's just a timeout in the devices firmware?
>>
> I assume that this is the same problem as above.
>
>> By the way. The timeouts in the sane logs are still rediculous. When it
>> counts down, between each line it waits up the 40 seconds and not the
>> amount of seconds it says in the log.
>>
> Maybe "pixma_common.c.patch4" will fix this.
>
>> I had to zip the logs, cause they are larger than 100 KB and the mailing
>> list server doesn't accept that.
>>
>> Last question: Is it possible to autodetect if adf has paper and
>> autoswitch the input method? Some scanner are able to do that.
>>
> Please keep this in mind.
>
> Cheers,
> Rolf

-------------- next part --------------
[sanei_debug] Setting debug level of pixma to 11.
[pixma] pixma is compiled with pthread support.
[pixma] pixma version 0.17.6
[pixma] pixma_collect_devices() found Canon PIXMA MX370 Series at libusb:002:020
[pixma] pixma_find_scanners() found 1 devices
[pixma] pixma_collect_devices() found Canon PIXMA MX370 Series at libusb:002:020
[pixma] pixma_open(): Canon PIXMA MX370 Series
[pixma] Reader task started
[pixma] Reader task id=139924564408064 (threaded)
[pixma] 
[pixma] pixma_scan(): start
[pixma]   line_size=885 image_size=261075 channels=3 depth=8
[pixma]   dpi=75x75 offset=(0,0) dimension=295x295
[pixma]   gamma_table=0xf677b0 source=0
[pixma]   threshold=127 threshold_curve=0
[pixma]   ADF page count: 0
[pixma] OUT  T=3.459 len=288
[pixma]  00000000:3c 3f 78 6d 6c 20 76 65  72 73 69 6f 6e 3d 22 31 
[pixma]  00000010:2e 30 22 20 65 6e 63 6f  64 69 6e 67 3d 22 75 74 
[pixma]  00000020:66 2d 38 22 20 3f 3e 3c  63 6d 64 20 78 6d 6c 6e 
[pixma]  00000030:73 3a 69 76 65 63 3d 22  68 74 74 70 3a 2f 2f 77 
[pixma]  00000040:77 77 2e 63 61 6e 6f 6e  2e 63 6f 6d 2f 6e 73 2f 
[pixma]  00000050:63 6d 64 2f 32 30 30 38  2f 30 37 2f 63 6f 6d 6d 
[pixma]  00000060:6f 6e 2f 22 3e 3c 69 76  65 63 3a 63 6f 6e 74 65 
[pixma]  00000070:6e 74 73 3e 3c 69 76 65  63 3a 6f 70 65 72 61 74 
[pixma]  ...
[pixma] 
[pixma] IN   T=3.484 len=365
[pixma]  00000000:3c 3f 78 6d 6c 20 76 65  72 73 69 6f 6e 3d 22 31 
[pixma]  00000010:2e 30 22 20 65 6e 63 6f  64 69 6e 67 3d 22 75 74 
[pixma]  00000020:66 2d 38 22 20 3f 3e 0d  0a 3c 63 6d 64 20 78 6d 
[pixma]  00000030:6c 6e 73 3a 69 76 65 63  3d 22 68 74 74 70 3a 2f 
[pixma]  00000040:2f 77 77 77 2e 63 61 6e  6f 6e 2e 63 6f 6d 2f 6e 
[pixma]  00000050:73 2f 63 6d 64 2f 32 30  30 38 2f 30 37 2f 63 6f 
[pixma]  00000060:6d 6d 6f 6e 2f 22 3e 0d  0a 09 3c 69 76 65 63 3a 
[pixma]  00000070:63 6f 6e 74 65 6e 74 73  3e 0d 0a 09 09 3c 69 76 
[pixma]  ...
[pixma] 
[pixma] XML message sent to scanner:
<?xml version="1.0" encoding="utf-8" ?><cmd xmlns:ivec="http://www.canon.com/ns/cmd/2008/07/common/"><ivec:contents><ivec:operation>StartJob</ivec:operation><ivec:param_set servicetype="scan"><ivec:jobID>00000001</ivec:jobID><ivec:bidi>1</ivec:bidi></ivec:param_set></ivec:contents></cmd>
[pixma] XML response back from scanner:
<?xml version="1.0" encoding="utf-8" ?>
<cmd xmlns:ivec="http://www.canon.com/ns/cmd/2008/07/common/">
	<ivec:contents>
		<ivec:operation>StartJobResponse</ivec:operation>
		<ivec:param_set servicetype="scan">
			<ivec:response>OK</ivec:response>
			<ivec:response_detail/>
			<ivec:jobID>00000001</ivec:jobID>
		</ivec:param_set>
	</ivec:contents>
</cmd>
[pixma] OUT  T=3.485 len=390
[pixma]  00000000:3c 3f 78 6d 6c 20 76 65  72 73 69 6f 6e 3d 22 31 
[pixma]  00000010:2e 30 22 20 65 6e 63 6f  64 69 6e 67 3d 22 75 74 
[pixma]  00000020:66 2d 38 22 20 3f 3e 3c  63 6d 64 20 78 6d 6c 6e 
[pixma]  00000030:73 3a 69 76 65 63 3d 22  68 74 74 70 3a 2f 2f 77 
[pixma]  00000040:77 77 2e 63 61 6e 6f 6e  2e 63 6f 6d 2f 6e 73 2f 
[pixma]  00000050:63 6d 64 2f 32 30 30 38  2f 30 37 2f 63 6f 6d 6d 
[pixma]  00000060:6f 6e 2f 22 20 78 6d 6c  6e 73 3a 76 63 6e 3d 22 
[pixma]  00000070:68 74 74 70 3a 2f 2f 77  77 77 2e 63 61 6e 6f 6e 
[pixma]  ...
[pixma] 
[pixma] IN   T=3.488 len=510
[pixma]  00000000:3c 3f 78 6d 6c 20 76 65  72 73 69 6f 6e 3d 22 31 
[pixma]  00000010:2e 30 22 20 65 6e 63 6f  64 69 6e 67 3d 22 75 74 
[pixma]  00000020:66 2d 38 22 20 3f 3e 0d  0a 3c 63 6d 64 20 78 6d 
[pixma]  00000030:6c 6e 73 3a 69 76 65 63  3d 22 68 74 74 70 3a 2f 
[pixma]  00000040:2f 77 77 77 2e 63 61 6e  6f 6e 2e 63 6f 6d 2f 6e 
[pixma]  00000050:73 2f 63 6d 64 2f 32 30  30 38 2f 30 37 2f 63 6f 
[pixma]  00000060:6d 6d 6f 6e 2f 22 0d 0a  78 6d 6c 6e 73 3a 76 63 
[pixma]  00000070:6e 3d 22 68 74 74 70 3a  2f 2f 77 77 77 2e 63 61 
[pixma]  ...
[pixma] 
[pixma] XML message sent to scanner:
<?xml version="1.0" encoding="utf-8" ?><cmd xmlns:ivec="http://www.canon.com/ns/cmd/2008/07/common/" xmlns:vcn="http://www.canon.com/ns/cmd/2008/07/canon/"><ivec:contents><ivec:operation>VendorCmd</ivec:operation><ivec:param_set servicetype="scan"><ivec:jobID>00000001</ivec:jobID><vcn:ijoperation>ModeShift</vcn:ijoperation><vcn:ijmode>1</vcn:ijmode></ivec:param_set></ivec:contents></cmd>
[pixma] XML response back from scanner:
<?xml version="1.0" encoding="utf-8" ?>
<cmd xmlns:ivec="http://www.canon.com/ns/cmd/2008/07/common/"
xmlns:vcn="http://www.canon.com/ns/cmd/2008/07/canon/">
	<ivec:contents>
		<ivec:operation>VendorCmdResponse</ivec:operation>
		<ivec:param_set servicetype="scan">
			<ivec:response>OK</ivec:response>
			<ivec:response_detail/>
			<vcn:ijoperation>ModeShiftResponse</vcn:ijoperation>
			<vcn:ijresponse>OK</vcn:ijresponse>
			<vcn:ijresponse_detail/>
		</ivec:param_set>
	</ivec:contents>
</cmd>
[pixma] *mp150_scan***** start scanning *****
[pixma] OUT  T=3.590 len=16
[pixma]  00000000:db 20 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] IN   T=3.591 len=8
[pixma]  00000000:06 06 00 00 00 00 00 00  
[pixma] 
[pixma] OUT  T=3.591 len=2072
[pixma]  00000000:ee 20 00 00 00 00 00 00  00 00 00 00 00 00 08 08 
[pixma]  00000010:10 00 08 04 00 00 0b 0b  0f 0f 12 12 15 15 17 17 
[pixma]  00000020:19 19 1a 1a 1c 1c 1e 1e  1f 1f 20 20 22 22 23 23 
[pixma]  00000030:24 24 25 25 27 27 28 28  29 29 2a 2a 2b 2b 2c 2c 
[pixma]  00000040:2d 2d 2d 2d 2e 2e 2f 2f  30 30 31 31 32 32 32 32 
[pixma]  00000050:33 33 34 34 35 35 36 36  36 36 37 37 38 38 38 38 
[pixma]  00000060:39 39 3a 3a 3a 3a 3b 3b  3c 3c 3c 3c 3d 3d 3e 3e 
[pixma]  00000070:3e 3e 3f 3f 3f 3f 40 40  41 41 41 41 42 42 42 42 
[pixma]  ...
[pixma] 
[pixma] IN   T=3.592 len=8
[pixma]  00000000:06 06 00 00 00 00 00 00  
[pixma] 
[pixma] OUT  T=3.593 len=2072
[pixma]  00000000:ee 20 00 00 00 00 00 00  00 00 00 00 00 00 08 08 
[pixma]  00000010:10 00 08 04 00 00 0b 0b  0f 0f 12 12 15 15 17 17 
[pixma]  00000020:19 19 1a 1a 1c 1c 1e 1e  1f 1f 20 20 22 22 23 23 
[pixma]  00000030:24 24 25 25 27 27 28 28  29 29 2a 2a 2b 2b 2c 2c 
[pixma]  00000040:2d 2d 2d 2d 2e 2e 2f 2f  30 30 31 31 32 32 32 32 
[pixma]  00000050:33 33 34 34 35 35 36 36  36 36 37 37 38 38 38 38 
[pixma]  00000060:39 39 3a 3a 3a 3a 3b 3b  3c 3c 3c 3c 3d 3d 3e 3e 
[pixma]  00000070:3e 3e 3f 3f 3f 3f 40 40  41 41 41 41 42 42 42 42 
[pixma]  ...
[pixma] 
[pixma] IN   T=3.594 len=8
[pixma]  00000000:06 06 00 00 00 00 00 00  
[pixma] 
[pixma] OUT  T=3.594 len=2072
[pixma]  00000000:ee 20 00 00 00 00 00 00  00 00 00 00 00 00 08 08 
[pixma]  00000010:10 00 08 04 00 00 0b 0b  0f 0f 12 12 15 15 17 17 
[pixma]  00000020:19 19 1a 1a 1c 1c 1e 1e  1f 1f 20 20 22 22 23 23 
[pixma]  00000030:24 24 25 25 27 27 28 28  29 29 2a 2a 2b 2b 2c 2c 
[pixma]  00000040:2d 2d 2d 2d 2e 2e 2f 2f  30 30 31 31 32 32 32 32 
[pixma]  00000050:33 33 34 34 35 35 36 36  36 36 37 37 38 38 38 38 
[pixma]  00000060:39 39 3a 3a 3a 3a 3b 3b  3c 3c 3c 3c 3d 3d 3e 3e 
[pixma]  00000070:3e 3e 3f 3f 3f 3f 40 40  41 41 41 41 42 42 42 42 
[pixma]  ...
[pixma] 
[pixma] IN   T=3.595 len=8
[pixma]  00000000:06 06 00 00 00 00 00 00  
[pixma] 
[pixma] OUT  T=3.595 len=72
[pixma]  00000000:d8 20 00 00 00 00 00 00  00 00 00 00 00 00 00 38 
[pixma]  00000010:01 01 01 00 00 01 00 00  80 4b 80 4b 00 00 00 00 
[pixma]  00000020:00 00 00 00 00 00 01 40  00 00 01 27 08 18 00 01 
[pixma]  00000030:ff 81 00 02 01 00 00 00  00 00 00 00 00 00 00 00 
[pixma]  00000040:01 00 00 00 00 00 00 58  
[pixma] 
[pixma] IN   T=3.596 len=8
[pixma]  00000000:06 06 00 00 00 00 00 00  
[pixma] 
[pixma] OUT  T=3.596 len=16
[pixma]  00000000:d9 20 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] IN   T=3.596 len=8
[pixma]  00000000:06 06 00 00 00 00 00 00  
[pixma] 
[pixma] OUT  T=3.596 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=3.597 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] INTR T=3.738 len=32
[pixma]  00000000:00 00 00 01 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma]  00000010:00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] OUT  T=3.738 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=3.738 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] INTR T=3.994 len=32
[pixma]  00000000:00 00 00 01 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma]  00000010:00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] OUT  T=3.994 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=3.994 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] OUT  T=4.997 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=4.997 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] OUT  T=6.000 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=6.000 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] OUT  T=7.002 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=7.003 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] OUT  T=8.006 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=8.006 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  02 00 00 00 00 00 00 fe 
[pixma] 
[pixma] OUT  T=9.009 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=9.010 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  02 00 00 00 00 00 00 fe 
[pixma] 
[pixma] OUT  T=10.012 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=10.013 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  02 00 00 00 00 00 00 fe 
[pixma] 
[pixma] OUT  T=11.015 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=11.016 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  02 00 00 00 00 00 00 fe 
[pixma] 
[pixma] OUT  T=12.018 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=12.019 len=16
[pixma]  00000000:06 06 00 00 00 00 00 00  02 00 00 00 00 00 00 fe 
[pixma] 
[pixma] OUT  T=13.021 len=16
[pixma]  00000000:da 20 00 00 00 00 00 00  00 00 00 00 00 00 00 08 
[pixma] 
[pixma] IN   T=13.022 len=8
[pixma]  00000000:15 15 00 00 00 00 00 00  
[pixma] 
[pixma] *mp150_finish_scan***** abort session  *****
[pixma] OUT  T=13.022 len=16
[pixma]  00000000:ef 20 00 00 00 00 00 00  00 00 00 00 00 00 00 00 
[pixma] 
[pixma] IN   T=13.022 len=8
[pixma]  00000000:06 06 00 00 00 00 00 00  
[pixma] 
[pixma] OUT  T=13.022 len=262
[pixma]  00000000:3c 3f 78 6d 6c 20 76 65  72 73 69 6f 6e 3d 22 31 
[pixma]  00000010:2e 30 22 20 65 6e 63 6f  64 69 6e 67 3d 22 75 74 
[pixma]  00000020:66 2d 38 22 20 3f 3e 3c  63 6d 64 20 78 6d 6c 6e 
[pixma]  00000030:73 3a 69 76 65 63 3d 22  68 74 74 70 3a 2f 2f 77 
[pixma]  00000040:77 77 2e 63 61 6e 6f 6e  2e 63 6f 6d 2f 6e 73 2f 
[pixma]  00000050:63 6d 64 2f 32 30 30 38  2f 30 37 2f 63 6f 6d 6d 
[pixma]  00000060:6f 6e 2f 22 3e 3c 69 76  65 63 3a 63 6f 6e 74 65 
[pixma]  00000070:6e 74 73 3e 3c 69 76 65  63 3a 6f 70 65 72 61 74 
[pixma]  ...
[pixma] 
[pixma] IN   T=13.024 len=363
[pixma]  00000000:3c 3f 78 6d 6c 20 76 65  72 73 69 6f 6e 3d 22 31 
[pixma]  00000010:2e 30 22 20 65 6e 63 6f  64 69 6e 67 3d 22 75 74 
[pixma]  00000020:66 2d 38 22 20 3f 3e 0d  0a 3c 63 6d 64 20 78 6d 
[pixma]  00000030:6c 6e 73 3a 69 76 65 63  3d 22 68 74 74 70 3a 2f 
[pixma]  00000040:2f 77 77 77 2e 63 61 6e  6f 6e 2e 63 6f 6d 2f 6e 
[pixma]  00000050:73 2f 63 6d 64 2f 32 30  30 38 2f 30 37 2f 63 6f 
[pixma]  00000060:6d 6d 6f 6e 2f 22 3e 0d  0a 09 3c 69 76 65 63 3a 
[pixma]  00000070:63 6f 6e 74 65 6e 74 73  3e 0d 0a 09 09 3c 69 76 
[pixma]  ...
[pixma] 
[pixma] XML message sent to scanner:
<?xml version="1.0" encoding="utf-8" ?><cmd xmlns:ivec="http://www.canon.com/ns/cmd/2008/07/common/"><ivec:contents><ivec:operation>EndJob</ivec:operation><ivec:param_set servicetype="scan"><ivec:jobID>00000001</ivec:jobID></ivec:param_set></ivec:contents></cmd>
[pixma] XML response back from scanner:
<?xml version="1.0" encoding="utf-8" ?>
<cmd xmlns:ivec="http://www.canon.com/ns/cmd/2008/07/common/">
	<ivec:contents>
		<ivec:operation>EndJobResponse</ivec:operation>
		<ivec:param_set servicetype="scan">
			<ivec:response>OK</ivec:response>
			<ivec:response_detail/>
			<ivec:jobID>00000001</ivec:jobID>
		</ivec:param_set>
	</ivec:contents>
</cmd>
[pixma] pixma_read_image(): cancelled by hardware
[pixma] Reader task terminated: ECANCELED
[pixma] read_image():reader task closed the pipe:0 bytes received, 261075 bytes expected
scanimage: sane_read: Operation was cancelled
[pixma] pixma_close(): Canon PIXMA MX370 Series


More information about the sane-devel mailing list