I [06/May/2009:11:45:48 +0300] Listening to ::1:631 (IPv6)
I [06/May/2009:11:45:48 +0300] Listening to 127.0.0.1:631 (IPv4)
I [06/May/2009:11:45:48 +0300] Listening to /var/run/cups/cups.sock (Domain)
I [06/May/2009:11:45:48 +0300] Loaded configuration file "/etc/cups/cupsd.conf"
I [06/May/2009:11:45:48 +0300] Using default TempDir of /var/spool/cups/tmp...
I [06/May/2009:11:45:48 +0300] Configured for up to 100 clients.
I [06/May/2009:11:45:48 +0300] Allowing up to 100 client connections per host.
I [06/May/2009:11:45:48 +0300] Using policy "default" as the default!
I [06/May/2009:11:45:48 +0300] Full reload is required.
I [06/May/2009:11:45:48 +0300] Saving job cache file "/var/cache/cups/job.cache"...
D [06/May/2009:11:45:48 +0300] Discarding unused printer-stopped event...
D [06/May/2009:11:45:48 +0300] Discarding unused printer-stopped event...
I [06/May/2009:11:45:48 +0300] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 37 types, 65 filters...
D [06/May/2009:11:45:48 +0300] Loading printer LBP5000...
D [06/May/2009:11:45:48 +0300] Loading printer LBP50002...
D [06/May/2009:11:45:48 +0300] cupsdLoadRemoteCache: Not loading remote cache.
I [06/May/2009:11:45:48 +0300] Loading job cache file "/var/cache/cups/job.cache"...
D [06/May/2009:11:45:48 +0300] [Job 1] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 2] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 3] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 4] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 5] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 6] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 7] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 8] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 9] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 10] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 11] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 12] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 13] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 14] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 15] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 16] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 17] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 18] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 19] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 20] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 21] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 22] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 23] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 24] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 25] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 26] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 27] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 28] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 29] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 30] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 31] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 32] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 33] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 34] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 35] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 36] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 37] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 38] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 39] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 40] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 41] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 42] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 43] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 44] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 45] Loading from cache...
D [06/May/2009:11:45:48 +0300] [Job 46] Loading from cache...
D [06/May/2009:11:45:48 +0300] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/May/2009:11:45:48 +0300] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
I [06/May/2009:11:45:48 +0300] Full reload complete.
I [06/May/2009:11:45:48 +0300] Listening to ::1:631 on fd 4...
I [06/May/2009:11:45:48 +0300] Listening to 127.0.0.1:631 on fd 5...
I [06/May/2009:11:45:48 +0300] Listening to /var/run/cups/cups.sock on fd 6...
I [06/May/2009:11:45:48 +0300] Resuming new connection processing...
D [06/May/2009:11:45:48 +0300] Discarding unused server-restarted event...
D [06/May/2009:11:45:49 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:11:45:49 +0300] cupsdAcceptClient: 10 from localhost (Domain)
D [06/May/2009:11:45:49 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:11:45:49 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:11:45:49 +0300] Get-Notifications /
D [06/May/2009:11:45:49 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:11:45:49 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:11:45:49 +0300] cupsdReadClient: 10 POST / HTTP/1.1
D [06/May/2009:11:45:49 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:11:45:49 +0300] Get-Jobs ipp://localhost/printers/
D [06/May/2009:11:45:49 +0300] cupsdProcessIPPRequest: 10 status_code=0 (successful-ok)
D [06/May/2009:11:45:49 +0300] cupsdCloseClient: 10
D [06/May/2009:11:45:49 +0300] cupsdCloseClient: 9
D [06/May/2009:12:28:47 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:28:47 +0300] Report: clients=1
D [06/May/2009:12:28:47 +0300] Report: jobs=46
D [06/May/2009:12:28:47 +0300] Report: jobs-active=0
D [06/May/2009:12:28:47 +0300] Report: printers=2
D [06/May/2009:12:28:47 +0300] Report: printers-implicit=0
D [06/May/2009:12:28:47 +0300] Report: stringpool-string-count=516
D [06/May/2009:12:28:47 +0300] Report: stringpool-alloc-bytes=7232
D [06/May/2009:12:28:47 +0300] Report: stringpool-total-bytes=9584
D [06/May/2009:12:28:47 +0300] cupsdReadClient: 9 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:28:47 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:28:47 +0300] cupsdIsAuthorized: username=""
D [06/May/2009:12:28:47 +0300] cupsdSendError: 9 code=401 (Unauthorized)
D [06/May/2009:12:28:47 +0300] cupsdSendHeader: WWW-Authenticate: Basic realm="CUPS"
D [06/May/2009:12:28:47 +0300] cupsdCloseClient: 9
D [06/May/2009:12:28:47 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:28:47 +0300] cupsdReadClient: 9 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:28:47 +0300] cupsdAuthorize: Authorized as root using Local
D [06/May/2009:12:28:47 +0300] cupsdIsAuthorized: username="root"
I [06/May/2009:12:28:47 +0300] Installing config file "/etc/cups/cupsd.conf"...
D [06/May/2009:12:28:47 +0300] cupsdSendError: 9 code=201 (Created)
D [06/May/2009:12:28:47 +0300] cupsdCloseClient: 9
D [06/May/2009:12:28:47 +0300] Saving remote.cache...
I [06/May/2009:12:28:47 +0300] Listening to ::1:631 (IPv6)
I [06/May/2009:12:28:47 +0300] Listening to 127.0.0.1:631 (IPv4)
I [06/May/2009:12:28:47 +0300] Listening to /var/run/cups/cups.sock (Domain)
I [06/May/2009:12:28:47 +0300] Loaded configuration file "/etc/cups/cupsd.conf"
I [06/May/2009:12:28:47 +0300] Using default TempDir of /var/spool/cups/tmp...
I [06/May/2009:12:28:47 +0300] Configured for up to 100 clients.
I [06/May/2009:12:28:47 +0300] Allowing up to 100 client connections per host.
I [06/May/2009:12:28:47 +0300] Using policy "default" as the default!
I [06/May/2009:12:28:47 +0300] Partial reload complete.
I [06/May/2009:12:28:47 +0300] Listening to ::1:631 on fd 3...
I [06/May/2009:12:28:47 +0300] Listening to 127.0.0.1:631 on fd 5...
I [06/May/2009:12:28:47 +0300] Listening to /var/run/cups/cups.sock on fd 6...
I [06/May/2009:12:28:47 +0300] Resuming new connection processing...
D [06/May/2009:12:28:47 +0300] Discarding unused server-restarted event...
D [06/May/2009:12:29:16 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:29:16 +0300] cupsdCloseClient: 9
D [06/May/2009:12:29:16 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:29:17 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:17 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:17 +0300] CUPS-Get-Printers
D [06/May/2009:12:29:17 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:17 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:29:17 +0300] cupsdCloseClient: 9
D [06/May/2009:12:29:17 +0300] cupsdReadClient: 11 GET /printers/LBP5000.ppd HTTP/1.1
D [06/May/2009:12:29:17 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:17 +0300] cupsdCloseClient: 11
D [06/May/2009:12:29:19 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:29:19 +0300] cupsdReadClient: 9 POST /printers/LBP5000 HTTP/1.1
D [06/May/2009:12:29:19 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:19 +0300] Print-Job ipp://localhost:631/printers/LBP5000
D [06/May/2009:12:29:19 +0300] [Job ???] Auto-typing file...
I [06/May/2009:12:29:19 +0300] [Job ???] Request file type is application/postscript.
D [06/May/2009:12:29:19 +0300] add_job: requesting-user-name="carlo"
I [06/May/2009:12:29:19 +0300] [Job 47] Adding start banner page "none".
I [06/May/2009:12:29:19 +0300] Saving subscriptions.conf...
I [06/May/2009:12:29:19 +0300] [Job 47] Adding end banner page "none".
I [06/May/2009:12:29:19 +0300] [Job 47] File of type application/postscript queued by "carlo".
D [06/May/2009:12:29:19 +0300] [Job 47] hold_until=0
I [06/May/2009:12:29:19 +0300] [Job 47] Queued on "LBP5000" by "carlo".
I [06/May/2009:12:29:19 +0300] Saving subscriptions.conf...
D [06/May/2009:12:29:19 +0300] [Job 47] job-sheets=none,none
D [06/May/2009:12:29:19 +0300] [Job 47] banner_page = 0
D [06/May/2009:12:29:19 +0300] [Job 47] argv[0]="LBP5000"
D [06/May/2009:12:29:19 +0300] [Job 47] argv[1]="47"
D [06/May/2009:12:29:19 +0300] [Job 47] argv[2]="carlo"
D [06/May/2009:12:29:19 +0300] [Job 47] argv[3]="TIVI-PROJEKTIEN JOHTAMINEN - Projektimallit ja läpivienti"
D [06/May/2009:12:29:19 +0300] [Job 47] argv[4]="1"
D [06/May/2009:12:29:19 +0300] [Job 47] argv[5]="noCNBackPaperPrint CNMTonerDensity=8 noCNDetectPaperSize MediaType=PlainPaper BindEdge=Left CNHalftone=pattern1 CNKeepGray=Standard PageSize=A4 CNSkipBlank number-up=1 noCNRotatePrint CNCTonerDensity=8 CNYTonerDensity=8 CNColorHalftone=pattern1 InputSlot=Auto CNTonerDensity=8 CNColorMode=Auto job-uuid=urn:uuid:2195b279-5e97-34a8-449b-a3b1493371a4"
D [06/May/2009:12:29:19 +0300] [Job 47] argv[6]="/var/spool/cups/d00047-001"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[9]="SERVER_ADMIN=root@carlo-desktop"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[10]="SOFTWARE=CUPS/1.3.9"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[12]="TZ=Europe/Helsinki"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[13]="USER=root"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[16]="IPP_PORT=631"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[17]="CHARSET=utf-8"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[18]="LANG=en_GB.UTF8"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[19]="PPD=/etc/cups/ppd/LBP5000.ppd"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[20]="RIP_MAX_CACHE=8m"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[21]="CONTENT_TYPE=application/postscript"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[22]="DEVICE_URI=ccp:/var/ccpd/fifo0"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[23]="PRINTER=LBP5000"
D [06/May/2009:12:29:19 +0300] [Job 47] envp[24]="FINAL_CONTENT_TYPE=printer/LBP5000"
I [06/May/2009:12:29:19 +0300] [Job 47] Started filter /usr/lib/cups/filter/pstopdf (PID 7100)
I [06/May/2009:12:29:19 +0300] [Job 47] Started filter /usr/lib/cups/filter/pdftopdf (PID 7101)
I [06/May/2009:12:29:19 +0300] [Job 47] Started filter /usr/lib/cups/filter/cpdftocps (PID 7102)
I [06/May/2009:12:29:19 +0300] [Job 47] Started filter /usr/lib/cups/filter/pstocapt2 (PID 7103)
I [06/May/2009:12:29:19 +0300] [Job 47] Started backend /usr/lib/cups/backend/ccp (PID 7104)
I [06/May/2009:12:29:19 +0300] Saving subscriptions.conf...
D [06/May/2009:12:29:19 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:19 +0300] [Job 47] pstopdf 6 args: 47 carlo TIVI-PROJEKTIEN JOHTAMINEN - Projektimallit ja läpivienti 1 noCNBackPaperPrint CNMTonerDensity=8 noCNDetectPaperSize MediaType=PlainPaper BindEdge=Left CNHalftone=pattern1 CNKeepGray=Standard PageSize=A4 CNSkipBlank number-up=1 noCNRotatePrint CNCTonerDensity=8 CNYTonerDensity=8 CNColorHalftone=pattern1 InputSlot=Auto CNTonerDensity=8 CNColorMode=Auto job-uuid=urn:uuid:2195b279-5e97-34a8-449b-a3b1493371a4 /var/spool/cups/d00047-001
D [06/May/2009:12:29:19 +0300] [Job 47] PPD: /etc/cups/ppd/LBP5000.ppd
D [06/May/2009:12:29:19 +0300] cupsdCloseClient: 9
D [06/May/2009:12:29:19 +0300] [Job 47] Resolution: 600
D [06/May/2009:12:29:19 +0300] [Job 47] Page size: A4
D [06/May/2009:12:29:19 +0300] [Job 47] pstocapt2 start.
D [06/May/2009:12:29:19 +0300] [Job 47] Width: , height: , absolute margins: , , , 
D [06/May/2009:12:29:19 +0300] [Job 47] Relative margins: , , , 
D [06/May/2009:12:29:19 +0300] [Job 47] PPD options: -r600
D [06/May/2009:12:29:19 +0300] [Job 47] PostScript to be injected: 
D [06/May/2009:12:29:19 +0300] [Job 47] Running cat | /usr/bin/ps2pdf13 -dAutoRotatePages=/None -dAutoFilterColorImages=false                -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode                -dDoNumCopies -dPDFSETTINGS=/printer -r600 - -
D [06/May/2009:12:29:19 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:29:19 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:19 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:19 +0300] Get-Jobs ipp://localhost/printers/
D [06/May/2009:12:29:19 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:19 +0300] cupsdCloseClient: 9
D [06/May/2009:12:29:19 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:29:19 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:19 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:19 +0300] Get-Notifications /
D [06/May/2009:12:29:19 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:29:19 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:19 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:29:19 +0300] cupsdReadClient: 11 POST / HTTP/1.1
D [06/May/2009:12:29:19 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:19 +0300] Get-Printer-Attributes ipp://localhost/printers/LBP5000
D [06/May/2009:12:29:19 +0300] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [06/May/2009:12:29:19 +0300] cupsdCloseClient: 9
D [06/May/2009:12:29:20 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:29:20 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:20 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:20 +0300] Create-Printer-Subscription /
D [06/May/2009:12:29:20 +0300] cupsdCreateSubscription(con=0xb9a48b58(9), uri="/")
D [06/May/2009:12:29:20 +0300] pullmethod="ippget"
D [06/May/2009:12:29:20 +0300] notify-lease-duration=86400
D [06/May/2009:12:29:20 +0300] notify-time-interval=0
D [06/May/2009:12:29:20 +0300] cupsdAddSubscription(mask=798f, dest=(nil)(), job=(nil)(0), uri="(null)")
D [06/May/2009:12:29:20 +0300] Added subscription 24 for server
I [06/May/2009:12:29:20 +0300] Saving subscriptions.conf...
D [06/May/2009:12:29:20 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:20 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:20 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:20 +0300] CUPS-Get-Printers
D [06/May/2009:12:29:20 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:20 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:20 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:20 +0300] CUPS-Get-Printers
D [06/May/2009:12:29:20 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:20 +0300] cupsdCloseClient: 9
D [06/May/2009:12:29:20 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:29:20 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:20 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:20 +0300] Get-Jobs ipp://localhost/printers/
D [06/May/2009:12:29:20 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:20 +0300] cupsdAcceptClient: 12 from localhost (Domain)
D [06/May/2009:12:29:20 +0300] cupsdReadClient: 12 POST / HTTP/1.1
D [06/May/2009:12:29:20 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:20 +0300] Get-Printer-Attributes ipp://carlo-desktop:631/printers/LBP5000
D [06/May/2009:12:29:20 +0300] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [06/May/2009:12:29:20 +0300] cupsdCloseClient: 12
D [06/May/2009:12:29:20 +0300] cupsdCloseClient: 9
D [06/May/2009:12:29:20 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:29:20 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:20 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:20 +0300] Get-Jobs ipp://localhost/printers/
D [06/May/2009:12:29:20 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:20 +0300] cupsdCloseClient: 9
D [06/May/2009:12:29:20 +0300] [Job 47] GPL Ghostscript 8.64: Set UseCIEColor for UseDeviceIndependentColor to work properly.
D [06/May/2009:12:29:21 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:29:21 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:21 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:21 +0300] Get-Notifications /
D [06/May/2009:12:29:21 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:29:21 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:21 +0300] cupsdCloseClient: 9
D [06/May/2009:12:29:21 +0300] PID 7100 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [06/May/2009:12:29:22 +0300] PID 7101 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [06/May/2009:12:29:22 +0300] [Job 47] Device copies: 1; device collate: 
D [06/May/2009:12:29:22 +0300] [Job 47] pdftops - copying to temp print file "/tmp/4a01587216ba4"
D [06/May/2009:12:29:22 +0300] [Job 47] Page = 595x842; 14,14 to 581,828
D [06/May/2009:12:29:22 +0300] [Job 47] slow_collate=0, slow_duplex=0, slow_order=0
D [06/May/2009:12:29:22 +0300] [Job 47] Before copy_comments - %!PS-Adobe-3.0
D [06/May/2009:12:29:22 +0300] [Job 47] %!PS-Adobe-3.0
D [06/May/2009:12:29:22 +0300] [Job 47] %%Pages: (atend)
D [06/May/2009:12:29:22 +0300] [Job 47] %%BoundingBox: (atend)
D [06/May/2009:12:29:22 +0300] [Job 47] %%HiResBoundingBox: (atend)
D [06/May/2009:12:29:22 +0300] [Job 47] %%Creator: GPL Ghostscript 864 (pswrite)
D [06/May/2009:12:29:22 +0300] [Job 47] %%CreationDate: 2009/05/06 12:29:22
D [06/May/2009:12:29:22 +0300] [Job 47] %%DocumentData: Clean7Bit
D [06/May/2009:12:29:22 +0300] [Job 47] %%LanguageLevel: 3
D [06/May/2009:12:29:22 +0300] [Job 47] %%EndComments
D [06/May/2009:12:29:22 +0300] [Job 47] Before copy_prolog - %%BeginProlog
D [06/May/2009:12:29:22 +0300] [Job 47] Before copy_setup - %%Page: 1 1
D [06/May/2009:12:29:22 +0300] [Job 47] Before page loop - %%Page: 1 1
D [06/May/2009:12:29:22 +0300] [Job 47] Copying page 1...
D [06/May/2009:12:29:22 +0300] [Job 47] pagew = 566.2, pagel = 813.2
D [06/May/2009:12:29:22 +0300] [Job 47] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [06/May/2009:12:29:22 +0300] [Job 47] PageLeft = 14.4, PageRight = 580.6
D [06/May/2009:12:29:22 +0300] [Job 47] PageTop = 827.6, PageBottom = 14.4
D [06/May/2009:12:29:22 +0300] [Job 47] PageWidth = 595.0, PageLength = 842.0
D [06/May/2009:12:29:22 +0300] [Job 47] Copying page 2...
D [06/May/2009:12:29:22 +0300] [Job 47] pagew = 566.2, pagel = 813.2
D [06/May/2009:12:29:22 +0300] [Job 47] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [06/May/2009:12:29:22 +0300] [Job 47] PageLeft = 14.4, PageRight = 580.6
D [06/May/2009:12:29:22 +0300] [Job 47] PageTop = 827.6, PageBottom = 14.4
D [06/May/2009:12:29:22 +0300] [Job 47] PageWidth = 595.0, PageLength = 842.0
D [06/May/2009:12:29:22 +0300] [Job 47] Copying page 3...
D [06/May/2009:12:29:22 +0300] [Job 47] pagew = 566.2, pagel = 813.2
D [06/May/2009:12:29:22 +0300] [Job 47] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [06/May/2009:12:29:22 +0300] [Job 47] PageLeft = 14.4, PageRight = 580.6
D [06/May/2009:12:29:22 +0300] [Job 47] PageTop = 827.6, PageBottom = 14.4
D [06/May/2009:12:29:22 +0300] [Job 47] PageWidth = 595.0, PageLength = 842.0
D [06/May/2009:12:29:22 +0300] [Job 47] CNDefaultCS=RGB
D [06/May/2009:12:29:22 +0300] [Job 47] MediaCopy=1
D [06/May/2009:12:29:22 +0300] [Job 47] DeviceResolution=deviceResolution_600x600
D [06/May/2009:12:29:22 +0300] [Job 47] MediaPageRotation=portrait
D [06/May/2009:12:29:22 +0300] [Job 47] MediaSize=iso_a4_210x297mm
D [06/May/2009:12:29:22 +0300] cupsdAcceptClient: 9 from localhost:631 (IPv6)
D [06/May/2009:12:29:22 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:29:22 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:22 +0300] Get-Jobs ipp://localhost/printers/LBP5000
D [06/May/2009:12:29:22 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:29:22 +0300] [Job 47] Copying page 4...
D [06/May/2009:12:29:22 +0300] [Job 47] pagew = 566.2, pagel = 813.2
D [06/May/2009:12:29:22 +0300] [Job 47] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [06/May/2009:12:29:22 +0300] [Job 47] PageLeft = 14.4, PageRight = 580.6
D [06/May/2009:12:29:22 +0300] [Job 47] PageTop = 827.6, PageBottom = 14.4
D [06/May/2009:12:29:22 +0300] [Job 47] PageWidth = 595.0, PageLength = 842.0
D [06/May/2009:12:29:22 +0300] [Job 47] Wrote 4 pages...
D [06/May/2009:12:29:22 +0300] PID 7102 (/usr/lib/cups/filter/cpdftocps) exited with no errors.
D [06/May/2009:12:29:26 +0300] [Job 47] GPL Ghostscript 8.64: Unrecoverable error, exit code 1
E [06/May/2009:12:29:26 +0300] [Job 47] pstocapt2 write error,32.
D [06/May/2009:12:29:26 +0300] [Job 47] ccp: last data.
I [06/May/2009:12:29:26 +0300] Saving subscriptions.conf...
E [06/May/2009:12:29:26 +0300] PID 7103 (/usr/lib/cups/filter/pstocapt2) stopped with status 1!
D [06/May/2009:12:29:26 +0300] PID 7104 (/usr/lib/cups/backend/ccp) exited with no errors.
D [06/May/2009:12:29:26 +0300] [Job 47] ccp: end of send data.
D [06/May/2009:12:29:26 +0300] [Job 47] File 0 is complete.
E [06/May/2009:12:29:26 +0300] [Job 47] Job stopped due to filter errors.
I [06/May/2009:12:29:26 +0300] Saving subscriptions.conf...
I [06/May/2009:12:29:26 +0300] Saving subscriptions.conf...
D [06/May/2009:12:29:26 +0300] cupsdAcceptClient: 12 from localhost (Domain)
D [06/May/2009:12:29:26 +0300] cupsdAcceptClient: 13 from localhost (Domain)
D [06/May/2009:12:29:26 +0300] cupsdReadClient: 12 POST / HTTP/1.1
D [06/May/2009:12:29:26 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:26 +0300] Get-Jobs ipp://localhost/printers/
D [06/May/2009:12:29:26 +0300] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [06/May/2009:12:29:26 +0300] cupsdReadClient: 13 POST / HTTP/1.1
D [06/May/2009:12:29:26 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:26 +0300] Get-Notifications /
D [06/May/2009:12:29:26 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:29:26 +0300] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
D [06/May/2009:12:29:26 +0300] cupsdCloseClient: 12
D [06/May/2009:12:29:26 +0300] cupsdReadClient: 11 POST / HTTP/1.1
D [06/May/2009:12:29:26 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:26 +0300] Get-Printer-Attributes ipp://localhost/printers/LBP5000
D [06/May/2009:12:29:26 +0300] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [06/May/2009:12:29:26 +0300] cupsdAcceptClient: 12 from localhost (Domain)
D [06/May/2009:12:29:26 +0300] cupsdReadClient: 12 POST / HTTP/1.1
D [06/May/2009:12:29:26 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:26 +0300] Get-Notifications /
D [06/May/2009:12:29:26 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:29:26 +0300] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [06/May/2009:12:29:26 +0300] cupsdAcceptClient: 14 from localhost (Domain)
D [06/May/2009:12:29:26 +0300] cupsdReadClient: 14 POST / HTTP/1.1
D [06/May/2009:12:29:26 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:26 +0300] Get-Printer-Attributes ipp://carlo-desktop:631/printers/LBP5000
D [06/May/2009:12:29:26 +0300] cupsdProcessIPPRequest: 14 status_code=0 (successful-ok)
D [06/May/2009:12:29:26 +0300] cupsdReadClient: 14 POST / HTTP/1.1
D [06/May/2009:12:29:26 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:26 +0300] Get-Job-Attributes ipp://localhost/jobs/47
D [06/May/2009:12:29:26 +0300] cupsdProcessIPPRequest: 14 status_code=0 (successful-ok)
D [06/May/2009:12:29:26 +0300] cupsdReadClient: 11 POST / HTTP/1.1
D [06/May/2009:12:29:26 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:29:26 +0300] Get-Printer-Attributes ipp://localhost/printers/LBP5000
D [06/May/2009:12:29:26 +0300] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [06/May/2009:12:29:26 +0300] cupsdCloseClient: 13
D [06/May/2009:12:29:26 +0300] cupsdCloseClient: 12
D [06/May/2009:12:29:27 +0300] [Job 47] Unloading...
D [06/May/2009:12:32:16 +0300] cupsdAcceptClient: 12 from localhost (Domain)
D [06/May/2009:12:32:16 +0300] Report: clients=4
D [06/May/2009:12:32:16 +0300] Report: jobs=47
D [06/May/2009:12:32:16 +0300] Report: jobs-active=1
D [06/May/2009:12:32:16 +0300] Report: printers=2
D [06/May/2009:12:32:16 +0300] Report: printers-implicit=0
D [06/May/2009:12:32:16 +0300] Report: stringpool-string-count=802
D [06/May/2009:12:32:16 +0300] Report: stringpool-alloc-bytes=7952
D [06/May/2009:12:32:16 +0300] Report: stringpool-total-bytes=15912
D [06/May/2009:12:32:16 +0300] cupsdReadClient: 12 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:32:16 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:32:16 +0300] cupsdIsAuthorized: username=""
D [06/May/2009:12:32:16 +0300] cupsdSendError: 12 code=401 (Unauthorized)
D [06/May/2009:12:32:16 +0300] cupsdSendHeader: WWW-Authenticate: Basic realm="CUPS"
D [06/May/2009:12:32:16 +0300] cupsdCloseClient: 12
D [06/May/2009:12:32:16 +0300] cupsdAcceptClient: 12 from localhost (Domain)
D [06/May/2009:12:32:16 +0300] cupsdReadClient: 12 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:32:16 +0300] cupsdAuthorize: Authorized as root using Local
D [06/May/2009:12:32:16 +0300] cupsdIsAuthorized: username="root"
I [06/May/2009:12:32:16 +0300] Installing config file "/etc/cups/cupsd.conf"...
D [06/May/2009:12:32:16 +0300] cupsdSendError: 12 code=201 (Created)
D [06/May/2009:12:32:16 +0300] cupsdCloseClient: 11
D [06/May/2009:12:32:16 +0300] cupsdCloseClient: 9
D [06/May/2009:12:32:16 +0300] cupsdCloseClient: 14
D [06/May/2009:12:32:16 +0300] cupsdCloseClient: 12
D [06/May/2009:12:32:16 +0300] Saving remote.cache...
I [06/May/2009:12:32:16 +0300] Listening to ::1:631 (IPv6)
I [06/May/2009:12:32:16 +0300] Listening to 127.0.0.1:631 (IPv4)
I [06/May/2009:12:32:16 +0300] Listening to /var/run/cups/cups.sock (Domain)
I [06/May/2009:12:32:16 +0300] Loaded configuration file "/etc/cups/cupsd.conf"
I [06/May/2009:12:32:16 +0300] Using default TempDir of /var/spool/cups/tmp...
I [06/May/2009:12:32:16 +0300] Configured for up to 100 clients.
I [06/May/2009:12:32:16 +0300] Allowing up to 100 client connections per host.
I [06/May/2009:12:32:16 +0300] Using policy "default" as the default!
I [06/May/2009:12:32:16 +0300] Partial reload complete.
I [06/May/2009:12:32:16 +0300] Listening to ::1:631 on fd 3...
I [06/May/2009:12:32:16 +0300] Listening to 127.0.0.1:631 on fd 5...
I [06/May/2009:12:32:16 +0300] Listening to /var/run/cups/cups.sock on fd 6...
I [06/May/2009:12:32:16 +0300] Resuming new connection processing...
D [06/May/2009:12:32:16 +0300] Discarding unused server-restarted event...
D [06/May/2009:12:32:46 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:32:46 +0300] cupsdReadClient: 9 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:32:46 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:32:46 +0300] cupsdIsAuthorized: username=""
D [06/May/2009:12:32:46 +0300] cupsdSendError: 9 code=401 (Unauthorized)
D [06/May/2009:12:32:46 +0300] cupsdSendHeader: WWW-Authenticate: Basic realm="CUPS"
D [06/May/2009:12:32:46 +0300] cupsdCloseClient: 9
D [06/May/2009:12:32:46 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:32:46 +0300] cupsdReadClient: 9 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:32:46 +0300] cupsdAuthorize: Authorized as root using Local
D [06/May/2009:12:32:46 +0300] cupsdIsAuthorized: username="root"
I [06/May/2009:12:32:46 +0300] Installing config file "/etc/cups/cupsd.conf"...
D [06/May/2009:12:32:46 +0300] cupsdSendError: 9 code=201 (Created)
D [06/May/2009:12:32:46 +0300] cupsdCloseClient: 9
D [06/May/2009:12:32:46 +0300] Saving remote.cache...
I [06/May/2009:12:32:46 +0300] Listening to ::1:631 (IPv6)
I [06/May/2009:12:32:46 +0300] Listening to 127.0.0.1:631 (IPv4)
I [06/May/2009:12:32:46 +0300] Listening to /var/run/cups/cups.sock (Domain)
I [06/May/2009:12:32:46 +0300] Loaded configuration file "/etc/cups/cupsd.conf"
I [06/May/2009:12:32:46 +0300] Using default TempDir of /var/spool/cups/tmp...
I [06/May/2009:12:32:46 +0300] Configured for up to 100 clients.
I [06/May/2009:12:32:46 +0300] Allowing up to 100 client connections per host.
I [06/May/2009:12:32:46 +0300] Using policy "default" as the default!
I [06/May/2009:12:32:46 +0300] Partial reload complete.
I [06/May/2009:12:32:46 +0300] Listening to ::1:631 on fd 3...
I [06/May/2009:12:32:46 +0300] Listening to 127.0.0.1:631 on fd 5...
I [06/May/2009:12:32:46 +0300] Listening to /var/run/cups/cups.sock on fd 6...
I [06/May/2009:12:32:46 +0300] Resuming new connection processing...
D [06/May/2009:12:32:46 +0300] Discarding unused server-restarted event...
D [06/May/2009:12:33:06 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:33:06 +0300] cupsdReadClient: 9 POST /jobs/ HTTP/1.1
D [06/May/2009:12:33:06 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:33:06 +0300] Cancel-Job ipp://localhost/jobs/47
D [06/May/2009:12:33:06 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:33:06 +0300] [Job 47] Loading attributes...
I [06/May/2009:12:33:06 +0300] Saving subscriptions.conf...
I [06/May/2009:12:33:06 +0300] [Job 47] Canceled by "carlo".
D [06/May/2009:12:33:06 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:33:07 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:33:07 +0300] cupsdReadClient: 11 POST / HTTP/1.1
D [06/May/2009:12:33:07 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:33:07 +0300] Get-Notifications /
D [06/May/2009:12:33:07 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:33:07 +0300] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [06/May/2009:12:33:07 +0300] cupsdCloseClient: 11
D [06/May/2009:12:33:21 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:33:21 +0300] Report: clients=2
D [06/May/2009:12:33:21 +0300] Report: jobs=47
D [06/May/2009:12:33:21 +0300] Report: jobs-active=0
D [06/May/2009:12:33:21 +0300] Report: printers=2
D [06/May/2009:12:33:21 +0300] Report: printers-implicit=0
D [06/May/2009:12:33:21 +0300] Report: stringpool-string-count=904
D [06/May/2009:12:33:21 +0300] Report: stringpool-alloc-bytes=9232
D [06/May/2009:12:33:21 +0300] Report: stringpool-total-bytes=17976
D [06/May/2009:12:33:21 +0300] cupsdReadClient: 11 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:33:21 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:33:21 +0300] cupsdIsAuthorized: username=""
D [06/May/2009:12:33:21 +0300] cupsdSendError: 11 code=401 (Unauthorized)
D [06/May/2009:12:33:21 +0300] cupsdSendHeader: WWW-Authenticate: Basic realm="CUPS"
D [06/May/2009:12:33:21 +0300] cupsdCloseClient: 11
D [06/May/2009:12:33:21 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:33:21 +0300] cupsdReadClient: 11 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:33:21 +0300] cupsdAuthorize: Authorized as root using Local
D [06/May/2009:12:33:21 +0300] cupsdIsAuthorized: username="root"
I [06/May/2009:12:33:21 +0300] Installing config file "/etc/cups/cupsd.conf"...
D [06/May/2009:12:33:21 +0300] cupsdSendError: 11 code=201 (Created)
D [06/May/2009:12:33:21 +0300] cupsdCloseClient: 9
D [06/May/2009:12:33:21 +0300] cupsdCloseClient: 11
D [06/May/2009:12:33:21 +0300] Saving remote.cache...
I [06/May/2009:12:33:21 +0300] Listening to ::1:631 (IPv6)
I [06/May/2009:12:33:21 +0300] Listening to 127.0.0.1:631 (IPv4)
I [06/May/2009:12:33:21 +0300] Listening to /var/run/cups/cups.sock (Domain)
I [06/May/2009:12:33:21 +0300] Loaded configuration file "/etc/cups/cupsd.conf"
I [06/May/2009:12:33:21 +0300] Using default TempDir of /var/spool/cups/tmp...
I [06/May/2009:12:33:21 +0300] Configured for up to 100 clients.
I [06/May/2009:12:33:21 +0300] Allowing up to 100 client connections per host.
I [06/May/2009:12:33:21 +0300] Using policy "default" as the default!
I [06/May/2009:12:33:21 +0300] Partial reload complete.
I [06/May/2009:12:33:21 +0300] Listening to ::1:631 on fd 3...
I [06/May/2009:12:33:21 +0300] Listening to 127.0.0.1:631 on fd 5...
I [06/May/2009:12:33:21 +0300] Listening to /var/run/cups/cups.sock on fd 6...
I [06/May/2009:12:33:21 +0300] Resuming new connection processing...
D [06/May/2009:12:33:21 +0300] Discarding unused server-restarted event...
D [06/May/2009:12:33:55 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:33:55 +0300] cupsdCloseClient: 9
D [06/May/2009:12:33:55 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:33:55 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:33:55 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:33:55 +0300] CUPS-Get-Printers
D [06/May/2009:12:33:55 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:33:55 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:33:55 +0300] cupsdCloseClient: 9
D [06/May/2009:12:33:55 +0300] cupsdReadClient: 11 GET /printers/LBP5000.ppd HTTP/1.1
D [06/May/2009:12:33:55 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:33:55 +0300] cupsdCloseClient: 11
D [06/May/2009:12:33:59 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:33:59 +0300] cupsdReadClient: 9 POST /printers/LBP5000 HTTP/1.1
D [06/May/2009:12:33:59 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:33:59 +0300] Print-Job ipp://localhost:631/printers/LBP5000
D [06/May/2009:12:33:59 +0300] [Job ???] Auto-typing file...
I [06/May/2009:12:33:59 +0300] [Job ???] Request file type is application/postscript.
D [06/May/2009:12:33:59 +0300] add_job: requesting-user-name="carlo"
I [06/May/2009:12:33:59 +0300] [Job 48] Adding start banner page "none".
I [06/May/2009:12:33:59 +0300] Saving subscriptions.conf...
I [06/May/2009:12:33:59 +0300] [Job 48] Adding end banner page "none".
I [06/May/2009:12:33:59 +0300] [Job 48] File of type application/postscript queued by "carlo".
D [06/May/2009:12:33:59 +0300] [Job 48] hold_until=0
I [06/May/2009:12:33:59 +0300] [Job 48] Queued on "LBP5000" by "carlo".
I [06/May/2009:12:33:59 +0300] Saving subscriptions.conf...
D [06/May/2009:12:33:59 +0300] [Job 48] job-sheets=none,none
D [06/May/2009:12:33:59 +0300] [Job 48] banner_page = 0
D [06/May/2009:12:33:59 +0300] [Job 48] argv[0]="LBP5000"
D [06/May/2009:12:33:59 +0300] [Job 48] argv[1]="48"
D [06/May/2009:12:33:59 +0300] [Job 48] argv[2]="carlo"
D [06/May/2009:12:33:59 +0300] [Job 48] argv[3]="TIVI-PROJEKTIEN JOHTAMINEN - Projektimallit ja läpivienti"
D [06/May/2009:12:33:59 +0300] [Job 48] argv[4]="1"
D [06/May/2009:12:33:59 +0300] [Job 48] argv[5]="noCNBackPaperPrint CNMTonerDensity=8 noCNDetectPaperSize MediaType=PlainPaper BindEdge=Left CNHalftone=pattern1 CNKeepGray=Standard PageSize=A4 CNSkipBlank number-up=1 noCNRotatePrint CNCTonerDensity=8 CNYTonerDensity=8 CNColorHalftone=pattern1 InputSlot=Auto CNTonerDensity=8 CNColorMode=Auto job-uuid=urn:uuid:3df13e05-2d40-32b9-7f0b-1de192300e5b"
D [06/May/2009:12:33:59 +0300] [Job 48] argv[6]="/var/spool/cups/d00048-001"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[9]="SERVER_ADMIN=root@carlo-desktop"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[10]="SOFTWARE=CUPS/1.3.9"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[12]="TZ=Europe/Helsinki"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[13]="USER=root"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[16]="IPP_PORT=631"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[17]="CHARSET=utf-8"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[18]="LANG=en_GB.UTF8"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[19]="PPD=/etc/cups/ppd/LBP5000.ppd"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[20]="RIP_MAX_CACHE=8m"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[21]="CONTENT_TYPE=application/postscript"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[22]="DEVICE_URI=ccp:/var/ccpd/fifo0"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[23]="PRINTER=LBP5000"
D [06/May/2009:12:33:59 +0300] [Job 48] envp[24]="FINAL_CONTENT_TYPE=printer/LBP5000"
I [06/May/2009:12:33:59 +0300] [Job 48] Started filter /usr/lib/cups/filter/pstopdf (PID 7404)
I [06/May/2009:12:33:59 +0300] [Job 48] Started filter /usr/lib/cups/filter/pdftopdf (PID 7405)
I [06/May/2009:12:33:59 +0300] [Job 48] Started filter /usr/lib/cups/filter/cpdftocps (PID 7406)
I [06/May/2009:12:33:59 +0300] [Job 48] Started filter /usr/lib/cups/filter/pstocapt2 (PID 7407)
I [06/May/2009:12:33:59 +0300] [Job 48] Started backend /usr/lib/cups/backend/ccp (PID 7410)
I [06/May/2009:12:33:59 +0300] Saving subscriptions.conf...
D [06/May/2009:12:33:59 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:33:59 +0300] [Job 48] pstopdf 6 args: 48 carlo TIVI-PROJEKTIEN JOHTAMINEN - Projektimallit ja läpivienti 1 noCNBackPaperPrint CNMTonerDensity=8 noCNDetectPaperSize MediaType=PlainPaper BindEdge=Left CNHalftone=pattern1 CNKeepGray=Standard PageSize=A4 CNSkipBlank number-up=1 noCNRotatePrint CNCTonerDensity=8 CNYTonerDensity=8 CNColorHalftone=pattern1 InputSlot=Auto CNTonerDensity=8 CNColorMode=Auto job-uuid=urn:uuid:3df13e05-2d40-32b9-7f0b-1de192300e5b /var/spool/cups/d00048-001
D [06/May/2009:12:33:59 +0300] [Job 48] PPD: /etc/cups/ppd/LBP5000.ppd
D [06/May/2009:12:33:59 +0300] [Job 48] pstocapt2 start.
D [06/May/2009:12:33:59 +0300] cupsdCloseClient: 9
D [06/May/2009:12:33:59 +0300] [Job 48] Resolution: 600
D [06/May/2009:12:33:59 +0300] [Job 48] Page size: A4
D [06/May/2009:12:33:59 +0300] [Job 48] Width: , height: , absolute margins: , , , 
D [06/May/2009:12:33:59 +0300] [Job 48] Relative margins: , , , 
D [06/May/2009:12:33:59 +0300] [Job 48] PPD options: -r600
D [06/May/2009:12:33:59 +0300] [Job 48] PostScript to be injected: 
D [06/May/2009:12:34:00 +0300] [Job 48] Running cat | /usr/bin/ps2pdf13 -dAutoRotatePages=/None -dAutoFilterColorImages=false                -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode                -dDoNumCopies -dPDFSETTINGS=/printer -r600 - -
D [06/May/2009:12:34:00 +0300] cupsdAcceptClient: 9 from localhost (Domain)
D [06/May/2009:12:34:00 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:34:00 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:00 +0300] Get-Notifications /
D [06/May/2009:12:34:00 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:34:00 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:34:00 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:34:00 +0300] cupsdReadClient: 11 POST / HTTP/1.1
D [06/May/2009:12:34:00 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:00 +0300] Get-Jobs ipp://localhost/printers/
D [06/May/2009:12:34:00 +0300] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [06/May/2009:12:34:00 +0300] cupsdCloseClient: 11
D [06/May/2009:12:34:00 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:34:00 +0300] cupsdAcceptClient: 12 from localhost (Domain)
D [06/May/2009:12:34:00 +0300] cupsdReadClient: 11 POST / HTTP/1.1
D [06/May/2009:12:34:00 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:00 +0300] Get-Notifications /
D [06/May/2009:12:34:00 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:34:00 +0300] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [06/May/2009:12:34:00 +0300] cupsdReadClient: 12 POST / HTTP/1.1
D [06/May/2009:12:34:00 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:00 +0300] Get-Printer-Attributes ipp://localhost/printers/LBP5000
D [06/May/2009:12:34:00 +0300] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [06/May/2009:12:34:00 +0300] cupsdReadClient: 11 POST / HTTP/1.1
D [06/May/2009:12:34:00 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:00 +0300] Get-Job-Attributes ipp://localhost/jobs/48
D [06/May/2009:12:34:00 +0300] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [06/May/2009:12:34:00 +0300] [Job 48] GPL Ghostscript 8.64: Set UseCIEColor for UseDeviceIndependentColor to work properly.
D [06/May/2009:12:34:00 +0300] cupsdCloseClient: 9
D [06/May/2009:12:34:00 +0300] cupsdCloseClient: 11
D [06/May/2009:12:34:00 +0300] PID 7404 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [06/May/2009:12:34:00 +0300] PID 7405 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [06/May/2009:12:34:00 +0300] [Job 48] Device copies: 1; device collate: 
D [06/May/2009:12:34:00 +0300] [Job 48] pdftops - copying to temp print file "/tmp/4a01598884ded"
D [06/May/2009:12:34:00 +0300] [Job 48] Page = 595x842; 14,14 to 581,828
D [06/May/2009:12:34:00 +0300] [Job 48] slow_collate=0, slow_duplex=0, slow_order=0
D [06/May/2009:12:34:00 +0300] [Job 48] Before copy_comments - %!PS-Adobe-3.0
D [06/May/2009:12:34:00 +0300] [Job 48] %!PS-Adobe-3.0
D [06/May/2009:12:34:00 +0300] [Job 48] %%Pages: (atend)
D [06/May/2009:12:34:00 +0300] [Job 48] %%BoundingBox: (atend)
D [06/May/2009:12:34:00 +0300] [Job 48] %%HiResBoundingBox: (atend)
D [06/May/2009:12:34:00 +0300] [Job 48] %%Creator: GPL Ghostscript 864 (pswrite)
D [06/May/2009:12:34:00 +0300] [Job 48] %%CreationDate: 2009/05/06 12:34:00
D [06/May/2009:12:34:00 +0300] [Job 48] %%DocumentData: Clean7Bit
D [06/May/2009:12:34:00 +0300] [Job 48] %%LanguageLevel: 3
D [06/May/2009:12:34:00 +0300] [Job 48] %%EndComments
D [06/May/2009:12:34:00 +0300] [Job 48] Before copy_prolog - %%BeginProlog
D [06/May/2009:12:34:00 +0300] [Job 48] Before copy_setup - %%Page: 1 1
D [06/May/2009:12:34:00 +0300] [Job 48] Before page loop - %%Page: 1 1
D [06/May/2009:12:34:00 +0300] [Job 48] Copying page 1...
D [06/May/2009:12:34:00 +0300] [Job 48] pagew = 566.2, pagel = 813.2
D [06/May/2009:12:34:00 +0300] [Job 48] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [06/May/2009:12:34:00 +0300] [Job 48] PageLeft = 14.4, PageRight = 580.6
D [06/May/2009:12:34:00 +0300] [Job 48] PageTop = 827.6, PageBottom = 14.4
D [06/May/2009:12:34:00 +0300] [Job 48] PageWidth = 595.0, PageLength = 842.0
D [06/May/2009:12:34:00 +0300] [Job 48] Wrote 1 pages...
D [06/May/2009:12:34:00 +0300] [Job 48] CNDefaultCS=RGB
D [06/May/2009:12:34:00 +0300] [Job 48] MediaCopy=1
D [06/May/2009:12:34:00 +0300] [Job 48] DeviceResolution=deviceResolution_600x600
D [06/May/2009:12:34:00 +0300] [Job 48] MediaPageRotation=portrait
D [06/May/2009:12:34:00 +0300] [Job 48] MediaSize=iso_a4_210x297mm
D [06/May/2009:12:34:00 +0300] cupsdAcceptClient: 9 from localhost:631 (IPv6)
D [06/May/2009:12:34:00 +0300] PID 7406 (/usr/lib/cups/filter/cpdftocps) exited with no errors.
D [06/May/2009:12:34:00 +0300] cupsdReadClient: 9 POST / HTTP/1.1
D [06/May/2009:12:34:00 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:00 +0300] Get-Jobs ipp://localhost/printers/LBP5000
D [06/May/2009:12:34:00 +0300] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [06/May/2009:12:34:04 +0300] [Job 48] GPL Ghostscript 8.64: Unrecoverable error, exit code 1
D [06/May/2009:12:34:04 +0300] PID 7407 (/usr/lib/cups/filter/pstocapt2) exited with no errors.
D [06/May/2009:12:34:04 +0300] [Job 48] ccp: last data.
D [06/May/2009:12:34:04 +0300] [Job 48] ccp: end of send data.
D [06/May/2009:12:34:04 +0300] PID 7410 (/usr/lib/cups/backend/ccp) exited with no errors.
D [06/May/2009:12:34:04 +0300] [Job 48] File 0 is complete.
I [06/May/2009:12:34:04 +0300] [Job 48] Completed successfully.
I [06/May/2009:12:34:04 +0300] Saving subscriptions.conf...
I [06/May/2009:12:34:04 +0300] Saving subscriptions.conf...
D [06/May/2009:12:34:05 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:34:05 +0300] [Job 48] Unloading...
D [06/May/2009:12:34:05 +0300] cupsdReadClient: 11 POST / HTTP/1.1
D [06/May/2009:12:34:05 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:05 +0300] Get-Jobs ipp://localhost/printers/
D [06/May/2009:12:34:05 +0300] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [06/May/2009:12:34:05 +0300] cupsdCloseClient: 11
D [06/May/2009:12:34:05 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:34:05 +0300] cupsdReadClient: 11 POST / HTTP/1.1
D [06/May/2009:12:34:05 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:05 +0300] Get-Notifications /
D [06/May/2009:12:34:05 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:34:05 +0300] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [06/May/2009:12:34:05 +0300] cupsdAcceptClient: 13 from localhost (Domain)
D [06/May/2009:12:34:05 +0300] cupsdReadClient: 13 POST / HTTP/1.1
D [06/May/2009:12:34:05 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:05 +0300] Get-Notifications /
D [06/May/2009:12:34:05 +0300] cupsdIsAuthorized: requesting-user-name="carlo"
D [06/May/2009:12:34:05 +0300] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
D [06/May/2009:12:34:05 +0300] cupsdReadClient: 12 POST / HTTP/1.1
D [06/May/2009:12:34:05 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:05 +0300] Get-Printer-Attributes ipp://localhost/printers/LBP5000
D [06/May/2009:12:34:05 +0300] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [06/May/2009:12:34:05 +0300] cupsdCloseClient: 13
D [06/May/2009:12:34:05 +0300] cupsdCloseClient: 11
D [06/May/2009:12:34:53 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:34:53 +0300] [Job 47] Unloading...
D [06/May/2009:12:34:53 +0300] Report: clients=3
D [06/May/2009:12:34:53 +0300] Report: jobs=48
D [06/May/2009:12:34:53 +0300] Report: jobs-active=0
D [06/May/2009:12:34:53 +0300] Report: printers=2
D [06/May/2009:12:34:53 +0300] Report: printers-implicit=0
D [06/May/2009:12:34:53 +0300] Report: stringpool-string-count=1137
D [06/May/2009:12:34:53 +0300] Report: stringpool-alloc-bytes=8104
D [06/May/2009:12:34:53 +0300] Report: stringpool-total-bytes=23168
D [06/May/2009:12:34:53 +0300] cupsdReadClient: 11 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:34:53 +0300] cupsdAuthorize: No authentication data provided.
D [06/May/2009:12:34:53 +0300] cupsdIsAuthorized: username=""
D [06/May/2009:12:34:53 +0300] cupsdSendError: 11 code=401 (Unauthorized)
D [06/May/2009:12:34:53 +0300] cupsdSendHeader: WWW-Authenticate: Basic realm="CUPS"
D [06/May/2009:12:34:53 +0300] cupsdCloseClient: 11
D [06/May/2009:12:34:53 +0300] cupsdAcceptClient: 11 from localhost (Domain)
D [06/May/2009:12:34:53 +0300] cupsdReadClient: 11 PUT /admin/conf/cupsd.conf HTTP/1.1
D [06/May/2009:12:34:53 +0300] cupsdAuthorize: Authorized as root using Local
D [06/May/2009:12:34:53 +0300] cupsdIsAuthorized: username="root"
I [06/May/2009:12:34:53 +0300] Installing config file "/etc/cups/cupsd.conf"...
D [06/May/2009:12:34:53 +0300] cupsdSendError: 11 code=201 (Created)
D [06/May/2009:12:34:53 +0300] cupsdCloseClient: 12
D [06/May/2009:12:34:53 +0300] cupsdCloseClient: 9
D [06/May/2009:12:34:53 +0300] cupsdCloseClient: 11
D [06/May/2009:12:34:53 +0300] Saving remote.cache...
I [06/May/2009:12:34:53 +0300] Listening to ::1:631 (IPv6)
I [06/May/2009:12:34:53 +0300] Listening to 127.0.0.1:631 (IPv4)
I [06/May/2009:12:34:53 +0300] Listening to /var/run/cups/cups.sock (Domain)
I [06/May/2009:12:34:53 +0300] Loaded configuration file "/etc/cups/cupsd.conf"
I [06/May/2009:12:34:53 +0300] Using default TempDir of /var/spool/cups/tmp...
I [06/May/2009:12:34:53 +0300] Configured for up to 100 clients.
I [06/May/2009:12:34:53 +0300] Allowing up to 100 client connections per host.
I [06/May/2009:12:34:53 +0300] Using policy "default" as the default!
I [06/May/2009:12:34:53 +0300] Partial reload complete.
I [06/May/2009:12:34:53 +0300] Listening to ::1:631 on fd 3...
I [06/May/2009:12:34:53 +0300] Listening to 127.0.0.1:631 on fd 5...
I [06/May/2009:12:34:53 +0300] Listening to /var/run/cups/cups.sock on fd 6...
I [06/May/2009:12:34:53 +0300] Resuming new connection processing...
D [06/May/2009:12:34:53 +0300] Discarding unused server-restarted event...