Bug#497492: cupsd: Child exited on signal 13!

2008-09-02 Thread Martin Pitt
severity 497492 important
tag 497492 moreinfo
thanks

Hi Brian,

thank you for your report.

Brian May [2008-09-02 14:14 +1000]:
 Justification: renders package unusable

I downgraded the severity because it really does not affect everyone.

 It works fine in the foreground though:
 
 I tried downgrading to version 1.3.7-9 again, but it didn't seem to help

Ok, so it doesn't sound like another effect of
http://bugs.debian.org/494168 then.
 
 I don't think strace helps:
 
 [pid  3977] write(2, *** WARNING *** The program 'cups..., 89) = 89
 [...]
 [pid  3977] write(2, *** WARNING *** Please fix your a..., 76) = -1 EPIPE 
 (Broken pipe)
 [pid  3977] --- SIGPIPE (Broken pipe) @ 0 (0) ---
 [...]
 Process 3977 detached
 ... nanosleep resumed 0xbfe312e4) = ? ERESTART_RESTARTBLOCK (To be 
 restarted)
 --- SIGCHLD (Child exited) @ 0 (0) ---
 sigreturn() = ? (mask now [])
 wait4(-1, [{WIFSIGNALED(s)  WTERMSIG(s) == SIGPIPE}], 0, NULL) = 3977
 write(2, cupsd: Child exited on signal 13!..., 34cupsd: Child exited on 
 signal 13!
 
 ) = 34

This is actually quite insightful, thanks. The outer process
apparently can write to stderr (fd 2) just fine, but the subprocess
tries to write to stderr which fails. This is probably a filter or a
backend. The interesting bit is that neither *** WARNING nor Please
fix your appears anywhere in the cups source, so maybe you are using
a third-party driver?

How did you do the strace on the backend process, modified the init
script?

Can you please do:
 * rm /var/log/cups/error_log
 * set LogLevel debug in /etc/cups/cupsd.conf
 * try to start cups

and send me /var/log/cups/error_log and /etc/cups/cupsd.conf and
/etc/cups/printers.conf?

Thanks,

Martin

-- 
Martin Pitt| http://www.piware.de
Ubuntu Developer (www.ubuntu.com)  | Debian Developer  (www.debian.org)


signature.asc
Description: Digital signature


Bug#497492: cupsd: Child exited on signal 13!

2008-09-02 Thread Brian May

Martin Pitt wrote:

Ok, so it doesn't sound like another effect of
http://bugs.debian.org/494168 then.
  
Yes, the description in the title sounded different. I haven't read the 
details though.



This is actually quite insightful, thanks. The outer process
apparently can write to stderr (fd 2) just fine, but the subprocess
tries to write to stderr which fails. This is probably a filter or a
backend. The interesting bit is that neither *** WARNING nor Please
fix your appears anywhere in the cups source, so maybe you are using
a third-party driver?
  

I would assume it is all part of the following message:

sam lintory # /usr/sbin/cupsd -f 
*** WARNING *** The program 'cupsd' uses the Apple Bonjour compatibility layer of Avahi.

*** WARNING *** Please fix your application to use the native API of Avahi!
*** WARNING *** For more information see 
http://0pointer.de/avahi-compat?s=libdns_sde=cupsd


No, nothing related installed outside of Debian. Not that I know of anyway...



How did you do the strace on the backend process, modified the init
script?
  


strace -ff cupsd


Can you please do:
 * rm /var/log/cups/error_log
 * set LogLevel debug in /etc/cups/cupsd.conf
 * try to start cups

and send me /var/log/cups/error_log and /etc/cups/cupsd.conf and
/etc/cups/printers.conf?
  
I [02/Sep/2008:17:56:57 +1000] Saving job cache file 
/var/cache/cups/job.cache...

I [02/Sep/2008:17:57:04 +1000] Listening to :::631 (IPv6)
I [02/Sep/2008:17:57:04 +1000] Listening to 0.0.0.0:631 (IPv4)
I [02/Sep/2008:17:57:04 +1000] Listening to /var/run/cups/cups.sock (Domain)
I [02/Sep/2008:17:57:04 +1000] Loaded configuration file 
/etc/cups/cupsd.conf
I [02/Sep/2008:17:57:04 +1000] Using default TempDir of 
/var/spool/cups/tmp...

I [02/Sep/2008:17:57:04 +1000] Configured for up to 100 clients.
I [02/Sep/2008:17:57:04 +1000] Allowing up to 100 client connections per 
host.

I [02/Sep/2008:17:57:04 +1000] Using policy default as the default!
I [02/Sep/2008:17:57:04 +1000] Full reload is required.
I [02/Sep/2008:17:57:05 +1000] Loaded MIME database from '/etc/cups': 36 
types, 40 filters...

D [02/Sep/2008:17:57:05 +1000] Loading printer DellLaser-CfCP...

Hmmm. Maybe this is more significant when I run it with -F and it works:

I [02/Sep/2008:17:58:57 +1000] Listening to :::631 (IPv6)
I [02/Sep/2008:17:58:57 +1000] Listening to 0.0.0.0:631 (IPv4)
I [02/Sep/2008:17:58:57 +1000] Listening to /var/run/cups/cups.sock (Domain)
I [02/Sep/2008:17:58:57 +1000] Loaded configuration file 
/etc/cups/cupsd.conf
I [02/Sep/2008:17:58:57 +1000] Using default TempDir of 
/var/spool/cups/tmp...

I [02/Sep/2008:17:58:57 +1000] Configured for up to 100 clients.
I [02/Sep/2008:17:58:57 +1000] Allowing up to 100 client connections per 
host.

I [02/Sep/2008:17:58:57 +1000] Using policy default as the default!
I [02/Sep/2008:17:58:57 +1000] Full reload is required.
I [02/Sep/2008:17:58:57 +1000] Loaded MIME database from '/etc/cups': 36 
types, 40 filters...

D [02/Sep/2008:17:58:57 +1000] Loading printer DellLaser-CfCP...
W [02/Sep/2008:17:58:57 +1000] DNS-SD registration of DellLaser-CfCP 
failed with -65537

D [02/Sep/2008:17:58:57 +1000] Loading printer Fax-CfCP...
W [02/Sep/2008:17:58:57 +1000] DNS-SD registration of Fax-CfCP failed 
with -65537

D [02/Sep/2008:17:58:57 +1000] Loading printer Fax-Level1...
W [02/Sep/2008:17:58:57 +1000] DNS-SD registration of Fax-Level1 
failed with -65537

D [02/Sep/2008:17:58:57 +1000] Loading printer Fax-Level3...
W [02/Sep/2008:17:58:57 +1000] DNS-SD registration of Fax-Level3 
failed with -65537

D [02/Sep/2008:17:58:57 +1000] Loading printer Kyocera-Level3...
W [02/Sep/2008:17:58:57 +1000] DNS-SD registration of Kyocera-Level3 
failed with -65537

D [02/Sep/2008:17:58:57 +1000] Loading printer LaserJet-4350-Level3...
W [02/Sep/2008:17:58:57 +1000] DNS-SD registration of 
LaserJet-4350-Level3 failed with -65537

D [02/Sep/2008:17:58:57 +1000] Loading printer LaserJet-Level1...
W [02/Sep/2008:17:58:57 +1000] DNS-SD registration of LaserJet-Level1 
failed with -65537

D [02/Sep/2008:17:58:57 +1000] Loading printer LaserJet2300-Level3...
W [02/Sep/2008:17:58:57 +1000] DNS-SD registration of 
LaserJet2300-Level3 failed with -65537

D [02/Sep/2008:17:58:57 +1000] Loading printer Oki-C9500...
W [02/Sep/2008:17:58:57 +1000] DNS-SD registration of Oki-C9500 failed 
with -65537
I [02/Sep/2008:17:58:57 +1000] Loading job cache file 
/var/cache/cups/job.cache...

D [02/Sep/2008:17:58:57 +1000] [Job 9960] Loading from cache...

I have no idea what this error code -65537 is, what DNS-SD is, or if it 
is in anyway related. I am very suspicious in any case, it happens about 
the right point. Out of time now, will investigate again tomorrow.


Thanks

Brian May



--
To UNSUBSCRIBE, email to [EMAIL PROTECTED]
with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]



Bug#497492: cupsd: Child exited on signal 13!

2008-09-02 Thread Steve Cotton
 *** WARNING *** The program 'cupsd' uses the Apple Bonjour compatibility 
 layer of Avahi.
 ii  libavahi-compat-libdn 0.6.22-3   Avahi Apple Bonjour 
 compatibility 

That's where the error message is coming from, specifically
avahi-compat-libdns_sd/warn.c's avahi_warn_linkage().
It appears to be intended to trigger for anything using that API.

OTOH, for a packaged distribution like Debian I think a mass bug
filing would be more appropriate (against any package depending on
libavahi-compat-libdnssd1 ).

http://www.cups.org/str.php?L2655
The Avahi error that's already linked
http://ubuntuforums.org/showthread.php?t=862068
(I'm not going to set this as forwarded upstream, upstream
aren't going to fix it.)

Steve



-- 
To UNSUBSCRIBE, email to [EMAIL PROTECTED]
with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]



Bug#497492: cupsd: Child exited on signal 13!

2008-09-01 Thread Brian May
Package: cups
Version: 1.3.8-1
Severity: grave
Justification: renders package unusable

After upgrading to lenny (several weeks old) to lenny, cups won't start anymore.

sam lintory # /etc/init.d/cups restart
Restarting Common Unix Printing System: cupsdcupsd: Child exited on signal 13!
 failed!


It works fine in the foreground though:

sam lintory # /usr/sbin/cupsd -f 
*** WARNING *** The program 'cupsd' uses the Apple Bonjour compatibility layer 
of Avahi.
*** WARNING *** Please fix your application to use the native API of Avahi!
*** WARNING *** For more information see 
http://0pointer.de/avahi-compat?s=libdns_sde=cupsd


I tried downgrading to version 1.3.7-9 again, but it didn't seem to help


I don't think strace helps:

[pid  3977] open(/etc/cups/ppd/DellLaser-CfCP.ppd, O_RDONLY|O_LARGEFILE) = 4
[pid  3977] fcntl64(4, F_GETFD) = 0
[pid  3977] fcntl64(4, F_SETFD, FD_CLOEXEC) = 0
[pid  3977] read(4, *PPD-Adobe: \4.3\\n*%\n*% For infor..., 4096) = 4096
[pid  3977] read(4, eRegion 11x17/11x17: \/PageSize..., 4096) = 4096
[pid  3977] read(4, ous\n\n*OpenUI *PreFilter/GhostScri..., 4096) = 2953
[pid  3977] read(4, ..., 4096)= 0
[pid  3977] read(4, ..., 4096)= 0
[pid  3977] close(4)= 0
[pid  3977] access(/usr/lib/cups/filter/foomatic-rip, X_OK) = 0
[pid  3977] readlink(/proc/self/exe, /usr/sbin/cupsd..., 1023) = 15
[pid  3977] write(2, *** WARNING *** The program 'cups..., 89) = 89
[pid  3977] time(NULL)  = 1220327944
[pid  3977] stat64(/etc/localtime, {st_mode=S_IFREG|0644, st_size=2183, ...}) 
= 0
[pid  3977] socket(PF_FILE, SOCK_DGRAM, 0) = 4
[pid  3977] fcntl64(4, F_SETFD, FD_CLOEXEC) = 0
[pid  3977] connect(4, {sa_family=AF_FILE, path=/dev/log...}, 110) = 0
[pid  3977] send(4, 12Sep  2 13:59:04 cupsd[3977]: ..., 121, MSG_NOSIGNAL) 
= 121
[pid  3977] close(4)= 0
[pid  3977] write(2, *** WARNING *** Please fix your a..., 76) = -1 EPIPE 
(Broken pipe)
[pid  3977] --- SIGPIPE (Broken pipe) @ 0 (0) ---
Process 3977 detached
... nanosleep resumed 0xbfe312e4) = ? ERESTART_RESTARTBLOCK (To be 
restarted)
--- SIGCHLD (Child exited) @ 0 (0) ---
sigreturn() = ? (mask now [])
wait4(-1, [{WIFSIGNALED(s)  WTERMSIG(s) == SIGPIPE}], 0, NULL) = 3977
write(2, cupsd: Child exited on signal 13!..., 34cupsd: Child exited on 
signal 13!

) = 34
exit_group(3)   = ?


I tried gdb too, but so far can't get it to break at the right point (its been 
a while since I used
gdb - am I doing something wrong?):


sam lintory # gdb /usr/sbin/cupsd 
GNU gdb 6.8-debian
Copyright (C) 2008 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later http://gnu.org/licenses/gpl.html
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.  Type show copying
and show warranty for details.
This GDB was configured as i486-linux-gnu...
(no debugging symbols found)
(gdb) stop
(gdb) r
Starting program: /usr/sbin/cupsd 
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
[Thread debugging using libthread_db enabled]
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
(no debugging symbols found)
cupsd: Child exited on signal 13!

Program exited with code 03.
(gdb) bt
No stack.
(gdb) quit



-- System Information:
Debian Release: lenny/sid
  APT prefers testing
  APT policy: (200, 'testing')
Architecture: i386 (i686)

Kernel: Linux 2.6.16-xen (SMP w/1 CPU core)
Locale: LANG=en_AU.UTF-8, LC_CTYPE=en_AU.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/bash

Versions of packages cups depends on:
ii  adduser   3.110  add and remove users and groups
ii  cups-common   1.3.8-1Common UNIX Printing System(tm) - 
ii  debconf [debconf-2.0] 1.5.22 Debian configuration management sy
ii  ghostscript   8.62.dfsg.1-3  The GPL Ghostscript PostScript/PDF
ii  libavahi-compat-libdn 0.6.22-3   Avahi Apple Bonjour compatibility 
ii  libc6 2.7-13 GNU C Library: Shared libraries
ii  libcups2  1.3.8-1Common UNIX Printing System(tm) - 
ii  libcupsimage2 1.3.8-1