You are not logged in.

#1 2016-01-20 22:09:59

Pluribootent
Member
Registered: 2008-09-16
Posts: 25

Networkprinter Brother DCP-9022DW problem

I can print fine through Win and OSx, but Linux is a problem.

Cups finds the printer and I add it, but then it doesnt print anything. I can only print selftestpages, which result in 3 lines being printed. I installed the driver from the AUR. And then installed the driver from brother by hand using the WIKIPAGES. No luck. Whats wrong?
I tried connecting by dnssd and lpd.

# avahi-browse -art
+   eno1 IPv6 Arch                                          SSH-Fernzugriff      local
+   eno1 IPv4 Arch                                          SSH-Fernzugriff      local
+   eno1 IPv6 Arch                                          SFTP File Transfer   local
+   eno1 IPv4 Arch                                          SFTP File Transfer   local
+   eno1 IPv4 Brother DCP-9022CDW                           Web-Angebot          local
+   eno1 IPv4 Brother DCP-9022CDW                           _scanner._tcp        local
+   eno1 IPv4 Brother DCP-9022CDW                           Internet Printer     local
+   eno1 IPv4 Brother DCP-9022CDW                           UNIX Printer         local
+   eno1 IPv4 Brother DCP-9022CDW                           PDL Printer          local
=   eno1 IPv4 Brother DCP-9022CDW                           Web-Angebot          local
   hostname = [BRW346895697C19.local]
   address = [192.168.3.137]
   port = [80]
   txt = []
=   eno1 IPv4 Brother DCP-9022CDW                           _scanner._tcp        local
   hostname = [BRW346895697C19.local]
   address = [192.168.3.137]
   port = [54921]
   txt = ["flatbed=T" "feeder=T" "button=T" "mdl=DCP-9022CDW" "mfg=Brother" "ty=Brother DCP-9022CDW" "adminurl=http://BRW346895697C19.local./" "note=" "txtvers=1"]
=   eno1 IPv4 Brother DCP-9022CDW                           Internet Printer     local
   hostname = [BRW346895697C19.local]
   address = [192.168.3.137]
   port = [631]
   txt = ["print_wfds=T" "UUID=e3248000-80ce-11db-8000-30055c84e8f9" "URF=SRGB24,W8,CP1,IS1-4,MT1-3-4-5-8-11,OB10,PQ4-5,RS600,DM1" "TBCP=F" "Transparent=T" "Binary=T" "PaperCustom=T" "Scan=T" "Duplex=T" "Copies=T" "Color=T" "usb_CMD=PJL,PCL,PCLXL,URF" "usb_MDL=DCP-9022CDW" "usb_MFG=Brother" "priority=25" "adminurl=http://BRW346895697C19.local./net/net/airprint.html" "product=(Brother DCP-9022CDW)" "ty=Brother DCP-9022CDW" "note=" "rp=ipp/print" "pdl=application/octet-stream,image/urf,image/pwg-raster" "qtotal=1" "txtvers=1"]
=   eno1 IPv4 Brother DCP-9022CDW                           UNIX Printer         local
   hostname = [BRW346895697C19.local]
   address = [192.168.3.137]
   port = [515]
   txt = ["UUID=e3248000-80ce-11db-8000-30055c84e8f9" "TBCP=F" "Transparent=T" "Binary=T" "PaperCustom=T" "Scan=T" "Duplex=T" "Copies=T" "Color=T" "usb_CMD=PJL,PCL,PCLXL,URF" "usb_MDL=DCP-9022CDW" "usb_MFG=Brother" "priority=50" "adminurl=http://BRW346895697C19.local./net/net/airprint.html" "product=(Brother DCP-9022CDW)" "ty=Brother DCP-9022CDW" "note=" "rp=duerqxesz5090" "pdl=application/octet-stream,image/urf,image/pwg-raster" "qtotal=1" "txtvers=1"]
=   eno1 IPv4 Brother DCP-9022CDW                           PDL Printer          local
   hostname = [BRW346895697C19.local]
   address = [192.168.3.137]
   port = [9100]
   txt = ["UUID=e3248000-80ce-11db-8000-30055c84e8f9" "TBCP=T" "Transparent=F" "Binary=T" "PaperCustom=T" "Scan=T" "Duplex=T" "Copies=T" "Color=T" "usb_CMD=PJL,PCL,PCLXL,URF" "usb_MDL=DCP-9022CDW" "usb_MFG=Brother" "priority=75" "adminurl=http://BRW346895697C19.local./net/net/airprint.html" "product=(Brother DCP-9022CDW)" "ty=Brother DCP-9022CDW" "note=" "pdl=application/octet-stream,image/urf,image/pwg-raster" "qtotal=1" "txtvers=1"]
=   eno1 IPv6 Arch                                          SSH-Fernzugriff      local
   hostname = [Arch.local]
   address = [fe80::1c4d:92f8:992a:93db]
   port = [22]
   txt = []
=   eno1 IPv6 Arch                                          SFTP File Transfer   local
   hostname = [Arch.local]
   address = [fe80::1c4d:92f8:992a:93db]
   port = [22]
   txt = []
=   eno1 IPv4 Arch                                          SSH-Fernzugriff      local
   hostname = [Arch.local]
   address = [192.168.3.126]
   port = [22]
   txt = []
=   eno1 IPv4 Arch                                          SFTP File Transfer   local
   hostname = [Arch.local]
   address = [192.168.3.126]
   port = [22]
   txt = []

Last edited by Pluribootent (2016-01-20 22:10:45)

Offline

#2 2016-01-21 10:56:04

Pluribootent
Member
Registered: 2008-09-16
Posts: 25

Re: Networkprinter Brother DCP-9022DW problem

At the moment the connection looks like this:

dnssd://Brother%20DCP-9022CDW._ipp._tcp.local/?uuid=e3248000-80ce-11db-8000-30055c84e8f9

Offline

#3 2016-01-22 22:43:44

paulkerry
Member
From: Sheffield, UK
Registered: 2014-10-02
Posts: 611

Re: Networkprinter Brother DCP-9022DW problem

Pluribootent wrote:

Cups finds the printer and I add it, but then it doesnt print anything. I can only print selftestpages, which result in 3 lines being printed. I installed the driver from the AUR. And then installed the driver from brother by hand using the WIKIPAGES.

Which drivers did you try as I cannot find anything specifically relating to a DCP-9022DW in the AUR nor can I find it listed under
http://www.openprinting.org/printers/ma … er/Brother ?

Offline

#4 2016-01-22 22:53:43

paulkerry
Member
From: Sheffield, UK
Registered: 2014-10-02
Posts: 611

Re: Networkprinter Brother DCP-9022DW problem

Having had a further look around, you may have to try downloading a rpm or deb file pertaining to Linux from Brother...
http://support.brother.com/g/b/download … 9022cdw_eu

extract it into the relevant location and see if you can get it to work...

Offline

#5 2016-01-23 05:05:20

x33a
Forum Fellow
Registered: 2009-08-15
Posts: 4,587

Re: Networkprinter Brother DCP-9022DW problem

Moving to "Kernel and Hardware".

Offline

#6 2016-01-31 15:47:35

Pluribootent
Member
Registered: 2008-09-16
Posts: 25

Re: Networkprinter Brother DCP-9022DW problem

I have added an old usb printer HL-2030. Installed the drivers and tried to print, but ... nothing. So, maybe the problem is not the driver?
Maybe smth wrong with cups?

Offline

#7 2016-01-31 17:13:43

paulkerry
Member
From: Sheffield, UK
Registered: 2014-10-02
Posts: 611

Re: Networkprinter Brother DCP-9022DW problem

If you suspect there is something wrong with cups, then set LogLevel to debug in /etc/cups/cupsd.conf, restart the cups service, then test printing something and see what you get in /var/log/cups/error_log

Offline

#8 2016-02-12 14:14:35

Pluribootent
Member
Registered: 2008-09-16
Posts: 25

Re: Networkprinter Brother DCP-9022DW problem

OK: This is the outcome of trying to print to my old printer. New printer=same problem

 
I [12/Feb/2016:15:08:35 +0100] Expiring subscriptions...
D [12/Feb/2016:15:08:35 +0100] cupsdAddCert: Adding certificate for PID 0
D [12/Feb/2016:15:08:35 +0100] Closing client 466 after 300 seconds of inactivity.
D [12/Feb/2016:15:08:35 +0100] [Client 466] Closing connection.
D [12/Feb/2016:15:08:35 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:35 +0100] Report: clients=10
D [12/Feb/2016:15:08:35 +0100] Report: jobs=10
D [12/Feb/2016:15:08:35 +0100] Report: jobs-active=0
D [12/Feb/2016:15:08:35 +0100] Report: printers=2
D [12/Feb/2016:15:08:35 +0100] Report: stringpool-string-count=10743
D [12/Feb/2016:15:08:35 +0100] Report: stringpool-alloc-bytes=12600
D [12/Feb/2016:15:08:35 +0100] Report: stringpool-total-bytes=233800
D [12/Feb/2016:15:08:37 +0100] [Client 684] POST /printers/Brother_HL-2030_series HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 684] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 684] Authorized as "root" using Basic.
D [12/Feb/2016:15:08:37 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/run/cups"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@Arch"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/2.1.3"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[13] = "USER=root"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[15] = "CUPS_SERVER=/run/cups/cups.sock"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[17] = "IPP_PORT=631"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[18] = "AUTH_TYPE=Basic"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[19] = "LANG=de_DE.UTF8"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[20] = "REDIRECT_STATUS=1"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[22] = "SERVER_NAME=localhost"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[23] = "SERVER_PORT=631"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[24] = "REMOTE_ADDR=[v1.::1]"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[25] = "REMOTE_HOST=localhost"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[26] = "SCRIPT_NAME=/printers/Brother_HL-2030_series"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc/printers/Brother_HL-2030_series"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[28] = "PATH_INFO=/Brother_HL-2030_series"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[29] = "REMOTE_USER=root"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[30] = "SERVER_PROTOCOL=HTTP/1.1"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[31] = "HTTP_COOKIE=org.cups.sid=47aee0b2775a56b1235fded01e097e04"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[32] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/48.0.2564.103 Safari/537.36"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[33] = "HTTP_REFERER=http://localhost:631/printers/Brother_HL-2030_series"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[34] = "REQUEST_METHOD=POST"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[35] = "CONTENT_LENGTH=64"
D [12/Feb/2016:15:08:37 +0100] [CGI] envp[36] = "CONTENT_TYPE=application/x-www-form-urlencoded"
D [12/Feb/2016:15:08:37 +0100] cupsdAddCert: Adding certificate for PID 3484
D [12/Feb/2016:15:08:37 +0100] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 3484)
I [12/Feb/2016:15:08:37 +0100] [Client 684] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=3484, file=27)
D [12/Feb/2016:15:08:37 +0100] [Client 684] Waiting for CGI data.
I [12/Feb/2016:15:08:37 +0100] Expiring subscriptions...
D [12/Feb/2016:15:08:37 +0100] [CGI] org.cups.sid cookie is \"47aee0b2775a56b1235fded01e097e04\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: org.cups.sid=\"47aee0b2775a56b1235fded01e097e04\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: OP=\"print-test-page\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: SECTION=\"printers\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: REFRESH_PAGE=\"\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: PRINTER_NAME=\"Brother_HL-2030_series\"
D [12/Feb/2016:15:08:37 +0100] [Client 752] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 752] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [Client 752] POST /printers/Brother_HL-2030_series HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 752] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 752] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 752] 2.0 Print-Job 1
D [12/Feb/2016:15:08:37 +0100] [Client 752] Read: status=100
D [12/Feb/2016:15:08:37 +0100] Print-Job ipp://localhost:631/printers/Brother_HL-2030_series
D [12/Feb/2016:15:08:37 +0100] [Job ???] Auto-typing file...
I [12/Feb/2016:15:08:37 +0100] [Job ???] Request file type is application/vnd.cups-pdf-banner.
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(---J-)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:37 +0100] add_job: requesting-user-name="root"
D [12/Feb/2016:15:08:37 +0100] Adding default job-sheets values "none,none"...
I [12/Feb/2016:15:08:37 +0100] [Job 115] Adding start banner page "none".
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(----S)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(---J-)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [12/Feb/2016:15:08:37 +0100] [Job 115] Adding end banner page "none".
I [12/Feb/2016:15:08:37 +0100] [Job 115] File of type application/vnd.cups-pdf-banner queued by "root".
D [12/Feb/2016:15:08:37 +0100] [Job 115] hold_until=0
I [12/Feb/2016:15:08:37 +0100] [Job 115] Queued on "Brother_HL-2030_series" by "root".
D [12/Feb/2016:15:08:37 +0100] [Job 115] time-at-processing=1455286117
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(---J-)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(----S)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Job 115] 4 filters for job:
D [12/Feb/2016:15:08:37 +0100] [Job 115] bannertopdf (application/vnd.cups-pdf-banner to application/pdf, cost 32)
D [12/Feb/2016:15:08:37 +0100] [Job 115] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [12/Feb/2016:15:08:37 +0100] [Job 115] pdftops (application/vnd.cups-pdf to application/vnd.cups-postscript, cost 100)
D [12/Feb/2016:15:08:37 +0100] [Job 115] brlpdwrapperHL2030 (application/vnd.cups-postscript to printer/Brother_HL-2030_series, cost 0)
D [12/Feb/2016:15:08:37 +0100] [Job 115] job-sheets=none,none
D [12/Feb/2016:15:08:37 +0100] [Job 115] argv[0]="Brother_HL-2030_series"
D [12/Feb/2016:15:08:37 +0100] [Job 115] argv[1]="115"
D [12/Feb/2016:15:08:37 +0100] [Job 115] argv[2]="root"
D [12/Feb/2016:15:08:37 +0100] [Job 115] argv[3]="Test Page"
D [12/Feb/2016:15:08:37 +0100] [Job 115] argv[4]="1"
D [12/Feb/2016:15:08:37 +0100] [Job 115] argv[5]="job-uuid=urn:uuid:c6acbbfb-b580-34f1-4481-179c369fce12 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1455286117 time-at-processing=1455286117"
D [12/Feb/2016:15:08:37 +0100] [Job 115] argv[6]="/var/spool/cups/d00115-001"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[7]="CUPS_STATEDIR=/run/cups"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[8]="HOME=/var/spool/cups/tmp"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[10]="SERVER_ADMIN=root@Arch"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[11]="SOFTWARE=CUPS/2.1.3"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[13]="USER=root"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[14]="CUPS_MAX_MESSAGE=2047"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[15]="CUPS_SERVER=/run/cups/cups.sock"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[17]="IPP_PORT=631"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[18]="CHARSET=utf-8"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[19]="LANG=de_DE.UTF-8"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[20]="PPD=/etc/cups/ppd/Brother_HL-2030_series.ppd"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[21]="RIP_MAX_CACHE=128m"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[23]="DEVICE_URI=usb://Brother/HL-2030%20series?serial=C7J320458"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[24]="PRINTER_INFO=Brother HL-2030 series"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[25]="PRINTER_LOCATION="
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[26]="PRINTER=Brother_HL-2030_series"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[27]="PRINTER_STATE_REASONS=none"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[28]="CUPS_FILETYPE=document"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [12/Feb/2016:15:08:37 +0100] [Job 115] envp[30]="AUTH_I****"
I [12/Feb/2016:15:08:37 +0100] [Job 115] Started filter /usr/lib/cups/filter/bannertopdf (PID 3485)
I [12/Feb/2016:15:08:37 +0100] [Job 115] Started filter /usr/lib/cups/filter/pdftopdf (PID 3486)
I [12/Feb/2016:15:08:37 +0100] [Job 115] Started filter /usr/lib/cups/filter/pdftops (PID 3487)
I [12/Feb/2016:15:08:37 +0100] [Job 115] Started filter /usr/lib/cups/filter/brlpdwrapperHL2030 (PID 3488)
I [12/Feb/2016:15:08:37 +0100] [Job 115] Started backend /usr/lib/cups/backend/usb (PID 3489)
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(----S)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 752] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/Brother_HL-2030_series) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 752] Content-Length: 193
D [12/Feb/2016:15:08:37 +0100] [Client 752] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 752] con->http=0x55ba5d2f3480
D [12/Feb/2016:15:08:37 +0100] [Client 752] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=193, response=0x55ba5d2345b0(IPP_STATE_IDLE), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 752] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 752] bytes=0, http_state=0, data_remaining=193
D [12/Feb/2016:15:08:37 +0100] [Client 752] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 752] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 752] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] JobCreated
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] PrinterStateChanged
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] JobState
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Client 748] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 748] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 753] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 753] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: SERVER_NAME=\"localhost\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: REMOTE_USER=\"root\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: CUPS_VERSION=\"CUPS v2.1.3\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: SERVER_NAME=\"localhost\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: REMOTE_USER=\"root\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: CUPS_VERSION=\"CUPS v2.1.3\"
D [12/Feb/2016:15:08:37 +0100] [Client 753] POST / HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 753] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 753] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 753] 2.0 Get-Notifications 269
D [12/Feb/2016:15:08:37 +0100] Get-Notifications /printers/
D [12/Feb/2016:15:08:37 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:37 +0100] [Client 753] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 753] Content-Length: 1643
D [12/Feb/2016:15:08:37 +0100] [Client 753] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 753] con->http=0x55ba5d24ac90
D [12/Feb/2016:15:08:37 +0100] [Client 753] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1643, response=0x55ba5d1fef80(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 753] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 753] bytes=0, http_state=0, data_remaining=1643
D [12/Feb/2016:15:08:37 +0100] [Client 753] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 753] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 753] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 754] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 754] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [Client 754] POST / HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 754] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 754] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 754] 2.0 Get-Job-Attributes 270
D [12/Feb/2016:15:08:37 +0100] Get-Job-Attributes ipp://localhost/jobs/115
D [12/Feb/2016:15:08:37 +0100] [Client 754] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/115) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 754] Content-Length: 75
D [12/Feb/2016:15:08:37 +0100] [Client 754] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 754] con->http=0x55ba5d2c9bc0
D [12/Feb/2016:15:08:37 +0100] [Client 754] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x55ba5d1fef50(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 754] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 754] bytes=0, http_state=0, data_remaining=75
D [12/Feb/2016:15:08:37 +0100] [Client 754] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 754] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 754] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 754] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 754] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 755] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 755] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [Client 755] POST / HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 755] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 755] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 755] 2.0 Get-Job-Attributes 271
D [12/Feb/2016:15:08:37 +0100] Get-Job-Attributes ipp://localhost/jobs/115
D [12/Feb/2016:15:08:37 +0100] [Client 755] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/115) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 755] Content-Length: 75
D [12/Feb/2016:15:08:37 +0100] [Client 755] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 755] con->http=0x55ba5d2c9bc0
D [12/Feb/2016:15:08:37 +0100] [Client 755] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x55ba5d1fef50(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 755] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 755] bytes=0, http_state=0, data_remaining=75
D [12/Feb/2016:15:08:37 +0100] [Client 755] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 755] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 755] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetArray: job_uri[0]=\"/jobs/115\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetArray: job_id[0]=\"115\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetArray: job_state[0]=\"3\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetArray: job_state_message[0]=\"\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetArray: job_state_reasons[0]=\"none\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: refresh_page=\"2;URL=/printers/Brother_HL-2030_series\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: TITLE=\"Testseite drucken\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: SERVER_NAME=\"localhost\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: REMOTE_USER=\"root\"
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: CUPS_VERSION=\"CUPS v2.1.3\"
D [12/Feb/2016:15:08:37 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:37 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:37 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=2147483647, response=(nil)(), pipe_pid=3484, file=27
D [12/Feb/2016:15:08:37 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:37 +0100] [Client 684] Script header: Content-Type: text/html;charset=utf-8
D [12/Feb/2016:15:08:37 +0100] [Client 684] Script header: 
D [12/Feb/2016:15:08:37 +0100] [Client 684] Sending status 200 for CGI.
D [12/Feb/2016:15:08:37 +0100] [Client 684] cupsdSendHeader: code=200, type="(null)", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:37 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3484, file=27
D [12/Feb/2016:15:08:37 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:37 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:37 +0100] [CGI] cgiSetVariable: PRINTER_NAME=\"Brother_HL-2030_series\"
D [12/Feb/2016:15:08:37 +0100] [Client 752] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 752] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:37 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3484, file=27
D [12/Feb/2016:15:08:37 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:37 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:37 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3484, file=27
D [12/Feb/2016:15:08:37 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:37 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:37 +0100] PID 3484 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [12/Feb/2016:15:08:37 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:37 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3484, file=27
D [12/Feb/2016:15:08:37 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:37 +0100] [Client 684] Sending 0-length chunk.
D [12/Feb/2016:15:08:37 +0100] [Client 684] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 684] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 684] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 755] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 755] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 753] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 753] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 756] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 756] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [Client 756] POST / HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 756] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 756] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 756] 2.0 Get-Notifications 272
D [12/Feb/2016:15:08:37 +0100] Get-Notifications /printers/
D [12/Feb/2016:15:08:37 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:37 +0100] [Client 756] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 756] Content-Length: 127
D [12/Feb/2016:15:08:37 +0100] [Client 756] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 756] con->http=0x55ba5d24ac90
D [12/Feb/2016:15:08:37 +0100] [Client 756] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0x55ba5d2c34b0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 756] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 756] bytes=0, http_state=0, data_remaining=127
D [12/Feb/2016:15:08:37 +0100] [Client 756] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 756] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 756] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 756] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 756] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 757] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 757] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [Client 757] POST / HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 757] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 757] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 757] 2.0 Get-Notifications 273
D [12/Feb/2016:15:08:37 +0100] Get-Notifications /printers/
D [12/Feb/2016:15:08:37 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:37 +0100] [Client 757] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 757] Content-Length: 127
D [12/Feb/2016:15:08:37 +0100] [Client 757] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 757] con->http=0x55ba5d24ac90
D [12/Feb/2016:15:08:37 +0100] [Client 757] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0x55ba5d2c34b0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 757] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 757] bytes=0, http_state=0, data_remaining=127
D [12/Feb/2016:15:08:37 +0100] [Client 757] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 757] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 757] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Job 115] pdftops - copying to temp print file \"/var/spool/cups/tmp/00d9f56c9ca67\"
D [12/Feb/2016:15:08:37 +0100] [Job 115] Loading USB quirks from \"/usr/share/cups/usb\".
D [12/Feb/2016:15:08:37 +0100] [Job 115] Loaded 77 quirks.
D [12/Feb/2016:15:08:37 +0100] [Job 115] Printing on printer with URI: usb://Brother/HL-2030%20series?serial=C7J320458
D [12/Feb/2016:15:08:37 +0100] [Job 115] PDF template file doesn\'t have form. It\'s okay.
D [12/Feb/2016:15:08:37 +0100] [Job 115] PID 3485 (/usr/lib/cups/filter/bannertopdf) exited with no errors.
D [12/Feb/2016:15:08:37 +0100] [Job 115] libusb_get_device_list=10
D [12/Feb/2016:15:08:37 +0100] [Job 115] STATE: +connecting-to-device
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(---J-)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(----S)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] PrinterStateChanged
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Client 757] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 757] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 758] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 758] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [Client 758] POST / HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 758] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 758] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 758] 2.0 Get-Notifications 274
D [12/Feb/2016:15:08:37 +0100] Get-Notifications /printers/
D [12/Feb/2016:15:08:37 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:37 +0100] [Client 758] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 758] Content-Length: 586
D [12/Feb/2016:15:08:37 +0100] [Client 758] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 758] con->http=0x55ba5d24ac90
D [12/Feb/2016:15:08:37 +0100] [Client 758] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=586, response=0x55ba5d26ced0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 758] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 758] bytes=0, http_state=0, data_remaining=586
D [12/Feb/2016:15:08:37 +0100] [Client 758] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 758] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 758] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Job 115] STATE: -connecting-to-device
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(---J-)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(----S)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] PrinterStateChanged
D [12/Feb/2016:15:08:37 +0100] [Client 758] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 758] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 759] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 759] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [Client 759] POST / HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 759] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 759] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 759] 2.0 Get-Notifications 275
D [12/Feb/2016:15:08:37 +0100] Get-Notifications /printers/
D [12/Feb/2016:15:08:37 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:37 +0100] [Client 759] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 759] Content-Length: 570
D [12/Feb/2016:15:08:37 +0100] [Client 759] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 759] con->http=0x55ba5d24ac90
D [12/Feb/2016:15:08:37 +0100] [Client 759] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=570, response=0x55ba5d26dfd0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 759] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 759] bytes=0, http_state=0, data_remaining=570
D [12/Feb/2016:15:08:37 +0100] [Client 759] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 759] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 759] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Job 115] PID 3486 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [12/Feb/2016:15:08:37 +0100] [Job 115] Printer make and model: Brother Brother HL2030 series
D [12/Feb/2016:15:08:37 +0100] [Job 115] Switching to Poppler\'s pdftops instead of Ghostscript for Brother, Minolta, and Konica Minolta to work around bugs in the printer\'s PS interpreters
D [12/Feb/2016:15:08:37 +0100] [Job 115] Running command line for pstops: pstops 115 root \'Test Page\' 1 \'job-uuid=urn:uuid:c6acbbfb-b580-34f1-4481-179c369fce12 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1455286117 time-at-processing=1455286117\'
D [12/Feb/2016:15:08:37 +0100] [Job 115] Using image rendering resolution 600 dpi
D [12/Feb/2016:15:08:37 +0100] [Job 115] Running command line for pdftops: pdftops -level3 -origpagesizes -nocenter -r 600 /var/spool/cups/tmp/00d9f56c9ca67 -
D [12/Feb/2016:15:08:37 +0100] [Job 115] Started filter pdftops (PID 3498)
D [12/Feb/2016:15:08:37 +0100] [Job 115] Started filter pstops (PID 3499)
D [12/Feb/2016:15:08:37 +0100] [Job 115] Device protocol: 2
I [12/Feb/2016:15:08:37 +0100] [Job 115] Sende Daten zum Drucker.
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(---J-)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Job 115] Set job-printer-state-message to "Sende Daten zum Drucker.", current level=INFO
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(----S)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] cupsdMarkDirty(----S)
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] JobProgress
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Notifier] PrinterStateChanged
D [12/Feb/2016:15:08:37 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:37 +0100] [Client 759] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 759] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 760] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 760] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [Client 760] POST / HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 760] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 760] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 760] 2.0 Get-Notifications 276
D [12/Feb/2016:15:08:37 +0100] Get-Notifications /printers/
D [12/Feb/2016:15:08:37 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:37 +0100] [Client 760] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 760] Content-Length: 570
D [12/Feb/2016:15:08:37 +0100] [Client 760] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 760] con->http=0x55ba5d24ac90
D [12/Feb/2016:15:08:37 +0100] [Client 760] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=570, response=0x55ba5d26f090(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 760] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 760] bytes=0, http_state=0, data_remaining=570
D [12/Feb/2016:15:08:37 +0100] [Client 760] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 760] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 760] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 760] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:37 +0100] [Client 760] Closing connection.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 761] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:37 +0100] [Client 761] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] [Client 761] POST / HTTP/1.1
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Client 761] Read: status=200
D [12/Feb/2016:15:08:37 +0100] [Client 761] No authentication data provided.
D [12/Feb/2016:15:08:37 +0100] [Client 761] 2.0 Get-Notifications 277
D [12/Feb/2016:15:08:37 +0100] Get-Notifications /printers/
D [12/Feb/2016:15:08:37 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:37 +0100] [Client 761] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost
D [12/Feb/2016:15:08:37 +0100] [Client 761] Content-Length: 127
D [12/Feb/2016:15:08:37 +0100] [Client 761] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:37 +0100] [Client 761] con->http=0x55ba5d24ac90
D [12/Feb/2016:15:08:37 +0100] [Client 761] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0x55ba5d252300(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:37 +0100] [Client 761] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:37 +0100] [Client 761] bytes=0, http_state=0, data_remaining=127
D [12/Feb/2016:15:08:37 +0100] [Client 761] Flushing write buffer.
D [12/Feb/2016:15:08:37 +0100] [Client 761] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:37 +0100] [Client 761] Waiting for request.
D [12/Feb/2016:15:08:37 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:37 +0100] [Job 115] Page = 595x842; 18,12 to 577,830
D [12/Feb/2016:15:08:37 +0100] [Job 115] slow_collate=0, slow_duplex=0, slow_order=0
D [12/Feb/2016:15:08:37 +0100] [Job 115] Before copy_comments - %!PS-Adobe-3.0
D [12/Feb/2016:15:08:37 +0100] [Job 115] %!PS-Adobe-3.0
D [12/Feb/2016:15:08:37 +0100] [Job 115] %Produced by poppler pdftops version: 0.40.0 (http://poppler.freedesktop.org)
D [12/Feb/2016:15:08:37 +0100] [Job 115] %%Creator: cairo 1.10.2 (http://cairographics.org)
D [12/Feb/2016:15:08:37 +0100] [Job 115] %%LanguageLevel: 3
D [12/Feb/2016:15:08:37 +0100] [Job 115] %%DocumentSuppliedResources: (atend)
D [12/Feb/2016:15:08:37 +0100] [Job 115] %%DocumentMedia: A4 595 842 0 () ()
D [12/Feb/2016:15:08:37 +0100] [Job 115] %%BoundingBox: 0 0 595 842
D [12/Feb/2016:15:08:37 +0100] [Job 115] %%Pages: 1
D [12/Feb/2016:15:08:37 +0100] [Job 115] %%EndComments
D [12/Feb/2016:15:08:37 +0100] [Job 115] Before copy_prolog - %%BeginProlog
D [12/Feb/2016:15:08:37 +0100] [Job 115] Before copy_setup - %%BeginSetup
D [12/Feb/2016:15:08:37 +0100] [Job 115] Before page loop - %%Page: 1 1
D [12/Feb/2016:15:08:37 +0100] [Job 115] Copying page 1...
D [12/Feb/2016:15:08:37 +0100] [Job 115] pagew = 559.0, pagel = 818.0
D [12/Feb/2016:15:08:37 +0100] [Job 115] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [12/Feb/2016:15:08:37 +0100] [Job 115] PageLeft = 18.0, PageRight = 577.0
D [12/Feb/2016:15:08:37 +0100] [Job 115] PageTop = 830.0, PageBottom = 12.0
D [12/Feb/2016:15:08:37 +0100] [Job 115] PageWidth = 595.0, PageLength = 842.0
D [12/Feb/2016:15:08:38 +0100] [Client 762] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:38 +0100] [Client 762] Waiting for request.
I [12/Feb/2016:15:08:38 +0100] Expiring subscriptions...
D [12/Feb/2016:15:08:38 +0100] [Client 762] POST / HTTP/1.1
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 762] Read: status=200
D [12/Feb/2016:15:08:38 +0100] [Client 762] No authentication data provided.
D [12/Feb/2016:15:08:38 +0100] [Client 762] 2.0 Get-Notifications 77
D [12/Feb/2016:15:08:38 +0100] Get-Notifications /
D [12/Feb/2016:15:08:38 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:38 +0100] [Client 762] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [12/Feb/2016:15:08:38 +0100] [Client 762] Content-Length: 3529
D [12/Feb/2016:15:08:38 +0100] [Client 762] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:38 +0100] [Client 762] con->http=0x55ba5d2f3480
D [12/Feb/2016:15:08:38 +0100] [Client 762] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=3529, response=0x55ba5d2537c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:38 +0100] [Client 762] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:38 +0100] [Client 762] bytes=0, http_state=0, data_remaining=3529
D [12/Feb/2016:15:08:38 +0100] [Client 762] Flushing write buffer.
D [12/Feb/2016:15:08:38 +0100] [Client 762] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:38 +0100] [Client 762] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 762] POST / HTTP/1.1
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 762] Read: status=200
D [12/Feb/2016:15:08:38 +0100] [Client 762] No authentication data provided.
D [12/Feb/2016:15:08:38 +0100] [Client 762] 2.0 Get-Job-Attributes 78
D [12/Feb/2016:15:08:38 +0100] Get-Job-Attributes ipp://localhost/jobs/115
D [12/Feb/2016:15:08:38 +0100] [Client 762] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/115) from localhost
D [12/Feb/2016:15:08:38 +0100] [Client 762] Content-Length: 1038
D [12/Feb/2016:15:08:38 +0100] [Client 762] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:38 +0100] [Client 762] con->http=0x55ba5d2f3480
D [12/Feb/2016:15:08:38 +0100] [Client 762] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1038, response=0x55ba5d24e850(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:38 +0100] [Client 762] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:38 +0100] [Client 762] bytes=0, http_state=0, data_remaining=1038
D [12/Feb/2016:15:08:38 +0100] [Client 762] Flushing write buffer.
D [12/Feb/2016:15:08:38 +0100] [Client 762] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:38 +0100] [Client 762] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 763] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:38 +0100] [Client 763] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] [Client 763] POST / HTTP/1.1
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 763] Read: status=200
D [12/Feb/2016:15:08:38 +0100] [Client 763] No authentication data provided.
D [12/Feb/2016:15:08:38 +0100] [Client 763] 2.0 Get-Printer-Attributes 79
D [12/Feb/2016:15:08:38 +0100] Get-Printer-Attributes 
D [12/Feb/2016:15:08:38 +0100] Get-Printer-Attributes client-error-not-found: Der Drucker oder die Klasse existiert nicht.
D [12/Feb/2016:15:08:38 +0100] [Client 763] Returning IPP client-error-not-found for Get-Printer-Attributes () from localhost
D [12/Feb/2016:15:08:38 +0100] [Client 763] Content-Length: 138
D [12/Feb/2016:15:08:38 +0100] [Client 763] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:38 +0100] [Client 763] con->http=0x55ba5d2c9bc0
D [12/Feb/2016:15:08:38 +0100] [Client 763] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=138, response=0x55ba5d2537e0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:38 +0100] [Client 763] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:38 +0100] [Client 763] bytes=0, http_state=0, data_remaining=138
D [12/Feb/2016:15:08:38 +0100] [Client 763] Flushing write buffer.
D [12/Feb/2016:15:08:38 +0100] [Client 763] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:38 +0100] [Client 763] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 763] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:38 +0100] [Client 763] Closing connection.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 764] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:38 +0100] [Client 764] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] [Client 764] POST / HTTP/1.1
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 764] Read: status=200
D [12/Feb/2016:15:08:38 +0100] [Client 764] No authentication data provided.
D [12/Feb/2016:15:08:38 +0100] [Client 764] 2.0 Get-Job-Attributes 80
D [12/Feb/2016:15:08:38 +0100] Get-Job-Attributes ipp://localhost/jobs/115
D [12/Feb/2016:15:08:38 +0100] [Client 764] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/115) from localhost
D [12/Feb/2016:15:08:38 +0100] [Client 764] Content-Length: 186
D [12/Feb/2016:15:08:38 +0100] [Client 764] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:38 +0100] [Client 764] con->http=0x55ba5d2c9bc0
D [12/Feb/2016:15:08:38 +0100] [Client 764] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=186, response=0x55ba5d2537e0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:38 +0100] [Client 764] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:38 +0100] [Client 764] bytes=0, http_state=0, data_remaining=186
D [12/Feb/2016:15:08:38 +0100] [Client 764] Flushing write buffer.
D [12/Feb/2016:15:08:38 +0100] [Client 764] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:38 +0100] [Client 764] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 764] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:38 +0100] [Client 764] Closing connection.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 765] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:38 +0100] [Client 765] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] [Client 765] POST / HTTP/1.1
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 765] Read: status=200
D [12/Feb/2016:15:08:38 +0100] [Client 765] No authentication data provided.
D [12/Feb/2016:15:08:38 +0100] [Client 765] 2.0 Get-Job-Attributes 81
D [12/Feb/2016:15:08:38 +0100] Get-Job-Attributes ipp://localhost/jobs/115
D [12/Feb/2016:15:08:38 +0100] [Client 765] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/115) from localhost
D [12/Feb/2016:15:08:38 +0100] [Client 765] Content-Length: 101
D [12/Feb/2016:15:08:38 +0100] [Client 765] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:38 +0100] [Client 765] con->http=0x55ba5d2c9bc0
D [12/Feb/2016:15:08:38 +0100] [Client 765] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x55ba5d2507b0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:38 +0100] [Client 765] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:38 +0100] [Client 765] bytes=0, http_state=0, data_remaining=101
D [12/Feb/2016:15:08:38 +0100] [Client 765] Flushing write buffer.
D [12/Feb/2016:15:08:38 +0100] [Client 765] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:38 +0100] [Client 765] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 765] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:38 +0100] [Client 765] Closing connection.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 766] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:38 +0100] [Client 766] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] [Client 766] POST / HTTP/1.1
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 766] Read: status=200
D [12/Feb/2016:15:08:38 +0100] [Client 766] No authentication data provided.
D [12/Feb/2016:15:08:38 +0100] [Client 766] 2.0 Get-Job-Attributes 82
D [12/Feb/2016:15:08:38 +0100] Get-Job-Attributes ipp://localhost/jobs/115
D [12/Feb/2016:15:08:38 +0100] [Client 766] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/115) from localhost
D [12/Feb/2016:15:08:38 +0100] [Client 766] Content-Length: 101
D [12/Feb/2016:15:08:38 +0100] [Client 766] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:38 +0100] [Client 766] con->http=0x55ba5d2c9bc0
D [12/Feb/2016:15:08:38 +0100] [Client 766] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x55ba5d1c79f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:38 +0100] [Client 766] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:38 +0100] [Client 766] bytes=0, http_state=0, data_remaining=101
D [12/Feb/2016:15:08:38 +0100] [Client 766] Flushing write buffer.
D [12/Feb/2016:15:08:38 +0100] [Client 766] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:38 +0100] [Client 766] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 766] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:38 +0100] [Client 766] Closing connection.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 767] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:38 +0100] [Client 767] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] [Client 767] POST / HTTP/1.1
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 767] Read: status=200
D [12/Feb/2016:15:08:38 +0100] [Client 767] No authentication data provided.
D [12/Feb/2016:15:08:38 +0100] [Client 767] 2.0 Get-Job-Attributes 83
D [12/Feb/2016:15:08:38 +0100] Get-Job-Attributes ipp://localhost/jobs/115
D [12/Feb/2016:15:08:38 +0100] [Client 767] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/115) from localhost
D [12/Feb/2016:15:08:38 +0100] [Client 767] Content-Length: 101
D [12/Feb/2016:15:08:38 +0100] [Client 767] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:38 +0100] [Client 767] con->http=0x55ba5d2c9bc0
D [12/Feb/2016:15:08:38 +0100] [Client 767] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x55ba5d24f4f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:38 +0100] [Client 767] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:38 +0100] [Client 767] bytes=0, http_state=0, data_remaining=101
D [12/Feb/2016:15:08:38 +0100] [Client 767] Flushing write buffer.
D [12/Feb/2016:15:08:38 +0100] [Client 767] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:38 +0100] [Client 767] Waiting for request.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 767] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:38 +0100] [Client 767] Closing connection.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Client 762] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:38 +0100] [Client 762] Closing connection.
D [12/Feb/2016:15:08:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:38 +0100] [Job 115] Wrote 1 pages...
D [12/Feb/2016:15:08:38 +0100] [Job 115] PID 3499 (pstops) exited with no errors.
D [12/Feb/2016:15:08:38 +0100] [Job 115] PID 3498 (pdftops) exited with no errors.
D [12/Feb/2016:15:08:38 +0100] [Job 115] PID 3487 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [12/Feb/2016:15:08:38 +0100] [Job 115] /usr/lib/cups/filter/brlpdwrapperHL2030: Zeile 139: /usr/local/Brother/cupswrapper/brcupsconfig3: Datei oder Verzeichnis nicht gefunden
D [12/Feb/2016:15:08:38 +0100] [Job 115] /usr/local/Brother/lpd/filterHL2030: Zeile 129: /usr/local/Brother/lpd/rawtobr2: Datei oder Verzeichnis nicht gefunden
D [12/Feb/2016:15:08:38 +0100] [Job 115] Sent 0 bytes...
D [12/Feb/2016:15:08:38 +0100] [Job 115] Waiting for read thread to exit...
D [12/Feb/2016:15:08:38 +0100] [Job 115] PID 3488 (/usr/lib/cups/filter/brlpdwrapperHL2030) exited with no errors.
I [12/Feb/2016:15:08:39 +0100] Expiring subscriptions...
D [12/Feb/2016:15:08:39 +0100] [Job 115] PID 3489 (/usr/lib/cups/backend/usb) exited with no errors.
D [12/Feb/2016:15:08:39 +0100] [Job 115] time-at-completed=1455286119
D [12/Feb/2016:15:08:39 +0100] cupsdMarkDirty(----S)
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [12/Feb/2016:15:08:39 +0100] [Job 115] Job completed.
I [12/Feb/2016:15:08:39 +0100] Expiring subscriptions...
D [12/Feb/2016:15:08:39 +0100] cupsdMarkDirty(---J-)
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:39 +0100] cupsdMarkDirty(----S)
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:39 +0100] cupsdMarkDirty(---J-)
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Job 115] Removing document files.
D [12/Feb/2016:15:08:39 +0100] cupsdMarkDirty(---J-)
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:39 +0100] [Notifier] JobCompleted
D [12/Feb/2016:15:08:39 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:39 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:39 +0100] [Notifier] PrinterStateChanged
D [12/Feb/2016:15:08:39 +0100] [Notifier] state=3
D [12/Feb/2016:15:08:39 +0100] [Client 761] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:39 +0100] [Client 761] Closing connection.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 768] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:39 +0100] [Client 768] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] [Client 768] POST / HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 768] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 768] No authentication data provided.
D [12/Feb/2016:15:08:39 +0100] [Client 768] 2.0 Get-Notifications 278
D [12/Feb/2016:15:08:39 +0100] Get-Notifications /printers/
D [12/Feb/2016:15:08:39 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:39 +0100] [Client 768] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost
D [12/Feb/2016:15:08:39 +0100] [Client 768] Content-Length: 1124
D [12/Feb/2016:15:08:39 +0100] [Client 768] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:39 +0100] [Client 768] con->http=0x55ba5d24ac90
D [12/Feb/2016:15:08:39 +0100] [Client 768] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1124, response=0x55ba5d2ae150(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:39 +0100] [Client 768] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:39 +0100] [Client 768] bytes=0, http_state=0, data_remaining=1124
D [12/Feb/2016:15:08:39 +0100] [Client 768] Flushing write buffer.
D [12/Feb/2016:15:08:39 +0100] [Client 768] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:39 +0100] [Client 768] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 769] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:39 +0100] [Client 769] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] [Client 769] POST / HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 769] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 769] No authentication data provided.
D [12/Feb/2016:15:08:39 +0100] [Client 769] 2.0 Get-Job-Attributes 279
D [12/Feb/2016:15:08:39 +0100] Get-Job-Attributes ipp://localhost/jobs/115
D [12/Feb/2016:15:08:39 +0100] [Client 769] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/115) from localhost
D [12/Feb/2016:15:08:39 +0100] [Client 769] Content-Length: 75
D [12/Feb/2016:15:08:39 +0100] [Client 769] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:39 +0100] [Client 769] con->http=0x55ba5d2f3480
D [12/Feb/2016:15:08:39 +0100] [Client 769] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x55ba5d23b260(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:39 +0100] [Client 769] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:39 +0100] [Client 769] bytes=0, http_state=0, data_remaining=75
D [12/Feb/2016:15:08:39 +0100] [Client 769] Flushing write buffer.
D [12/Feb/2016:15:08:39 +0100] [Client 769] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:39 +0100] [Client 769] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 769] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:39 +0100] [Client 769] Closing connection.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 768] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:39 +0100] [Client 768] Closing connection.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 770] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:39 +0100] [Client 770] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] [Client 770] POST / HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 770] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 770] No authentication data provided.
D [12/Feb/2016:15:08:39 +0100] [Client 770] 2.0 Get-Notifications 280
D [12/Feb/2016:15:08:39 +0100] Get-Notifications /printers/
D [12/Feb/2016:15:08:39 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:39 +0100] [Client 770] Returning IPP successful-ok for Get-Notifications (/printers/) from localhost
D [12/Feb/2016:15:08:39 +0100] [Client 770] Content-Length: 127
D [12/Feb/2016:15:08:39 +0100] [Client 770] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:39 +0100] [Client 770] con->http=0x55ba5d24ac90
D [12/Feb/2016:15:08:39 +0100] [Client 770] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=127, response=0x55ba5d2ae150(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:39 +0100] [Client 770] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:39 +0100] [Client 770] bytes=0, http_state=0, data_remaining=127
D [12/Feb/2016:15:08:39 +0100] [Client 770] Flushing write buffer.
D [12/Feb/2016:15:08:39 +0100] [Client 770] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:39 +0100] [Client 770] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 771] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:39 +0100] [Client 771] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] [Client 771] POST / HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 771] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 771] No authentication data provided.
D [12/Feb/2016:15:08:39 +0100] [Client 771] 2.0 Get-Notifications 84
D [12/Feb/2016:15:08:39 +0100] Get-Notifications /
D [12/Feb/2016:15:08:39 +0100] cupsdIsAuthorized: requesting-user-name="myusername"
D [12/Feb/2016:15:08:39 +0100] [Client 771] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [12/Feb/2016:15:08:39 +0100] [Client 771] Content-Length: 1124
D [12/Feb/2016:15:08:39 +0100] [Client 771] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:39 +0100] [Client 771] con->http=0x55ba5d2f3480
D [12/Feb/2016:15:08:39 +0100] [Client 771] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1124, response=0x55ba5d23b2a0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:39 +0100] [Client 771] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:39 +0100] [Client 771] bytes=0, http_state=0, data_remaining=1124
D [12/Feb/2016:15:08:39 +0100] [Client 771] Flushing write buffer.
D [12/Feb/2016:15:08:39 +0100] [Client 771] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:39 +0100] [Client 771] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 772] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:39 +0100] [Client 772] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] [Client 772] POST / HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 772] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 772] No authentication data provided.
D [12/Feb/2016:15:08:39 +0100] [Client 772] 2.0 Get-Printer-Attributes 85
D [12/Feb/2016:15:08:39 +0100] Get-Printer-Attributes ipp://Arch/printers/Brother_HL-2030_series
D [12/Feb/2016:15:08:39 +0100] [Client 772] Returning IPP successful-ok for Get-Printer-Attributes (ipp://Arch/printers/Brother_HL-2030_series) from localhost
D [12/Feb/2016:15:08:39 +0100] [Client 772] Content-Length: 138
D [12/Feb/2016:15:08:39 +0100] [Client 772] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:39 +0100] [Client 772] con->http=0x55ba5d2c9bc0
D [12/Feb/2016:15:08:39 +0100] [Client 772] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=138, response=0x55ba5d23b260(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:39 +0100] [Client 772] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:39 +0100] [Client 772] bytes=0, http_state=0, data_remaining=138
D [12/Feb/2016:15:08:39 +0100] [Client 772] Flushing write buffer.
D [12/Feb/2016:15:08:39 +0100] [Client 772] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:39 +0100] [Client 772] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 771] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:39 +0100] [Client 771] Closing connection.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 684] GET /printers/Brother_HL-2030_series HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 684] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 684] Authorized as "root" using Basic.
D [12/Feb/2016:15:08:39 +0100] [Client 684] Processing GET /printers/Brother_HL-2030_series
D [12/Feb/2016:15:08:39 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/run/cups"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@Arch"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/2.1.3"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[13] = "USER=root"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[15] = "CUPS_SERVER=/run/cups/cups.sock"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[17] = "IPP_PORT=631"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[18] = "AUTH_TYPE=Basic"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[19] = "LANG=de_DE.UTF8"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[20] = "REDIRECT_STATUS=1"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[22] = "SERVER_NAME=localhost"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[23] = "SERVER_PORT=631"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[24] = "REMOTE_ADDR=[v1.::1]"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[25] = "REMOTE_HOST=localhost"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[26] = "SCRIPT_NAME=/printers/Brother_HL-2030_series"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc/printers/Brother_HL-2030_series"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[28] = "PATH_INFO=/Brother_HL-2030_series"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[29] = "REMOTE_USER=root"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[30] = "SERVER_PROTOCOL=HTTP/1.1"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[31] = "HTTP_COOKIE=org.cups.sid=47aee0b2775a56b1235fded01e097e04"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[32] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/48.0.2564.103 Safari/537.36"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[33] = "HTTP_REFERER=http://localhost:631/printers/Brother_HL-2030_series"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[34] = "REQUEST_METHOD=GET"
D [12/Feb/2016:15:08:39 +0100] [CGI] envp[35] = "QUERY_STRING="
D [12/Feb/2016:15:08:39 +0100] cupsdAddCert: Adding certificate for PID 3575
D [12/Feb/2016:15:08:39 +0100] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 3575)
I [12/Feb/2016:15:08:39 +0100] [Client 684] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=3575, file=22)
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [CGI] org.cups.sid cookie is \"47aee0b2775a56b1235fded01e097e04\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: SECTION=\"printers\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: REFRESH_PAGE=\"\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: PRINTER_NAME=\"Brother_HL-2030_series\"
D [12/Feb/2016:15:08:39 +0100] [Client 773] Accepted from localhost (Domain)
D [12/Feb/2016:15:08:39 +0100] [Client 773] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] [Client 773] POST / HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 773] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 773] No authentication data provided.
D [12/Feb/2016:15:08:39 +0100] [Client 773] 2.0 CUPS-Get-Default 1
D [12/Feb/2016:15:08:39 +0100] CUPS-Get-Default
D [12/Feb/2016:15:08:39 +0100] CUPS-Get-Default client-error-not-found: Kein voreingestelltes Druckziel
D [12/Feb/2016:15:08:39 +0100] [Client 773] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [12/Feb/2016:15:08:39 +0100] [Client 773] Content-Length: 125
D [12/Feb/2016:15:08:39 +0100] [Client 773] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:39 +0100] [Client 773] con->http=0x55ba5d2f3480
D [12/Feb/2016:15:08:39 +0100] [Client 773] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=125, response=0x55ba5d2c9510(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:39 +0100] [Client 773] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:39 +0100] [Client 773] bytes=0, http_state=0, data_remaining=125
D [12/Feb/2016:15:08:39 +0100] [Client 773] Flushing write buffer.
D [12/Feb/2016:15:08:39 +0100] [Client 773] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:39 +0100] [Client 773] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [CGI] show_printer(http=0x5652db44fc70, printer=\"Brother_HL-2030_series\")
D [12/Feb/2016:15:08:39 +0100] [Client 773] POST / HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 773] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 773] No authentication data provided.
D [12/Feb/2016:15:08:39 +0100] [Client 773] 2.0 Get-Printer-Attributes 2
D [12/Feb/2016:15:08:39 +0100] Get-Printer-Attributes ipp://localhost/printers/Brother_HL-2030_series
D [12/Feb/2016:15:08:39 +0100] [Client 773] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother_HL-2030_series) from localhost
D [12/Feb/2016:15:08:39 +0100] [Client 773] Content-Length: 681
D [12/Feb/2016:15:08:39 +0100] [Client 773] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:39 +0100] [Client 773] con->http=0x55ba5d2f3480
D [12/Feb/2016:15:08:39 +0100] [Client 773] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=681, response=0x55ba5d283630(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:39 +0100] [Client 773] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:39 +0100] [Client 773] bytes=0, http_state=0, data_remaining=681
D [12/Feb/2016:15:08:39 +0100] [Client 773] Flushing write buffer.
D [12/Feb/2016:15:08:39 +0100] [Client 773] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:39 +0100] [Client 773] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: SERVER_NAME=\"localhost\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: REMOTE_USER=\"root\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: CUPS_VERSION=\"CUPS v2.1.3\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: SERVER_NAME=\"localhost\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: REMOTE_USER=\"root\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: CUPS_VERSION=\"CUPS v2.1.3\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: printer_is_accepting_jobs[0]=\"1\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: printer_is_shared[0]=\"0\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: printer_state[0]=\"3\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: admin_uri[0]=\"/admin/\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: printer_uri_supported[0]=\"/printers/Brother_HL-2030_series\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: printer_name[0]=\"Brother_HL-2030_series\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: printer_location[0]=\"\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: printer_info[0]=\"Brother HL-2030 series\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: job_sheets_default[0]=\"none, none\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: device_uri[0]=\"usb://Brother/HL-2030%20series?serial=C7J320458\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: color_supported[0]=\"0\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: printer_make_and_model[0]=\"Brother HL2030 for CUPS\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: media_default[0]=\"iso_a4_210x297mm\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: sides_supported[0]=\"one-sided\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: sides_default[0]=\"one-sided\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: printer_commands[0]=\"AutoConfigure, Clean, PrintSelfTestPage\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetArray: server_is_sharing_printers[0]=\"0\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: TITLE=\"Brother_HL-2030_series\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: SERVER_NAME=\"localhost\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: REMOTE_USER=\"root\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: CUPS_VERSION=\"CUPS v2.1.3\"
D [12/Feb/2016:15:08:39 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=2147483647, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] Script header: Content-Type: text/html;charset=utf-8
D [12/Feb/2016:15:08:39 +0100] [Client 684] Script header: 
D [12/Feb/2016:15:08:39 +0100] [Client 684] Sending status 200 for CGI.
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdSendHeader: code=200, type="(null)", auth_type=0
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [CGI] Regular expression \".*Clean.*\"
D [12/Feb/2016:15:08:39 +0100] [CGI] matches[0].rm_so=0
D [12/Feb/2016:15:08:39 +0100] [CGI] matches[1].rm_so=-1
D [12/Feb/2016:15:08:39 +0100] [CGI] Regular expression \".*PrintSelfTestPage.*\"
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [CGI] matches[0].rm_so=0
D [12/Feb/2016:15:08:39 +0100] [CGI] matches[1].rm_so=-1
D [12/Feb/2016:15:08:39 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 773] POST / HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 773] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 773] No authentication data provided.
D [12/Feb/2016:15:08:39 +0100] [Client 773] 2.0 Get-Jobs 3
D [12/Feb/2016:15:08:39 +0100] Get-Jobs ipp://localhost:631/printers/Brother_HL-2030_series
D [12/Feb/2016:15:08:39 +0100] [Client 773] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/Brother_HL-2030_series) from localhost
D [12/Feb/2016:15:08:39 +0100] [Client 773] Content-Length: 75
D [12/Feb/2016:15:08:39 +0100] [Client 773] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [12/Feb/2016:15:08:39 +0100] [Client 773] con->http=0x55ba5d2f3480
D [12/Feb/2016:15:08:39 +0100] [Client 773] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x55ba5d2ee0c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [12/Feb/2016:15:08:39 +0100] [Client 773] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [12/Feb/2016:15:08:39 +0100] [Client 773] bytes=0, http_state=0, data_remaining=75
D [12/Feb/2016:15:08:39 +0100] [Client 773] Flushing write buffer.
D [12/Feb/2016:15:08:39 +0100] [Client 773] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:39 +0100] [Client 773] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiClearVariables called.
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: ORDER=\"asc\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: SECTION=\"printers\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: TOTAL=\"0\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: PRINTER_NAME=\"Brother_HL-2030_series\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: PRINTER_URI_SUPPORTED=\"/printers/Brother_HL-2030_series\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: THISURL=\"/printers/Brother_HL-2030_series\"
D [12/Feb/2016:15:08:39 +0100] [CGI] cgiSetVariable: SEARCH_DEST=\"Brother_HL-2030_series\"
D [12/Feb/2016:15:08:39 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:39 +0100] [Client 773] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [12/Feb/2016:15:08:39 +0100] [Client 773] Closing connection.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] CGI data ready to be sent.
D [12/Feb/2016:15:08:39 +0100] PID 3575 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [12/Feb/2016:15:08:39 +0100] [Client 684] con->http=0x55ba5d2bfce0
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=3575, file=22
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for CGI data.
D [12/Feb/2016:15:08:39 +0100] [Client 684] Sending 0-length chunk.
D [12/Feb/2016:15:08:39 +0100] [Client 684] Flushing write buffer.
D [12/Feb/2016:15:08:39 +0100] [Client 684] New state is HTTP_STATE_WAITING
D [12/Feb/2016:15:08:39 +0100] [Client 684] Waiting for request.
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 684] GET /cups.css HTTP/1.1
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [12/Feb/2016:15:08:39 +0100] [Client 684] Read: status=200
D [12/Feb/2016:15:08:39 +0100] [Client 684] Authorized as "root" using Basic.
D [12/Feb/2016:15:08:39 +0100] [Client 684] Processing GET /cups.css
D [12/Feb/2016:15:08:39 +0100] [Client 684] filename="/usr/share/cups/doc/cups.css", type=text/css
D [12/Feb/2016:15:08:39 +0100] [Client 684] cupsdSendHeader: code=304, type="(null)", auth_type=0
D [12/Feb/2016:15:08:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
I [12/Feb/2016:15:08:40 +0100] Expiring subscriptions...

Offline

#9 2016-02-12 16:57:02

paulkerry
Member
From: Sheffield, UK
Registered: 2014-10-02
Posts: 611

Re: Networkprinter Brother DCP-9022DW problem

Pluribootent wrote:

OK: This is the outcome of trying to print to my old printer. New printer=same problem

D [12/Feb/2016:15:08:38 +0100] [Job 115] Wrote 1 pages...
D [12/Feb/2016:15:08:38 +0100] [Job 115] PID 3499 (pstops) exited with no errors.
D [12/Feb/2016:15:08:38 +0100] [Job 115] PID 3498 (pdftops) exited with no errors.
D [12/Feb/2016:15:08:38 +0100] [Job 115] PID 3487 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [12/Feb/2016:15:08:38 +0100] [Job 115] /usr/lib/cups/filter/brlpdwrapperHL2030: Zeile 139: /usr/local/Brother/cupswrapper/brcupsconfig3: Datei oder Verzeichnis nicht gefunden
D [12/Feb/2016:15:08:38 +0100] [Job 115] /usr/local/Brother/lpd/filterHL2030: Zeile 129: /usr/local/Brother/lpd/rawtobr2: Datei oder Verzeichnis nicht gefunden

Those last two lines I've taken from your log don't look right to me (I also don't understand the German).

Are you using the brother-hl2030 package from the AUR - https://aur.archlinux.org/packages/brother-hl2030/ ?

If I build and extract the brother-hl2030 AUR package, there are no references to files located in "/usr/local/Brother".

Have you tried to do something non-standard?

Offline

#10 2016-02-12 17:19:04

Pluribootent
Member
Registered: 2008-09-16
Posts: 25

Re: Networkprinter Brother DCP-9022DW problem

I used the installer from the brother homepage directly.

Offline

#11 2016-02-12 17:40:21

paulkerry
Member
From: Sheffield, UK
Registered: 2014-10-02
Posts: 611

Re: Networkprinter Brother DCP-9022DW problem

Pluribootent wrote:

I used the installer from the brother homepage directly.

Then I would recommend you remove the installed files from the brother install and try the AUR package instead.

Offline

#12 2016-02-12 17:42:08

Pluribootent
Member
Registered: 2008-09-16
Posts: 25

Re: Networkprinter Brother DCP-9022DW problem

OK. Now it is working.
I installed the package from the AUR. Then there was an error about files already existing etc. So I removed those files - retried the brother package from the AUR and I can finally print with both printers.
Thanks goes to everybody for helping.

Cheers.

Offline

#13 2016-02-12 17:53:47

paulkerry
Member
From: Sheffield, UK
Registered: 2014-10-02
Posts: 611

Re: Networkprinter Brother DCP-9022DW problem

Great - please remember to prepend "[SOLVED]" to your first post.

Offline

Board footer

Powered by FluxBB