[sane-devel] Pixma MP600R times out after scan stats

Fri May 1 18:59:50 UTC 2009

hi again
I jad a look at the available logfile: 
Apparently everything goes right upto the point where we send a
de20/cmd_scan_param. The 4 bytes ack (confirming a packet of 0x40 bytes)
on the command is received back(T=6.240). 

We then expect to start read an 8 byte response from the scanner, so we
send a BJNP read request to the scanner and wait for a response, but
nothing arrives, not even a data header. 

Sp it would indeed be good to see a wireshark trace of the TCP/IP data
flow as well as a trace. Nicolas, would it normally be possible that a
response to de20 could take more than 20 seconds? I seem to recall that
timeouts in the past were in the order of seconds and less than 10
seconds,so I would guess that 20 seconds is way too long, right? 

kind regards, Louis

On Fri, 2009-05-01 at 19:33 +0200, Nicolas Martin wrote:
> Hi Phil, 
> 
> So probably this has to do with the bjnp part of the backend, I'll take
> contact with Louis, who designed this part, for some help.
> 
> In the meantime and to step further, could you get a full trace of the
> backend using these commands:
> 
> $ export SANE_DEBUG_PIXMA=11
> $ scanimage -T &> /tmp/pixmalog
> 
> and send back the /tmp/pixmalog file you get.
> 
> Nicolas
> 
> Le jeudi 30 avril 2009 à 23:46 +0200, Phil Wooding a écrit :
> > Hi Nicolas,
> > 
> > Thank you for your reply. Its most appreciated.
> > Yes, I can successfully scan with a USB cable.
> > As mentioned in the compatibility list, all resolutions work except
> > 2400 dpi.
> > However, over the network, it always times out...
> > Including command scanimage -T which outputs:
> > 
> > scanimage: scanning image of size 640x877 pixels at 24 bits/pixel
> > scanimage: acquiring RGB frame, 8 bits/sample
> > scanimage: reading one scanline, 1920 bytes...    [pixma]
> > bjnp_recv_header: (recv) could not read response header, received 0
> > bytes!
> > [pixma] bjnp_recv_header: (recv) error: Success!
> > [pixma] Could not read response to command!
> > [pixma] bjnp_recv_header: (recv) could not read response header,
> > received 0 bytes!
> > [pixma] bjnp_recv_header: (recv) error: Success!
> > [pixma] Could not read response to command!
> > FAIL Error: Error during device I/O
> > 
> > Do you have any ideas of something I can try?
> > 
> > PS : I won't be able to reply immediately.
> > 
> > Thanks,
> > 
> > Phil
> > 
> > > Subject: Re: [sane-devel] Pixma MP600R times out after scan stats
> > > Date: Sat, 25 Apr 2009 10:46:39 +0200
> > > 
> > > In order to facilitate investigations on this: do you successfully
> > scan
> > > with an usb cable ?
> > > 
> > > Nicolas
> > > 
> > > Le vendredi 24 avril 2009 à 23:30 +0200, Phil Wooding a écrit :
> > > > Hi,
> > > > 
> > > > I am trying to get the latest svn code working with a MP600R.
> > > > The scanner is properly detected, it starts scanning, but then
> > > > nothing...
> > > > Any help would be apreciated as it should work according to the
> > > > documentation.
> > > > 
> > > > Thanks,
> > > > 
> > > > Phil
> > > > 
> > > > Here are the logs with maximum debug information:
> > > > 
> > > > [pixma] bjnp_set_timeout(requested 10000, set 20000):
> > > > [pixma] bjnp_read_bulk(0, bufferptr, 0x8 = -1075284088)
> > > > [pixma] bjnp_read_bulk: 0x0 = 0 bytes available at start, Short
> > block
> > > > = 0 blocksize = 0x400 = 1024
> > > > [pixma] So far received 0x0 bytes = 0, need 0x8 = 8
> > > > [pixma] No (more) scanner data available, requesting more
> > > > [pixma] bjnp_send_read_req sending command
> > > > [pixma] 00000000:42 4a 4e 50 02 20 00 00 00 0b 00 09 00 00 00 00 
> > > > [pixma] bjnp_recv_header: receiving response header
> > > > [pixma] TCP response header(scanner data = 8 bytes):
> > > > [pixma] 00000000:42 4a 4e 50 82 20 00 00 00 0b 00 09 00 00 00 08 
> > > > [pixma] Scanner reports 0x8 = 8 bytes available
> > > > [pixma] reading 0x8 = 8 (of max 0x8 = 8) bytes more
> > > > [pixma] bjnp_recv_data: receiving response data
> > > > [pixma] bjnp_recv_data: read response payload (8 bytes max)
> > > > [pixma] Received TCP response payload (8 bytes):
> > > > [pixma] 00000000:06 06 00 00 00 00 00 00 
> > > > [pixma] IN T=6.235 len=8
> > > > [pixma] 00000000:06 06 00 00 00 00 00 00 
> > > > [pixma]
> > > > [pixma] bjnp_set_timeout(requested 10000, set 20000):
> > > > [pixma] bjnp_write_bulk(0, bufferptr, 0x40 = 64)
> > > > [pixma] bjnp_write: sending 0x40 = 64 bytes
> > > > [pixma] 00000000:42 4a 4e 50 02 21 00 00 00 0c 00 09 00 00 00 40 
> > > > [pixma] 00000010:de 20 00 00 00 00 00 00 00 00 00 00 00 00 00 30 
> > > > [pixma] 00000020:00 00 00 00 80 4b 80 4b 00 00 00 00 00 00 00 00 
> > > > [pixma] 00000030:00 00 02 80 00 00 03 6d 08 18 00 00 00 00 00 00 
> > > > [pixma] 00000040:ff 00 00 81 00 00 02 01 00 00 00 00 00 00 00 d5 
> > > > [pixma] bjnp_recv_header: receiving response header
> > > > [pixma] TCP response header(scanner data = 4 bytes):
> > > > [pixma] 00000000:42 4a 4e 50 82 21 00 00 00 0c 00 09 00 00 00 04 
> > > > [pixma] bjnp_recv_data: receiving response data
> > > > [pixma] bjnp_recv_data: read response payload (4 bytes max)
> > > > [pixma] Received TCP response payload (4 bytes):
> > > > [pixma] 00000000:00 00 00 40 
> > > > [pixma] OUT T=6.240 len=64
> > > > [pixma] 00000000:de 20 00 00 00 00 00 00 00 00 00 00 00 00 00 30 
> > > > [pixma] 00000010:00 00 00 00 80 4b 80 4b 00 00 00 00 00 00 00 00 
> > > > [pixma] 00000020:00 00 02 80 00 00 03 6d 08 18 00 00 00 00 00 00 
> > > > [pixma] 00000030:ff 00 00 81 00 00 02 01 00 00 00 00 00 00 00 d5 
> > > > [pixma] 
> > > > [pixma] bjnp_set_timeout(requested 10000, set 20000):
> > > > [pixma] bjnp_read_bulk(0, bufferptr, 0x8 = -1075284088)
> > > > [pixma] bjnp_read_bulk: 0x0 = 0 bytes available at start, Short
> > block
> > > > = 0 blocksize = 0x400 = 1024
> > > > [pixma] So far received 0x0 bytes = 0, need 0x8 = 8
> > > > [pixma] No (more) scanner data available, requesting more
> > > > [pixma] bjnp_send_read_req sending command
> > > > [pixma] 00000000:42 4a 4e 50 02 20 00 00 00 0d 00 09 00 00 00 00 
> > > > [pixma] bjnp_recv_header: receiving response header
> > > > [pixma] bjnp_recv_header: could not read response header (select
> > timed
> > > > out): Success!
> > > > [pixma] IN T=26.257 len=-9
> > > > [pixma] ERROR: ETIMEDOUT
> > > > 
> > > > 
> > > >
> > ______________________________________________________________________
> > > > What can you do with the new Windows Live? Find out
> > > > --
> > > > sane-devel mailing list: sane-devel at lists.alioth.debian.org
> > > > http://lists.alioth.debian.org/mailman/listinfo/sane-devel
> > > > Unsubscribe: Send mail with subject "unsubscribe your_password"
> > > > to sane-devel-request at lists.alioth.debian.org
> > > 
> > > 
> > 
> > 
> > ______________________________________________________________________
> > What can you do with the new Windows Live? Find out
> 
> 
> 
> --
> sane-devel mailing list: sane-devel at lists.alioth.debian.org
> http://lists.alioth.debian.org/mailman/listinfo/sane-devel
> Unsubscribe: Send mail with subject "unsubscribe your_password"
>              to sane-devel-request at lists.alioth.debian.org