Code : Tout sélectionner
W [08/Jan/2022:11:23:47 +0100] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id \'DCP1610W-Gray..\' already exists
E [08/Jan/2022:11:36:26 +0100] [Job 22] Invalid printer command \"Clean\".
E [08/Jan/2022:11:36:26 +0100] [Job 22] Job stopped due to filter errors; please consult the /var/log/cups/error_log file for details.
D [08/Jan/2022:11:36:26 +0100] [Job 22] The following messages were recorded from 11:36:26 to 11:36:26
D [08/Jan/2022:11:36:26 +0100] [Job 22] Applying default options...
D [08/Jan/2022:11:36:26 +0100] [Job 22] Adding start banner page "none".
D [08/Jan/2022:11:36:26 +0100] [Job 22] Adding end banner page "none".
D [08/Jan/2022:11:36:26 +0100] [Job 22] File of type application/vnd.cups-command queued by "zzz".
D [08/Jan/2022:11:36:26 +0100] [Job 22] hold_until=0
D [08/Jan/2022:11:36:26 +0100] [Job 22] Queued on "DCP1610W" by "zzz".
D [08/Jan/2022:11:36:26 +0100] [Job 22] time-at-processing=1641638186
D [08/Jan/2022:11:36:26 +0100] [Job 22] 2 filters for job:
D [08/Jan/2022:11:36:26 +0100] [Job 22] commandtops (application/vnd.cups-command to printer/DCP1610W/application/postscript, cost 100)
D [08/Jan/2022:11:36:26 +0100] [Job 22] - (printer/DCP1610W/application/postscript to printer/DCP1610W, cost 0)
D [08/Jan/2022:11:36:26 +0100] [Job 22] job-sheets=none,none
D [08/Jan/2022:11:36:26 +0100] [Job 22] argv[0]="DCP1610W"
D [08/Jan/2022:11:36:26 +0100] [Job 22] argv[1]="22"
D [08/Jan/2022:11:36:26 +0100] [Job 22] argv[2]="zzz"
D [08/Jan/2022:11:36:26 +0100] [Job 22] argv[3]="Test Page"
D [08/Jan/2022:11:36:26 +0100] [Job 22] argv[4]="1"
D [08/Jan/2022:11:36:26 +0100] [Job 22] argv[5]="job-uuid=urn:uuid:dfd0ac5c-ee14-3dc4-7a27-5200aad54834 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1641638186 time-at-processing=1641638186"
D [08/Jan/2022:11:36:26 +0100] [Job 22] argv[6]="/var/spool/cups/d00022-001"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[7]="CUPS_STATEDIR=/run/cups"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[8]="HOME=/var/spool/cups/tmp"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[10]="SERVER_ADMIN=root@zzz"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[11]="SOFTWARE=CUPS/2.3.1"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[13]="USER=root"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[14]="CUPS_MAX_MESSAGE=2047"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[15]="CUPS_SERVER=/run/cups/cups.sock"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[17]="IPP_PORT=631"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[18]="CHARSET=utf-8"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[19]="LANG=fr_FR.UTF-8"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[20]="PPD=/etc/cups/ppd/DCP1610W.ppd"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[21]="RIP_MAX_CACHE=128m"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[22]="CONTENT_TYPE=application/vnd.cups-command"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[23]="DEVICE_URI=usb://Brother/DCP-1610W%20series?serial=E74233B9N915710"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[24]="PRINTER_INFO=DCP1610W"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[25]="PRINTER_LOCATION="
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[26]="PRINTER=DCP1610W"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[27]="PRINTER_STATE_REASONS=none"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[28]="CUPS_FILETYPE=document"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[29]="FINAL_CONTENT_TYPE=application/postscript"
D [08/Jan/2022:11:36:26 +0100] [Job 22] envp[30]="AUTH_I****"
D [08/Jan/2022:11:36:26 +0100] [Job 22] Started filter /usr/lib/cups/filter/commandtops (PID 3871)
D [08/Jan/2022:11:36:26 +0100] [Job 22] Started backend /usr/lib/cups/backend/usb (PID 3872)
D [08/Jan/2022:11:36:26 +0100] [Job 22] Loading USB quirks from \"/usr/share/cups/usb\".
D [08/Jan/2022:11:36:26 +0100] [Job 22] Loaded 181 quirks.
D [08/Jan/2022:11:36:26 +0100] [Job 22] Printing on printer with URI: usb://Brother/DCP-1610W%20series?serial=E74233B9N915710
D [08/Jan/2022:11:36:26 +0100] [Job 22] Set job-printer-state-message to "Invalid printer command \"Clean\".", current level=ERROR
D [08/Jan/2022:11:36:26 +0100] [Job 22] PID 3871 (/usr/lib/cups/filter/commandtops) stopped with status 1.
D [08/Jan/2022:11:36:26 +0100] [Job 22] Hint: Try setting the LogLevel to "debug" to find out more.
D [08/Jan/2022:11:36:26 +0100] [Job 22] libusb_get_device_list=7
D [08/Jan/2022:11:36:26 +0100] [Job 22] STATE: +connecting-to-device
D [08/Jan/2022:11:36:26 +0100] [Job 22] STATE: -connecting-to-device
D [08/Jan/2022:11:36:26 +0100] [Job 22] Printer found with device ID: MFG:Brother;CMD:PJL,HBP;MDL:DCP-1610W series;CLS:PRINTER;CID:Brother Laser Type1; Device URI: usb://Brother/DCP-1610W%20series?serial=E74233B9N915710
D [08/Jan/2022:11:36:26 +0100] [Job 22] Device protocol: 2
D [08/Jan/2022:11:36:26 +0100] [Job 22] Sending data to printer.
D [08/Jan/2022:11:36:26 +0100] [Job 22] Sent 0 bytes...
D [08/Jan/2022:11:36:26 +0100] [Job 22] Waiting for read thread to exit...
D [08/Jan/2022:11:36:26 +0100] [Job 22] PID 3872 (/usr/lib/cups/backend/usb) exited with no errors.
D [08/Jan/2022:11:36:26 +0100] [Job 22] End of messages
D [08/Jan/2022:11:36:26 +0100] [Job 22] printer-state=3(idle)
D [08/Jan/2022:11:36:26 +0100] [Job 22] printer-state-message="Sending data to printer."
D [08/Jan/2022:11:36:26 +0100] [Job 22] printer-state-reasons=none
E [08/Jan/2022:11:37:16 +0100] Scheduler shutting down due to program error.
I [08/Jan/2022:11:37:26 +0100] Listening to [v1.::1]:631 (IPv6)
I [08/Jan/2022:11:37:26 +0100] Listening to 127.0.0.1:631 (IPv4)
I [08/Jan/2022:11:37:26 +0100] Listening to /run/cups/cups.sock (Domain)
E [08/Jan/2022:11:37:26 +0100] Unknown directive JobPrivateAccess on line 123 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:37:26 +0100] Unknown directive JobPrivateValues on line 124 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:37:26 +0100] Unknown directive SubscriptionPrivateAccess on line 125 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:37:26 +0100] Unknown directive SubscriptionPrivateValues on line 126 of /etc/cups/cupsd.conf.
I [08/Jan/2022:11:37:26 +0100] Remote access is disabled.
D [08/Jan/2022:11:37:26 +0100] Added auto ServerAlias zzz
I [08/Jan/2022:11:37:26 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
D [08/Jan/2022:11:37:26 +0100] Using keychain "/etc/cups/ssl" for server name "zzz".
D [08/Jan/2022:11:37:26 +0100] Repairing access permissions of "/etc/cups/classes.conf"
I [08/Jan/2022:11:37:26 +0100] Using default TempDir of /var/spool/cups/tmp...
I [08/Jan/2022:11:37:26 +0100] Configured for up to 100 clients.
I [08/Jan/2022:11:37:26 +0100] Allowing up to 100 client connections per host.
I [08/Jan/2022:11:37:26 +0100] Using policy "default" as the default.
I [08/Jan/2022:11:37:26 +0100] Full reload is required.
I [08/Jan/2022:11:37:26 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 78 types, 118 filters...
D [08/Jan/2022:11:37:26 +0100] Loading printer DCP1610W...
D [08/Jan/2022:11:37:26 +0100] load_ppd: Loading /var/cache/cups/DCP1610W.data...
D [08/Jan/2022:11:37:26 +0100] cupsdRegisterPrinter(p=0x562e9da25b70(DCP1610W))
I [08/Jan/2022:11:37:26 +0100] Loading job cache file "/var/cache/cups/job.cache"...
D [08/Jan/2022:11:37:26 +0100] [Job 19] Loading from cache...
D [08/Jan/2022:11:37:26 +0100] [Job 19] Loading attributes...
D [08/Jan/2022:11:37:26 +0100] [Job 19] Unloading...
D [08/Jan/2022:11:37:26 +0100] [Job 20] Loading from cache...
D [08/Jan/2022:11:37:26 +0100] [Job 20] Loading attributes...
D [08/Jan/2022:11:37:26 +0100] [Job 20] Unloading...
D [08/Jan/2022:11:37:26 +0100] [Job 21] Loading from cache...
D [08/Jan/2022:11:37:26 +0100] [Job 21] Loading attributes...
D [08/Jan/2022:11:37:26 +0100] [Job 21] Unloading...
D [08/Jan/2022:11:37:26 +0100] [Job 22] Loading from cache...
D [08/Jan/2022:11:37:26 +0100] [Job 22] Loading attributes...
D [08/Jan/2022:11:37:26 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [08/Jan/2022:11:37:26 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [08/Jan/2022:11:37:26 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [08/Jan/2022:11:37:26 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [08/Jan/2022:11:37:26 +0100] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
I [08/Jan/2022:11:37:26 +0100] Full reload complete.
D [08/Jan/2022:11:37:26 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [08/Jan/2022:11:37:26 +0100] Cleaning out old files in "/var/spool/cups/tmp".
D [08/Jan/2022:11:37:26 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp/.hplip", pattern="(null)")
I [08/Jan/2022:11:37:26 +0100] Cleaning out old files in "/var/spool/cups/tmp/.hplip".
D [08/Jan/2022:11:37:26 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [08/Jan/2022:11:37:26 +0100] Cleaning out old files in "/var/cache/cups".
D [08/Jan/2022:11:37:26 +0100] service_checkin: pid=3945
D [08/Jan/2022:11:37:26 +0100] service_checkin: 1 listeners.
D [08/Jan/2022:11:37:26 +0100] service_add_listener: Listener #1 at fd 3, "/run/cups/cups.sock".
D [08/Jan/2022:11:37:26 +0100] service_add_listener: Matched existing listener #1 to /run/cups/cups.sock.
D [08/Jan/2022:11:37:26 +0100] Creating KeepAlive/PID file "/var/cache/cups/org.cups.cupsd".
D [08/Jan/2022:11:37:26 +0100] Calling FindDeviceById(cups-DCP1610W)
D [08/Jan/2022:11:37:26 +0100] FindDeviceById failed: org.freedesktop.ColorManager.NotFound:device id \'cups-DCP1610W\' does not exist
D [08/Jan/2022:11:37:26 +0100] Using profile ID "DCP1610W-Gray..".
D [08/Jan/2022:11:37:26 +0100] Calling CreateProfile(DCP1610W-Gray..,temp)
D [08/Jan/2022:11:37:26 +0100] Created profile "/org/freedesktop/ColorManager/profiles/DCP1610W_Gray__".
I [08/Jan/2022:11:37:26 +0100] Registering ICC color profiles for "DCP1610W".
D [08/Jan/2022:11:37:26 +0100] Calling CreateDevice(cups-DCP1610W,temp)
D [08/Jan/2022:11:37:26 +0100] Created device "/org/freedesktop/ColorManager/devices/cups_DCP1610W".
D [08/Jan/2022:11:37:26 +0100] Calling /org/freedesktop/ColorManager/devices/cups_DCP1610W:AddProfile(/org/freedesktop/ColorManager/profiles/DCP1610W_Gray__) [soft]
I [08/Jan/2022:11:37:26 +0100] Listening to [v1.::1]:631 on fd 7...
I [08/Jan/2022:11:37:26 +0100] Listening to 127.0.0.1:631 on fd 8...
I [08/Jan/2022:11:37:26 +0100] Listening to /run/cups/cups.sock on fd 3...
I [08/Jan/2022:11:37:26 +0100] Resuming new connection processing...
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [08/Jan/2022:11:37:26 +0100] cupsdAddCert: Adding certificate for PID 0
D [08/Jan/2022:11:37:26 +0100] Notifier dbus started - PID = 3948
D [08/Jan/2022:11:37:26 +0100] cupsdMarkDirty(----S)
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy"
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 1] Server address is "/run/cups/cups.sock".
D [08/Jan/2022:11:37:26 +0100] [Client 1] Accepted from localhost (Domain)
D [08/Jan/2022:11:37:26 +0100] [Client 1] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] Report: clients=1
D [08/Jan/2022:11:37:26 +0100] Report: jobs=4
D [08/Jan/2022:11:37:26 +0100] Report: jobs-active=1
D [08/Jan/2022:11:37:26 +0100] Report: printers=1
D [08/Jan/2022:11:37:26 +0100] Report: stringpool-string-count=597
D [08/Jan/2022:11:37:26 +0100] Report: stringpool-alloc-bytes=9368
D [08/Jan/2022:11:37:26 +0100] Report: stringpool-total-bytes=11408
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 2] Server address is "/run/cups/cups.sock".
D [08/Jan/2022:11:37:26 +0100] [Client 2] Accepted from localhost (Domain)
D [08/Jan/2022:11:37:26 +0100] [Client 2] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] [Client 1] GET /admin/log/error_log HTTP/1.1
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 1] Read: status=200, state=3
D [08/Jan/2022:11:37:26 +0100] [Client 1] No authentication data provided.
D [08/Jan/2022:11:37:26 +0100] cupsdIsAuthorized: username=""
D [08/Jan/2022:11:37:26 +0100] [Client 1] cupsdSendHeader: code=401, type="text/html", auth_type=0
D [08/Jan/2022:11:37:26 +0100] [Client 1] WWW-Authenticate: Basic realm=\"CUPS\", PeerCred, Local trc=\"y\"
D [08/Jan/2022:11:37:26 +0100] [Client 1] Closing connection.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 3] Server address is "/run/cups/cups.sock".
D [08/Jan/2022:11:37:26 +0100] [Client 3] Accepted from localhost (Domain)
D [08/Jan/2022:11:37:26 +0100] [Client 3] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 4] Server address is "/run/cups/cups.sock".
D [08/Jan/2022:11:37:26 +0100] [Client 4] Accepted from localhost (Domain)
D [08/Jan/2022:11:37:26 +0100] [Client 4] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] [Client 3] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [08/Jan/2022:11:37:26 +0100] [Client 3] Closing connection.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 5] Server address is "/run/cups/cups.sock".
D [08/Jan/2022:11:37:26 +0100] [Client 5] Accepted from localhost (Domain)
D [08/Jan/2022:11:37:26 +0100] [Client 5] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] [Client 4] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [08/Jan/2022:11:37:26 +0100] [Client 4] Closing connection.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 5] GET /admin/log/error_log HTTP/1.1
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 5] Read: status=200, state=3
D [08/Jan/2022:11:37:26 +0100] [Client 5] Authorized as root using Local.
D [08/Jan/2022:11:37:26 +0100] cupsdIsAuthorized: username="root"
D [08/Jan/2022:11:37:26 +0100] [Client 5] Processing GET /admin/log/error_log
D [08/Jan/2022:11:37:26 +0100] [Client 5] filename="/var/log/cups/error_log", type=text/plain
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdSendHeader: code=200, type="text/plain", auth_type=0
D [08/Jan/2022:11:37:26 +0100] [Client 5] Sending file.
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=15735, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=15735, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=15735, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=15735, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=15735, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=15735, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=15735, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=15735, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 5] Flushing write buffer.
D [08/Jan/2022:11:37:26 +0100] [Client 5] New state is HTTP_STATE_WAITING
D [08/Jan/2022:11:37:26 +0100] [Client 5] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Notifier] state=3
D [08/Jan/2022:11:37:26 +0100] [Notifier] Connected to D-BUS
D [08/Jan/2022:11:37:26 +0100] [Notifier] ServerStarted
D [08/Jan/2022:11:37:26 +0100] [Client 5] POST / HTTP/1.1
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 5] Read: status=200, state=6
D [08/Jan/2022:11:37:26 +0100] [Client 5] No authentication data provided.
D [08/Jan/2022:11:37:26 +0100] [Client 5] 2.0 Get-Jobs 52
D [08/Jan/2022:11:37:26 +0100] Get-Jobs ipp://localhost/printers/
D [08/Jan/2022:11:37:26 +0100] [Client 5] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost.
D [08/Jan/2022:11:37:26 +0100] [Client 5] Content-Length: 162
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=162, response=0x562e9da72c00(IPP_STATE_DATA), pipe_pid=0, file=-1
D [08/Jan/2022:11:37:26 +0100] [Client 5] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [08/Jan/2022:11:37:26 +0100] [Client 5] bytes=0, http_state=0, data_remaining=162
D [08/Jan/2022:11:37:26 +0100] [Client 5] Flushing write buffer.
D [08/Jan/2022:11:37:26 +0100] [Client 5] New state is HTTP_STATE_WAITING
D [08/Jan/2022:11:37:26 +0100] [Client 5] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 5] POST / HTTP/1.1
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 5] Read: status=200, state=6
D [08/Jan/2022:11:37:26 +0100] [Client 5] No authentication data provided.
D [08/Jan/2022:11:37:26 +0100] [Client 5] 2.0 Get-Jobs 53
D [08/Jan/2022:11:37:26 +0100] Get-Jobs ipp://localhost/printers/
I [08/Jan/2022:11:37:26 +0100] [Client 5] Limiting Get-Jobs response to 500 jobs.
D [08/Jan/2022:11:37:26 +0100] [Job 21] Loading attributes...
D [08/Jan/2022:11:37:26 +0100] [Job 20] Loading attributes...
D [08/Jan/2022:11:37:26 +0100] [Job 19] Loading attributes...
D [08/Jan/2022:11:37:26 +0100] [Client 5] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost.
D [08/Jan/2022:11:37:26 +0100] [Client 5] Content-Length: 350
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [08/Jan/2022:11:37:26 +0100] [Client 5] con->http=0x562e9da76840
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=350, response=0x562e9da70050(IPP_STATE_DATA), pipe_pid=0, file=-1
D [08/Jan/2022:11:37:26 +0100] [Client 5] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [08/Jan/2022:11:37:26 +0100] [Client 5] bytes=0, http_state=0, data_remaining=350
D [08/Jan/2022:11:37:26 +0100] [Client 5] Flushing write buffer.
D [08/Jan/2022:11:37:26 +0100] [Client 5] New state is HTTP_STATE_WAITING
D [08/Jan/2022:11:37:26 +0100] [Client 5] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 5] GET /admin/conf/cupsd.conf HTTP/1.1
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 5] Read: status=200, state=3
D [08/Jan/2022:11:37:26 +0100] [Client 5] No authentication data provided.
D [08/Jan/2022:11:37:26 +0100] cupsdIsAuthorized: username=""
D [08/Jan/2022:11:37:26 +0100] [Client 5] cupsdSendHeader: code=401, type="text/html", auth_type=0
D [08/Jan/2022:11:37:26 +0100] [Client 5] WWW-Authenticate: Basic realm=\"CUPS\", PeerCred, Local trc=\"y\"
D [08/Jan/2022:11:37:26 +0100] [Client 5] Closing connection.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 6] Server address is "/run/cups/cups.sock".
D [08/Jan/2022:11:37:26 +0100] [Client 6] Accepted from localhost (Domain)
D [08/Jan/2022:11:37:26 +0100] [Client 6] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 7] Server address is "/run/cups/cups.sock".
D [08/Jan/2022:11:37:26 +0100] [Client 7] Accepted from localhost (Domain)
D [08/Jan/2022:11:37:26 +0100] [Client 7] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] [Client 6] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [08/Jan/2022:11:37:26 +0100] [Client 6] Closing connection.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Server address is "/run/cups/cups.sock".
D [08/Jan/2022:11:37:26 +0100] [Client 8] Accepted from localhost (Domain)
D [08/Jan/2022:11:37:26 +0100] [Client 8] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] [Client 7] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [08/Jan/2022:11:37:26 +0100] [Client 7] Closing connection.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] GET /admin/conf/cupsd.conf HTTP/1.1
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Read: status=200, state=3
D [08/Jan/2022:11:37:26 +0100] [Client 8] Authorized as root using Local.
D [08/Jan/2022:11:37:26 +0100] cupsdIsAuthorized: username="root"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Processing GET /admin/conf/cupsd.conf
D [08/Jan/2022:11:37:26 +0100] [Client 8] filename="/etc/cups/cupsd.conf", type=text/plain
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdSendHeader: code=200, type="text/plain", auth_type=0
D [08/Jan/2022:11:37:26 +0100] [Client 8] Sending file.
D [08/Jan/2022:11:37:26 +0100] [Client 8] con->http=0x562e9da75680
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4740, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 8] con->http=0x562e9da75680
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4740, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 8] con->http=0x562e9da75680
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4740, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 8] Flushing write buffer.
D [08/Jan/2022:11:37:26 +0100] [Client 8] New state is HTTP_STATE_WAITING
D [08/Jan/2022:11:37:26 +0100] [Client 8] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] GET /admin/conf/cupsd.conf HTTP/1.1
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Read: status=200, state=3
D [08/Jan/2022:11:37:26 +0100] [Client 8] Authorized as root using Local.
D [08/Jan/2022:11:37:26 +0100] cupsdIsAuthorized: username="root"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Processing GET /admin/conf/cupsd.conf
D [08/Jan/2022:11:37:26 +0100] [Client 8] filename="/etc/cups/cupsd.conf", type=text/plain
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdSendHeader: code=200, type="text/plain", auth_type=0
D [08/Jan/2022:11:37:26 +0100] [Client 8] Sending file.
D [08/Jan/2022:11:37:26 +0100] [Client 8] con->http=0x562e9da75680
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4740, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 8] con->http=0x562e9da75680
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4740, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 8] con->http=0x562e9da75680
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4740, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 8] Flushing write buffer.
D [08/Jan/2022:11:37:26 +0100] [Client 8] New state is HTTP_STATE_WAITING
D [08/Jan/2022:11:37:26 +0100] [Client 8] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] GET /admin/conf/cupsd.conf HTTP/1.1
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Read: status=200, state=3
D [08/Jan/2022:11:37:26 +0100] [Client 8] Authorized as root using Local.
D [08/Jan/2022:11:37:26 +0100] cupsdIsAuthorized: username="root"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Processing GET /admin/conf/cupsd.conf
D [08/Jan/2022:11:37:26 +0100] [Client 8] filename="/etc/cups/cupsd.conf", type=text/plain
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdSendHeader: code=200, type="text/plain", auth_type=0
D [08/Jan/2022:11:37:26 +0100] [Client 8] Sending file.
D [08/Jan/2022:11:37:26 +0100] [Client 8] con->http=0x562e9da75680
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4740, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 8] con->http=0x562e9da75680
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4740, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 8] con->http=0x562e9da75680
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=4740, response=(nil)(), pipe_pid=0, file=17
D [08/Jan/2022:11:37:26 +0100] [Client 8] Flushing write buffer.
D [08/Jan/2022:11:37:26 +0100] [Client 8] New state is HTTP_STATE_WAITING
D [08/Jan/2022:11:37:26 +0100] [Client 8] Waiting for request.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] PUT /admin/conf/cupsd.conf HTTP/1.1
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Read: status=200, state=9
D [08/Jan/2022:11:37:26 +0100] [Client 8] Authorized as root using Local.
D [08/Jan/2022:11:37:26 +0100] cupsdIsAuthorized: username="root"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Read: status=100, state=9
I [08/Jan/2022:11:37:26 +0100] [Client 8] Installing config file "/etc/cups/cupsd.conf"...
D [08/Jan/2022:11:37:26 +0100] [Client 8] cupsdSendHeader: code=201, type="(null)", auth_type=0
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 2] Closing connection.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] [Client 8] Closing connection.
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
E [08/Jan/2022:11:37:26 +0100] Scheduler shutting down due to program error.
D [08/Jan/2022:11:37:26 +0100] cupsdMarkDirty(----S)
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [08/Jan/2022:11:37:26 +0100] Expiring subscriptions...
I [08/Jan/2022:11:37:26 +0100] Saving subscriptions.conf...
D [08/Jan/2022:11:37:26 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [08/Jan/2022:11:37:26 +0100] Creating KeepAlive/PID file "/var/cache/cups/org.cups.cupsd".
I [08/Jan/2022:11:37:26 +0100] Saving job.cache...
D [08/Jan/2022:11:37:26 +0100] [Job 19] Unloading...
D [08/Jan/2022:11:37:26 +0100] [Job 20] Unloading...
D [08/Jan/2022:11:37:26 +0100] [Job 21] Unloading...
D [08/Jan/2022:11:37:26 +0100] [Job 22] Unloading...
D [08/Jan/2022:11:37:26 +0100] cupsdStopSelect()
E [08/Jan/2022:11:37:27 +0100] Unknown directive JobPrivateAccess on line 123 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:37:27 +0100] Unknown directive JobPrivateValues on line 124 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:37:27 +0100] Unknown directive SubscriptionPrivateAccess on line 125 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:37:27 +0100] Unknown directive SubscriptionPrivateValues on line 126 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:39:01 +0100] Scheduler shutting down due to program error.
E [08/Jan/2022:11:39:12 +0100] Unknown directive JobPrivateAccess on line 122 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:39:12 +0100] Unknown directive JobPrivateValues on line 123 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:39:12 +0100] Unknown directive SubscriptionPrivateAccess on line 124 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:39:12 +0100] Unknown directive SubscriptionPrivateValues on line 125 of /etc/cups/cupsd.conf.
W [08/Jan/2022:11:45:15 +0100] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id \'DCP1610W-Gray..\' already exists
E [08/Jan/2022:11:47:21 +0100] Unknown directive JobPrivateAccess on line 122 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:47:21 +0100] Unknown directive JobPrivateValues on line 123 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:47:21 +0100] Unknown directive SubscriptionPrivateAccess on line 124 of /etc/cups/cupsd.conf.
E [08/Jan/2022:11:47:21 +0100] Unknown directive SubscriptionPrivateValues on line 125 of /etc/cups/cupsd.conf.
E [09/Jan/2022:11:01:14 +0100] Unknown directive JobPrivateAccess on line 122 of /etc/cups/cupsd.conf.
E [09/Jan/2022:11:01:14 +0100] Unknown directive JobPrivateValues on line 123 of /etc/cups/cupsd.conf.
E [09/Jan/2022:11:01:14 +0100] Unknown directive SubscriptionPrivateAccess on line 124 of /etc/cups/cupsd.conf.
E [09/Jan/2022:11:01:14 +0100] Unknown directive SubscriptionPrivateValues on line 125 of /etc/cups/cupsd.conf.
E [10/Jan/2022:08:32:44 +0100] Unknown directive JobPrivateAccess on line 122 of /etc/cups/cupsd.conf.
E [10/Jan/2022:08:32:44 +0100] Unknown directive JobPrivateValues on line 123 of /etc/cups/cupsd.conf.
E [10/Jan/2022:08:32:44 +0100] Unknown directive SubscriptionPrivateAccess on line 124 of /etc/cups/cupsd.conf.
E [10/Jan/2022:08:32:44 +0100] Unknown directive SubscriptionPrivateValues on line 125 of /etc/cups/cupsd.conf.
