[sane-devel] Delay with scanbd and sane

[Jan Gatzke]

Hi,

 
I am facing a strange problem when using scanbd. Scanbd is running on a raspberry pi. The pi is connected to a fujitsu scansnap s510. Sane has only the net backend enabled and scanbd uses the fujitsu backend. So far so good, I can scan locally or from a remote system without any problems. I am running a server which hosts my DMS and does OCR. I have configured scanbd to start a script which connects tot he DMS server and starts the scan there. So scanimage is running on the remote system. This works, too, but a 20 seconds delay is added. This is how it looks in the log:

 
Mar  2 23:04:08 raspberrypi scanbd: /usr/sbin/scanbd: stop_sane_threads

Mar  2 23:04:08 raspberrypi scanbd: /usr/sbin/scanbd: stop_sane_threads: an action is active, waiting ...

Mar  2 23:04:32 raspberrypi scanbm: /usr/sbin/scanbm: forking subprocess for saned

 
I don’t know which sane threads are ment. Saned is not running and there is only one client. Can somebody help, please?

 
Scanbd version is 1.4.4

Sane version is 1.0.25

 
 
Here ist he full log:

 
Mar  2 23:04:06 raspberrypi scanbd[856]: /usr/sbin/scanbd: trigger action for scan for device fujitsu:ScanSnap S510:7618 with script scan.script

Mar  2 23:04:06 raspberrypi scanbd[856]: /usr/sbin/scanbd: get_sane_option_value

Mar  2 23:04:06 raspberrypi scanbd[856]: /usr/sbin/scanbd: Value of mode as string (len 7, hash -621353420): Lineart

Mar  2 23:04:06 raspberrypi scanbd[856]: /usr/sbin/scanbd: setting env: SCANBD_FUNCTION_MODE=Lineart

Mar  2 23:04:06 raspberrypi scanbd[856]: /usr/sbin/scanbd: setting env: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin

Mar  2 23:04:06 raspberrypi scanbd[856]: /usr/sbin/scanbd: No PWD, setting env: PWD=/

Mar  2 23:04:06 raspberrypi scanbd[856]: /usr/sbin/scanbd: No USER, setting env: USER=saned

Mar  2 23:04:06 raspberrypi scanbd[856]: /usr/sbin/scanbd: No HOME, setting env: HOME=/var/lib/saned

Mar  2 23:04:06 raspberrypi scanbd: /usr/sbin/scanbd: waiting for child: /usr/share/scanbd/scripts/scan.script

Mar  2 23:04:06 raspberrypi scanbd: /usr/sbin/scanbd: exec for /usr/share/scanbd/scripts/scan.script

Mar  2 23:04:06 raspberrypi scanbd: /usr/sbin/scanbd: octal mode for /usr/share/scanbd/scripts/scan.script: 100755

Mar  2 23:04:06 raspberrypi scanbd: /usr/sbin/scanbd: uid: 0, gid: 0

Mar  2 23:04:06 raspberrypi scanbd: /usr/sbin/scanbd: Iteration on dbus call

Mar  2 23:04:07 raspberrypi scanbd[856]: /usr/sbin/scanbd: setting env: SCANBD_DEVICE=fujitsu:ScanSna################## Scanning ###################

Mar  2 23:04:07 raspberrypi scanbd: /usr/sbin/scanbd: Iteration on dbus call

Mar  2 23:04:07 raspberrypi systemd[1]: Starting Scanner Service (192.168.66.245:50962)...

Mar  2 23:04:07 raspberrypi systemd[1]: Started Scanner Service (192.168.66.245:50962).

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: We are called as scanbm - setting manager-mode

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: debug on: level: 5

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: Entering manager mode

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: dbus signal saned-start

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: dbus_init

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: dbus match type='signal',interface='org.freedesktop.Hal.Manager'

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: now sending signal saned_begin

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: manager mode: dbus

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: calling dbus method: aquire

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: dbus_call_method

Mar  2 23:04:07 raspberrypi scanbm: /usr/sbin/scanbm: waiting for reply

Mar  2 23:04:07 raspberrypi scanbd: /usr/sbin/scanbd: Iteration on dbus call

Mar  2 23:04:08 raspberrypi scanbd: /usr/sbin/scanbd: message_func

Mar  2 23:04:08 raspberrypi scanbd: /usr/sbin/scanbd: dbus_method_acquire

Mar  2 23:04:08 raspberrypi scanbd: /usr/sbin/scanbd: stop_sane_threads

Mar  2 23:04:08 raspberrypi scanbd: /usr/sbin/scanbd: stop_sane_threads: an action is active, waiting ...

Mar  2 23:04:32 raspberrypi scanbm: /usr/sbin/scanbm: forking subprocess for saned

Mar  2 23:04:32 raspberrypi scanbm: /usr/sbin/scanbm: waiting for saned

Mar  2 23:04:32 raspberrypi scanbm: /usr/sbin/scanbm: Setting environment: SANE_CONFIG_DIR=/etc/scanbd

Mar  2 23:04:32 raspberrypi saned[1112]: saned (AF-indep+IPv6) from sane-backends 1.0.25 starting up

Mar  2 23:04:32 raspberrypi saned[1112]: check_host: access by remote host: ::ffff:192.168.66.245

Mar  2 23:04:32 raspberrypi saned[1112]: init: access granted to root@::ffff:192.168.66.245

Mar  2 23:04:32 raspberrypi scanbd[856]: scanimage: rounded value of page-width from 210 to 210.01

Mar  2 23:04:32 raspberrypi scanbd[856]: scanimage: rounded value of page-height from 297 to 296.994

Mar  2 23:04:32 raspberrypi scanbd[856]: scanimage: rounded value of swskip from 6 to 6.00037

Mar  2 23:04:32 raspberrypi scanbd[856]: scanimage: rounded value of br-x from 210 to 210.01

Mar  2 23:04:32 raspberrypi scanbd[856]: scanimage: rounded value of br-y from 297 to 296.994

Mar  2 23:04:32 raspberrypi scanbd[856]: Scanning -1 pages, incrementing by 1, numbering from 100

Mar  2 23:04:32 raspberrypi scanbd[856]: Scanning page 100

Mar  2 23:04:41 raspberrypi scanbd[856]: Scanned page 100. (scanner status = 5)

Mar  2 23:04:41 raspberrypi scanbd[856]: Scanning page 101

Mar  2 23:04:43 raspberrypi scanbd[856]: Scanned page 101. (scanner status = 5)

Mar  2 23:04:43 raspberrypi scanbd[856]: Scanning page 102

Mar  2 23:04:43 raspberrypi scanbd[856]: scanimage: sane_start: Document feeder out of documents

Mar  2 23:04:43 raspberrypi saned[1112]: saned exiting

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.alioth.debian.org/pipermail/sane-devel/attachments/20170303/3bbeae3d/attachment.html>