cups/cups-browsed causing delay in shutdown (16.04)

Uploaded a fixed package to xenial-proposed. As soon as it gets approved instructions for testing it will get posted here. Please test it and report back here as your feedback is required for the package getting into the official updates for Xenial.

For the SRU team: debdiff attached.

Hello Lucas, or anyone else affected,

Accepted cups-filters into xenial-proposed. The package will build now and be available at https://launchpad.net/ubuntu/+source/cups-filters/1.8.3-2ubuntu3.2 in a few hours, and then in the -proposed repository.

Please help us by testing this new package. See https://wiki.ubuntu.com/Testing/EnableProposed for documentation on how to enable and use -proposed.Your feedback will aid us getting this update out to other Ubuntu users.

If this package fixes the bug for you, please add a comment to this bug, mentioning the version of the package you tested, and change the tag from verification-needed to verification-done. If it does not fix the bug for you, please add a comment stating that, and change the tag to verification-failed. In either case, details of your testing will help us make a better decision.

Further information regarding the verification process can be found at https://wiki.ubuntu.com/QATeam/PerformingSRUVerification . Thank you in advance!

Hi,

I've tested cups-filters 1.8.3-2ubuntu3.2, but the problem (90 sec delay on shutdown) remains.

apt-cache policy cups-filters
cups-filters:
  Installiert: 1.8.3-2ubuntu3.2
  Installationskandidat: 1.8.3-2ubuntu3.2
  Versionstabelle:
 *** 1.8.3-2ubuntu3.2 500
        500 http://archive.ubuntu.com/ubuntu xenial-proposed/main amd64 Packages
        100 /var/lib/dpkg/status
     1.8.3-2ubuntu3.1 500
        500 http://ftp.hosteurope.de/mirror/archive.ubuntu.com/ubuntu xenial-updates/main amd64 Packages
     1.8.3-2ubuntu3 500
        500 http://ftp.hosteurope.de/mirror/archive.ubuntu.com/ubuntu xenial/main amd64 Packages

Greetings, Jan Gerrit

Hi,

thank you very much for the update. Unfortunately, it doesn't work for me either. I just tested it an hour ago.

cups-filters:
  Installed: 1.8.3-2ubuntu3.2
  Candidate: 1.8.3-2ubuntu3.2
  Version table:
 *** 1.8.3-2ubuntu3.2 500
        500 http://us.archive.ubuntu.com/ubuntu xenial-proposed/main amd64 Packages
        100 /var/lib/dpkg/status
     1.8.3-2ubuntu3.1 500
        500 http://us.archive.ubuntu.com/ubuntu xenial-updates/main amd64 Packages
     1.8.3-2ubuntu3 500
        500 http://us.archive.ubuntu.com/ubuntu xenial/main amd64 Packages

Please let me know if you need any more information.

Best,
Lucas

Everyone for whom the proposed package does not work, please attach the following files, one by one, not compressed, and not packaged together:

/etc/cups/cups-browsed.conf
/var/log/cups/cups-browsed_log
/var/log/cups/error_log
/lib/systemd/system/cups.service
/lib/systemd/system/cups-browsed.service

Did you restart CUPS at some point (while cups-browsed was still running)? For example via a "kill -HUP ..." or a "sudo systemctl restart cups"/"sudo systemctl reload cups"?

Please also post the output of "lpstat -v" with cups-browsed running and without cups-browsed running.

Hello,

please find attached the desired files. Unfortunately, there is no /var/log/cups/cups-browsed_log, but only a access_log. I attached this one instead in case it helps.

I never restarted cups, only the computer itself to test it.

Sorry for the spam. I couldn't figure out how to attach multiple files.

Sorry, cups-browsed did not have debug logging yet in 1.8.3. So there will be no /var/log/cups/cups-browsed_log.

To make cups-browsed logging, open a terminal and run the following commands:

cd
sudo systemctl stop cups-browsed
nohup sudo /usr/sbin/cups-browsed --debug > `pwd`/cups-browsed.log 2>&1 &

Reboot and after that attach the cups-browsed.log file here (should be in your home directory).

If the delay does not always happen, please attach a cups-browsed.log from a delayed shutdown and one from a shutdown where the delay did not happen.

Please find attached the the log file. Remember to start cups-browsed again via sudo systemctl start cups-browsed so that you are connected to the cups server once more.

The delayed shutdown always happens when I am connected to the network that has cups printers. When I am not connected to any cups server it is fine.

Hi Till,

don't know why, but if I stop cups-browsed and restart it (with the commands below), all work fine.
~> sudo systemctl stop cups-browsed
~> nohup sudo /usr/sbin/cups-browsed --debug > `pwd`/cups-browsed.log 2>&1 &

If I restart it with
~> sudo systemctl stop cups-browsed
~> sudo systemctl start cups-browsed
I've the 90 seconds delay again.

I have uploaded a new version of this SRU now, cups-filters_1.8.3-2ubuntu3.3, in addition to the first version it contains an additional fix against delayed shutdown, namely not scheduling failed operations for repeating during shutdown.

In addition, I have added a patch for optional time-stamped debug logging into a file. Thia should help to find the cause of delayed shutdowns if this SRU still does not solve the problem.

So please test this version as soon as it gets available in xenial-proposed and appropriately announced here in this bug report. As always your feedback is required to make this an official update for everyone.

In the case that you still suffer the delayed shutdowns with this version, please add a line

DebugLogging file

to /etc/cups/cups-browsed.conf and restart cups-browsed via

sudo systemctl stop cups-browsed
sudo systemctl start cups-browsed

If you observe the delayed shutdown again in the future, please attach your /var/log/cups/cups-browsed.conf file to this bug report. Thanks.

Attached is the debdiff of all changes to fix this bug, including the first version of this SRU and the updated version.

Hello Lucas, or anyone else affected,

Accepted cups-filters into xenial-proposed. The package will build now and be available at https://launchpad.net/ubuntu/+source/cups-filters/1.8.3-2ubuntu3.3 in a few hours, and then in the -proposed repository.

Please help us by testing this new package. See https://wiki.ubuntu.com/Testing/EnableProposed for documentation on how to enable and use -proposed.Your feedback will aid us getting this update out to other Ubuntu users.

If this package fixes the bug for you, please add a comment to this bug, mentioning the version of the package you tested, and change the tag from verification-needed to verification-done. If it does not fix the bug for you, please add a comment stating that, and change the tag to verification-failed. In either case, details of your testing will help us make a better decision.

Further information regarding the verification process can be found at https://wiki.ubuntu.com/QATeam/PerformingSRUVerification . Thank you in advance!

As a part of the Stable Release Updates quality process a search for Launchpad bug reports using the version of cups-filters from xenial-proposed was performed and bug 1670436 was found. Please investigate this bug report to ensure that a regression will not be created by this SRU. In the event that this is not a regression remove the "verification-failed" tag from this bug report and add the tag "bot-stop-nagging" to bug 1670436 (not this bug). Thanks!

As part of a recent change in the Stable Release Update verification policy we would like to inform that for a bug to be considered verified for a given release a verification-done-$RELEASE tag needs to be added to the bug where $RELEASE is the name of the series the package that was tested (e.g. verification-done-xenial). Please note that the global 'verification-done' tag can no longer be used for this purpose.

Thank you!