[Samba] Printing with smbspool_krb5_wrapper not working in Ubuntu 16.04

Sat Aug 5 11:06:18 UTC 2017

Thanks for your reply! I have now filed a bug in launchpad (https://bugs.launchpad.net/ubuntu/+source/samba/+bug/1708817).

When I compare the cups error_log with 14.04 where it does work I see that 16.04 uses two backslashes when setting KRB5CCNAME while 14.04 does not use backslashes, maybe that is the problem?

Sometimes the cups error_log also have the below line "HTTP_STATE_WAITING Closing for error 32 (Broken pipe)" like I show below. Both this line and the line "Could not determine network interfaces, you must use a interfaces config line" maybe can give some idea on what goes wrong? The line "Printing jobs and dirty files" can maybe be ignored since it also shows up in 14.04 where it works.

D [05/Aug/2017:12:52:04 +0200] [Job 89] SMBSPOOL_KRB5 - Started with uid=0
D [05/Aug/2017:12:52:04 +0200] [Job 89] SMBSPOOL_KRB5 - AUTH_INFO_REQUIRED=negotiate
D [05/Aug/2017:12:52:04 +0200] [Job 89] SMBSPOOL_KRB5 - Switching to gid=1000
D [05/Aug/2017:12:52:04 +0200] [Job 89] SMBSPOOL_KRB5 - Switching to uid=1000
D [05/Aug/2017:12:52:04 +0200] [Job 89] SMBSPOOL_KRB5 - Setting KRB5CCNAME to \'FILE:/tmp/krb5cc_1000\'
D [05/Aug/2017:12:52:04 +0200] [Client 12] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [05/Aug/2017:12:52:04 +0200] [Client 12] Closing connection.
D [05/Aug/2017:12:52:04 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
E [05/Aug/2017:12:52:04 +0200] [Job 89] Could not determine network interfaces, you must use a interfaces config line

Thanks for any ideas!

Andreas Hasenack wrote:

> Unless somebody has an "aha!" moment and figures it out immediately, could
> you please file a bug in launchpad for this issue and attach the relevant
> config files and logs (for samba and cups)?
>
> On Fri, Aug 4, 2017 at 12:22 PM, Van Svensson wrote:
> 
> > Hello,
> >
> > I have two computers, one with Ubuntu 14.04 and one with Ubuntu 16.04. On
> > both computers I have configured the printer with cups to print by using my
> > Kerberos credential in the same way and it works in 14.04 but not on 16.04.
> >
> > For both /usr/bin/smbspool_krb5_wrapper is 700 and I have
> > "AuthInfoRequired negotiate" for both in /etc/cups/printers.conf. I have
> > made a symbolic link from /usr/lib/cups/backend/smb to
> > /usr/bin/smbspool_krb5_wrapper. I have set "LogLevel debug" in
> > /etc/cups/cupsd.conf.
> >
> > In 16.04 the print job just stays listed forever in "lpq" while it goes
> > through to the printer in 14.04.
> >
> > This is how it looks like in /var/log/cups/error_log in 16.04 where it
> > does not work (I have just changed my uid and gid to 1000):
> >
> > [...]
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] SMBSPOOL_KRB5 - Started with uid=0
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] SMBSPOOL_KRB5 -
> > AUTH_INFO_REQUIRED=negotiate
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] SMBSPOOL_KRB5 - Switching to
> > gid=1000
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] SMBSPOOL_KRB5 - Switching to
> > uid=1000
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] SMBSPOOL_KRB5 - Setting KRB5CCNAME
> > to \'FILE:/tmp/krb5cc_1000\'
> > E [04/Aug/2017:16:53:36 +0200] [Job 88] Could not determine network
> > interfaces, you must use a interfaces config line
> > D [04/Aug/2017:16:53:36 +0200] cupsdMarkDirty(---J-)
> > D [04/Aug/2017:16:53:36 +0200] cupsdSetBusyState: newbusy="Printing jobs
> > and dirty files", busy="Printing jobs and dirty files"
> > D [04/Aug/2017:16:53:36 +0200] cupsdMarkDirty(---J-)
> > D [04/Aug/2017:16:53:36 +0200] cupsdSetBusyState: newbusy="Printing jobs
> > and dirty files", busy="Printing jobs and dirty files"
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] Set job-printer-state-message to
> > "Could not determine network interfaces, you must use a interfaces config
> > line", current level=ERROR
> > D [04/Aug/2017:16:53:36 +0200] cupsdMarkDirty(----S)
> > D [04/Aug/2017:16:53:36 +0200] cupsdSetBusyState: newbusy="Printing jobs
> > and dirty files", busy="Printing jobs and dirty files"
> > D [04/Aug/2017:16:53:36 +0200] cupsdMarkDirty(----S)
> > D [04/Aug/2017:16:53:36 +0200] cupsdSetBusyState: newbusy="Printing jobs
> > and dirty files", busy="Printing jobs and dirty files"
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] state=3
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] JobProgress
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] state=3
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] state=3
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] state=3
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] PrinterStateChanged
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] state=3
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] state=3
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] PID 4534
> > (/usr/lib/cups/backend/smb) stopped with status 1.
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] Page = 612x792; 12,12 to 600,780
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] slow_collate=0, slow_duplex=0,
> > slow_order=0
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] Before copy_comments -
> > %!PS-Adobe-3.0
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] %!PS-Adobe-3.0
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] %%BoundingBox: 0 0 585 441
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] %%HiResBoundingBox: 0 0 585.00
> > 441.00
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] %%Creator: GPL Ghostscript 910
> > (ps2write)
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] %%LanguageLevel: 2
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] %%CreationDate:
> > D:20170804154259+02\'00\'
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] %%Pages: 1
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] %%EndComments
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] Before copy_prolog - %%BeginProlog
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] Before copy_setup - %%Page: 1 1
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] Before page loop - %%Page: 1 1
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] Copying page 1...
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] PAGE: 1 1
> > D [04/Aug/2017:16:53:36 +0200] cupsdMarkDirty(---J-)
> > D [04/Aug/2017:16:53:36 +0200] cupsdSetBusyState: newbusy="Printing jobs
> > and dirty files", busy="Printing jobs and dirty files"
> > D [04/Aug/2017:16:53:36 +0200] cupsdMarkDirty(---J-)
> > D [04/Aug/2017:16:53:36 +0200] cupsdSetBusyState: newbusy="Printing jobs
> > and dirty files", busy="Printing jobs and dirty files"
> > D [04/Aug/2017:16:53:36 +0200] cupsdMarkDirty(----S)
> > D [04/Aug/2017:16:53:36 +0200] cupsdSetBusyState: newbusy="Printing jobs
> > and dirty files", busy="Printing jobs and dirty files"
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] state=3
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] state=3
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] JobProgress
> > D [04/Aug/2017:16:53:36 +0200] [Notifier] state=3
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] pagew = 588.0, pagel = 768.0
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] bboxx = 0, bboxy = 0, bboxw = 612,
> > bboxl = 792
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] PageLeft = 12.0, PageRight = 600.0
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] PageTop = 780.0, PageBottom = 12.0
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] PageWidth = 612.0, PageLength =
> > 792.0
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] Wrote 1 pages...
> > D [04/Aug/2017:16:53:36 +0200] [Job 88] PID 4533
> > (/usr/lib/cups/filter/pstops) exited with no errors.
> > I [04/Aug/2017:16:53:36 +0200] [Job 88] Backend returned status 1 (failed)
> > [...]
> >
> > Can somebody please help me debug what is the problem in 16.04? Thank you
> > very much!
> >
> > --
> > To unsubscribe from this list go to the following URL and read the
> > instructions:  https://lists.samba.org/mailman/options/samba
> -- 
> To unsubscribe from this list go to the following URL and read the
> instructions:  https://lists.samba.org/mailman/options/samba