D [09/Jun/2013:16:06:21 +0200] cupsdReadClient: 15 POST / HTTP/1.1
D [09/Jun/2013:16:06:21 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [09/Jun/2013:16:06:21 +0200] cupsdAuthorize: No authentication data provided.
D [09/Jun/2013:16:06:21 +0200] cupsdReadClient: 15 1.1 Get-Jobs 1
D [09/Jun/2013:16:06:21 +0200] Get-Jobs ipp://localhost/printers/
D [09/Jun/2013:16:06:21 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [09/Jun/2013:16:06:21 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:21 +0200] cupsdReadClient: 15 POST / HTTP/1.1
D [09/Jun/2013:16:06:21 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [09/Jun/2013:16:06:21 +0200] cupsdAuthorize: No authentication data provided.
D [09/Jun/2013:16:06:21 +0200] cupsdReadClient: 15 1.1 Get-Jobs 1
D [09/Jun/2013:16:06:21 +0200] Get-Jobs ipp://localhost/printers/
D [09/Jun/2013:16:06:21 +0200] [Job 36] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 38] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 39] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 40] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 41] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 42] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 43] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 44] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 45] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 46] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 47] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] [Job 48] Loading attributes...
D [09/Jun/2013:16:06:21 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [09/Jun/2013:16:06:21 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:21 +0200] cupsdReadClient: 15 POST / HTTP/1.1
D [09/Jun/2013:16:06:21 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [09/Jun/2013:16:06:21 +0200] cupsdAuthorize: No authentication data provided.
D [09/Jun/2013:16:06:21 +0200] cupsdReadClient: 15 1.1 Create-Printer-Subscription 1
D [09/Jun/2013:16:06:21 +0200] Create-Printer-Subscription /
D [09/Jun/2013:16:06:21 +0200] cupsdCreateSubscription(con=0x21b259c8(15), uri="/")
D [09/Jun/2013:16:06:21 +0200] pullmethod="ippget"
D [09/Jun/2013:16:06:21 +0200] notify-lease-duration=86400
D [09/Jun/2013:16:06:21 +0200] notify-time-interval=0
D [09/Jun/2013:16:06:21 +0200] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")
D [09/Jun/2013:16:06:21 +0200] Added subscription #51 for server.
D [09/Jun/2013:16:06:21 +0200] cupsdMarkDirty(-----S)
D [09/Jun/2013:16:06:21 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:21 +0200] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost
D [09/Jun/2013:16:06:21 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:23 +0200] cupsdReadClient: 15 POST / HTTP/1.1
D [09/Jun/2013:16:06:23 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [09/Jun/2013:16:06:23 +0200] cupsdAuthorize: No authentication data provided.
D [09/Jun/2013:16:06:23 +0200] cupsdReadClient: 15 1.1 Get-Notifications 1
D [09/Jun/2013:16:06:23 +0200] Get-Notifications /
D [09/Jun/2013:16:06:23 +0200] cupsdIsAuthorized: requesting-user-name="jana"
D [09/Jun/2013:16:06:23 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [09/Jun/2013:16:06:23 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
I [09/Jun/2013:16:06:24 +0200] [Job 49] Unable to locate printer "cups-server".
I [09/Jun/2013:16:06:34 +0200] [Job 49] Unable to locate printer "cups-server".
D [09/Jun/2013:16:06:34 +0200] cupsdAcceptClient: 16 from localhost (Domain)
D [09/Jun/2013:16:06:34 +0200] cupsdReadClient: 16 POST /printers/BrotherMFC-J5910DW HTTP/1.1
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdAuthorize: No authentication data provided.
D [09/Jun/2013:16:06:34 +0200] cupsdReadClient: 16 1.1 Print-Job 1
D [09/Jun/2013:16:06:34 +0200] Print-Job ipp://localhost/printers/BrotherMFC-J5910DW
D [09/Jun/2013:16:06:34 +0200] [Job ???] Auto-typing file...
I [09/Jun/2013:16:06:34 +0200] [Job ???] Request file type is application/vnd.cups-pdf-banner.
D [09/Jun/2013:16:06:34 +0200] cupsdMarkDirty(----J-)
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] add_job: requesting-user-name="jana"
D [09/Jun/2013:16:06:34 +0200] Adding default job-sheets values "none,none"...
I [09/Jun/2013:16:06:34 +0200] [Job 53] Adding start banner page "none".
D [09/Jun/2013:16:06:34 +0200] cupsdMarkDirty(-----S)
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdMarkDirty(----J-)
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
I [09/Jun/2013:16:06:34 +0200] [Job 53] Adding end banner page "none".
I [09/Jun/2013:16:06:34 +0200] [Job 53] File of type application/vnd.cups-pdf-banner queued by "jana".
D [09/Jun/2013:16:06:34 +0200] [Job 53] hold_until=0
I [09/Jun/2013:16:06:34 +0200] [Job 53] Queued on "BrotherMFC-J5910DW" by "jana".
D [09/Jun/2013:16:06:34 +0200] cupsdMarkDirty(----J-)
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdMarkDirty(-----S)
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] [Job 53] job-sheets=none,none
D [09/Jun/2013:16:06:34 +0200] [Job 53] argv[0]="BrotherMFC-J5910DW"
D [09/Jun/2013:16:06:34 +0200] [Job 53] argv[1]="53"
D [09/Jun/2013:16:06:34 +0200] [Job 53] argv[2]="jana"
D [09/Jun/2013:16:06:34 +0200] [Job 53] argv[3]="Test Page"
D [09/Jun/2013:16:06:34 +0200] [Job 53] argv[4]="1"
D [09/Jun/2013:16:06:34 +0200] [Job 53] argv[5]="job-uuid=urn:uuid:12f7605f-b1f1-330c-580a-6444e4d7e35d job-originating-host-name=localhost time-at-creation=1370786794 time-at-processing=1370786794"
D [09/Jun/2013:16:06:34 +0200] [Job 53] argv[6]="/var/spool/cups/d00053-001"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[8]="HOME=/var/spool/cups/tmp"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[10]="SERVER_ADMIN=root@Joybook-R31"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[11]="SOFTWARE=CUPS/1.5.3"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[13]="USER=root"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[16]="IPP_PORT=631"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[17]="CHARSET=utf-8"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[18]="LANG=nl_NL.UTF-8"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[19]="PPD=/etc/cups/ppd/BrotherMFC-J5910DW.ppd"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[20]="RIP_MAX_CACHE=128m"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[21]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[22]="DEVICE_URI=socket://192.168.178.1:9100"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[23]="PRINTER_INFO=Brother MFC-J5910DW"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[24]="PRINTER_LOCATION=Lab 1"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[25]="PRINTER=BrotherMFC-J5910DW"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[26]="PRINTER_STATE_REASONS=none"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[27]="CUPS_FILETYPE=document"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[28]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [09/Jun/2013:16:06:34 +0200] [Job 53] envp[29]="AUTH_I****"
I [09/Jun/2013:16:06:34 +0200] [Job 53] Started filter /usr/lib/cups/filter/bannertopdf (PID 5425)
I [09/Jun/2013:16:06:34 +0200] [Job 53] Started filter /usr/lib/cups/filter/pdftopdf (PID 5426)
I [09/Jun/2013:16:06:34 +0200] [Job 53] Started filter /usr/lib/cups/filter/pdftops (PID 5427)
I [09/Jun/2013:16:06:34 +0200] [Job 53] Started backend /usr/lib/cups/backend/socket (PID 5428)
D [09/Jun/2013:16:06:34 +0200] cupsdMarkDirty(-----S)
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] Returning IPP successful-ok for Print-Job (ipp://localhost/printers/BrotherMFC-J5910DW) from localhost
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] [Job 53] STATE: +connecting-to-device
D [09/Jun/2013:16:06:34 +0200] cupsdMarkDirty(-----S)
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Jun/2013:16:06:34 +0200] [Job 53] Looking up "192.168.178.1"...
D [09/Jun/2013:16:06:34 +0200] [Job 53] pdftops - copying to temp print file "/tmp/0153351c0e296"
D [09/Jun/2013:16:06:34 +0200] PID 5425 (/usr/lib/cups/filter/bannertopdf) exited with no errors.
D [09/Jun/2013:16:06:34 +0200] cupsdAcceptClient: 19 from localhost (Domain)
D [09/Jun/2013:16:06:34 +0200] cupsdAcceptClient: 20 from localhost (Domain)
D [09/Jun/2013:16:06:34 +0200] cupsdReadClient: 19 POST / HTTP/1.1
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdAuthorize: No authentication data provided.
D [09/Jun/2013:16:06:34 +0200] cupsdReadClient: 20 POST / HTTP/1.1
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdAuthorize: No authentication data provided.
D [09/Jun/2013:16:06:34 +0200] cupsdReadClient: 19 1.1 Get-Notifications 1
D [09/Jun/2013:16:06:34 +0200] Get-Notifications /
D [09/Jun/2013:16:06:34 +0200] cupsdIsAuthorized: requesting-user-name="jana"
D [09/Jun/2013:16:06:34 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [09/Jun/2013:16:06:34 +0200] cupsdReadClient: 20 1.1 Get-Notifications 1
D [09/Jun/2013:16:06:34 +0200] Get-Notifications /
D [09/Jun/2013:16:06:34 +0200] cupsdIsAuthorized: requesting-user-name="jana"
D [09/Jun/2013:16:06:34 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdReadClient: 19 WAITING Closing on EOF
D [09/Jun/2013:16:06:34 +0200] cupsdCloseClient: 19
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdReadClient: 20 POST / HTTP/1.1
D [09/Jun/2013:16:06:34 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [09/Jun/2013:16:06:34 +0200] cupsdAuthorize: No authentication data provided.
D [09/Jun/2013:16:06:34 +0200] cupsdReadClient: 20 1.1 Get-Job-Attributes 1
D [09/Jun/2013:16:06:34 +0200] Get-Job-Attributes ipp://localhost/jobs/53
D [09/Jun/2013:16:06:34 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/53) from localhost