You are not logged in.
I'm trying to setup a new Brother DCP-L2640DW for printing. I can print to it from Android on the network.
I've turned on debug logging, and I can't see much in there that looks like an error except maybe "HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
"
I can get to the admin interface of the printer at https://brwc8a3e813594b.local so that part seems working.
if I use system-config-printer and print a test page, it seems to go through the motions of what you'd expect... filtering to ghostscript, queing, finishing, idle etc, but there's not a peep out of the printer itself.
this is the output of lpinfo -v:
network beh
network https
file cups-pdf:/
network http
network lpd
network ipps
network socket
network ipp
network smb
network dnssd://Brother%20DCP-L2640DW._ipp._tcp.local/?uuid=e3248000-80ce-11db-8000-94ddf86098e7
network ipps://Brother%20DCP-L2640DW._ipps._tcp.local/My /etc/cups/printers.conf is:
# Printer configuration file for CUPS v2.4.11
# Written by cupsd
# DO NOT EDIT THIS FILE WHEN CUPSD IS RUNNING
NextPrinterId 6
<Printer Brother>
PrinterId 5
UUID urn:uuid:e92fb749-bb7b-37ae-7ae0-350bdc01583a
AuthInfoRequired none
Info Brother
MakeModel Generic IPP Everywhere Printer
DeviceURI ipp://BRWC8A3E813594B.local/ipp/print
State Idle
StateTime 1742899191
ConfigTime 1742899101
Type 61468
Accepting Yes
Shared Yes
JobSheets none none
QuotaPeriod 0
PageLimit 0
KLimit 0
OpPolicy default
ErrorPolicy stop-printer
Attribute marker-colors \#000000,none
Attribute marker-levels -1,99
Attribute marker-low-levels 9
Attribute marker-high-levels 100
Attribute marker-names Black Toner Cartridge,Drum Unit
Attribute marker-types toner
Attribute marker-change-time 1742899191
</Printer>this is my error log after attempting a print:
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [25/Mar/2025:18:39:13 +0800] [Client 215] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:13 +0800] [Client 215] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:13 +0800] [Client 215] Waiting for request.
D [25/Mar/2025:18:39:13 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:13 +0800] [Client 215] POST /printers/Brother HTTP/1.1
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [25/Mar/2025:18:39:13 +0800] [Client 215] Read: status=200, state=6
D [25/Mar/2025:18:39:13 +0800] [Client 215] No authentication data provided.
D [25/Mar/2025:18:39:13 +0800] [Client 215] 2.0 Print-Job 377
D [25/Mar/2025:18:39:13 +0800] Print-Job ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:13 +0800] [Job ???] Auto-typing file...
I [25/Mar/2025:18:39:13 +0800] [Job ???] Request file type is application/vnd.cups-pdf-banner.
D [25/Mar/2025:18:39:13 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [25/Mar/2025:18:39:13 +0800] [Job 18] Applying default options...
D [25/Mar/2025:18:39:13 +0800] add_job: requesting-user-name="chris"
D [25/Mar/2025:18:39:13 +0800] Adding default job-sheets values "none,none"...
I [25/Mar/2025:18:39:13 +0800] [Job 18] Adding start banner page "none".
D [25/Mar/2025:18:39:13 +0800] Discarding unused job-created event...
D [25/Mar/2025:18:39:13 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [25/Mar/2025:18:39:13 +0800] [Job 18] Adding end banner page "none".
I [25/Mar/2025:18:39:13 +0800] [Job 18] File of type application/vnd.cups-pdf-banner queued by "chris".
D [25/Mar/2025:18:39:13 +0800] [Job 18] hold_until=0
I [25/Mar/2025:18:39:13 +0800] [Job 18] Queued on "Brother" by "chris".
D [25/Mar/2025:18:39:13 +0800] [Job 18] time-at-processing=1742899153
D [25/Mar/2025:18:39:13 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:13 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:13 +0800] [Job 18] 4 filters for job:
D [25/Mar/2025:18:39:13 +0800] [Job 18] - (application/vnd.cups-pdf-banner to application/vnd.universal-input, cost 0)
D [25/Mar/2025:18:39:13 +0800] [Job 18] universal (application/vnd.universal-input to application/vnd.cups-raster, cost 0)
D [25/Mar/2025:18:39:13 +0800] [Job 18] - (application/vnd.cups-raster to printer/Brother/image/pwg-raster, cost 0)
D [25/Mar/2025:18:39:13 +0800] [Job 18] - (printer/Brother/image/pwg-raster to printer/Brother, cost 0)
D [25/Mar/2025:18:39:13 +0800] [Job 18] job-sheets=none,none
D [25/Mar/2025:18:39:13 +0800] [Job 18] argv[0]="Brother"
D [25/Mar/2025:18:39:13 +0800] [Job 18] argv[1]="18"
D [25/Mar/2025:18:39:13 +0800] [Job 18] argv[2]="chris"
D [25/Mar/2025:18:39:13 +0800] [Job 18] argv[3]="Test Page"
D [25/Mar/2025:18:39:13 +0800] [Job 18] argv[4]="1"
D [25/Mar/2025:18:39:13 +0800] [Job 18] argv[5]="job-uuid=urn:uuid:0d8c3441-728d-305e-707d-ee44949ff154 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1742899153 time-at-processing=1742899153"
D [25/Mar/2025:18:39:13 +0800] [Job 18] argv[6]="/var/spool/cups/d00018-001"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[3]="CUPS_REQUESTROOT=/var/spool/cups"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[4]="CUPS_SERVERBIN=/usr/lib/cups"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[5]="CUPS_SERVERROOT=/etc/cups"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[6]="CUPS_STATEDIR=/run/cups"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[7]="HOME=/var/spool/cups/tmp"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[9]="SERVER_ADMIN=root@P14s-Arch"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[10]="SOFTWARE=CUPS/2.4.11"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[12]="USER=root"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[13]="CUPS_MAX_MESSAGE=2047"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[14]="CUPS_SERVER=/run/cups/cups.sock"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[16]="IPP_PORT=631"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[17]="CHARSET=utf-8"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[18]="LANG=en_US.UTF-8"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[19]="PPD=/etc/cups/ppd/Brother.ppd"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[20]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[21]="DEVICE_URI=ipp://BRWC8A3E813594B.local/ipp/print"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[22]="PRINTER_INFO=Brother"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[23]="PRINTER_LOCATION="
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[24]="PRINTER=Brother"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[25]="PRINTER_STATE_REASONS=none"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[26]="CUPS_FILETYPE=document"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[27]="FINAL_CONTENT_TYPE=image/pwg-raster"
D [25/Mar/2025:18:39:13 +0800] [Job 18] envp[28]="AUTH_I****"
I [25/Mar/2025:18:39:13 +0800] [Job 18] Started filter /usr/lib/cups/filter/universal (PID 2696186)
I [25/Mar/2025:18:39:13 +0800] [Job 18] Started backend /usr/lib/cups/backend/ipp (PID 2696187)
D [25/Mar/2025:18:39:13 +0800] Discarding unused job-state-changed event...
D [25/Mar/2025:18:39:13 +0800] [Client 215] Returning IPP successful-ok for Print-Job (no URI) from localhost.
D [25/Mar/2025:18:39:13 +0800] [Client 215] Content-Length: 192
D [25/Mar/2025:18:39:13 +0800] [Client 215] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:13 +0800] [Client 215] con->http=0x641786c4a440
D [25/Mar/2025:18:39:13 +0800] [Client 215] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=192, response=0x641786bfd830(IPP_STATE_IDLE), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:13 +0800] [Client 215] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:13 +0800] [Client 215] bytes=0, http_state=0, data_remaining=192
D [25/Mar/2025:18:39:13 +0800] [Client 215] Flushing write buffer.
D [25/Mar/2025:18:39:13 +0800] [Client 215] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:13 +0800] [Client 215] Waiting for request.
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:13 +0800] [Job 18] Sending stdin for job...
D [25/Mar/2025:18:39:13 +0800] [Job 18] STATE: +connecting-to-device
D [25/Mar/2025:18:39:13 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:13 +0800] [Job 18] Looking up \"BRWC8A3E813594B.local\"...
D [25/Mar/2025:18:39:13 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:13 +0800] [Job 18] STATE: -connecting-to-device
D [25/Mar/2025:18:39:13 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:13 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:13 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:13 +0800] [Job 18] BRWC8A3E813594B.local=[v1.fe80::caa3:e8ff:fe13:594b+wlp3s0]
D [25/Mar/2025:18:39:13 +0800] [Job 18] BRWC8A3E813594B.local=192.168.68.123
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterLoadPPD: Color profile qualifier determined from job and PPD data \'..600dpi\'
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterLoadPPD: No ICC profiles specified in PPD
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterLoadPPD: Searching for profile \"600dpi/-\"...
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterLoadPPD: Last filter determined by the PPD: -; Final data MIME type: image/pwg-raster => PDF filter will log pages in page_log.
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterUniversal: \"*cupsFilter(2): ...\" lines in the PPD file:
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterUniversal: application/vnd.cups-raw application/octet-stream 0 -
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterUniversal: application/vnd.cups-raster image/pwg-raster 0 -
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterUniversal: --> Selecting this line
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterUniversal: Cost value is down to zero, stopping reading further lines
D [25/Mar/2025:18:39:14 +0800] [Job 18] ppdFilterUniversal: Converting from application/vnd.cups-pdf-banner to application/vnd.cups-raster, final output will be image/pwg-raster
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterUniversal: Converting from application/vnd.cups-pdf-banner to application/vnd.cups-raster
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterUniversal: Final output format for job: image/pwg-raster
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterUniversal: Adding bannertopdf to chain
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterUniversal: Adding pdftopdf to chain
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterUniversal: Adding ghostscript to chain
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: Running filter: bannertopdf
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterChain: Running filter: bannertopdf", current level=INFO
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: Running filter: pdftopdf
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterChain: Running filter: pdftopdf", current level=INFO
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: Running filter: ghostscript
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterChain: Running filter: ghostscript", current level=INFO
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: bannertopdf (PID 2696188) started.
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterChain: bannertopdf (PID 2696188) started.", current level=INFO
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterBannerToPDF: Copying input to temp file \"/var/spool/cups/tmp/2923fc67e28eaa\"
D [25/Mar/2025:18:39:14 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: pdftopdf (PID 2696189) started.
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterChain: pdftopdf (PID 2696189) started.", current level=INFO
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: ghostscript (PID 2696190) started.
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterChain: ghostscript (PID 2696190) started.", current level=INFO
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Output format: CUPS Raster
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Copying input to temp file \"/var/spool/cups/tmp/2923fe67e2933e\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterPDFToPDF: Forced page logging selected by options.
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: bannertopdf completed with status 0.
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterPDFToPDF: Processing PDF input with QPDF: Page-ranges, page-set, number-up, booklet, size adjustment, ...
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterPDFToPDF: \"print-scaling\" IPP attribute: auto
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterPDFToPDF: Print scaling mode: Do not scale, center, crop if needed
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterPDFToPDF: After Cropping: 612.000000 792.000000 612.000000 792.000000
D [25/Mar/2025:18:39:14 +0800] [Job 18] PAGE: 1 1
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: pdftopdf completed with status 0.
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Input format: PDF
D [25/Mar/2025:18:39:14 +0800] [Job 18] Color space requested: Default
D [25/Mar/2025:18:39:14 +0800] [Job 18] Final output format: CUPS Raster
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: pdftopdf (PID 2696189) exited with no errors.
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterChain: pdftopdf (PID 2696189) exited with no errors.", current level=INFO
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Format of the input document: application/vnd.cups-pdf-banner
D [25/Mar/2025:18:39:14 +0800] [Job 18] Document\'s input format does not provide absolute size dimensions for each page, falling back to US Letter if no output page size is provided.
D [25/Mar/2025:18:39:14 +0800] [Job 18] Print rendering intent = auto
D [25/Mar/2025:18:39:14 +0800] [Job 18] Color Manager: Calibration Mode/Off
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterChain: bannertopdf (PID 2696188) exited with no errors.
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterChain: bannertopdf (PID 2696188) exited with no errors.", current level=INFO
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Calling FindDeviceById(cups-Brother)
D [25/Mar/2025:18:39:14 +0800] [Job 18] Found device /org/freedesktop/ColorManager/devices/cups_Brother
D [25/Mar/2025:18:39:14 +0800] [Job 18] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
D [25/Mar/2025:18:39:14 +0800] [Job 18] Calling FindDeviceById(cups-Brother)
D [25/Mar/2025:18:39:14 +0800] [Job 18] Found device /org/freedesktop/ColorManager/devices/cups_Brother
D [25/Mar/2025:18:39:14 +0800] [Job 18] Calling GetProfileForQualifiers(..600dpi...)
D [25/Mar/2025:18:39:14 +0800] [Job 18] Found profile /org/freedesktop/ColorManager/profiles/Brother_RGB__
D [25/Mar/2025:18:39:14 +0800] [Job 18] Calling org.freedesktop.ColorManager.Profile.Get(Filename)
D [25/Mar/2025:18:39:14 +0800] [Job 18] Failed to get profile filename for cups-Brother
D [25/Mar/2025:18:39:14 +0800] [Job 18] Color Manager: ICC Profile:
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Ghostscript using Any-Part-of-Pixel method to fill paths.
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Ghostscript command line: gs -dQUIET -dSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -dUsePDFX3Profile -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=cups -r600x600 -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -dcupsBitsPerColor=8 -dcupsColorOrder=0 -dcupsColorSpace=1 -scupsRenderingIntent=auto -scupsPageSizeName=Letter.Borderless -dcupsManualCopies -I/usr/share/cups/fonts -c \'<</.HWMargins[0.000000 0.000000 0.000000 0.000000] /Margins[0 0]>>setpagedevice\' -f -_
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Started Ghostscript (PID 2696191)
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Started logging (PID 2696192)
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Input data feed completed
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Start rendering...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterGhostscript: Start rendering...", current level=INFO
D [25/Mar/2025:18:39:14 +0800] [Job 18] cfFilterGhostscript: Processing page 1...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "cfFilterGhostscript: Processing page 1...", current level=INFO
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] ATTR: marker-colors=#000000,none
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] ATTR: marker-names=\'\"Black Toner Cartridge\"\',\'\"Drum Unit\"\'
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] ATTR: marker-types=toner,opc
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] ATTR: marker-levels=-1,99
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] new_supply_state=0, change_state=ffff
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -developer-low-report
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -developer-empty-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -marker-supply-low-report
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -marker-supply-empty-warning
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -opc-near-eol-report
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -opc-life-over-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -toner-low-report
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -toner-empty-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -waste-receptacle-almost-full-report
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -waste-receptacle-full-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -cleaner-life-almost-over-report
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -cleaner-life-over-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] new_state=0, change_state=ffff
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -media-empty-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -door-open-report
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -media-jam-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -input-tray-missing-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -output-tray-missing-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -marker-supply-missing-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -output-area-almost-full-report
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -output-area-full-warning
D [25/Mar/2025:18:39:14 +0800] [Job 18] backendWaitLoop(snmp_fd=5, addr=0x6284104ef388, side_cb=0x628408e80ea0)
D [25/Mar/2025:18:39:14 +0800] [Job 18] Connecting to BRWC8A3E813594B.local:631
D [25/Mar/2025:18:39:14 +0800] [Job 18] Connecting to printer.
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "Connecting to printer.", current level=INFO
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] update_reasons(attr=0(), s=\"-cups-certificate-error\")
D [25/Mar/2025:18:39:14 +0800] [Job 18] update_reasons(attr=0(), s=\"-connecting-to-device\")
D [25/Mar/2025:18:39:14 +0800] [Job 18] Connected to printer.
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Set job-printer-state-message to "Connected to printer.", current level=INFO
D [25/Mar/2025:18:39:14 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Connected to [v1.fe80::caa3:e8ff:fe13:594b+wlp3s0]:631...
D [25/Mar/2025:18:39:14 +0800] [Job 18] Getting supported attributes...
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 216] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:14 +0800] [Client 216] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:14 +0800] [Client 216] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 217] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:14 +0800] [Client 217] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:14 +0800] [Client 217] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] [Client 216] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 216] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 216] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 216] 2.0 Get-Notifications 378
D [25/Mar/2025:18:39:14 +0800] Get-Notifications /
D [25/Mar/2025:18:39:14 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:14 +0800] [Client 216] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 216] Content-Length: 5396
D [25/Mar/2025:18:39:14 +0800] [Client 216] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 216] con->http=0x641786c4da90
D [25/Mar/2025:18:39:14 +0800] [Client 216] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=5396, response=0x641786c04400(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 216] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 216] bytes=0, http_state=0, data_remaining=5396
D [25/Mar/2025:18:39:14 +0800] [Client 216] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 216] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 216] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 217] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 217] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 217] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 217] 2.0 Get-Notifications 87
D [25/Mar/2025:18:39:14 +0800] Get-Notifications /
D [25/Mar/2025:18:39:14 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:14 +0800] [Client 217] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 217] Content-Length: 5396
D [25/Mar/2025:18:39:14 +0800] [Client 217] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 217] con->http=0x641786c510e0
D [25/Mar/2025:18:39:14 +0800] [Client 217] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=5396, response=0x641786bd94c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 217] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 217] bytes=0, http_state=0, data_remaining=5396
D [25/Mar/2025:18:39:14 +0800] [Client 217] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 217] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 217] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 379
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786b151c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786b151c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 217] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:14 +0800] [Client 217] Closing connection.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 380
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c04400(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c04400(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 381
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c0a9f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c0a9f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 382
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786bd94c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786bd94c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 383
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c04400(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c04400(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 384
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c0a9f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c0a9f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 385
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786bd94c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786bd94c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 386
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c04400(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c04400(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 387
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c0a9f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c0a9f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 388
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786bd94c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786bd94c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 389
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c04400(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c04400(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 390
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c0a9f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786c0a9f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 391
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786bd94c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25276, response=0x641786bd94c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25276
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 216] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:14 +0800] [Client 216] Closing connection.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:14 +0800] [Job 18] Automatically using \"gzip\" compression.
D [25/Mar/2025:18:39:14 +0800] [Job 18] copies-supported=1-999
D [25/Mar/2025:18:39:14 +0800] [Job 18] document-format-supported (3 values)
D [25/Mar/2025:18:39:14 +0800] [Job 18] [0] = \"application/octet-stream\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [1] = \"image/urf\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [2] = \"image/pwg-raster\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] media-col-supported (9 values)
D [25/Mar/2025:18:39:14 +0800] [Job 18] [0] = \"media-type\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [1] = \"media-size\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [2] = \"media-top-margin\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [3] = \"media-left-margin\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [4] = \"media-right-margin\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [5] = \"media-bottom-margin\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [6] = \"media-source\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [7] = \"media-auto-dimension\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] [8] = \"media-source-properties\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] print-scaling-supported (5 values)
D [25/Mar/2025:18:39:14 +0800] [Job 18] [0] = auto
D [25/Mar/2025:18:39:14 +0800] [Job 18] [1] = auto-fit
D [25/Mar/2025:18:39:14 +0800] [Job 18] [2] = fill
D [25/Mar/2025:18:39:14 +0800] [Job 18] [3] = fit
D [25/Mar/2025:18:39:14 +0800] [Job 18] [4] = none
D [25/Mar/2025:18:39:14 +0800] [Job 18] operations-supported (11 values)
D [25/Mar/2025:18:39:14 +0800] [Job 18] [0] = Print-Job
D [25/Mar/2025:18:39:14 +0800] [Job 18] [1] = Validate-Job
D [25/Mar/2025:18:39:14 +0800] [Job 18] [2] = Create-Job
D [25/Mar/2025:18:39:14 +0800] [Job 18] [3] = Send-Document
D [25/Mar/2025:18:39:14 +0800] [Job 18] [4] = Cancel-Job
D [25/Mar/2025:18:39:14 +0800] [Job 18] [5] = Get-Job-Attributes
D [25/Mar/2025:18:39:14 +0800] [Job 18] [6] = Get-Jobs
D [25/Mar/2025:18:39:14 +0800] [Job 18] [7] = Get-Printer-Attributes
D [25/Mar/2025:18:39:14 +0800] [Job 18] [8] = Cancel-My-Jobs
D [25/Mar/2025:18:39:14 +0800] [Job 18] [9] = Close-Job
D [25/Mar/2025:18:39:14 +0800] [Job 18] [10] = Identify-Printer
D [25/Mar/2025:18:39:14 +0800] [Job 18] PPD: cupsMandatory=\"attributes-charset attributes-natural-language printer-uri\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] update_reasons(attr=1(none), s=\"(null)\")
D [25/Mar/2025:18:39:14 +0800] [Job 18] STATE: -none
D [25/Mar/2025:18:39:14 +0800] [Job 18] ATTR: marker-high-levels=100
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] ATTR: marker-levels=100
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] ATTR: marker-low-levels=9
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] ATTR: marker-types=\'\"toner\"\'
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] final_content_type=\"image/pwg-raster\", document_format=\"image/pwg-raster\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] retryable=0
D [25/Mar/2025:18:39:14 +0800] [Job 18] Validate-Job IPP/2.0
D [25/Mar/2025:18:39:14 +0800] [Job 18] printer-uri=\"ipp://BRWC8A3E813594B.local:631/ipp/print\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] requesting-user-name=\"chris\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] job-name=\"Test Page\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] document-format=\"image/pwg-raster\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Adding standard IPP operation/job attributes.
D [25/Mar/2025:18:39:14 +0800] [Job 18] IPP/2.0 Validate-Job #2
D [25/Mar/2025:18:39:14 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:14 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:14 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:14 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:14 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:14 +0800] [Job 18] job-name nameWithoutLanguage Test Page
D [25/Mar/2025:18:39:14 +0800] [Job 18] document-format mimeMediaType image/pwg-raster
D [25/Mar/2025:18:39:14 +0800] [Job 18] ---- job-attributes-tag ----
D [25/Mar/2025:18:39:14 +0800] [Job 18] sides keyword one-sided
D [25/Mar/2025:18:39:14 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:14 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 139] 2.0 CUPS-Get-Printers 88
D [25/Mar/2025:18:39:14 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:14 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 139] Content-Length: 455
D [25/Mar/2025:18:39:14 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:14 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=455, response=0x641786b27620(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 139] bytes=0, http_state=0, data_remaining=455
D [25/Mar/2025:18:39:14 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 139] 2.0 CUPS-Get-Classes 89
D [25/Mar/2025:18:39:14 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:14 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 139] Content-Length: 75
D [25/Mar/2025:18:39:14 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:14 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786ad9230(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 139] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:14 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 139] 2.0 CUPS-Get-Default 90
D [25/Mar/2025:18:39:14 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:14 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:14 +0800] [Client 139] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 139] Content-Length: 113
D [25/Mar/2025:18:39:14 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:14 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786b27620(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 139] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:14 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 148] 2.0 CUPS-Get-Printers 392
D [25/Mar/2025:18:39:14 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:14 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 148] Content-Length: 455
D [25/Mar/2025:18:39:14 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:14 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=455, response=0x641786ad9230(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 148] bytes=0, http_state=0, data_remaining=455
D [25/Mar/2025:18:39:14 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 148] 2.0 CUPS-Get-Classes 393
D [25/Mar/2025:18:39:14 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:14 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 148] Content-Length: 75
D [25/Mar/2025:18:39:14 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:14 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786b27620(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 148] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:14 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 148] 2.0 CUPS-Get-Default 394
D [25/Mar/2025:18:39:14 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:14 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:14 +0800] [Client 148] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 148] Content-Length: 113
D [25/Mar/2025:18:39:14 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:14 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786ad9230(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 148] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:14 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 218] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:14 +0800] [Client 218] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:14 +0800] [Client 218] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 219] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:14 +0800] [Client 219] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:14 +0800] [Client 219] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] [Client 218] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 218] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 218] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 218] 2.0 Get-Notifications 395
D [25/Mar/2025:18:39:14 +0800] Get-Notifications /
D [25/Mar/2025:18:39:14 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:14 +0800] [Client 218] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 218] Content-Length: 530
D [25/Mar/2025:18:39:14 +0800] [Client 218] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 218] con->http=0x641786c4da90
D [25/Mar/2025:18:39:14 +0800] [Client 218] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=530, response=0x641786b27620(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 218] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 218] bytes=0, http_state=0, data_remaining=530
D [25/Mar/2025:18:39:14 +0800] [Client 218] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 218] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 218] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 219] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 219] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 219] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 219] 2.0 Get-Notifications 91
D [25/Mar/2025:18:39:14 +0800] Get-Notifications /
D [25/Mar/2025:18:39:14 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:14 +0800] [Client 219] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 219] Content-Length: 530
D [25/Mar/2025:18:39:14 +0800] [Client 219] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 219] con->http=0x641786c510e0
D [25/Mar/2025:18:39:14 +0800] [Client 219] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=530, response=0x641786ad9230(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 219] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 219] bytes=0, http_state=0, data_remaining=530
D [25/Mar/2025:18:39:14 +0800] [Client 219] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 219] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 219] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:14 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:14 +0800] [Client 203] 2.0 Get-Printer-Attributes 396
D [25/Mar/2025:18:39:14 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:14 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:14 +0800] [Client 203] Content-Length: 25030
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25030, response=0x641786b27620(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25030
D [25/Mar/2025:18:39:14 +0800] [Client 219] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:14 +0800] [Client 219] Closing connection.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:14 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25030, response=0x641786b27620(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:14 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:14 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25030
D [25/Mar/2025:18:39:14 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:14 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:14 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Client 218] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:14 +0800] [Client 218] Closing connection.
D [25/Mar/2025:18:39:14 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Validate-Job: successful-ok (successful-ok)
D [25/Mar/2025:18:39:14 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:14 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:14 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:14 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:14 +0800] [Job 18] Create-Job IPP/2.0
D [25/Mar/2025:18:39:14 +0800] [Job 18] printer-uri=\"ipp://BRWC8A3E813594B.local:631/ipp/print\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] requesting-user-name=\"chris\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] job-name=\"Test Page\"
D [25/Mar/2025:18:39:14 +0800] [Job 18] Adding standard IPP operation/job attributes.
D [25/Mar/2025:18:39:14 +0800] [Job 18] IPP/2.0 Create-Job #3
D [25/Mar/2025:18:39:14 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:14 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:14 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:14 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:14 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:14 +0800] [Job 18] job-name nameWithoutLanguage Test Page
D [25/Mar/2025:18:39:14 +0800] [Job 18] ---- job-attributes-tag ----
D [25/Mar/2025:18:39:14 +0800] [Job 18] sides keyword one-sided
D [25/Mar/2025:18:39:14 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:15 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:15 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:15 +0800] [Client 148] 2.0 CUPS-Get-Printers 397
D [25/Mar/2025:18:39:15 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:15 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:15 +0800] [Client 148] Content-Length: 455
D [25/Mar/2025:18:39:15 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:15 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:15 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:15 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=455, response=0x641786b151c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:15 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:15 +0800] [Client 148] bytes=0, http_state=0, data_remaining=455
D [25/Mar/2025:18:39:15 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:15 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:15 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:15 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:15 +0800] [Client 139] 2.0 CUPS-Get-Printers 92
D [25/Mar/2025:18:39:15 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:15 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:15 +0800] [Client 139] Content-Length: 455
D [25/Mar/2025:18:39:15 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:15 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:15 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:15 +0800] [Client 148] 2.0 CUPS-Get-Classes 398
D [25/Mar/2025:18:39:15 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:15 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:15 +0800] [Client 148] Content-Length: 75
D [25/Mar/2025:18:39:15 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:15 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:15 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=455, response=0x641786bd7da0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:15 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:15 +0800] [Client 139] bytes=0, http_state=0, data_remaining=455
D [25/Mar/2025:18:39:15 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:15 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:15 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:15 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786af3d70(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:15 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:15 +0800] [Client 148] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:15 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:15 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:15 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:15 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:15 +0800] [Client 139] 2.0 CUPS-Get-Classes 93
D [25/Mar/2025:18:39:15 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:15 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:15 +0800] [Client 139] Content-Length: 75
D [25/Mar/2025:18:39:15 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:15 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:15 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786be0940(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:15 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:15 +0800] [Client 139] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:15 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:15 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:15 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:15 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:15 +0800] [Client 148] 2.0 CUPS-Get-Default 399
D [25/Mar/2025:18:39:15 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:15 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:15 +0800] [Client 148] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:15 +0800] [Client 148] Content-Length: 113
D [25/Mar/2025:18:39:15 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:15 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:15 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:15 +0800] [Client 139] 2.0 CUPS-Get-Default 94
D [25/Mar/2025:18:39:15 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:15 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:15 +0800] [Client 139] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:15 +0800] [Client 139] Content-Length: 113
D [25/Mar/2025:18:39:15 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:15 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:15 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786af3d70(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:15 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:15 +0800] [Client 148] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:15 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:15 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:15 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:15 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786b27620(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:15 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:15 +0800] [Client 139] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:15 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:15 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:15 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:15 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:15 +0800] [Job 18] Create-Job: successful-ok (successful-ok)
D [25/Mar/2025:18:39:15 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:15 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:15 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:15 +0800] [Job 18] ---- job-attributes-tag ----
D [25/Mar/2025:18:39:15 +0800] [Job 18] job-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print/job-26
D [25/Mar/2025:18:39:15 +0800] [Job 18] job-id integer 26
D [25/Mar/2025:18:39:15 +0800] [Job 18] job-state enum pending
D [25/Mar/2025:18:39:15 +0800] [Job 18] job-state-message textWithLanguage [en]
D [25/Mar/2025:18:39:15 +0800] [Job 18] job-state-reasons keyword none
D [25/Mar/2025:18:39:15 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:15 +0800] [Job 18] Print job accepted - job ID 26.
D [25/Mar/2025:18:39:15 +0800] [Job 18] Sending file 1 using chunking...
D [25/Mar/2025:18:39:15 +0800] [Job 18] IPP/2.0 Send-Document #4
D [25/Mar/2025:18:39:15 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:15 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:15 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:15 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:15 +0800] [Job 18] job-id integer 26
D [25/Mar/2025:18:39:15 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:15 +0800] [Job 18] last-document boolean true
D [25/Mar/2025:18:39:15 +0800] [Job 18] document-format mimeMediaType image/pwg-raster
D [25/Mar/2025:18:39:15 +0800] [Job 18] compression keyword gzip
D [25/Mar/2025:18:39:15 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:16 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:19 +0800] [Job 18] IPP/2.0 Get-Printer-Attributes #5
D [25/Mar/2025:18:39:19 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:19 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:19 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:19 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:19 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:19 +0800] [Job 18] requested-attributes 1setOf keyword compression-supported,copies-supported,cups-version,document-format-supported,job-password-encryption-supported,marker-colors,marker-high-levels,marker-levels,marker-low-levels,marker-message,marker-names,marker-types,media-col-supported,multiple-document-handling-supported,operations-supported,print-color-mode-supported,print-scaling-supported,printer-alert,printer-alert-description,printer-is-accepting-jobs,printer-mandatory-job-attributes,printer-state,printer-state-message,printer-state-reasons
D [25/Mar/2025:18:39:19 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:19 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:20 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:20 +0800] [Job 18] update_reasons(attr=1(none), s=\"(null)\")
D [25/Mar/2025:18:39:20 +0800] [Job 18] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:20 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:20 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:20 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:20 +0800] [Job 18] ---- unsupported-attributes-tag ----
D [25/Mar/2025:18:39:20 +0800] [Job 18] requested-attributes 1setOf keyword cups-version,job-password-encryption-supported,marker-message,multiple-document-handling-supported,printer-state-message
D [25/Mar/2025:18:39:20 +0800] [Job 18] ---- printer-attributes-tag ----
D [25/Mar/2025:18:39:20 +0800] [Job 18] compression-supported 1setOf keyword none,gzip
D [25/Mar/2025:18:39:20 +0800] [Job 18] copies-supported rangeOfInteger 1-999
D [25/Mar/2025:18:39:20 +0800] [Job 18] document-format-supported 1setOf mimeMediaType application/octet-stream,image/urf,image/pwg-raster
D [25/Mar/2025:18:39:20 +0800] [Job 18] marker-colors nameWithLanguage #000000[en]
D [25/Mar/2025:18:39:20 +0800] [Job 18] marker-high-levels integer 100
D [25/Mar/2025:18:39:20 +0800] [Job 18] marker-levels integer 100
D [25/Mar/2025:18:39:20 +0800] [Job 18] marker-low-levels integer 9
D [25/Mar/2025:18:39:20 +0800] [Job 18] marker-names nameWithLanguage BK[en]
D [25/Mar/2025:18:39:20 +0800] [Job 18] marker-types keyword toner
D [25/Mar/2025:18:39:20 +0800] [Job 18] media-col-supported 1setOf keyword media-type,media-size,media-top-margin,media-left-margin,media-right-margin,media-bottom-margin,media-source,media-auto-dimension,media-source-properties
D [25/Mar/2025:18:39:20 +0800] [Job 18] operations-supported 1setOf enum Print-Job,Validate-Job,Create-Job,Send-Document,Cancel-Job,Get-Job-Attributes,Get-Jobs,Get-Printer-Attributes,Cancel-My-Jobs,Close-Job,Identify-Printer
D [25/Mar/2025:18:39:20 +0800] [Job 18] print-color-mode-supported 1setOf keyword monochrome,auto,auto-monochrome
D [25/Mar/2025:18:39:20 +0800] [Job 18] print-scaling-supported 1setOf keyword auto,auto-fit,fill,fit,none
D [25/Mar/2025:18:39:20 +0800] [Job 18] printer-alert octetString code=other
D [25/Mar/2025:18:39:20 +0800] [Job 18] printer-alert-description textWithLanguage Ready[en]
D [25/Mar/2025:18:39:20 +0800] [Job 18] printer-is-accepting-jobs boolean true
D [25/Mar/2025:18:39:20 +0800] [Job 18] printer-mandatory-job-attributes 1setOf keyword attributes-charset,attributes-natural-language,printer-uri
D [25/Mar/2025:18:39:20 +0800] [Job 18] printer-state enum idle
D [25/Mar/2025:18:39:20 +0800] [Job 18] printer-state-reasons keyword none
D [25/Mar/2025:18:39:20 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:21 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:21 +0800] Report: clients=8
D [25/Mar/2025:18:39:21 +0800] Report: jobs=14
D [25/Mar/2025:18:39:21 +0800] Report: jobs-active=1
D [25/Mar/2025:18:39:21 +0800] Report: printers=1
D [25/Mar/2025:18:39:21 +0800] Report: stringpool-string-count=5838
D [25/Mar/2025:18:39:21 +0800] Report: stringpool-alloc-bytes=14984
D [25/Mar/2025:18:39:21 +0800] Report: stringpool-total-bytes=118096
D [25/Mar/2025:18:39:23 +0800] [Job 18] (monitor) Get-Job-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:23 +0800] [Job 18] (monitor) job-state = processing
D [25/Mar/2025:18:39:23 +0800] [Job 18] (monitor) job-state = processing
D [25/Mar/2025:18:39:23 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:24 +0800] [Job 18] IPP/2.0 Get-Printer-Attributes #7
D [25/Mar/2025:18:39:24 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:24 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:24 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:24 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:24 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:24 +0800] [Job 18] requested-attributes 1setOf keyword compression-supported,copies-supported,cups-version,document-format-supported,job-password-encryption-supported,marker-colors,marker-high-levels,marker-levels,marker-low-levels,marker-message,marker-names,marker-types,media-col-supported,multiple-document-handling-supported,operations-supported,print-color-mode-supported,print-scaling-supported,printer-alert,printer-alert-description,printer-is-accepting-jobs,printer-mandatory-job-attributes,printer-state,printer-state-message,printer-state-reasons
D [25/Mar/2025:18:39:24 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:24 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:25 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:29 +0800] [Job 18] update_reasons(attr=1(none), s=\"(null)\")
D [25/Mar/2025:18:39:29 +0800] [Job 18] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:29 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:29 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:29 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:29 +0800] [Job 18] ---- unsupported-attributes-tag ----
D [25/Mar/2025:18:39:29 +0800] [Job 18] requested-attributes 1setOf keyword cups-version,job-password-encryption-supported,marker-message,multiple-document-handling-supported,printer-state-message
D [25/Mar/2025:18:39:29 +0800] [Job 18] ---- printer-attributes-tag ----
D [25/Mar/2025:18:39:29 +0800] [Job 18] compression-supported 1setOf keyword none,gzip
D [25/Mar/2025:18:39:29 +0800] [Job 18] copies-supported rangeOfInteger 1-999
D [25/Mar/2025:18:39:29 +0800] [Job 18] document-format-supported 1setOf mimeMediaType application/octet-stream,image/urf,image/pwg-raster
D [25/Mar/2025:18:39:29 +0800] [Job 18] marker-colors nameWithLanguage #000000[en]
D [25/Mar/2025:18:39:29 +0800] [Job 18] marker-high-levels integer 100
D [25/Mar/2025:18:39:29 +0800] [Job 18] marker-levels integer 100
D [25/Mar/2025:18:39:29 +0800] [Job 18] marker-low-levels integer 9
D [25/Mar/2025:18:39:29 +0800] [Job 18] marker-names nameWithLanguage BK[en]
D [25/Mar/2025:18:39:29 +0800] [Job 18] marker-types keyword toner
D [25/Mar/2025:18:39:29 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:29 +0800] [Job 18] media-col-supported 1setOf keyword media-type,media-size,media-top-margin,media-left-margin,media-right-margin,media-bottom-margin,media-source,media-auto-dimension,media-source-properties
D [25/Mar/2025:18:39:29 +0800] [Job 18] operations-supported 1setOf enum Print-Job,Validate-Job,Create-Job,Send-Document,Cancel-Job,Get-Job-Attributes,Get-Jobs,Get-Printer-Attributes,Cancel-My-Jobs,Close-Job,Identify-Printer
D [25/Mar/2025:18:39:29 +0800] [Job 18] print-color-mode-supported 1setOf keyword monochrome,auto,auto-monochrome
D [25/Mar/2025:18:39:29 +0800] [Job 18] print-scaling-supported 1setOf keyword auto,auto-fit,fill,fit,none
D [25/Mar/2025:18:39:29 +0800] [Job 18] printer-alert octetString code=other
D [25/Mar/2025:18:39:29 +0800] [Job 18] printer-alert-description textWithLanguage Ready[en]
D [25/Mar/2025:18:39:29 +0800] [Job 18] printer-is-accepting-jobs boolean true
D [25/Mar/2025:18:39:29 +0800] [Job 18] printer-mandatory-job-attributes 1setOf keyword attributes-charset,attributes-natural-language,printer-uri
D [25/Mar/2025:18:39:29 +0800] [Job 18] printer-state enum idle
D [25/Mar/2025:18:39:29 +0800] [Job 18] printer-state-reasons keyword none
D [25/Mar/2025:18:39:29 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:30 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:31 +0800] [Job 18] cfFilterGhostscript: Processing page 2...
D [25/Mar/2025:18:39:31 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Job 18] Set job-printer-state-message to "cfFilterGhostscript: Processing page 2...", current level=INFO
D [25/Mar/2025:18:39:31 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:31 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:31 +0800] [Job 18] cfFilterGhostscript: Rendering completed
D [25/Mar/2025:18:39:31 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Job 18] Set job-printer-state-message to "cfFilterGhostscript: Rendering completed", current level=INFO
D [25/Mar/2025:18:39:31 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:31 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Job 18] cfFilterGhostscript: Ghostscript (PID 2696191) exited with no errors.
D [25/Mar/2025:18:39:31 +0800] [Job 18] cfFilterGhostscript: Logging (PID 2696192) exited with no errors.
D [25/Mar/2025:18:39:31 +0800] [Job 18] cfFilterChain: ghostscript completed with status 0.
D [25/Mar/2025:18:39:31 +0800] [Job 18] cfFilterChain: ghostscript (PID 2696190) exited with no errors.
D [25/Mar/2025:18:39:31 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Job 18] Set job-printer-state-message to "cfFilterChain: ghostscript (PID 2696190) exited with no errors.", current level=INFO
D [25/Mar/2025:18:39:31 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:31 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Job 18] PID 2696186 (/usr/lib/cups/filter/universal) exited with no errors.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 220] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:31 +0800] [Client 220] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:31 +0800] [Client 220] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 221] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:31 +0800] [Client 221] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:31 +0800] [Client 221] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] [Client 220] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 220] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 220] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 220] 2.0 Get-Notifications 95
D [25/Mar/2025:18:39:31 +0800] Get-Notifications /
D [25/Mar/2025:18:39:31 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:31 +0800] [Client 220] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 220] Content-Length: 1336
D [25/Mar/2025:18:39:31 +0800] [Client 220] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 220] con->http=0x641786c4da90
D [25/Mar/2025:18:39:31 +0800] [Client 220] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1336, response=0x641786bdb9a0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 220] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 220] bytes=0, http_state=0, data_remaining=1336
D [25/Mar/2025:18:39:31 +0800] [Client 220] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 220] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 220] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 221] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 221] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 221] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 221] 2.0 Get-Notifications 400
D [25/Mar/2025:18:39:31 +0800] Get-Notifications /
D [25/Mar/2025:18:39:31 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:31 +0800] [Client 221] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 221] Content-Length: 1336
D [25/Mar/2025:18:39:31 +0800] [Client 221] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 221] con->http=0x641786c510e0
D [25/Mar/2025:18:39:31 +0800] [Client 221] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1336, response=0x641786bf83e0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 221] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 221] bytes=0, http_state=0, data_remaining=1336
D [25/Mar/2025:18:39:31 +0800] [Client 221] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 221] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 221] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 203] 2.0 Get-Printer-Attributes 401
D [25/Mar/2025:18:39:31 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:31 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 203] Content-Length: 25072
D [25/Mar/2025:18:39:31 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:31 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25072, response=0x641786bdb9a0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25072
D [25/Mar/2025:18:39:31 +0800] [Client 220] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:31 +0800] [Client 220] Closing connection.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:31 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25072, response=0x641786bdb9a0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25072
D [25/Mar/2025:18:39:31 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 203] 2.0 Get-Printer-Attributes 402
D [25/Mar/2025:18:39:31 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:31 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 203] Content-Length: 25072
D [25/Mar/2025:18:39:31 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:31 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25072, response=0x641786c29200(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25072
D [25/Mar/2025:18:39:31 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:31 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25072, response=0x641786c29200(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25072
D [25/Mar/2025:18:39:31 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 203] 2.0 Get-Printer-Attributes 403
D [25/Mar/2025:18:39:31 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:31 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 203] Content-Length: 25072
D [25/Mar/2025:18:39:31 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:31 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25072, response=0x641786c21fc0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25072
D [25/Mar/2025:18:39:31 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:31 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25072, response=0x641786c21fc0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25072
D [25/Mar/2025:18:39:31 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 221] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:31 +0800] [Client 221] Closing connection.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 139] 2.0 CUPS-Get-Printers 96
D [25/Mar/2025:18:39:31 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:31 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 139] Content-Length: 497
D [25/Mar/2025:18:39:31 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:31 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=497, response=0x641786afcf60(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 139] bytes=0, http_state=0, data_remaining=497
D [25/Mar/2025:18:39:31 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 139] 2.0 CUPS-Get-Classes 97
D [25/Mar/2025:18:39:31 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:31 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 139] Content-Length: 75
D [25/Mar/2025:18:39:31 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:31 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786b2c410(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 139] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:31 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 139] 2.0 CUPS-Get-Default 98
D [25/Mar/2025:18:39:31 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:31 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:31 +0800] [Client 139] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 139] Content-Length: 113
D [25/Mar/2025:18:39:31 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:31 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786bdb9a0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 139] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:31 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 148] 2.0 CUPS-Get-Printers 404
D [25/Mar/2025:18:39:31 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:31 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 148] Content-Length: 497
D [25/Mar/2025:18:39:31 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:31 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=497, response=0x641786b2c410(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 148] bytes=0, http_state=0, data_remaining=497
D [25/Mar/2025:18:39:31 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 148] 2.0 CUPS-Get-Classes 405
D [25/Mar/2025:18:39:31 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:31 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 148] Content-Length: 75
D [25/Mar/2025:18:39:31 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:31 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786bdb9a0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 148] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:31 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:31 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:31 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:31 +0800] [Client 148] 2.0 CUPS-Get-Default 406
D [25/Mar/2025:18:39:31 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:31 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:31 +0800] [Client 148] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:31 +0800] [Client 148] Content-Length: 113
D [25/Mar/2025:18:39:31 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:31 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:31 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786b2c410(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:31 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:31 +0800] [Client 148] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:31 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:31 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:31 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:31 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:32 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:34 +0800] [Job 18] (monitor) Get-Job-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:34 +0800] [Job 18] (monitor) job-state = processing
D [25/Mar/2025:18:39:34 +0800] [Job 18] (monitor) job-state = processing
D [25/Mar/2025:18:39:34 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:35 +0800] [Job 18] IPP/2.0 Get-Printer-Attributes #9
D [25/Mar/2025:18:39:35 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:35 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:35 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:35 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:35 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:35 +0800] [Job 18] requested-attributes 1setOf keyword compression-supported,copies-supported,cups-version,document-format-supported,job-password-encryption-supported,marker-colors,marker-high-levels,marker-levels,marker-low-levels,marker-message,marker-names,marker-types,media-col-supported,multiple-document-handling-supported,operations-supported,print-color-mode-supported,print-scaling-supported,printer-alert,printer-alert-description,printer-is-accepting-jobs,printer-mandatory-job-attributes,printer-state,printer-state-message,printer-state-reasons
D [25/Mar/2025:18:39:35 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:35 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:36 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:41 +0800] [Job 18] update_reasons(attr=1(none), s=\"(null)\")
D [25/Mar/2025:18:39:41 +0800] [Job 18] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:41 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:41 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:41 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:41 +0800] [Job 18] ---- unsupported-attributes-tag ----
D [25/Mar/2025:18:39:41 +0800] [Job 18] requested-attributes 1setOf keyword cups-version,job-password-encryption-supported,marker-message,multiple-document-handling-supported,printer-state-message
D [25/Mar/2025:18:39:41 +0800] [Job 18] ---- printer-attributes-tag ----
D [25/Mar/2025:18:39:41 +0800] [Job 18] compression-supported 1setOf keyword none,gzip
D [25/Mar/2025:18:39:41 +0800] [Job 18] copies-supported rangeOfInteger 1-999
D [25/Mar/2025:18:39:41 +0800] [Job 18] document-format-supported 1setOf mimeMediaType application/octet-stream,image/urf,image/pwg-raster
D [25/Mar/2025:18:39:41 +0800] [Job 18] marker-colors nameWithLanguage #000000[en]
D [25/Mar/2025:18:39:41 +0800] [Job 18] marker-high-levels integer 100
D [25/Mar/2025:18:39:41 +0800] [Job 18] marker-levels integer 100
D [25/Mar/2025:18:39:41 +0800] [Job 18] marker-low-levels integer 9
D [25/Mar/2025:18:39:41 +0800] [Job 18] marker-names nameWithLanguage BK[en]
D [25/Mar/2025:18:39:41 +0800] [Job 18] marker-types keyword toner
D [25/Mar/2025:18:39:41 +0800] [Job 18] media-col-supported 1setOf keyword media-type,media-size,media-top-margin,media-left-margin,media-right-margin,media-bottom-margin,media-source,media-auto-dimension,media-source-properties
D [25/Mar/2025:18:39:41 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:41 +0800] [Job 18] operations-supported 1setOf enum Print-Job,Validate-Job,Create-Job,Send-Document,Cancel-Job,Get-Job-Attributes,Get-Jobs,Get-Printer-Attributes,Cancel-My-Jobs,Close-Job,Identify-Printer
D [25/Mar/2025:18:39:41 +0800] [Job 18] print-color-mode-supported 1setOf keyword monochrome,auto,auto-monochrome
D [25/Mar/2025:18:39:41 +0800] [Job 18] print-scaling-supported 1setOf keyword auto,auto-fit,fill,fit,none
D [25/Mar/2025:18:39:41 +0800] [Job 18] printer-alert octetString code=other
D [25/Mar/2025:18:39:41 +0800] [Job 18] printer-alert-description textWithLanguage Ready[en]
D [25/Mar/2025:18:39:41 +0800] [Job 18] printer-is-accepting-jobs boolean true
D [25/Mar/2025:18:39:41 +0800] [Job 18] printer-mandatory-job-attributes 1setOf keyword attributes-charset,attributes-natural-language,printer-uri
D [25/Mar/2025:18:39:41 +0800] [Job 18] printer-state enum idle
D [25/Mar/2025:18:39:41 +0800] [Job 18] printer-state-reasons keyword none
D [25/Mar/2025:18:39:41 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:42 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:43 +0800] [Job 18] (monitor) Get-Job-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:43 +0800] [Job 18] (monitor) job-state = processing
D [25/Mar/2025:18:39:43 +0800] [Job 18] (monitor) job-state = processing
I [25/Mar/2025:18:39:43 +0800] Saving printers.conf...
I [25/Mar/2025:18:39:43 +0800] Saving job.cache...
I [25/Mar/2025:18:39:43 +0800] Saving subscriptions.conf...
D [25/Mar/2025:18:39:43 +0800] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:43 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:44 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:45 +0800] [Job 18] IPP/2.0 Get-Printer-Attributes #11
D [25/Mar/2025:18:39:45 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:45 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:45 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:45 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:45 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:45 +0800] [Job 18] requested-attributes 1setOf keyword compression-supported,copies-supported,cups-version,document-format-supported,job-password-encryption-supported,marker-colors,marker-high-levels,marker-levels,marker-low-levels,marker-message,marker-names,marker-types,media-col-supported,multiple-document-handling-supported,operations-supported,print-color-mode-supported,print-scaling-supported,printer-alert,printer-alert-description,printer-is-accepting-jobs,printer-mandatory-job-attributes,printer-state,printer-state-message,printer-state-reasons
D [25/Mar/2025:18:39:45 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:45 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:46 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:49 +0800] [Job 18] update_reasons(attr=1(none), s=\"(null)\")
D [25/Mar/2025:18:39:49 +0800] [Job 18] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- unsupported-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] requested-attributes 1setOf keyword cups-version,job-password-encryption-supported,marker-message,multiple-document-handling-supported,printer-state-message
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- printer-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] compression-supported 1setOf keyword none,gzip
D [25/Mar/2025:18:39:49 +0800] [Job 18] copies-supported rangeOfInteger 1-999
D [25/Mar/2025:18:39:49 +0800] [Job 18] document-format-supported 1setOf mimeMediaType application/octet-stream,image/urf,image/pwg-raster
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-colors nameWithLanguage #000000[en]
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-high-levels integer 100
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-levels integer 100
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-low-levels integer 9
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-names nameWithLanguage BK[en]
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-types keyword toner
D [25/Mar/2025:18:39:49 +0800] [Job 18] media-col-supported 1setOf keyword media-type,media-size,media-top-margin,media-left-margin,media-right-margin,media-bottom-margin,media-source,media-auto-dimension,media-source-properties
D [25/Mar/2025:18:39:49 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:49 +0800] [Job 18] operations-supported 1setOf enum Print-Job,Validate-Job,Create-Job,Send-Document,Cancel-Job,Get-Job-Attributes,Get-Jobs,Get-Printer-Attributes,Cancel-My-Jobs,Close-Job,Identify-Printer
D [25/Mar/2025:18:39:49 +0800] [Job 18] print-color-mode-supported 1setOf keyword monochrome,auto,auto-monochrome
D [25/Mar/2025:18:39:49 +0800] [Job 18] print-scaling-supported 1setOf keyword auto,auto-fit,fill,fit,none
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-alert octetString code=other
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-alert-description textWithLanguage Ready[en]
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-is-accepting-jobs boolean true
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-mandatory-job-attributes 1setOf keyword attributes-charset,attributes-natural-language,printer-uri
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-state enum idle
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-state-reasons keyword none
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] Send-Document: successful-ok (successful-ok)
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- job-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print/job-26
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-id integer 26
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-state enum processing
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-state-message textWithLanguage [en]
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-state-reasons 1setOf keyword job-incoming,job-printing
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] STATE: +cups-waiting-for-job-completed
D [25/Mar/2025:18:39:49 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs"
D [25/Mar/2025:18:39:49 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Job 18] Waiting for job to complete.
D [25/Mar/2025:18:39:49 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Job 18] Set job-printer-state-message to "Waiting for job to complete.", current level=INFO
D [25/Mar/2025:18:39:49 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:49 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Job 18] IPP/2.0 Get-Printer-Attributes #13
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:49 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:49 +0800] [Job 18] requested-attributes 1setOf keyword compression-supported,copies-supported,cups-version,document-format-supported,job-password-encryption-supported,marker-colors,marker-high-levels,marker-levels,marker-low-levels,marker-message,marker-names,marker-types,media-col-supported,multiple-document-handling-supported,operations-supported,print-color-mode-supported,print-scaling-supported,printer-alert,printer-alert-description,printer-is-accepting-jobs,printer-mandatory-job-attributes,printer-state,printer-state-message,printer-state-reasons
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] (monitor) Get-Job-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:49 +0800] [Job 18] (monitor) job-state = processing
D [25/Mar/2025:18:39:49 +0800] [Job 18] JOBSTATE: document-format-error
D [25/Mar/2025:18:39:49 +0800] [Job 18] (monitor) job-state = processing
D [25/Mar/2025:18:39:49 +0800] [Job 18] update_reasons(attr=1(none), s=\"(null)\")
D [25/Mar/2025:18:39:49 +0800] [Job 18] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- unsupported-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] requested-attributes 1setOf keyword cups-version,job-password-encryption-supported,marker-message,multiple-document-handling-supported,printer-state-message
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- printer-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] compression-supported 1setOf keyword none,gzip
D [25/Mar/2025:18:39:49 +0800] [Job 18] copies-supported rangeOfInteger 1-999
D [25/Mar/2025:18:39:49 +0800] [Job 18] document-format-supported 1setOf mimeMediaType application/octet-stream,image/urf,image/pwg-raster
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-colors nameWithLanguage #000000[en]
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-high-levels integer 100
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-levels integer 100
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-low-levels integer 9
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-names nameWithLanguage BK[en]
D [25/Mar/2025:18:39:49 +0800] [Job 18] marker-types keyword toner
D [25/Mar/2025:18:39:49 +0800] [Job 18] media-col-supported 1setOf keyword media-type,media-size,media-top-margin,media-left-margin,media-right-margin,media-bottom-margin,media-source,media-auto-dimension,media-source-properties
D [25/Mar/2025:18:39:49 +0800] [Job 18] operations-supported 1setOf enum Print-Job,Validate-Job,Create-Job,Send-Document,Cancel-Job,Get-Job-Attributes,Get-Jobs,Get-Printer-Attributes,Cancel-My-Jobs,Close-Job,Identify-Printer
D [25/Mar/2025:18:39:49 +0800] [Job 18] print-color-mode-supported 1setOf keyword monochrome,auto,auto-monochrome
D [25/Mar/2025:18:39:49 +0800] [Job 18] print-scaling-supported 1setOf keyword auto,auto-fit,fill,fit,none
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-alert octetString code=other
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-alert-description textWithLanguage Cancel Printing[en]
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-is-accepting-jobs boolean true
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-mandatory-job-attributes 1setOf keyword attributes-charset,attributes-natural-language,printer-uri
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-state enum idle
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-state-reasons keyword none
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] IPP/2.0 Get-Job-Attributes #14
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:49 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-id integer 26
D [25/Mar/2025:18:39:49 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:49 +0800] [Job 18] requested-attributes 1setOf keyword job-id,job-impressions-completed,job-media-sheets-completed,job-name,job-originating-user-name,job-state,job-state-reasons
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 222] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:49 +0800] [Client 222] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:49 +0800] [Client 222] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 223] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:49 +0800] [Client 223] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:49 +0800] [Client 223] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] [Client 222] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 222] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 222] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 222] 2.0 Get-Notifications 99
D [25/Mar/2025:18:39:49 +0800] Get-Notifications /
D [25/Mar/2025:18:39:49 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:49 +0800] [Client 222] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 222] Content-Length: 556
D [25/Mar/2025:18:39:49 +0800] [Client 222] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 222] con->http=0x641786c4da90
D [25/Mar/2025:18:39:49 +0800] [Client 222] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=556, response=0x641786c08530(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 222] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 222] bytes=0, http_state=0, data_remaining=556
D [25/Mar/2025:18:39:49 +0800] [Client 222] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 222] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 222] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 223] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 223] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 223] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 223] 2.0 Get-Notifications 407
D [25/Mar/2025:18:39:49 +0800] Get-Notifications /
D [25/Mar/2025:18:39:49 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:49 +0800] [Client 223] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 223] Content-Length: 556
D [25/Mar/2025:18:39:49 +0800] [Client 223] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 223] con->http=0x641786c510e0
D [25/Mar/2025:18:39:49 +0800] [Client 223] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=556, response=0x641786c280c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 223] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 223] bytes=0, http_state=0, data_remaining=556
D [25/Mar/2025:18:39:49 +0800] [Client 223] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 223] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 223] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 222] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:49 +0800] [Client 222] Closing connection.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 203] 2.0 Get-Printer-Attributes 408
D [25/Mar/2025:18:39:49 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:49 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 203] Content-Length: 25063
D [25/Mar/2025:18:39:49 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:49 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25063, response=0x641786c08530(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25063
D [25/Mar/2025:18:39:49 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:49 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25063, response=0x641786c08530(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25063
D [25/Mar/2025:18:39:49 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 223] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:49 +0800] [Client 223] Closing connection.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 203] 2.0 Get-Printer-Attributes 409
D [25/Mar/2025:18:39:49 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:49 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 203] Content-Length: 25063
D [25/Mar/2025:18:39:49 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:49 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25063, response=0x641786c0b150(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 203] bytes=1, http_state=7, data_remaining=25063
D [25/Mar/2025:18:39:49 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:49 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=25063, response=0x641786c0b150(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 203] bytes=0, http_state=0, data_remaining=25063
D [25/Mar/2025:18:39:49 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 139] 2.0 CUPS-Get-Printers 100
D [25/Mar/2025:18:39:49 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:49 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 139] Content-Length: 488
D [25/Mar/2025:18:39:49 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:49 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=488, response=0x641786c21fc0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 139] bytes=0, http_state=0, data_remaining=488
D [25/Mar/2025:18:39:49 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 148] 2.0 CUPS-Get-Printers 410
D [25/Mar/2025:18:39:49 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:49 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 148] Content-Length: 488
D [25/Mar/2025:18:39:49 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 139] 2.0 CUPS-Get-Classes 101
D [25/Mar/2025:18:39:49 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:49 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 139] Content-Length: 75
D [25/Mar/2025:18:39:49 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:49 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=488, response=0x641786c08530(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 148] bytes=0, http_state=0, data_remaining=488
D [25/Mar/2025:18:39:49 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:49 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786afcf60(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 139] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:49 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Job 18] Get-Job-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:49 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- unsupported-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] requested-attributes keyword job-media-sheets-completed
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- job-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-id integer 26
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-impressions-completed integer 0
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-name nameWithoutLanguage Test Page
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-originating-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-state enum processing
D [25/Mar/2025:18:39:49 +0800] [Job 18] job-state-reasons 1setOf keyword job-incoming,job-printing,processing-to-stop-point,document-format-error
D [25/Mar/2025:18:39:49 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:49 +0800] [Job 18] PAGE: total 0
D [25/Mar/2025:18:39:49 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:49 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 148] 2.0 CUPS-Get-Classes 411
D [25/Mar/2025:18:39:49 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:49 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 148] Content-Length: 75
D [25/Mar/2025:18:39:49 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 139] 2.0 CUPS-Get-Default 102
D [25/Mar/2025:18:39:49 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:49 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:49 +0800] [Client 139] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 139] Content-Length: 113
D [25/Mar/2025:18:39:49 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:49 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786c0add0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 148] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:49 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:49 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786c21fc0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 139] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:49 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:49 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:49 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:49 +0800] [Client 148] 2.0 CUPS-Get-Default 412
D [25/Mar/2025:18:39:49 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:49 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:49 +0800] [Client 148] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:49 +0800] [Client 148] Content-Length: 113
D [25/Mar/2025:18:39:49 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:49 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:49 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786c08530(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:49 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:49 +0800] [Client 148] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:49 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:49 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:49 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:49 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [25/Mar/2025:18:39:50 +0800] [Job 18] IPP/2.0 Get-Printer-Attributes #15
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:50 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:50 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:50 +0800] [Job 18] requested-attributes 1setOf keyword compression-supported,copies-supported,cups-version,document-format-supported,job-password-encryption-supported,marker-colors,marker-high-levels,marker-levels,marker-low-levels,marker-message,marker-names,marker-types,media-col-supported,multiple-document-handling-supported,operations-supported,print-color-mode-supported,print-scaling-supported,printer-alert,printer-alert-description,printer-is-accepting-jobs,printer-mandatory-job-attributes,printer-state,printer-state-message,printer-state-reasons
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:50 +0800] [Job 18] update_reasons(attr=1(none), s=\"(null)\")
D [25/Mar/2025:18:39:50 +0800] [Job 18] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- unsupported-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] requested-attributes 1setOf keyword cups-version,job-password-encryption-supported,marker-message,multiple-document-handling-supported,printer-state-message
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- printer-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] compression-supported 1setOf keyword none,gzip
D [25/Mar/2025:18:39:50 +0800] [Job 18] copies-supported rangeOfInteger 1-999
D [25/Mar/2025:18:39:50 +0800] [Job 18] document-format-supported 1setOf mimeMediaType application/octet-stream,image/urf,image/pwg-raster
D [25/Mar/2025:18:39:50 +0800] [Job 18] marker-colors nameWithLanguage #000000[en]
D [25/Mar/2025:18:39:50 +0800] [Job 18] marker-high-levels integer 100
D [25/Mar/2025:18:39:50 +0800] [Job 18] marker-levels integer 100
D [25/Mar/2025:18:39:50 +0800] [Job 18] marker-low-levels integer 9
D [25/Mar/2025:18:39:50 +0800] [Job 18] marker-names nameWithLanguage BK[en]
D [25/Mar/2025:18:39:50 +0800] [Job 18] marker-types keyword toner
D [25/Mar/2025:18:39:50 +0800] [Job 18] media-col-supported 1setOf keyword media-type,media-size,media-top-margin,media-left-margin,media-right-margin,media-bottom-margin,media-source,media-auto-dimension,media-source-properties
D [25/Mar/2025:18:39:50 +0800] [Job 18] operations-supported 1setOf enum Print-Job,Validate-Job,Create-Job,Send-Document,Cancel-Job,Get-Job-Attributes,Get-Jobs,Get-Printer-Attributes,Cancel-My-Jobs,Close-Job,Identify-Printer
D [25/Mar/2025:18:39:50 +0800] [Job 18] print-color-mode-supported 1setOf keyword monochrome,auto,auto-monochrome
D [25/Mar/2025:18:39:50 +0800] [Job 18] print-scaling-supported 1setOf keyword auto,auto-fit,fill,fit,none
D [25/Mar/2025:18:39:50 +0800] [Job 18] printer-alert octetString code=other
D [25/Mar/2025:18:39:50 +0800] [Job 18] printer-alert-description textWithLanguage Ready[en]
D [25/Mar/2025:18:39:50 +0800] [Job 18] printer-is-accepting-jobs boolean true
D [25/Mar/2025:18:39:50 +0800] [Job 18] printer-mandatory-job-attributes 1setOf keyword attributes-charset,attributes-natural-language,printer-uri
D [25/Mar/2025:18:39:50 +0800] [Job 18] printer-state enum idle
D [25/Mar/2025:18:39:50 +0800] [Job 18] printer-state-reasons keyword none
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] IPP/2.0 Get-Job-Attributes #16
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:50 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:50 +0800] [Job 18] job-id integer 26
D [25/Mar/2025:18:39:50 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:50 +0800] [Job 18] requested-attributes 1setOf keyword job-id,job-impressions-completed,job-media-sheets-completed,job-name,job-originating-user-name,job-state,job-state-reasons
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] Get-Job-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- unsupported-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] requested-attributes keyword job-media-sheets-completed
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- job-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] job-id integer 26
D [25/Mar/2025:18:39:50 +0800] [Job 18] job-impressions-completed integer 0
D [25/Mar/2025:18:39:50 +0800] [Job 18] job-name nameWithoutLanguage Test Page
D [25/Mar/2025:18:39:50 +0800] [Job 18] job-originating-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:50 +0800] [Job 18] job-state enum aborted
D [25/Mar/2025:18:39:50 +0800] [Job 18] job-state-reasons keyword document-format-error
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] PAGE: total 0
D [25/Mar/2025:18:39:50 +0800] Discarding unused job-progress event...
D [25/Mar/2025:18:39:50 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:50 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:50 +0800] [Job 18] IPP/2.0 Get-Printer-Attributes #17
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:50 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:50 +0800] [Job 18] printer-uri uri ipp://BRWC8A3E813594B.local:631/ipp/print
D [25/Mar/2025:18:39:50 +0800] [Job 18] requesting-user-name nameWithoutLanguage chris
D [25/Mar/2025:18:39:50 +0800] [Job 18] requested-attributes 1setOf keyword compression-supported,copies-supported,cups-version,document-format-supported,job-password-encryption-supported,marker-colors,marker-high-levels,marker-levels,marker-low-levels,marker-message,marker-names,marker-types,media-col-supported,multiple-document-handling-supported,operations-supported,print-color-mode-supported,print-scaling-supported,printer-alert,printer-alert-description,printer-is-accepting-jobs,printer-mandatory-job-attributes,printer-state,printer-state-message,printer-state-reasons
D [25/Mar/2025:18:39:50 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:51 +0800] [Job 18] update_reasons(attr=1(none), s=\"(null)\")
D [25/Mar/2025:18:39:51 +0800] [Job 18] Get-Printer-Attributes: successful-ok-ignored-or-substituted-attributes (successful-ok-ignored-or-substituted-attributes)
D [25/Mar/2025:18:39:51 +0800] [Job 18] ---- operation-attributes-tag ----
D [25/Mar/2025:18:39:51 +0800] [Job 18] attributes-charset charset utf-8
D [25/Mar/2025:18:39:51 +0800] [Job 18] attributes-natural-language naturalLanguage en-us
D [25/Mar/2025:18:39:51 +0800] [Job 18] ---- unsupported-attributes-tag ----
D [25/Mar/2025:18:39:51 +0800] [Job 18] requested-attributes 1setOf keyword cups-version,job-password-encryption-supported,marker-message,multiple-document-handling-supported,printer-state-message
D [25/Mar/2025:18:39:51 +0800] [Job 18] ---- printer-attributes-tag ----
D [25/Mar/2025:18:39:51 +0800] [Job 18] compression-supported 1setOf keyword none,gzip
D [25/Mar/2025:18:39:51 +0800] [Job 18] copies-supported rangeOfInteger 1-999
D [25/Mar/2025:18:39:51 +0800] [Job 18] document-format-supported 1setOf mimeMediaType application/octet-stream,image/urf,image/pwg-raster
D [25/Mar/2025:18:39:51 +0800] [Job 18] marker-colors nameWithLanguage #000000[en]
D [25/Mar/2025:18:39:51 +0800] [Job 18] marker-high-levels integer 100
D [25/Mar/2025:18:39:51 +0800] [Job 18] marker-levels integer 100
D [25/Mar/2025:18:39:51 +0800] [Job 18] marker-low-levels integer 9
D [25/Mar/2025:18:39:51 +0800] [Job 18] marker-names nameWithLanguage BK[en]
D [25/Mar/2025:18:39:51 +0800] [Job 18] marker-types keyword toner
D [25/Mar/2025:18:39:51 +0800] [Job 18] media-col-supported 1setOf keyword media-type,media-size,media-top-margin,media-left-margin,media-right-margin,media-bottom-margin,media-source,media-auto-dimension,media-source-properties
D [25/Mar/2025:18:39:51 +0800] [Job 18] operations-supported 1setOf enum Print-Job,Validate-Job,Create-Job,Send-Document,Cancel-Job,Get-Job-Attributes,Get-Jobs,Get-Printer-Attributes,Cancel-My-Jobs,Close-Job,Identify-Printer
D [25/Mar/2025:18:39:51 +0800] [Job 18] print-color-mode-supported 1setOf keyword monochrome,auto,auto-monochrome
D [25/Mar/2025:18:39:51 +0800] [Job 18] print-scaling-supported 1setOf keyword auto,auto-fit,fill,fit,none
D [25/Mar/2025:18:39:51 +0800] [Job 18] printer-alert octetString code=other
D [25/Mar/2025:18:39:51 +0800] [Job 18] printer-alert-description textWithLanguage Ready[en]
D [25/Mar/2025:18:39:51 +0800] [Job 18] printer-is-accepting-jobs boolean true
D [25/Mar/2025:18:39:51 +0800] [Job 18] printer-mandatory-job-attributes 1setOf keyword attributes-charset,attributes-natural-language,printer-uri
D [25/Mar/2025:18:39:51 +0800] [Job 18] printer-state enum idle
D [25/Mar/2025:18:39:51 +0800] [Job 18] printer-state-reasons keyword none
D [25/Mar/2025:18:39:51 +0800] [Job 18] ---- end-of-attributes-tag ----
D [25/Mar/2025:18:39:51 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:51 +0800] [Job 18] ATTR: marker-levels=-1,99
D [25/Mar/2025:18:39:51 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Job 18] new_supply_state=0, change_state=0
D [25/Mar/2025:18:39:51 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Job 18] new_state=0, change_state=0
D [25/Mar/2025:18:39:51 +0800] [Job 18] ATTR: auth-info-required=none
D [25/Mar/2025:18:39:51 +0800] load_ppd: Loading /var/cache/cups/Brother.data...
D [25/Mar/2025:18:39:51 +0800] Brother: pdl='application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster,image/urf'
D [25/Mar/2025:18:39:51 +0800] cupsdRegisterPrinter(p=0x641786ae54f0(Brother))
D [25/Mar/2025:18:39:51 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Job 18] PID 2696187 (/usr/lib/cups/backend/ipp) exited with no errors.
D [25/Mar/2025:18:39:51 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Job 18] time-at-completed=1742899191
D [25/Mar/2025:18:39:51 +0800] Discarding unused job-completed event...
I [25/Mar/2025:18:39:51 +0800] [Job 18] Job completed.
D [25/Mar/2025:18:39:51 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:51 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:51 +0800] cupsdMarkDirty(----S)
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:51 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:51 +0800] cupsdMarkDirty(---J-)
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [25/Mar/2025:18:39:51 +0800] Updating keywords in PPD file for Brother...
D [25/Mar/2025:18:39:51 +0800] *cupsMandatory: attributes-charset attributes-natural-language printer-uri
D [25/Mar/2025:18:39:51 +0800] cupsdMarkDirty(P----)
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [25/Mar/2025:18:39:51 +0800] load_ppd: Loading /etc/cups/ppd/Brother.ppd...
D [25/Mar/2025:18:39:51 +0800] load_ppd: Saving /var/cache/cups/Brother.data...
D [25/Mar/2025:18:39:51 +0800] Brother: pdl='application/pdf,application/postscript,image/jpeg,image/png,image/pwg-raster,image/urf'
D [25/Mar/2025:18:39:51 +0800] cupsdRegisterPrinter(p=0x641786ae54f0(Brother))
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 224] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:51 +0800] [Client 224] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:51 +0800] [Client 224] Waiting for request.
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 225] Server address is "/run/cups/cups.sock".
D [25/Mar/2025:18:39:51 +0800] [Client 225] Accepted from localhost (Domain)
D [25/Mar/2025:18:39:51 +0800] [Client 225] Waiting for request.
D [25/Mar/2025:18:39:51 +0800] [Client 224] POST / HTTP/1.1
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 224] Read: status=200, state=6
D [25/Mar/2025:18:39:51 +0800] [Client 224] No authentication data provided.
D [25/Mar/2025:18:39:51 +0800] [Client 224] 2.0 Get-Notifications 413
D [25/Mar/2025:18:39:51 +0800] Get-Notifications /
D [25/Mar/2025:18:39:51 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:51 +0800] [Client 224] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:51 +0800] [Client 224] Content-Length: 967
D [25/Mar/2025:18:39:51 +0800] [Client 224] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:51 +0800] [Client 224] con->http=0x641786c4da90
D [25/Mar/2025:18:39:51 +0800] [Client 224] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=967, response=0x641786b295c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:51 +0800] [Client 224] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:51 +0800] [Client 224] bytes=0, http_state=0, data_remaining=967
D [25/Mar/2025:18:39:51 +0800] [Client 224] Flushing write buffer.
D [25/Mar/2025:18:39:51 +0800] [Client 224] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:51 +0800] [Client 224] Waiting for request.
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 225] POST / HTTP/1.1
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 225] Read: status=200, state=6
D [25/Mar/2025:18:39:51 +0800] [Client 225] No authentication data provided.
D [25/Mar/2025:18:39:51 +0800] [Client 225] 2.0 Get-Notifications 103
D [25/Mar/2025:18:39:51 +0800] Get-Notifications /
D [25/Mar/2025:18:39:51 +0800] cupsdIsAuthorized: requesting-user-name="chris"
D [25/Mar/2025:18:39:51 +0800] [Client 225] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [25/Mar/2025:18:39:51 +0800] [Client 225] Content-Length: 967
D [25/Mar/2025:18:39:51 +0800] [Client 225] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:51 +0800] [Client 225] con->http=0x641786c42070
D [25/Mar/2025:18:39:51 +0800] [Client 225] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=967, response=0x641786c0a9f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:51 +0800] [Client 225] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:51 +0800] [Client 225] bytes=0, http_state=0, data_remaining=967
D [25/Mar/2025:18:39:51 +0800] [Client 225] Flushing write buffer.
D [25/Mar/2025:18:39:51 +0800] [Client 225] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:51 +0800] [Client 225] Waiting for request.
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:51 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:51 +0800] [Client 203] 2.0 Get-Printer-Attributes 414
D [25/Mar/2025:18:39:51 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:51 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:51 +0800] [Client 203] Content-Length: 24952
D [25/Mar/2025:18:39:51 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:51 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:51 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=24952, response=0x641786c06ac0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:51 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:51 +0800] [Client 203] bytes=1, http_state=7, data_remaining=24952
D [25/Mar/2025:18:39:51 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:51 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=24952, response=0x641786c06ac0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:51 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:51 +0800] [Client 203] bytes=0, http_state=0, data_remaining=24952
D [25/Mar/2025:18:39:51 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:51 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:51 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 225] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:51 +0800] [Client 225] Closing connection.
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:51 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:51 +0800] [Client 203] 2.0 Get-Printer-Attributes 415
D [25/Mar/2025:18:39:51 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:51 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:51 +0800] [Client 203] Content-Length: 24952
D [25/Mar/2025:18:39:51 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:51 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:51 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=24952, response=0x641786b295c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:51 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:51 +0800] [Client 203] bytes=1, http_state=7, data_remaining=24952
D [25/Mar/2025:18:39:51 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:51 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=24952, response=0x641786b295c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:51 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:51 +0800] [Client 203] bytes=0, http_state=0, data_remaining=24952
D [25/Mar/2025:18:39:51 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:51 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:51 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 224] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [25/Mar/2025:18:39:51 +0800] [Client 224] Closing connection.
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 203] POST / HTTP/1.1
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:51 +0800] [Client 203] Read: status=200, state=6
D [25/Mar/2025:18:39:51 +0800] [Client 203] No authentication data provided.
D [25/Mar/2025:18:39:51 +0800] [Client 203] 2.0 Get-Printer-Attributes 416
D [25/Mar/2025:18:39:51 +0800] Get-Printer-Attributes ipp://localhost/printers/Brother
D [25/Mar/2025:18:39:51 +0800] [Client 203] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Brother) from localhost.
D [25/Mar/2025:18:39:51 +0800] [Client 203] Content-Length: 24952
D [25/Mar/2025:18:39:51 +0800] [Client 203] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:51 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:51 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=24952, response=0x641786bf7080(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:51 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_ATTRIBUTE, old wused=0, new wused=0
D [25/Mar/2025:18:39:51 +0800] [Client 203] bytes=1, http_state=7, data_remaining=24952
D [25/Mar/2025:18:39:51 +0800] [Client 203] con->http=0x641786b313e0
D [25/Mar/2025:18:39:51 +0800] [Client 203] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=24952, response=0x641786bf7080(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:51 +0800] [Client 203] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:51 +0800] [Client 203] bytes=0, http_state=0, data_remaining=24952
D [25/Mar/2025:18:39:51 +0800] [Client 203] Flushing write buffer.
D [25/Mar/2025:18:39:51 +0800] [Client 203] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:51 +0800] [Client 203] Waiting for request.
D [25/Mar/2025:18:39:51 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:52 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:52 +0800] [Client 139] 2.0 CUPS-Get-Printers 104
D [25/Mar/2025:18:39:52 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:52 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:52 +0800] [Client 139] Content-Length: 434
D [25/Mar/2025:18:39:52 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:52 +0800] Expiring subscriptions...
D [25/Mar/2025:18:39:52 +0800] [Job 18] Unloading...
D [25/Mar/2025:18:39:52 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:52 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=434, response=0x641786c06ac0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:52 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:52 +0800] [Client 139] bytes=0, http_state=0, data_remaining=434
D [25/Mar/2025:18:39:52 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:52 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:52 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:52 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:52 +0800] [Client 139] 2.0 CUPS-Get-Classes 105
D [25/Mar/2025:18:39:52 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:52 +0800] [Client 139] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:52 +0800] [Client 139] Content-Length: 75
D [25/Mar/2025:18:39:52 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:52 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:52 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786c19c30(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:52 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:52 +0800] [Client 139] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:52 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:52 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:52 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 139] POST / HTTP/1.1
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 139] Read: status=200, state=6
D [25/Mar/2025:18:39:52 +0800] [Client 139] No authentication data provided.
D [25/Mar/2025:18:39:52 +0800] [Client 139] 2.0 CUPS-Get-Default 106
D [25/Mar/2025:18:39:52 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:52 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:52 +0800] [Client 139] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:52 +0800] [Client 139] Content-Length: 113
D [25/Mar/2025:18:39:52 +0800] [Client 139] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:52 +0800] [Client 139] con->http=0x641786b39580
D [25/Mar/2025:18:39:52 +0800] [Client 139] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786c2fa10(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:52 +0800] [Client 139] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:52 +0800] [Client 139] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:52 +0800] [Client 139] Flushing write buffer.
D [25/Mar/2025:18:39:52 +0800] [Client 139] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:52 +0800] [Client 139] Waiting for request.
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:52 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:52 +0800] [Client 148] 2.0 CUPS-Get-Printers 417
D [25/Mar/2025:18:39:52 +0800] CUPS-Get-Printers
D [25/Mar/2025:18:39:52 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost.
D [25/Mar/2025:18:39:52 +0800] [Client 148] Content-Length: 434
D [25/Mar/2025:18:39:52 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:52 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:52 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=434, response=0x641786c19c30(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:52 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:52 +0800] [Client 148] bytes=0, http_state=0, data_remaining=434
D [25/Mar/2025:18:39:52 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:52 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:52 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:52 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:52 +0800] [Client 148] 2.0 CUPS-Get-Classes 418
D [25/Mar/2025:18:39:52 +0800] CUPS-Get-Classes
D [25/Mar/2025:18:39:52 +0800] [Client 148] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost.
D [25/Mar/2025:18:39:52 +0800] [Client 148] Content-Length: 75
D [25/Mar/2025:18:39:52 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:52 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:52 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x641786c2fa10(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:52 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:52 +0800] [Client 148] bytes=0, http_state=0, data_remaining=75
D [25/Mar/2025:18:39:52 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:52 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:52 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 148] POST / HTTP/1.1
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [25/Mar/2025:18:39:52 +0800] [Client 148] Read: status=200, state=6
D [25/Mar/2025:18:39:52 +0800] [Client 148] No authentication data provided.
D [25/Mar/2025:18:39:52 +0800] [Client 148] 2.0 CUPS-Get-Default 419
D [25/Mar/2025:18:39:52 +0800] CUPS-Get-Default
D [25/Mar/2025:18:39:52 +0800] CUPS-Get-Default client-error-not-found: No default printer.
D [25/Mar/2025:18:39:52 +0800] [Client 148] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost.
D [25/Mar/2025:18:39:52 +0800] [Client 148] Content-Length: 113
D [25/Mar/2025:18:39:52 +0800] [Client 148] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [25/Mar/2025:18:39:52 +0800] [Client 148] con->http=0x641786c1aee0
D [25/Mar/2025:18:39:52 +0800] [Client 148] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x641786c19c30(IPP_STATE_DATA), pipe_pid=0, file=-1
D [25/Mar/2025:18:39:52 +0800] [Client 148] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [25/Mar/2025:18:39:52 +0800] [Client 148] bytes=0, http_state=0, data_remaining=113
D [25/Mar/2025:18:39:52 +0800] [Client 148] Flushing write buffer.
D [25/Mar/2025:18:39:52 +0800] [Client 148] New state is HTTP_STATE_WAITING
D [25/Mar/2025:18:39:52 +0800] [Client 148] Waiting for request.
D [25/Mar/2025:18:39:52 +0800] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [25/Mar/2025:18:39:53 +0800] Expiring subscriptions...
I [25/Mar/2025:18:40:20 +0800] Saving printers.conf...
I [25/Mar/2025:18:40:20 +0800] Saving job.cache...
I [25/Mar/2025:18:40:20 +0800] Saving subscriptions.conf...
D [25/Mar/2025:18:40:20 +0800] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [25/Mar/2025:18:40:20 +0800] Expiring subscriptions...Last edited by xpusostomos (2025-03-29 00:09:01)
Offline
The printer isn't listed at https://www.pwg.org/printers/
You can probably lift https://aur.archlinux.org/packages/brother-dcp-l2660dw to install https://www.brother.ae/en/support/dcp-l2640dw/downloads
nb. that the brother filters tend to silently rely on https://archlinux.org/packages/core/x86_64/which/
Offline
The printer isn't listed at https://www.pwg.org/printers/
You can probably lift https://aur.archlinux.org/packages/brother-dcp-l2660dw to install https://www.brother.ae/en/support/dcp-l2640dw/downloads
nb. that the brother filters tend to silently rely on https://archlinux.org/packages/core/x86_64/which/
Yes but the printer supports Airprint, so fiddling with Brother drivers shouldn't be necessary should it?
That web site of IPP printers is very incomplete.
Last edited by xpusostomos (2025-03-25 16:48:27)
Offline
That "web site" is the IPP Everywhere authority, https://www.pwg.org/about.html
IPPE and AirPrint will require cups-pdf to be installed.
Offline
Well for whatever reason, maybe manufacturers don't bother to get them certified because they charge them or something, lots of models are not there. Airprint is listed in the settings of the printer, so I know it's there.
And yes I have cups-pdf installed
Offline
That "web site" is the IPP Everywhere authority, https://www.pwg.org/about.html
IPPE and AirPrint will require cups-pdf to be installed.
I'm not sure what package you mean by "IPPE" though.
Offline
IPP Everywhere…
Airprint is listed in the settings of the printer, so I know it's there
nmap BRWC8A3E813594B.localDoes the printer allow you to inspect its status/print queue?
Offline
IPP Everywhere…
Airprint is listed in the settings of the printer, so I know it's there
nmap BRWC8A3E813594B.localDoes the printer allow you to inspect its status/print queue?
$ nmap BRWC8A3E813594B.local
Starting Nmap 7.95 ( https://nmap.org ) at 2025-03-26 22:23 PST
Nmap scan report for BRWC8A3E813594B.local (192.168.68.123)
Host is up (0.0066s latency).
Other addresses for BRWC8A3E813594B.local (not scanned): fe80::caa3:e8ff:fe13:594b
Not shown: 995 closed tcp ports (conn-refused)
PORT STATE SERVICE
80/tcp open http
443/tcp open https
515/tcp open printer
631/tcp open ipp
9100/tcp open jetdirect
Nmap done: 1 IP address (1 host up) scanned in 7.18 secondsOffline
IPP Everywhere…
Airprint is listed in the settings of the printer, so I know it's there
nmap BRWC8A3E813594B.localDoes the printer allow you to inspect its status/print queue?
What do you mean by inspect its status/print queue? I can access its administrative console... I can use lpq to see the local queue. I'm not aware that the printer itself has any kind of queue.
Offline
It's certainly listening and your cups log shows sending a pdf there.
According to google™ the URI pattern for brother would be ipp://BRWC8A3E813594B.local:631/ipp - not ipp://BRWC8A3E813594B.local:631/ipp/print
More luck with that?
Edit: the printer listens on 80 and 443 - you can likely access http://BRWC8A3E813594B.local/ and https://BRWC8A3E813594B.local/ and pot. even http://BRWC8A3E813594B.local:631
Last edited by seth (2025-03-26 14:32:57)
Offline
It's certainly listening and your cups log shows sending a pdf there.
According to google™ the URI pattern for brother would be ipp://BRWC8A3E813594B.local:631/ipp - not ipp://BRWC8A3E813594B.local:631/ipp/print
More luck with that?Edit: the printer listens on 80 and 443 - you can likely access http://BRWC8A3E813594B.local/ and https://BRWC8A3E813594B.local/ and pot. even http://BRWC8A3E813594B.local:631
I changed the URI:
sudo lpadmin -p Brother -v ipp://BRWC8A3E813594B.local:631/ippBut that didn't help.
Yes, I can access those URLs, that's the administrative console
Offline
The 631 port doesn't yield a web page, but as I understand it, 631 is the ipp port because ipp uses http, so I wouldn't really expect it to.
Offline
Did you restart cups after hte change?
Updated log?
And that "administrative console" doesn't show the printer state or queue?
(And yes, you usually can send multiple jobs to a network printer - from mutliple hosts. They then get queued and executed or you get an error because the printer is OOM)
Having a webserver directly on 631 isn't uncommen either - cups works this way: http://localhost:631
Offline
Did you restart cups after hte change?
Updated log?And that "administrative console" doesn't show the printer state or queue?
(And yes, you usually can send multiple jobs to a network printer - from mutliple hosts. They then get queued and executed or you get an error because the printer is OOM)Having a webserver directly on 631 isn't uncommen either - cups works this way: http://localhost:631
I don't see anything like a queue mentioned on the console. Maybe if it gets a job for real something appears, but at least I haven't seen it.
I'm not sure restarting it makes sense, since it's setup as cups.socket, so it only really starts when you connect a socket, it doesn't run all the time. Nevertheless I just "restarted" it, and that didn't help.
Interestingly, I telneted to 9100, and while trying to remember how to exit telnet, I typed in quit a few times, and that actually popped out on the printer.
However, a lot of places say I should be able to
nc BRWC8A3E813594B.local 9100 < somefileand have it come out, but that doesn't seem to work either. It just hangs, which is odd.
Offline
9100 is the jetdirect (appsocket) protocol, you'll need a local driver for that to pass it the expected data.
Feeding some random (binary) data there will cost you ink… lots of ink.
lpinfo shows ipps://, you added an ipp:// printer? How? Was it autodetected?
Offline
From what I read, you should be able to feed 9100 text files or pdf files, and they probably ought to come out. That's why some people out there are saying just print with "nc"... although you'd miss a lot of features doing that. But anyway, I don't get how I telnet there and made some text come out, but nc can't make it come out.
I don't know how it got those last 2 lines from ipinfo... what I did do is enter that lpadmin command above to set the URI to be ipp://BRWC8A3E813594B.local:631/ipp/print (or now ipp://BRWC8A3E813594B.local:631/ipp at your suggestion). Brother%20DCP-L2640DW._ipps._tcp.local does not seem to be a real host name, I can't ping it, I can't nmap it, so maybe that's the problem.
Offline
http://localhost:631/ - use the web interface to add the printer.
Offline
http://localhost:631/ - use the web interface to add the printer.
What do you mean by add using the web interface? When I go to that URL what I see is a bunch of documentation, I don't see anything to control it, no buttons, no forms, no settings. When I first saw that, I thought oh, that's kind of lame. What am I missing.
Offline
There's supposed to be a bar on the top of the webpage that allows you to inspect, manage etc. your printers
https://i.imgur.com/EDxgXIi.png
Offline
seth wrote:http://localhost:631/ - use the web interface to add the printer.
What do you mean by add using the web interface? When I go to that URL what I see is a bunch of documentation, I don't see anything to control it, no buttons, no forms, no settings. When I first saw that, I thought oh, that's kind of lame. What am I missing.
How lame to see documentation when you don't understand what you're doing. ![]()
Offline
OK, I guess I'm stupid I didn't see that menu up top. When I navigate that, and fill it in, it all works. So thanks for your patience guys.
Offline
\o/
Please always remember to mark resolved threads by editing your initial posts subject - so others will know that there's no task left, but maybe a solution to find.
Thanks.
Also for posterity maybe post the correct IPP URI for your printer.
Offline
the console shows ipps://Brother%20DCP-L2640DW._ipps._tcp.local/ as the URL, so maybe if I'd fed that into lpadmin -v, it would have worked. The trouble is I don't remember anything in the documentation that would have led me to do that.
Offline