I [05/Oct/2009:08:13:10 +0200] Listening to ::1:631 (IPv6) I [05/Oct/2009:08:13:10 +0200] Listening to 127.0.0.1:631 (IPv4) I [05/Oct/2009:08:13:10 +0200] Listening to /var/run/cups/cups.sock (Domain) I [05/Oct/2009:08:13:10 +0200] Remote access is disabled. D [05/Oct/2009:08:13:10 +0200] Added auto ServerAlias wiesel I [05/Oct/2009:08:13:10 +0200] Loaded configuration file "/etc/cups/cupsd.conf" D [05/Oct/2009:08:13:10 +0200] Repairing ownership of "/var/run/cups" D [05/Oct/2009:08:13:10 +0200] Repairing ownership of "/var/run/cups/certs" D [05/Oct/2009:08:13:10 +0200] Repairing access permissions of "/var/run/cups/certs" I [05/Oct/2009:08:13:10 +0200] Using default TempDir of /var/spool/cups/tmp... I [05/Oct/2009:08:13:10 +0200] Configured for up to 100 clients. I [05/Oct/2009:08:13:10 +0200] Allowing up to 100 client connections per host. I [05/Oct/2009:08:13:10 +0200] Using policy "default" as the default! I [05/Oct/2009:08:13:10 +0200] Full reload is required. I [05/Oct/2009:08:13:10 +0200] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 38 types, 73 filters... D [05/Oct/2009:08:13:10 +0200] Loading printer FS-C5100DN... D [05/Oct/2009:08:13:11 +0200] load_ppd: Loading /var/cache/cups/FS-C5100DN.ipp... D [05/Oct/2009:08:13:11 +0200] cupsdRegisterPrinter(p=0xa25948(FS-C5100DN)) D [05/Oct/2009:08:13:11 +0200] load_ppd: Loading /var/cache/cups/FS-C5100DN.ipp... D [05/Oct/2009:08:13:11 +0200] cupsdRegisterPrinter(p=0xa25948(FS-C5100DN)) D [05/Oct/2009:08:13:11 +0200] cupsdLoadRemoteCache: Not loading remote cache. I [05/Oct/2009:08:13:11 +0200] Generating printcap /var/run/cups/printcap... I [05/Oct/2009:08:13:11 +0200] Loading job cache file "/var/cache/cups/job.cache"... D [05/Oct/2009:08:13:11 +0200] [Job 21] Loading from cache... D [05/Oct/2009:08:13:11 +0200] [Job 22] Loading from cache... D [05/Oct/2009:08:13:11 +0200] [Job 23] Loading from cache... D [05/Oct/2009:08:13:11 +0200] [Job 24] Loading from cache... D [05/Oct/2009:08:13:11 +0200] [Job 25] Loading from cache... D [05/Oct/2009:08:13:11 +0200] [Job 26] Loading from cache... D [05/Oct/2009:08:13:11 +0200] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)") D [05/Oct/2009:08:13:11 +0200] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)") D [05/Oct/2009:08:13:11 +0200] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)") D [05/Oct/2009:08:13:11 +0200] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)") I [05/Oct/2009:08:13:11 +0200] Full reload complete. I [05/Oct/2009:08:13:11 +0200] Cleaning out old temporary files in "/var/spool/cups/tmp"... E [05/Oct/2009:08:13:11 +0200] Unable to remove temporary file "/var/spool/cups/tmp/.fontconfig" - Is a directory I [05/Oct/2009:08:13:11 +0200] Listening to ::1:631 on fd 6... I [05/Oct/2009:08:13:11 +0200] Listening to 127.0.0.1:631 on fd 7... I [05/Oct/2009:08:13:11 +0200] Listening to /var/run/cups/cups.sock on fd 8... I [05/Oct/2009:08:13:11 +0200] Resuming new connection processing... D [05/Oct/2009:08:13:11 +0200] Discarding unused server-started event... D [05/Oct/2009:08:13:12 +0200] Report: clients=0 D [05/Oct/2009:08:13:12 +0200] Report: jobs=6 D [05/Oct/2009:08:13:12 +0200] Report: jobs-active=0 D [05/Oct/2009:08:13:12 +0200] Report: printers=1 D [05/Oct/2009:08:13:12 +0200] Report: printers-implicit=0 D [05/Oct/2009:08:13:12 +0200] Report: stringpool-string-count=313 D [05/Oct/2009:08:13:12 +0200] Report: stringpool-alloc-bytes=7112 D [05/Oct/2009:08:13:12 +0200] Report: stringpool-total-bytes=6840 D [05/Oct/2009:08:13:58 +0200] cupsdAcceptClient: 11 from localhost (Domain) D [05/Oct/2009:08:13:58 +0200] cupsdReadClient: 11 POST / HTTP/1.1 D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Active clients D [05/Oct/2009:08:13:58 +0200] cupsdAuthorize: No authentication data provided. D [05/Oct/2009:08:13:58 +0200] cupsdReadClient: 11 1.1 Get-Printer-Attributes 1 D [05/Oct/2009:08:13:58 +0200] Get-Printer-Attributes ipp://localhost:631/printers/HL-820 D [05/Oct/2009:08:13:58 +0200] Get-Printer-Attributes client-error-not-found: The printer or class was not found. D [05/Oct/2009:08:13:58 +0200] Returning IPP client-error-not-found for Get-Printer-Attributes (ipp://localhost:631/printers/HL-820) from localhost D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Not busy D [05/Oct/2009:08:13:58 +0200] cupsdReadClient: 11 POST / HTTP/1.1 D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Active clients D [05/Oct/2009:08:13:58 +0200] cupsdAuthorize: No authentication data provided. D [05/Oct/2009:08:13:58 +0200] cupsdReadClient: 11 1.1 CUPS-Get-Default 1 D [05/Oct/2009:08:13:58 +0200] CUPS-Get-Default D [05/Oct/2009:08:13:58 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Not busy D [05/Oct/2009:08:13:58 +0200] cupsdReadClient: 11 POST /printers/FS-C5100DN HTTP/1.1 D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Active clients D [05/Oct/2009:08:13:58 +0200] cupsdAuthorize: No authentication data provided. D [05/Oct/2009:08:13:58 +0200] cupsdReadClient: 11 1.1 Create-Job 1 D [05/Oct/2009:08:13:58 +0200] Create-Job ipp://localhost:631/printers/FS-C5100DN D [05/Oct/2009:08:13:58 +0200] cupsdMarkDirty(----J-) D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Active clients and dirty files D [05/Oct/2009:08:13:58 +0200] add_job: requesting-user-name="sam" I [05/Oct/2009:08:13:58 +0200] [Job 27] Adding start banner page "none". D [05/Oct/2009:08:13:58 +0200] cupsdMarkDirty(-----S) I [05/Oct/2009:08:13:58 +0200] [Job 27] Queued on "FS-C5100DN" by "sam". D [05/Oct/2009:08:13:58 +0200] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/FS-C5100DN) from localhost D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Dirty files D [05/Oct/2009:08:13:58 +0200] cupsdReadClient: 11 POST /printers/FS-C5100DN HTTP/1.1 D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Active clients and dirty files D [05/Oct/2009:08:13:58 +0200] cupsdAuthorize: No authentication data provided. D [05/Oct/2009:08:13:58 +0200] cupsdReadClient: 11 1.1 Send-Document 1 D [05/Oct/2009:08:13:58 +0200] Send-Document ipp://localhost:631/printers/FS-C5100DN D [05/Oct/2009:08:13:58 +0200] cupsdIsAuthorized: requesting-user-name="sam" D [05/Oct/2009:08:13:58 +0200] [Job 27] Auto-typing file... D [05/Oct/2009:08:13:58 +0200] [Job 27] Request file type is text/plain. D [05/Oct/2009:08:13:58 +0200] cupsdMarkDirty(----J-) I [05/Oct/2009:08:13:58 +0200] [Job 27] File of type text/plain queued by "sam". I [05/Oct/2009:08:13:58 +0200] [Job 27] Adding end banner page "none". D [05/Oct/2009:08:13:58 +0200] cupsdMarkDirty(----J-) D [05/Oct/2009:08:13:58 +0200] cupsdMarkDirty(----J-) D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Active clients, printing jobs, and dirty files D [05/Oct/2009:08:13:58 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:13:58 +0200] [Job 27] job-sheets=none,none D [05/Oct/2009:08:13:58 +0200] [Job 27] argv[0]="FS-C5100DN" D [05/Oct/2009:08:13:58 +0200] [Job 27] argv[1]="27" D [05/Oct/2009:08:13:58 +0200] [Job 27] argv[2]="sam" D [05/Oct/2009:08:13:58 +0200] [Job 27] argv[3]="fstab" D [05/Oct/2009:08:13:58 +0200] [Job 27] argv[4]="1" D [05/Oct/2009:08:13:58 +0200] [Job 27] argv[5]="finishings=3 media=iso_a4_210x297mm number-up=1 sides=one-sided job-uuid=urn:uuid:f015794d-5a8c-321d-63b0-bbb7b820fbcf job-originating-host-name=localhost" D [05/Oct/2009:08:13:58 +0200] [Job 27] argv[6]="/var/spool/cups/d00027-001" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[1]="CUPS_DATADIR=/usr/share/cups" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[6]="CUPS_SERVERROOT=/etc/cups" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[7]="CUPS_STATEDIR=/var/run/cups" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[8]="HOME=/var/spool/cups/tmp" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[10]="SERVER_ADMIN=root@wiesel" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[11]="SOFTWARE=CUPS/1.4.1" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[12]="TMPDIR=/var/spool/cups/tmp" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[13]="TZ=Europe/Berlin" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[14]="USER=root" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[16]="CUPS_ENCRYPTION=IfRequested" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[17]="IPP_PORT=631" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[18]="CHARSET=utf-8" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[19]="LANG=de_DE.UTF-8" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[20]="PPD=/etc/cups/ppd/FS-C5100DN.ppd" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[21]="RIP_MAX_CACHE=256649k" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[22]="CONTENT_TYPE=text/plain" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[23]="DEVICE_URI=lpd://192.168.0.100/PASSTHRU" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[24]="PRINTER_INFO=Kyocera Farblaser mit Duplexeinheit" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[25]="PRINTER_LOCATION=Schreibtisch" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[26]="PRINTER=FS-C5100DN" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[27]="CUPS_FILETYPE=document" D [05/Oct/2009:08:13:58 +0200] [Job 27] envp[28]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript" I [05/Oct/2009:08:13:58 +0200] [Job 27] Started filter /usr/lib/cups/filter/texttopdf (PID 2560) I [05/Oct/2009:08:13:58 +0200] [Job 27] Started filter /usr/lib/cups/filter/pdftopdf (PID 2561) I [05/Oct/2009:08:13:58 +0200] [Job 27] Started filter /usr/lib/cups/filter/cpdftocps (PID 2562) I [05/Oct/2009:08:13:58 +0200] [Job 27] Started backend /usr/lib/cups/backend/lpd (PID 2563) D [05/Oct/2009:08:13:58 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:13:58 +0200] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/FS-C5100DN) from localhost D [05/Oct/2009:08:13:58 +0200] cupsdSetBusyState: Printing jobs and dirty files D [05/Oct/2009:08:13:58 +0200] cupsdReadClient: 11 WAITING Closing on EOF D [05/Oct/2009:08:13:58 +0200] cupsdCloseClient: 11 D [05/Oct/2009:08:13:58 +0200] [Job 27] STATE: +connecting-to-device D [05/Oct/2009:08:13:58 +0200] [Job 27] Looking up "192.168.0.100"... D [05/Oct/2009:08:13:58 +0200] [Job 27] backendRunLoop(print_fd=-1, device_fd=6, snmp_fd=5, addr=0x9b28dc, use_bc=0, side_cb=0x7cf030) D [05/Oct/2009:08:13:58 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:13:58 +0200] [Job 27] Page = 595x842; 12,10 to 583,832 D [05/Oct/2009:08:13:59 +0200] [Job 27] pdftops argv[5] = 27 sam fstab 1 finishings=3 media=iso_a4_210x297mm number-up=1 sides=one-sided job-uuid=urn:uuid:f015794d-5a8c-321d-63b0-bbb7b820fbcf job-originating-host-name=localhost D [05/Oct/2009:08:13:59 +0200] [Job 27] PPD: /etc/cups/ppd/FS-C5100DN.ppd D [05/Oct/2009:08:13:59 +0200] [Job 27] /usr/bin/pdftops supports '-origpagesizes': yes D [05/Oct/2009:08:13:59 +0200] [Job 27] PostScript Level: 2 D [05/Oct/2009:08:13:59 +0200] [Job 27] Duplex: yes D [05/Oct/2009:08:13:59 +0200] [Job 27] Resolution: 600 D [05/Oct/2009:08:13:59 +0200] [Job 27] Page size: iso_a4_210x297mm D [05/Oct/2009:08:13:59 +0200] [Job 27] Width: , height: , absolute margins: 0, 0, , D [05/Oct/2009:08:13:59 +0200] [Job 27] Relative margins: , , , D [05/Oct/2009:08:13:59 +0200] [Job 27] PPD options: -level2 -origpagesizes -duplex D [05/Oct/2009:08:13:59 +0200] [Job 27] PostScript to be injected: D [05/Oct/2009:08:13:59 +0200] PID 2560 (/usr/lib/cups/filter/texttopdf) exited with no errors. D [05/Oct/2009:08:13:59 +0200] PID 2561 (/usr/lib/cups/filter/pdftopdf) exited with no errors. D [05/Oct/2009:08:14:00 +0200] [Job 27] Device copies: 1; device collate: D [05/Oct/2009:08:14:00 +0200] [Job 27] Running /usr/bin/pdftops -level2 -origpagesizes -duplex /var/spool/cups/tmp/pdftops.BIkN71 - D [05/Oct/2009:08:14:00 +0200] [Job 27] Running pstops '27' 'sam' 'fstab' '1' ' finishings=3 media=iso_a4_210x297mm sides=one-sided job-uuid=urn:uuid:f015794d-5a8c-321d-63b0-bbb7b820fbcf job-originating-host-name=localhost' D [05/Oct/2009:08:14:00 +0200] [Job 27] Page = 595x842; 12,10 to 583,832 D [05/Oct/2009:08:14:00 +0200] [Job 27] slow_collate=0, slow_duplex=0, slow_order=0 D [05/Oct/2009:08:14:00 +0200] [Job 27] Before copy_comments - %!PS-Adobe-3.0 D [05/Oct/2009:08:14:00 +0200] [Job 27] %!PS-Adobe-3.0 D [05/Oct/2009:08:14:00 +0200] [Job 27] %%LanguageLevel: 2 D [05/Oct/2009:08:14:00 +0200] [Job 27] %%DocumentSuppliedResources: (atend) D [05/Oct/2009:08:14:00 +0200] [Job 27] %%DocumentMedia: plain 595 842 0 () () D [05/Oct/2009:08:14:00 +0200] [Job 27] %%BoundingBox: 0 0 595 842 D [05/Oct/2009:08:14:00 +0200] [Job 27] %%Pages: 1 D [05/Oct/2009:08:14:00 +0200] [Job 27] %%EndComments D [05/Oct/2009:08:14:00 +0200] [Job 27] Before copy_prolog - %%BeginDefaults D [05/Oct/2009:08:14:00 +0200] [Job 27] Before copy_setup - %%BeginSetup D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] ATTR: marker-colors=#00FFFF,#FF00FF,#FFFF00,#000000,none D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(P-----) D [05/Oct/2009:08:14:00 +0200] [Job 27] ATTR: marker-names="TK-540CS","TK-540MS","TK-540YS","TK-540KS","Waste Toner Box" D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(P-----) D [05/Oct/2009:08:14:00 +0200] [Job 27] ATTR: marker-types=toner,toner,toner,toner,wasteToner D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(P-----) D [05/Oct/2009:08:14:00 +0200] [Job 27] ATTR: marker-levels=96,96,96,86,-1 D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(P-----) D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -media-low-report D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -media-empty-warning D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -toner-low-report D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -toner-empty-warning D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -door-open-report D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -media-jam-warning D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -input-tray-missing-warning D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -output-tray-missing-warning D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -marker-supply-missing-warning D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -output-area-almost-full-report D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -output-area-full-warning D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -media-empty-warning D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -offline-report I [05/Oct/2009:08:14:00 +0200] [Job 27] Drucker ist jetzt online. D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 4096 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 4096 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 4096 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 4096 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 4096 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 4096 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Before page loop - %%Page: 1 1 D [05/Oct/2009:08:14:00 +0200] [Job 27] Copying page 1... D [05/Oct/2009:08:14:00 +0200] [Job 27] PAGE: 1 1 D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... D [05/Oct/2009:08:14:00 +0200] [Job 27] pagew = 571.0, pagel = 822.0 D [05/Oct/2009:08:14:00 +0200] [Job 27] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842 D [05/Oct/2009:08:14:00 +0200] [Job 27] PageLeft = 12.0, PageRight = 583.0 D [05/Oct/2009:08:14:00 +0200] [Job 27] PageTop = 832.0, PageBottom = 10.0 D [05/Oct/2009:08:14:00 +0200] [Job 27] PageWidth = 595.0, PageLength = 842.0 D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 1 pages... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 8192 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Read 5135 bytes of print data... D [05/Oct/2009:08:14:00 +0200] [Job 27] Wrote 5135 bytes of print data... D [05/Oct/2009:08:14:00 +0200] PID 2562 (/usr/lib/cups/filter/cpdftocps) exited with no errors. D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: +connecting-to-device D [05/Oct/2009:08:14:00 +0200] [Job 27] Looking up "192.168.0.100"... D [05/Oct/2009:08:14:00 +0200] [Job 27] Connecting to 192.168.0.100:515 for printer PASSTHRU I [05/Oct/2009:08:14:00 +0200] [Job 27] Mit Drucker verbinden … D [05/Oct/2009:08:14:00 +0200] [Job 27] STATE: -connecting-to-device I [05/Oct/2009:08:14:00 +0200] [Job 27] Mit Drucker verbunden … D [05/Oct/2009:08:14:00 +0200] [Job 27] Connected to 192.168.0.100:515 (IPv4) (local port 1023)... D [05/Oct/2009:08:14:00 +0200] [Job 27] ATTR: marker-levels=96,96,96,85,-1 D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(P-----) D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... D [05/Oct/2009:08:14:00 +0200] [Job 27] lpd_command 02 PASSTHRU D [05/Oct/2009:08:14:00 +0200] [Job 27] Sending command string (10 bytes)... D [05/Oct/2009:08:14:00 +0200] [Job 27] Reading command status... D [05/Oct/2009:08:14:00 +0200] [Job 27] lpd_command returning 0 D [05/Oct/2009:08:14:00 +0200] [Job 27] Control file is: D [05/Oct/2009:08:14:00 +0200] [Job 27] Hwiesel D [05/Oct/2009:08:14:00 +0200] [Job 27] Psam D [05/Oct/2009:08:14:00 +0200] [Job 27] Jfstab D [05/Oct/2009:08:14:00 +0200] [Job 27] ldfA563wiesel D [05/Oct/2009:08:14:00 +0200] [Job 27] UdfA563wiesel D [05/Oct/2009:08:14:00 +0200] [Job 27] Nfstab D [05/Oct/2009:08:14:00 +0200] [Job 27] lpd_command 02 55 cfA563wiesel D [05/Oct/2009:08:14:00 +0200] [Job 27] Sending command string (17 bytes)... D [05/Oct/2009:08:14:00 +0200] [Job 27] Reading command status... D [05/Oct/2009:08:14:00 +0200] [Job 27] lpd_command returning 0 I [05/Oct/2009:08:14:00 +0200] [Job 27] Steuerungsdatei senden (55 Byte) D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] Steuerungsdatei erfolgreich übertragen D [05/Oct/2009:08:14:00 +0200] [Job 27] lpd_command 03 312335 dfA563wiesel D [05/Oct/2009:08:14:00 +0200] [Job 27] Sending command string (21 bytes)... D [05/Oct/2009:08:14:00 +0200] [Job 27] Reading command status... D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... D [05/Oct/2009:08:14:00 +0200] [Job 27] lpd_command returning 0 I [05/Oct/2009:08:14:00 +0200] [Job 27] Datendatei senden (312335 Byte) I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 0 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 10 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 21 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 31 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 42 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 52 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 63 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 73 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 84 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] LPR-Druckauftrag aufzeichnen, 94 % abgeschlossen … D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... I [05/Oct/2009:08:14:00 +0200] [Job 27] Datendatei erfolgreich übertragen D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] Discarding unused job-progress event... D [05/Oct/2009:08:14:00 +0200] [Job 27] ATTR: marker-levels=96,96,96,85,-1 D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(P-----) D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:00 +0200] PID 2563 (/usr/lib/cups/backend/lpd) exited with no errors. D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) I [05/Oct/2009:08:14:00 +0200] [Job 27] Job completed. D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(----J-) D [05/Oct/2009:08:14:00 +0200] cupsdMarkDirty(-----S) D [05/Oct/2009:08:14:01 +0200] [Job 27] Unloading... D [05/Oct/2009:08:14:01 +0200] cupsdAcceptClient: 14 from localhost (Domain) D [05/Oct/2009:08:14:01 +0200] cupsdReadClient: 14 POST / HTTP/1.1 D [05/Oct/2009:08:14:01 +0200] cupsdSetBusyState: Active clients and dirty files D [05/Oct/2009:08:14:01 +0200] cupsdAuthorize: No authentication data provided. D [05/Oct/2009:08:14:01 +0200] cupsdReadClient: 14 1.1 Get-Jobs 1 D [05/Oct/2009:08:14:01 +0200] Get-Jobs ipp://localhost/printers/ D [05/Oct/2009:08:14:01 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost D [05/Oct/2009:08:14:01 +0200] cupsdSetBusyState: Dirty files D [05/Oct/2009:08:14:01 +0200] cupsdReadClient: 14 WAITING Closing on EOF D [05/Oct/2009:08:14:01 +0200] cupsdCloseClient: 14 I [05/Oct/2009:08:14:29 +0200] Saving printers.conf... I [05/Oct/2009:08:14:29 +0200] Saving job cache file "/var/cache/cups/job.cache"... I [05/Oct/2009:08:14:29 +0200] Saving subscriptions.conf... D [05/Oct/2009:08:14:29 +0200] cupsdSetBusyState: Not busy D [05/Oct/2009:08:14:29 +0200] Report: clients=0 D [05/Oct/2009:08:14:29 +0200] Report: jobs=7 D [05/Oct/2009:08:14:29 +0200] Report: jobs-active=0 D [05/Oct/2009:08:14:29 +0200] Report: printers=1 D [05/Oct/2009:08:14:29 +0200] Report: printers-implicit=0 D [05/Oct/2009:08:14:29 +0200] Report: stringpool-string-count=2150 D [05/Oct/2009:08:14:29 +0200] Report: stringpool-alloc-bytes=8440 D [05/Oct/2009:08:14:29 +0200] Report: stringpool-total-bytes=46624