So, jetzt habe ich den Drucker noch mal nach einer anderen Anleitung (http://linux.wikia.com/wiki/Getting_Canon_PIXMA_to_work_on_Linux) versucht zu installieren, und jetzt verändert sich das Error-Log schon deutlich.
Da wird systemseitig alles für den Druckjob zusammengebaut, aber am Ende konnte der Druckjob nicht "gesendet" werden, ich vermute doch ein Verbindungsproblem zum Drucker und kein Treiber-Problem:
[Job 34] Job held for 300 seconds since it could not be sent.
Wer so richtig Ahnung hat, kann ja gerne mal hier durchwühlen, das ist das Debug-Level Error-Log eines Druckjobs:
D [20/Apr/2014:22:48:02 +0200] [Job 34] Gutenprint: About to start printing loop.
D [20/Apr/2014:22:48:02 +0200] Report: clients=1
D [20/Apr/2014:22:48:02 +0200] Report: jobs=4
D [20/Apr/2014:22:48:02 +0200] Report: jobs-active=1
D [20/Apr/2014:22:48:02 +0200] Report: printers=4
D [20/Apr/2014:22:48:02 +0200] Report: stringpool-string-count=385325
D [20/Apr/2014:22:48:02 +0200] Report: stringpool-alloc-bytes=17400
D [20/Apr/2014:22:48:02 +0200] Report: stringpool-total-bytes=7207992
D [20/Apr/2014:22:48:02 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:02 +0200] [Job 34] Gutenprint: ================ Printing page 1 ================
D [20/Apr/2014:22:48:02 +0200] [Job 34] PAGE: 1 1
D [20/Apr/2014:22:48:03 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:03 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs"
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Initialize page
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Set special string ChannelBitDepth to 8
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Set special string PrintingMode to Color
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Set special string InputImageType to RGB
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Clear special parameter Resolution
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Set special parameter Quality to choice 1 (Standard)
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Set special string InputSlot to AutoSwitch
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Set special string MediaType to Plain
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: PageSize = 595x842
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Using page size A4 with (842, 595)
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Set special string PageSize to A4
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Set special string JobMode to Job
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Validating options
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Clearing string CDInnerRadius ((null))
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Clearing string Resolution ((null))
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Setting default string Resolution to 600x600dpi
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Clearing string STPIOutputType ((null))
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Setting default string STPIOutputType to (null)
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Done validating options
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: limits w 595 l 10 r 585 h 842 t 9 b 827
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: max limits l -8 r 603 t -6 b 857
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: left margin 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: right margin 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: top margin 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: bottom margin 0
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: CUPS settings w 4958 l 83 r 83 h 7016 t 75 b 125
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: adjusted w 4958 h 7016
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: End initialize page
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Interim page settings:
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: === BEGIN GUTENPRINT SETTINGS ===
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Driver: bjc-MG5300-series
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: L: 10 T: 9 W: 575 H: 818
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Page: 595x842
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Conversion: traditional
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (PageSize) (2) (String) [A4]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (MediaType) (2) (String) [Plain]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (InputSlot) (2) (String) [AutoSwitch]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (InkType) (2) (String) [CMYK]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (PrintingMode) (2) (String) [Color]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (InkSet) (2) (String) [None]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Duplex) (2) (String) [None]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Quality) (2) (String) [Standard]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (ColorCorrection) (2) (String) [None]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (ChannelBitDepth) (2) (String) [8]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (InputImageType) (2) (String) [RGB]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (DitherAlgorithm) (2) (String) [None]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (ImageType) (2) (String) [TextGraphics]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (JobMode) (2) (String) [Job]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Resolution) (2) (String) [600x600dpi]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (STPIRawChannels) (2) (Int) [1]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CUPSShrinkPage) (2) (Int) [1]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (FullBleed) (2) (Bool) [0]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (LinearContrast) (2) (Bool) [0]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Brightness) (2) (Double) [1,000000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Contrast) (2) (Double) [1,000000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Saturation) (2) (Double) [1,000000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (AppGamma) (2) (Double) [1,000000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CDOuterDiameter) (2) (Dimension) [329]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CDInnerDiameter) (2) (Dimension) [121]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CDXAdjustment) (2) (Dimension) [0]
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CDYAdjustment) (2) (Dimension) [0]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: === END GUTENPRINT SETTINGS ===
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Page data:
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: MediaClass = "AutoSwitch"
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: MediaColor = ""
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: MediaType = "Plain"
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: OutputType = ""
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: AdvanceDistance = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: AdvanceMedia = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Collate = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: CutMedia = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Duplex = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: HWResolution = [ 600 600 ]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: ImagingBoundingBox = [ 0 0 595 842 ]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: InsertSheet = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Jog = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: LeadingEdge = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Margins = [ 0 0 ]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: ManualFeed = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: MediaPosition = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: MediaWeight = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: MirrorPrint = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: NegativePrint = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: NumCopies = 1
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Orientation = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: OutputFaceUp = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: PageSize = [ 595 842 ]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Separations = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: TraySwitch = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Tumble = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsWidth = 4958
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsHeight = 7017
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cups->width = 4958
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cups->height = 7016
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cups->adjusted_width = 4958
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cups->adjusted_height = 7016
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsMediaType = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsBitsPerColor = 8
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsBitsPerPixel = 24
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsBytesPerLine = 14874
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsColorOrder = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsColorSpace = 1
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsCompression = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsRowCount = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsRowFeed = 2
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: cupsRowStep = 0
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: shrink page to fit 1
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: === BEGIN GUTENPRINT SETTINGS ===
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Driver: bjc-MG5300-series
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: L: 10 T: 9 W: 575 H: 818
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Page: 595x842
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Conversion: traditional
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (PageSize) (2) (String) [A4]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (MediaType) (2) (String) [Plain]
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (InputSlot) (2) (String) [AutoSwitch]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (InkType) (2) (String) [CMYK]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (PrintingMode) (2) (String) [Color]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (InkSet) (2) (String) [None]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Duplex) (2) (String) [None]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Quality) (2) (String) [Standard]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (ColorCorrection) (2) (String) [None]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (ChannelBitDepth) (2) (String) [8]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (InputImageType) (2) (String) [RGB]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (DitherAlgorithm) (2) (String) [None]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (ImageType) (2) (String) [TextGraphics]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (JobMode) (2) (String) [Job]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Resolution) (2) (String) [600x600dpi]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (STPIRawChannels) (2) (Int) [1]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CUPSShrinkPage) (2) (Int) [1]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (PageNumber) (2) (Int) [0]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (FullBleed) (2) (Bool) [0]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (LinearContrast) (2) (Bool) [0]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Brightness) (2) (Double) [0,700000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Contrast) (2) (Double) [1,700000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Saturation) (2) (Double) [1,000000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (AppGamma) (2) (Double) [1,000000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Gamma) (1) (Double) [1,111111]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (BlackGamma) (1) (Double) [0,600000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (Density) (1) (Double) [0,600000]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CDOuterDiameter) (2) (Dimension) [329]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CDInnerDiameter) (2) (Dimension) [121]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CDXAdjustment) (2) (Dimension) [0]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: (CDYAdjustment) (2) (Dimension) [0]
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: === END GUTENPRINT SETTINGS ===
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: End page data
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:03 +0200] [Job 34] Starting page 1...
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Image_height 7016
D [20/Apr/2014:22:48:03 +0200] [Job 34] Gutenprint: Image_width 4958
D [20/Apr/2014:22:48:03 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:03 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Apr/2014:22:48:03 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:03 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Apr/2014:22:48:03 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:04 +0200] [Client 14] GET /printers/CanonMG5300 HTTP/1.1
D [20/Apr/2014:22:48:04 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [20/Apr/2014:22:48:08 +0200] [Client 14] Authorized as ***** using Basic
D [20/Apr/2014:22:48:08 +0200] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc-root"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[10] = "SERVER_ADMIN=root@********"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[11] = "SOFTWARE=CUPS/1.7.2"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[13] = "USER=root"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[15] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[17] = "IPP_PORT=631"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[18] = "AUTH_TYPE=Basic"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[19] = "LANG=de_DE.UTF8"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[20] = "REDIRECT_STATUS=1"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[22] = "SERVER_NAME=localhost"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[23] = "SERVER_PORT=631"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[24] = "REMOTE_ADDR=127.0.0.1"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[25] = "REMOTE_HOST=localhost"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[26] = "SCRIPT_NAME=/printers/CanonMG5300"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc-root/printers/CanonMG5300"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[28] = "PATH_INFO=/CanonMG5300"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[29] = "REMOTE_USER=*****"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[30] = "SERVER_PROTOCOL=HTTP/1.1"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[31] = "HTTP_COOKIE=org.cups.sid=5bd3e9da0a9c28eabc8c21e92917ce45"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[32] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux i686) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/34.0.1847.116 Safari/537.36"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[33] = "HTTP_REFERER=http://localhost:631/printers/CanonMG5300"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[34] = "REQUEST_METHOD=GET"
D [20/Apr/2014:22:48:08 +0200] [CGI] envp[35] = "QUERY_STRING="
D [20/Apr/2014:22:48:09 +0200] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 15052)
I [20/Apr/2014:22:48:09 +0200] [Client 14] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=15052)
D [20/Apr/2014:22:48:09 +0200] [Client 14] file=15
D [20/Apr/2014:22:48:09 +0200] [Client 14] Waiting for CGI data.
D [20/Apr/2014:22:48:09 +0200] [Job 34] PID 15046 (/usr/lib/cups/filter/gstoraster) exited with no errors.
D [20/Apr/2014:22:48:09 +0200] [Job 34] PID 15047 (/usr/lib/cups/filter/rastertogutenprint.5.2) did not catch or ignore signal 13.
D [20/Apr/2014:22:48:09 +0200] [Job 34] PID 15048 (/usr/lib/cups/backend/cnijnet) stopped with status 1.
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:09 +0200] [Job 34] Gutenprint: Image_width 4958
D [20/Apr/2014:22:48:09 +0200] [Job 34] Gutenprint: Image_width 4958
D [20/Apr/2014:22:48:09 +0200] [Client 16] Accepted from localhost (Domain)
D [20/Apr/2014:22:48:09 +0200] [Client 16] Waiting for request.
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 1%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=1
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] [Client 16] POST / HTTP/1.1
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] [Client 16] No authentication data provided.
D [20/Apr/2014:22:48:09 +0200] [Client 16] 2.0 Get-Notifications 1782
D [20/Apr/2014:22:48:09 +0200] Get-Notifications /
D [20/Apr/2014:22:48:09 +0200] cupsdIsAuthorized: requesting-user-name="****"
D [20/Apr/2014:22:48:09 +0200] [Client 16] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [20/Apr/2014:22:48:09 +0200] [Client 16] Content-Length: 963
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 2%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=2
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=963, response=0xb9e3ca30(IPP_IDLE), pipe_pid=0, file=-1
D [20/Apr/2014:22:48:09 +0200] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [20/Apr/2014:22:48:09 +0200] [Client 16] bytes=0, http_state=0, data_remaining=0
D [20/Apr/2014:22:48:09 +0200] [Client 16] Waiting for request.
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 3%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=3
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 4%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=4
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 5%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=5
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 6%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=6
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 7%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=7
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 8%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=8
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 9%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=9
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 10%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=10
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 11%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=11
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 12%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=12
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 13%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=13
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 14%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=14
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 15%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=15
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 16%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=16
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:09 +0200] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [20/Apr/2014:22:48:09 +0200] [Client 16] Closing connection.
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 17%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=17
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 18%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=18
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 19%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=19
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Printing page 1, 20%
D [20/Apr/2014:22:48:09 +0200] [Job 34] ATTR: job-media-progress=20
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Processing page 2...
I [20/Apr/2014:22:48:09 +0200] [Job 34] Rendering completed
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.
I [20/Apr/2014:22:48:09 +0200] [Job 34] Backend returned status 1 (failed)
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
I [20/Apr/2014:22:48:09 +0200] [Job 34] Job held for 300 seconds since it could not be sent.
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(---J-)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsdMarkDirty(----S)
D [20/Apr/2014:22:48:09 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Apr/2014:22:48:09 +0200] cupsd is not idle any more, canceling shutdown.