Package: cups-filters Version: 1.0.16-2 Severity: important
The cups package was removed and cups-filters purged. The fonts-liberation package was installed as the only TrueType font on the system. cups was re-installed. >From comment #55 in bug report #662660 I'd expect a text file to be printed >with the mono-spaced Liberation font. Using a backend similar to the one described in the cups-filters README the output file in /tmp was empty and the error_log (which is attached) reported "No usable font available". Adding the ttf-dejavu-core package restores the capability to print text files. Regards, Brian. -- System Information: Debian Release: wheezy/sid APT prefers unstable APT policy: (500, 'unstable') Architecture: i386 (i686) Kernel: Linux 3.2.0-2-686-pae (SMP w/1 CPU core) Locale: LANG=en_GB.UTF-8, LC_CTYPE=en_GB.UTF-8 (charmap=UTF-8) Shell: /bin/sh linked to /bin/dash Versions of packages cups-filters depends on: ii fonts-liberation 1.07.2-2 ii ghostscript 9.05~dfsg-4 ii libc6 2.13-30 ii libcups2 1.5.2-10 ii libcupsfilters1 1.0.16-2 ii libcupsimage2 1.5.2-10 ii libfontconfig1 2.8.0-3.1 ii libgcc1 1:4.7.0-3 ii libijs-0.35 0.35-8 ii liblcms2-2 2.2+git20110628-2.1 ii libpoppler13 0.16.7-3 ii libstdc++6 4.7.0-3 ii zlib1g 1:1.2.6.dfsg-2 Versions of packages cups-filters recommends: ii colord <none> ii foomatic-filters 4.0.15-1 ii ghostscript-cups 9.05~dfsg-4 Versions of packages cups-filters suggests: ii foomatic-db 20120322-1 -- no debconf information
I [22/Apr/2012:16:33:53 +0100] Saving job.cache... D [22/Apr/2012:16:33:53 +0100] [Job 697] Unloading... I [22/Apr/2012:16:33:53 +0100] Remote access is enabled. D [22/Apr/2012:16:33:53 +0100] Added auto ServerAlias dektop3 I [22/Apr/2012:16:33:53 +0100] Loaded configuration file "/etc/cups/cupsd.conf" I [22/Apr/2012:16:33:53 +0100] Using default TempDir of /var/spool/cups/tmp... I [22/Apr/2012:16:33:53 +0100] Configured for up to 100 clients. I [22/Apr/2012:16:33:53 +0100] Allowing up to 100 client connections per host. I [22/Apr/2012:16:33:53 +0100] Using policy "default" as the default. I [22/Apr/2012:16:33:53 +0100] Full reload is required. I [22/Apr/2012:16:33:53 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 38 types, 52 filters... D [22/Apr/2012:16:33:53 +0100] Loading printer CUPSout... D [22/Apr/2012:16:33:53 +0100] load_ppd: Loading /var/cache/cups/CUPSout.data... D [22/Apr/2012:16:33:53 +0100] Calling DeleteDevice(cups-CUPSout) D [22/Apr/2012:16:33:53 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files D [22/Apr/2012:16:33:53 +0100] Using profile id of CUPSout-Gray.. D [22/Apr/2012:16:33:53 +0100] Calling CreateProfile(CUPSout-Gray..,temp) W [22/Apr/2012:16:33:53 +0100] failed to CreateProfile: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files D [22/Apr/2012:16:33:53 +0100] Using profile id of CUPSout-CMYK.. D [22/Apr/2012:16:33:53 +0100] Calling CreateProfile(CUPSout-CMYK..,temp) W [22/Apr/2012:16:33:53 +0100] failed to CreateProfile: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files I [22/Apr/2012:16:33:53 +0100] Registering ICC color profiles for "CUPSout" D [22/Apr/2012:16:33:53 +0100] Calling CreateDevice(cups-CUPSout,temp) W [22/Apr/2012:16:33:53 +0100] failed to CreateDevice: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files D [22/Apr/2012:16:33:53 +0100] cupsdRegisterPrinter(p=0xb922dbb0(CUPSout)) D [22/Apr/2012:16:33:53 +0100] Loading printer PDFprinter... D [22/Apr/2012:16:33:53 +0100] load_ppd: Loading /var/cache/cups/PDFprinter.data... D [22/Apr/2012:16:33:53 +0100] Calling DeleteDevice(cups-PDFprinter) D [22/Apr/2012:16:33:53 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files D [22/Apr/2012:16:33:53 +0100] Using profile id of PDFprinter-Gray.. D [22/Apr/2012:16:33:53 +0100] Calling CreateProfile(PDFprinter-Gray..,temp) W [22/Apr/2012:16:33:53 +0100] failed to CreateProfile: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files D [22/Apr/2012:16:33:53 +0100] Using profile id of PDFprinter-CMYK.. D [22/Apr/2012:16:33:53 +0100] Calling CreateProfile(PDFprinter-CMYK..,temp) W [22/Apr/2012:16:33:53 +0100] failed to CreateProfile: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files I [22/Apr/2012:16:33:53 +0100] Registering ICC color profiles for "PDFprinter" D [22/Apr/2012:16:33:53 +0100] Calling CreateDevice(cups-PDFprinter,temp) W [22/Apr/2012:16:33:53 +0100] failed to CreateDevice: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files D [22/Apr/2012:16:33:53 +0100] cupsdRegisterPrinter(p=0xb9246470(PDFprinter)) D [22/Apr/2012:16:33:53 +0100] Loading printer testprinter... D [22/Apr/2012:16:33:53 +0100] load_ppd: Loading /var/cache/cups/testprinter.data... D [22/Apr/2012:16:33:53 +0100] Calling DeleteDevice(cups-testprinter) D [22/Apr/2012:16:33:53 +0100] failed to DeleteDevice: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files D [22/Apr/2012:16:33:53 +0100] Using profile id of testprinter-Gray.. D [22/Apr/2012:16:33:53 +0100] Calling CreateProfile(testprinter-Gray..,temp) W [22/Apr/2012:16:33:53 +0100] failed to CreateProfile: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files I [22/Apr/2012:16:33:53 +0100] Registering ICC color profiles for "testprinter" D [22/Apr/2012:16:33:53 +0100] Calling CreateDevice(cups-testprinter,temp) W [22/Apr/2012:16:33:53 +0100] failed to CreateDevice: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files D [22/Apr/2012:16:33:53 +0100] cupsdRegisterPrinter(p=0xb9247910(testprinter)) I [22/Apr/2012:16:33:53 +0100] Loading job cache file "/var/cache/cups/job.cache"... D [22/Apr/2012:16:33:53 +0100] [Job 504] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 505] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 506] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 507] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 508] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 509] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 510] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 511] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 512] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 513] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 514] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 515] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 516] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 517] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 518] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 519] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 520] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 521] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 522] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 523] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 524] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 525] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 526] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 527] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 528] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 529] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 530] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 531] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 532] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 533] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 534] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 535] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 536] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 537] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 538] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 539] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 540] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 541] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 542] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 543] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 544] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 545] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 546] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 547] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 548] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 549] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 550] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 551] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 552] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 553] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 554] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 555] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 556] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 557] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 558] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 559] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 560] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 561] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 562] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 563] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 564] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 565] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 566] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 567] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 568] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 569] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 570] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 571] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 572] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 573] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 574] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 575] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 576] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 577] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 578] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 579] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 580] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 581] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 582] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 583] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 584] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 585] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 586] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 587] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 588] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 589] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 590] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 591] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 592] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 593] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 594] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 595] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 596] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 597] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 598] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 599] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 600] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 601] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 602] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 603] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 604] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 605] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 606] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 607] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 608] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 609] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 610] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 611] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 612] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 613] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 614] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 615] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 616] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 617] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 618] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 619] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 620] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 621] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 622] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 623] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 624] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 625] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 626] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 627] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 628] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 629] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 630] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 631] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 632] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 633] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 634] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 635] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 636] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 637] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 638] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 639] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 640] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 641] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 642] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 643] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 644] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 645] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 646] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 647] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 648] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 649] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 650] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 651] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 652] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 653] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 654] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 655] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 656] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 657] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 658] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 659] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 660] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 661] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 662] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 663] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 664] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 665] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 666] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 667] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 668] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 669] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 670] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 671] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 672] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 673] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 674] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 675] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 676] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 677] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 678] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 679] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 680] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 681] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 682] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 683] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 684] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 685] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 686] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 687] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 688] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 689] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 690] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 691] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 692] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 693] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 695] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 696] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 696] Loading attributes... D [22/Apr/2012:16:33:53 +0100] [Job 697] Loading from cache... D [22/Apr/2012:16:33:53 +0100] [Job 697] Loading attributes... I [22/Apr/2012:16:33:53 +0100] Full reload complete. D [22/Apr/2012:16:33:53 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)") I [22/Apr/2012:16:33:53 +0100] Cleaning out old files in "/var/spool/cups/tmp"... D [22/Apr/2012:16:33:53 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp") I [22/Apr/2012:16:33:53 +0100] Cleaning out old files in "/var/cache/cups"... I [22/Apr/2012:16:33:53 +0100] Listening to 0.0.0.0:631 on fd 9... I [22/Apr/2012:16:33:53 +0100] Listening to [v1.::]:631 on fd 10... I [22/Apr/2012:16:33:53 +0100] Listening to /var/run/cups/cups.sock:631 on fd 11... I [22/Apr/2012:16:33:53 +0100] Resuming new connection processing... D [22/Apr/2012:16:33:53 +0100] Avahi client connecting D [22/Apr/2012:16:33:53 +0100] cupsdRegisterPrinter(p=0xb922dbb0(CUPSout)) D [22/Apr/2012:16:33:53 +0100] cupsdRegisterPrinter(p=0xb9246470(PDFprinter)) D [22/Apr/2012:16:33:53 +0100] cupsdRegisterPrinter(p=0xb9247910(testprinter)) D [22/Apr/2012:16:33:53 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy" D [22/Apr/2012:16:33:53 +0100] Discarding unused server-started event... D [22/Apr/2012:16:33:54 +0100] cupsdNetIFUpdate: "lo" = localhost:631 D [22/Apr/2012:16:33:54 +0100] cupsdNetIFUpdate: "wlan0" = 192.168.7.65:631 D [22/Apr/2012:16:33:54 +0100] cupsdNetIFUpdate: "lo" = localhost:631 D [22/Apr/2012:16:33:54 +0100] cupsdNetIFUpdate: "wlan0" = [v1.fe80::212:bfff:fe37:b7de+wlan0]:631 D [22/Apr/2012:16:33:54 +0100] Report: clients=0 D [22/Apr/2012:16:33:54 +0100] Report: jobs=193 D [22/Apr/2012:16:33:54 +0100] Report: jobs-active=2 D [22/Apr/2012:16:33:54 +0100] Report: printers=3 D [22/Apr/2012:16:33:54 +0100] Report: printers-implicit=0 D [22/Apr/2012:16:33:54 +0100] Report: stringpool-string-count=10318 D [22/Apr/2012:16:33:54 +0100] Report: stringpool-alloc-bytes=12784 D [22/Apr/2012:16:33:54 +0100] Report: stringpool-total-bytes=186480 D [22/Apr/2012:16:33:58 +0100] cupsdAcceptClient: 16 from localhost (Domain) D [22/Apr/2012:16:33:58 +0100] cupsdReadClient: 16 POST / HTTP/1.1 D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" D [22/Apr/2012:16:33:58 +0100] cupsdAuthorize: No authentication data provided. D [22/Apr/2012:16:33:58 +0100] cupsdReadClient: 16 1.1 Get-Printer-Attributes 1 D [22/Apr/2012:16:33:58 +0100] Get-Printer-Attributes ipp://localhost:631/printers/CUPSout D [22/Apr/2012:16:33:58 +0100] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/CUPSout) from localhost D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" D [22/Apr/2012:16:33:58 +0100] cupsdReadClient: 16 POST /printers/CUPSout HTTP/1.1 D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" D [22/Apr/2012:16:33:58 +0100] cupsdAuthorize: No authentication data provided. D [22/Apr/2012:16:33:58 +0100] cupsdReadClient: 16 1.1 Create-Job 1 D [22/Apr/2012:16:33:58 +0100] Create-Job ipp://localhost:631/printers/CUPSout D [22/Apr/2012:16:33:58 +0100] cupsdMarkDirty(----J-) D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients" D [22/Apr/2012:16:33:58 +0100] add_job: requesting-user-name="brian" I [22/Apr/2012:16:33:58 +0100] [Job 698] Adding start banner page "none". D [22/Apr/2012:16:33:58 +0100] Discarding unused job-created event... I [22/Apr/2012:16:33:58 +0100] [Job 698] Queued on "CUPSout" by "brian". D [22/Apr/2012:16:33:58 +0100] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/CUPSout) from localhost D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [22/Apr/2012:16:33:58 +0100] cupsdReadClient: 16 POST /printers/CUPSout HTTP/1.1 D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [22/Apr/2012:16:33:58 +0100] cupsdAuthorize: No authentication data provided. D [22/Apr/2012:16:33:58 +0100] cupsdReadClient: 16 1.1 Send-Document 1 D [22/Apr/2012:16:33:58 +0100] Send-Document ipp://localhost:631/printers/CUPSout D [22/Apr/2012:16:33:58 +0100] cupsdIsAuthorized: requesting-user-name="brian" D [22/Apr/2012:16:33:58 +0100] [Job 698] Auto-typing file... D [22/Apr/2012:16:33:58 +0100] [Job 698] Request file type is text/plain. D [22/Apr/2012:16:33:58 +0100] cupsdMarkDirty(----J-) D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" I [22/Apr/2012:16:33:58 +0100] [Job 698] File of type text/plain queued by "brian". I [22/Apr/2012:16:33:58 +0100] [Job 698] Adding end banner page "none". D [22/Apr/2012:16:33:58 +0100] cupsdMarkDirty(----J-) D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [22/Apr/2012:16:33:58 +0100] cupsdMarkDirty(----J-) D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [22/Apr/2012:16:33:58 +0100] Discarding unused printer-state-changed event... D [22/Apr/2012:16:33:58 +0100] [Job 698] job-sheets=none,none D [22/Apr/2012:16:33:58 +0100] [Job 698] argv[0]="CUPSout" D [22/Apr/2012:16:33:58 +0100] [Job 698] argv[1]="698" D [22/Apr/2012:16:33:58 +0100] [Job 698] argv[2]="brian" D [22/Apr/2012:16:33:58 +0100] [Job 698] argv[3]="mbox" D [22/Apr/2012:16:33:58 +0100] [Job 698] argv[4]="1" D [22/Apr/2012:16:33:58 +0100] [Job 698] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:3663ed79-9888-3d25-543f-75ff8fc58ab0 job-originating-host-name=localhost time-at-creation=1335108838 time-at-processing=1335108838 AP_D_InputSlot=" D [22/Apr/2012:16:33:58 +0100] [Job 698] argv[6]="/var/spool/cups/d00698-001" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[1]="CUPS_DATADIR=/usr/share/cups" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[6]="CUPS_SERVERROOT=/etc/cups" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[7]="CUPS_STATEDIR=/var/run/cups" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[8]="HOME=/var/spool/cups/tmp" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[10]="SERVER_ADMIN=root@dektop3" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[11]="SOFTWARE=CUPS/1.5.2" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[12]="TMPDIR=/var/spool/cups/tmp" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[13]="TZ=Europe/London" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[14]="USER=root" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[16]="CUPS_ENCRYPTION=IfRequested" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[17]="IPP_PORT=631" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[18]="CHARSET=utf-8" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[19]="LANG=en_GB.UTF-8" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[20]="PPD=/etc/cups/ppd/CUPSout.ppd" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[21]="RIP_MAX_CACHE=128m" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[22]="CONTENT_TYPE=text/plain" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[23]="DEVICE_URI=CUPSout:/tmp/CUPSout" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[24]="PRINTER_INFO=CUPSout" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[25]="PRINTER_LOCATION=" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[26]="PRINTER=CUPSout" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[27]="PRINTER_STATE_REASONS=none" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[28]="CUPS_FILETYPE=document" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-pdf" D [22/Apr/2012:16:33:58 +0100] [Job 698] envp[30]="AUTH_I****" I [22/Apr/2012:16:33:58 +0100] [Job 698] Started filter /usr/lib/cups/filter/texttopdf (PID 18543) I [22/Apr/2012:16:33:58 +0100] [Job 698] Started filter /usr/lib/cups/filter/pdftopdf (PID 18544) I [22/Apr/2012:16:33:58 +0100] [Job 698] Started backend /usr/lib/cups/backend/CUPSout (PID 18545) D [22/Apr/2012:16:33:58 +0100] Discarding unused job-state-changed event... D [22/Apr/2012:16:33:58 +0100] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/CUPSout) from localhost D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files" D [22/Apr/2012:16:33:58 +0100] cupsdReadClient: 16 WAITING Closing on EOF D [22/Apr/2012:16:33:58 +0100] cupsdCloseClient: 16 D [22/Apr/2012:16:33:58 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [22/Apr/2012:16:33:58 +0100] [Job 698] Page = 612x792; 18,36 to 594,756 D [22/Apr/2012:16:33:58 +0100] [Job 698] No viable font found W [22/Apr/2012:16:33:58 +0100] [Job 698] Ignored bad font "FreeMono" D [22/Apr/2012:16:33:58 +0100] [Job 698] Set job-printer-state-message to "Ignored bad font "FreeMono"", current level=WARN D [22/Apr/2012:16:33:58 +0100] Discarding unused job-progress event... D [22/Apr/2012:16:33:58 +0100] Discarding unused printer-state-changed event... D [22/Apr/2012:16:33:58 +0100] [Job 698] No viable font found W [22/Apr/2012:16:33:58 +0100] [Job 698] Ignored bad font "FreeMono" E [22/Apr/2012:16:33:58 +0100] [Job 698] No usable font available D [22/Apr/2012:16:33:58 +0100] [Job 698] Set job-printer-state-message to "No usable font available", current level=ERROR D [22/Apr/2012:16:33:58 +0100] Discarding unused job-progress event... D [22/Apr/2012:16:33:58 +0100] Discarding unused printer-state-changed event... E [22/Apr/2012:16:33:58 +0100] [Job 698] PDF file is damaged - attempting to reconstruct xref table... D [22/Apr/2012:16:33:58 +0100] Discarding unused job-progress event... D [22/Apr/2012:16:33:58 +0100] Discarding unused printer-state-changed event... E [22/Apr/2012:16:33:58 +0100] [Job 698] Couldn't find trailer dictionary D [22/Apr/2012:16:33:58 +0100] Discarding unused job-progress event... D [22/Apr/2012:16:33:58 +0100] Discarding unused printer-state-changed event... E [22/Apr/2012:16:33:58 +0100] [Job 698] Couldn't read xref table D [22/Apr/2012:16:33:58 +0100] Discarding unused job-progress event... D [22/Apr/2012:16:33:58 +0100] Discarding unused printer-state-changed event... D [22/Apr/2012:16:33:58 +0100] PID 18543 (/usr/lib/cups/filter/texttopdf) stopped with status 1. D [22/Apr/2012:16:33:58 +0100] PID 18544 (/usr/lib/cups/filter/pdftopdf) stopped with status 1. D [22/Apr/2012:16:33:59 +0100] PID 18545 (/usr/lib/cups/backend/CUPSout) exited with no errors. D [22/Apr/2012:16:33:59 +0100] Discarding unused job-state-changed event... E [22/Apr/2012:16:33:59 +0100] [Job 698] Job stopped due to filter errors; please consult the error_log file for details. D [22/Apr/2012:16:33:59 +0100] cupsdMarkDirty(----J-) D [22/Apr/2012:16:33:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [22/Apr/2012:16:33:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [22/Apr/2012:16:33:59 +0100] Discarding unused printer-state-changed event... D [22/Apr/2012:16:34:00 +0100] [Job 698] Unloading...
