Bugzilla – Attachment 820270 Details for
Bug 1152720
EMU: ghostscript 9.27 breaks printing
Home
|
New
|
Browse
|
Search
|
[?]
|
Reports
|
Requests
|
Forgot Password
cups LogLevel debug file
cups_gs927.log (text/x-log), 153.33 KB, created by
Luigi Baldoni
on 2019-10-02 14:47:34 UTC
(
hide
)
Description:
cups LogLevel debug file
Filename:
MIME Type:
Creator:
Luigi Baldoni
Created:
2019-10-02 14:47:34 UTC
Size:
153.33 KB
patch
obsolete
>W [02/Oct/2019:16:35:36 +0200] Notifier for subscription 3241 (dbus://) went away, retrying! >I [02/Oct/2019:16:35:36 +0200] Listening to [v1.::1]:631 (IPv6) >I [02/Oct/2019:16:35:36 +0200] Listening to 127.0.0.1:631 (IPv4) >I [02/Oct/2019:16:35:36 +0200] Listening to /run/cups/cups.sock (Domain) >I [02/Oct/2019:16:35:36 +0200] Remote access is disabled. >D [02/Oct/2019:16:35:36 +0200] Added auto ServerAlias myhost.mydomain >D [02/Oct/2019:16:35:36 +0200] Added auto ServerAlias myhost >I [02/Oct/2019:16:35:36 +0200] Loaded configuration file "/etc/cups/cupsd.conf" >D [02/Oct/2019:16:35:36 +0200] Using keychain "/etc/cups/ssl" for server name "myhost.mydomain". >I [02/Oct/2019:16:35:36 +0200] Using default TempDir of /var/spool/cups/tmp... >I [02/Oct/2019:16:35:36 +0200] Configured for up to 100 clients. >I [02/Oct/2019:16:35:36 +0200] Allowing up to 100 client connections per host. >I [02/Oct/2019:16:35:36 +0200] Full reload is required. >I [02/Oct/2019:16:35:36 +0200] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 78 types, 114 filters... >D [02/Oct/2019:16:35:36 +0200] Loading printer Brother_HL_2037... >D [02/Oct/2019:16:35:36 +0200] load_ppd: Loading /var/cache/cups/Brother_HL_2037.data... >D [02/Oct/2019:16:35:36 +0200] cupsdRegisterPrinter(p=0x5559a8fcfa30(Brother_HL_2037)) >D [02/Oct/2019:16:35:36 +0200] Loading printer CUPS-PDF... >D [02/Oct/2019:16:35:36 +0200] load_ppd: Loading /var/cache/cups/CUPS-PDF.data... >D [02/Oct/2019:16:35:36 +0200] cupsdRegisterPrinter(p=0x5559a8fda4e0(CUPS-PDF)) >I [02/Oct/2019:16:35:36 +0200] Loading job cache file "/var/cache/cups/job.cache"... >D [02/Oct/2019:16:35:36 +0200] [Job 9] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 10] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 13] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 14] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 15] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 16] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 17] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 18] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 19] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 20] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 21] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 22] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 23] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 24] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 25] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 26] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 27] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 28] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 29] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 30] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 31] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 32] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 33] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 34] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 35] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 36] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 37] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 38] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 39] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 40] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 41] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 42] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 43] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 44] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 45] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 46] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 47] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 48] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 49] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 50] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 51] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 52] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 53] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 54] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 55] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 56] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 57] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 58] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 59] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 60] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 61] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 62] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 63] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 64] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 65] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 66] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 67] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 68] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 69] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 70] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 71] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 72] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 73] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 74] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 75] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 76] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 77] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 78] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 79] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 80] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 81] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 82] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 83] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 84] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 85] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 86] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 87] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 88] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 89] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 90] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 91] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 92] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 93] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 94] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 95] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 96] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 97] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 98] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 99] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 100] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 101] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 102] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 103] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 104] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 105] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 106] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 107] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 108] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 109] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 110] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 111] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 112] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 113] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 114] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 115] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 116] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 117] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 118] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 119] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 120] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 121] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 122] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 123] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 124] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 125] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 126] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 127] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 128] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 129] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 130] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 131] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 132] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 133] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 134] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 135] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 136] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 137] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 138] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 139] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 140] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 141] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 142] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 143] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 144] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 145] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 146] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 147] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 148] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 149] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 150] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 151] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 152] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 153] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 154] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 155] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 156] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 157] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 158] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 159] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 160] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 161] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 162] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 163] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 164] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 165] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 166] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 167] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 168] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 169] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 170] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 171] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 172] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 173] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 174] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 175] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 176] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 177] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 178] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 179] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 180] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 181] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 182] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 183] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 184] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 185] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 186] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 187] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 188] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 189] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 190] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 191] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 192] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 193] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 194] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 195] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 196] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 197] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 198] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 199] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 200] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 201] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 202] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 203] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 204] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 205] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 206] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 207] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 208] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 209] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 210] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 211] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 211] Loading attributes... >D [02/Oct/2019:16:35:36 +0200] [Job 212] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 212] Loading attributes... >D [02/Oct/2019:16:35:36 +0200] [Job 213] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 213] Loading attributes... >D [02/Oct/2019:16:35:36 +0200] [Job 214] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 215] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 216] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 217] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 218] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 218] Loading attributes... >D [02/Oct/2019:16:35:36 +0200] [Job 218] Unloading... >D [02/Oct/2019:16:35:36 +0200] [Job 219] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 219] Loading attributes... >D [02/Oct/2019:16:35:36 +0200] [Job 219] Unloading... >D [02/Oct/2019:16:35:36 +0200] [Job 220] Loading from cache... >D [02/Oct/2019:16:35:36 +0200] [Job 220] Loading attributes... >D [02/Oct/2019:16:35:36 +0200] [Job 220] Unloading... >D [02/Oct/2019:16:35:36 +0200] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)") >I [02/Oct/2019:16:35:36 +0200] Full reload complete. >D [02/Oct/2019:16:35:36 +0200] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)") >I [02/Oct/2019:16:35:36 +0200] Cleaning out old files in "/var/spool/cups/tmp". >D [02/Oct/2019:16:35:36 +0200] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp") >I [02/Oct/2019:16:35:36 +0200] Cleaning out old files in "/var/cache/cups". >D [02/Oct/2019:16:35:36 +0200] service_checkin: pid=20120 >D [02/Oct/2019:16:35:36 +0200] service_checkin: 1 listeners. >D [02/Oct/2019:16:35:36 +0200] service_add_listener: Listener #1 at fd 3, "/run/cups/cups.sock". >D [02/Oct/2019:16:35:36 +0200] service_add_listener: Matched existing listener #1 to /run/cups/cups.sock. >D [02/Oct/2019:16:35:36 +0200] Creating KeepAlive/PID file "/var/cache/cups/org.cups.cupsd". >D [02/Oct/2019:16:35:36 +0200] Calling FindDeviceById(cups-Brother_HL_2037) >D [02/Oct/2019:16:35:36 +0200] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files >D [02/Oct/2019:16:35:36 +0200] Using profile ID "Brother_HL_2037-Gray..". >D [02/Oct/2019:16:35:36 +0200] Calling CreateProfile(Brother_HL_2037-Gray..,temp) >W [02/Oct/2019:16:35:36 +0200] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files >I [02/Oct/2019:16:35:36 +0200] Registering ICC color profiles for "Brother_HL_2037". >D [02/Oct/2019:16:35:36 +0200] Calling CreateDevice(cups-Brother_HL_2037,temp) >W [02/Oct/2019:16:35:36 +0200] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files >D [02/Oct/2019:16:35:36 +0200] Calling FindDeviceById(cups-CUPS-PDF) >D [02/Oct/2019:16:35:36 +0200] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files >D [02/Oct/2019:16:35:36 +0200] Using profile ID "CUPS-PDF-Gray..". >D [02/Oct/2019:16:35:36 +0200] Calling CreateProfile(CUPS-PDF-Gray..,temp) >W [02/Oct/2019:16:35:36 +0200] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files >D [02/Oct/2019:16:35:36 +0200] Using profile ID "CUPS-PDF-RGB..". >D [02/Oct/2019:16:35:36 +0200] Calling CreateProfile(CUPS-PDF-RGB..,temp) >W [02/Oct/2019:16:35:36 +0200] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files >I [02/Oct/2019:16:35:36 +0200] Registering ICC color profiles for "CUPS-PDF". >D [02/Oct/2019:16:35:36 +0200] Calling CreateDevice(cups-CUPS-PDF,temp) >W [02/Oct/2019:16:35:36 +0200] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files >E [02/Oct/2019:16:35:36 +0200] Unable to open listen socket for address [v1.::1]:631 - Cannot assign requested address. >I [02/Oct/2019:16:35:36 +0200] Listening to 127.0.0.1:631 on fd 7... >I [02/Oct/2019:16:35:36 +0200] Listening to /run/cups/cups.sock on fd 3... >I [02/Oct/2019:16:35:36 +0200] Resuming new connection processing... >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [02/Oct/2019:16:35:36 +0200] cupsdAddCert: Adding certificate for PID 0 >D [02/Oct/2019:16:35:36 +0200] Notifier dbus started - PID = 20122 >D [02/Oct/2019:16:35:36 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy" >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:35:36 +0200] [Notifier] state=3 >D [02/Oct/2019:16:35:36 +0200] Report: clients=0 >D [02/Oct/2019:16:35:36 +0200] Report: jobs=210 >D [02/Oct/2019:16:35:36 +0200] Report: jobs-active=3 >D [02/Oct/2019:16:35:36 +0200] Report: printers=2 >D [02/Oct/2019:16:35:36 +0200] Report: stringpool-string-count=5237 >D [02/Oct/2019:16:35:36 +0200] Report: stringpool-alloc-bytes=13744 >D [02/Oct/2019:16:35:36 +0200] Report: stringpool-total-bytes=96344 >D [02/Oct/2019:16:35:36 +0200] [Notifier] Connected to D-BUS >D [02/Oct/2019:16:35:36 +0200] [Notifier] ServerStarted >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:35:36 +0200] [Client 1] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:35:36 +0200] [Client 1] Accepted from localhost (Domain) >D [02/Oct/2019:16:35:36 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:35:36 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:35:36 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:35:36 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:35:36 +0200] [Client 1] 2.0 CUPS-Get-Printers 47 >D [02/Oct/2019:16:35:36 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:35:36 +0200] [Client 1] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:35:36 +0200] [Client 1] Content-Length: 889 >D [02/Oct/2019:16:35:36 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:35:36 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:35:36 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=889, response=0x5559a90f7f60(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:35:36 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:35:36 +0200] [Client 1] bytes=0, http_state=0, data_remaining=889 >D [02/Oct/2019:16:35:36 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:35:36 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:35:36 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:35:36 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:35:36 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:35:36 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:35:36 +0200] [Client 1] 2.0 Get-Jobs 48 >D [02/Oct/2019:16:35:36 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:35:36 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:35:36 +0200] [Client 1] Content-Length: 1338 >D [02/Oct/2019:16:35:36 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:35:36 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:35:36 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1338, response=0x5559a90f7370(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:35:36 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:35:36 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1338 >D [02/Oct/2019:16:35:36 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:35:36 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:35:36 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:35:36 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:35:36 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:35:36 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:35:36 +0200] [Client 1] 2.0 Get-Jobs 49 >D [02/Oct/2019:16:35:36 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:35:36 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:35:36 +0200] [Client 1] Content-Length: 1338 >D [02/Oct/2019:16:35:36 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:35:36 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:35:36 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1338, response=0x5559a90f7f60(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:35:36 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:35:36 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1338 >D [02/Oct/2019:16:35:36 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:35:36 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:35:36 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:35:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >I [02/Oct/2019:16:35:37 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:05 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:05 +0200] [Client 2] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:05 +0200] [Client 2] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:05 +0200] [Client 2] Waiting for request. >I [02/Oct/2019:16:36:05 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:05 +0200] [Client 2] POST / HTTP/1.1 >D [02/Oct/2019:16:36:05 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:05 +0200] [Client 2] Read: status=200, state=6 >D [02/Oct/2019:16:36:05 +0200] [Client 2] No authentication data provided. >D [02/Oct/2019:16:36:05 +0200] [Client 2] 2.0 CUPS-Get-Devices 1 >D [02/Oct/2019:16:36:05 +0200] CUPS-Get-Devices >D [02/Oct/2019:16:36:05 +0200] cupsdIsAuthorized: username="" >D [02/Oct/2019:16:36:05 +0200] [Client 2] Returning HTTP Non autorizzato for CUPS-Get-Devices (no URI) from localhost >D [02/Oct/2019:16:36:05 +0200] [Client 2] cupsdSendHeader: code=401, type="text/html", auth_type=0 >D [02/Oct/2019:16:36:05 +0200] [Client 2] WWW-Authenticate: Basic realm=\"CUPS\", PeerCred, Local trc=\"y\" >D [02/Oct/2019:16:36:05 +0200] [Client 2] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:05 +0200] [Client 2] Closing connection. >D [02/Oct/2019:16:36:05 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:05 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:05 +0200] [Client 3] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:05 +0200] [Client 3] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:05 +0200] [Client 3] Waiting for request. >D [02/Oct/2019:16:36:05 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:05 +0200] [Client 4] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:05 +0200] [Client 4] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:05 +0200] [Client 4] Waiting for request. >D [02/Oct/2019:16:36:05 +0200] [Client 3] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:05 +0200] [Client 3] Closing connection. >D [02/Oct/2019:16:36:05 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:05 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:05 +0200] [Client 5] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:05 +0200] [Client 5] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:05 +0200] [Client 5] Waiting for request. >D [02/Oct/2019:16:36:05 +0200] [Client 4] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:05 +0200] [Client 4] Closing connection. >D [02/Oct/2019:16:36:05 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:05 +0200] [Client 5] POST / HTTP/1.1 >D [02/Oct/2019:16:36:05 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:05 +0200] [Client 5] Read: status=200, state=6 >D [02/Oct/2019:16:36:05 +0200] [Client 5] Authorized as root using Local. >D [02/Oct/2019:16:36:05 +0200] [Client 5] 2.0 CUPS-Get-Devices 1 >D [02/Oct/2019:16:36:05 +0200] CUPS-Get-Devices >D [02/Oct/2019:16:36:05 +0200] cupsdIsAuthorized: username="root" >D [02/Oct/2019:16:36:05 +0200] [CGI] argv[0] = "/usr/lib/cups/daemon/cups-deviced" >D [02/Oct/2019:16:36:05 +0200] [CGI] argv[1] = "1" >D [02/Oct/2019:16:36:05 +0200] [CGI] argv[2] = "0" >D [02/Oct/2019:16:36:05 +0200] [CGI] argv[3] = "2" >D [02/Oct/2019:16:36:05 +0200] [CGI] argv[4] = "497" >D [02/Oct/2019:16:36:05 +0200] [CGI] argv[5] = "requested-attributes=all exclude-schemes=\'beh\',\'cups-pdf\',\'bluetooth\',\'dnssd\',\'http\',\'https\',\'ipp\',\'lpd\',\'ncp\',\'parallel\',\'scsi\',\'smb\',\'snmp\',\'socket\'" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/webcontent" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[7] = "CUPS_STATEDIR=/run/cups" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[8] = "HOME=/var/spool/cups/tmp" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[10] = "SERVER_ADMIN=root@myhost.mydomain" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[11] = "SOFTWARE=CUPS/2.2.7" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[13] = "USER=root" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[15] = "CUPS_SERVER=/run/cups/cups.sock" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[17] = "IPP_PORT=631" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[18] = "AUTH_TYPE=Local" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[19] = "LANG=it_IT.UTF8" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[20] = "REDIRECT_STATUS=1" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[22] = "SERVER_NAME=localhost" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[23] = "SERVER_PORT=631" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[24] = "REMOTE_ADDR=localhost" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[25] = "REMOTE_HOST=localhost" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[26] = "SCRIPT_NAME=/" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/webcontent/" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[28] = "REMOTE_USER=root" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[29] = "SERVER_PROTOCOL=HTTP/1.1" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[30] = "HTTP_USER_AGENT=CUPS/2.2.7 (Linux 4.12.14-lp151.28.16-default; x86_64) IPP/2.0" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[31] = "REQUEST_METHOD=POST" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[32] = "CONTENT_LENGTH=244" >D [02/Oct/2019:16:36:05 +0200] [CGI] envp[33] = "CONTENT_TYPE=application/ipp" >D [02/Oct/2019:16:36:05 +0200] cupsdAddCert: Adding certificate for PID 20166 >D [02/Oct/2019:16:36:05 +0200] [CGI] Started /usr/lib/cups/daemon/cups-deviced (PID 20166) >I [02/Oct/2019:16:36:05 +0200] [Client 5] Started "/usr/lib/cups/daemon/cups-deviced" (pid=20166, file=16) >D [02/Oct/2019:16:36:05 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Started backend /usr/lib/cups/backend/cups-brf (PID 20167) >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Started backend /usr/lib/cups/backend/driverless (PID 20168) >E [02/Oct/2019:16:36:05 +0200] [CGI] cups-brf must be called as root >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Started backend /usr/lib/cups/backend/usb (PID 20169) >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Started backend /usr/lib/cups/backend/serial (PID 20170) >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Started backend /usr/lib/cups/backend/implicitclass (PID 20171) >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Started backend /usr/lib/cups/backend/gutenprint52+usb (PID 20172) >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Started backend /usr/lib/cups/backend/ipps (PID 20173) >E [02/Oct/2019:16:36:05 +0200] [cups-deviced] PID 20167 (cups-brf) stopped with status 1! >D [02/Oct/2019:16:36:05 +0200] [CGI] Multi-Call Dye-sublimation CUPS Backend version 0.75G >D [02/Oct/2019:16:36:05 +0200] [CGI] Copyright 2007-2017 Solomon Peachy >D [02/Oct/2019:16:36:05 +0200] [CGI] This free software comes with ABSOLUTELY NO WARRANTY! >D [02/Oct/2019:16:36:05 +0200] [CGI] Licensed under the GNU GPL. Run with \'-G\' for more details. >D [02/Oct/2019:16:36:05 +0200] [CGI] >D [02/Oct/2019:16:36:05 +0200] [CGI] Loading USB quirks from \"/usr/share/cups/usb\". >D [02/Oct/2019:16:36:05 +0200] [CGI] Started ippfind (PID 20175) >D [02/Oct/2019:16:36:05 +0200] [CGI] Loaded 161 quirks. >D [02/Oct/2019:16:36:05 +0200] [CGI] list_devices >D [02/Oct/2019:16:36:05 +0200] [CGI] Started post-processing (PID 20176) >D [02/Oct/2019:16:36:05 +0200] [CGI] Environment variables: >D [02/Oct/2019:16:36:05 +0200] [CGI] DYESUB_DEBUG EXTRA_PID EXTRA_VID EXTRA_TYPE BACKEND SERIAL >D [02/Oct/2019:16:36:05 +0200] [CGI] CUPS Usage: >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] PID 20171 (implicitclass) exited with no errors. >D [02/Oct/2019:16:36:05 +0200] [CGI] DEVICE_URI=someuri gutenprint52+usb job user title num-copies options [ filename ] >D [02/Oct/2019:16:36:05 +0200] [CGI] >D [02/Oct/2019:16:36:05 +0200] [CGI] Standalone Usage: >D [02/Oct/2019:16:36:05 +0200] [CGI] gutenprint52+usb >D [02/Oct/2019:16:36:05 +0200] [ -D ] [ -G ] [ -f ] >D [02/Oct/2019:16:36:05 +0200] [ backend_specific_args ] >D [02/Oct/2019:16:36:05 +0200] [ -d copies ] >D [02/Oct/2019:16:36:05 +0200] [ - | infile ] >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=canonselphy\t# Canon SELPHY CP/ES version 0.94 >D [02/Oct/2019:16:36:05 +0200] [ -R ] # Reset printer >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=canonselphyneo\t# Canon SELPHY CPneo version 0.10 >D [02/Oct/2019:16:36:05 +0200] [ -R ] # Reset printer >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=kodak6800\t# Kodak 6800/6850 version 0.58 >D [02/Oct/2019:16:36:05 +0200] [ -c filename ] # Get tone curve >D [02/Oct/2019:16:36:05 +0200] [ -C filename ] # Set tone curve >D [02/Oct/2019:16:36:05 +0200] [ -m ] # Query media >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query status >D [02/Oct/2019:16:36:05 +0200] [ -R ] # Reset printer >D [02/Oct/2019:16:36:05 +0200] [ -X jobid ] # Cancel Job >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=kodak605\t# Kodak 605 version 0.27 >D [02/Oct/2019:16:36:05 +0200] [ -C filename ] # Set tone curve >D [02/Oct/2019:16:36:05 +0200] [ -m ] # Query media >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query status >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=kodak1400\t# Kodak 1400/805 version 0.34 >D [02/Oct/2019:16:36:05 +0200] [ -C filename ] # Set tone curve >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=shinkos1245\t# Shinko/Sinfonia CHC-S1245 version 0.18 >D [02/Oct/2019:16:36:05 +0200] [ -m ] # Query media >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query status >D [02/Oct/2019:16:36:05 +0200] [ -u ] # Query user string >D [02/Oct/2019:16:36:05 +0200] [ -U sometext ] # Set user string >D [02/Oct/2019:16:36:05 +0200] [ -R ] # Reset printer >D [02/Oct/2019:16:36:05 +0200] [ -X jobid ] # Abort a printjob >D [02/Oct/2019:16:36:05 +0200] [ -F ] # Tone curve refers to FINE mode >D [02/Oct/2019:16:36:05 +0200] [ -c filename ] # Get user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -C filename ] # Set user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -l filename ] # Get current tone curve >D [02/Oct/2019:16:36:05 +0200] [ -L filename ] # Set current tone curve >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=shinkos2145\t# Shinko/Sinfonia CHC-S2145 version 0.48 >D [02/Oct/2019:16:36:05 +0200] [ -b 0|1 ] # Disable/Enable control panel >D [02/Oct/2019:16:36:05 +0200] [ -c filename ] # Get user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -C filename ] # Set user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -e ] # Query error log >D [02/Oct/2019:16:36:05 +0200] [ -f ] # Use fast return mode >D [02/Oct/2019:16:36:05 +0200] [ -F ] # Flash Printer LED >D [02/Oct/2019:16:36:05 +0200] [ -i ] # Query printer info >D [02/Oct/2019:16:36:05 +0200] [ -l filename ] # Get current tone curve >D [02/Oct/2019:16:36:05 +0200] [ -L filename ] # Set current tone curve >D [02/Oct/2019:16:36:05 +0200] [ -m ] # Query media >D [02/Oct/2019:16:36:05 +0200] [ -r ] # Reset user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -R ] # Reset printer to factory defaults >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query status >D [02/Oct/2019:16:36:05 +0200] [ -u ] # Query user string >D [02/Oct/2019:16:36:05 +0200] [ -U sometext ] # Set user string >D [02/Oct/2019:16:36:05 +0200] [ -X jobid ] # Abort a printjob >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=shinkos6145\t# Shinko/Sinfonia CHC-S6145 version 0.22 >D [02/Oct/2019:16:36:05 +0200] [ -c filename ] # Get user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -C filename ] # Set user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -e ] # Query error log >D [02/Oct/2019:16:36:05 +0200] [ -F ] # Flash Printer LED >D [02/Oct/2019:16:36:05 +0200] [ -i ] # Query printer info >D [02/Oct/2019:16:36:05 +0200] [ -k num ] # Set sleep time (5-240 minutes) >D [02/Oct/2019:16:36:05 +0200] [ -l filename ] # Get current tone curve >D [02/Oct/2019:16:36:05 +0200] [ -L filename ] # Set current tone curve >D [02/Oct/2019:16:36:05 +0200] [ -m ] # Query media >D [02/Oct/2019:16:36:05 +0200] [ -q filename ] # Extract eeprom data >D [02/Oct/2019:16:36:05 +0200] [ -Q filename ] # Extract image correction params >D [02/Oct/2019:16:36:05 +0200] [ -r ] # Reset user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -R ] # Reset printer to factory defaults >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query status >D [02/Oct/2019:16:36:05 +0200] [ -X jobid ] # Abort a printjob >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=shinkos6245\t# Shinko/Sinfonia CHC-S6245 version 0.08WIP >D [02/Oct/2019:16:36:05 +0200] [ -c filename ] # Get user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -C filename ] # Set user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -e ] # Query error log >D [02/Oct/2019:16:36:05 +0200] [ -F ] # Flash Printer LED >D [02/Oct/2019:16:36:05 +0200] [ -i ] # Query printer info >D [02/Oct/2019:16:36:05 +0200] [ -k num ] # Set sleep time (5-240 minutes) >D [02/Oct/2019:16:36:05 +0200] [ -l filename ] # Get current tone curve >D [02/Oct/2019:16:36:05 +0200] [ -L filename ] # Set current tone curve >D [02/Oct/2019:16:36:05 +0200] [ -m ] # Query media >D [02/Oct/2019:16:36:05 +0200] [ -r ] # Reset user/NV tone curve >D [02/Oct/2019:16:36:05 +0200] [ -R ] # Reset printer to factory defaults >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query status >D [02/Oct/2019:16:36:05 +0200] [ -X jobid ] # Abort a printjob >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=sonyupdr150\t# Sony UP-DR150/UP-DR200/UP-CR10 version 0.19 >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=mitsu70x\t# Mitsubishi CP-D70/D707/K60/D80 version 0.74 >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query printer status >D [02/Oct/2019:16:36:05 +0200] [ -j ] # Query job status >D [02/Oct/2019:16:36:05 +0200] [ -w ] # Wake up printer >D [02/Oct/2019:16:36:05 +0200] [ -W ] # Wake up printer and wait >D [02/Oct/2019:16:36:05 +0200] [ -f ] # Use fast return mode >D [02/Oct/2019:16:36:05 +0200] [ -k num ] # Set standby time (1-60 minutes, 0 disables) >D [02/Oct/2019:16:36:05 +0200] [ -x num ] # Set USB iSerialNumber Reporting (1 on, 0 off) >D [02/Oct/2019:16:36:05 +0200] [ -X jobid ] # Abort a printjob >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=mitsu9550\t# Mitsubishi CP-9xxx family version 0.29 >D [02/Oct/2019:16:36:05 +0200] [ -m ] # Query media >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query status >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=mitsup95d\t# Mitsubishi P93D/P95D version 0.05 >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=dnpds40\t# DNP DS40/DS80/DSRX1/DS620/DS820 version 0.97 >D [02/Oct/2019:16:36:05 +0200] [ -i ] # Query printer info >D [02/Oct/2019:16:36:05 +0200] [ -I ] # Query sensor info >D [02/Oct/2019:16:36:05 +0200] [ -k num ] # Set standby time (1-99 minutes, 0 disables) >D [02/Oct/2019:16:36:05 +0200] [ -K num ] # Keep Media Status Across Power Cycles (1 on, 0 off) >D [02/Oct/2019:16:36:05 +0200] [ -n ] # Query counters >D [02/Oct/2019:16:36:05 +0200] [ -N A|B|M ] # Clear counter A/B/M >D [02/Oct/2019:16:36:05 +0200] [ -p num ] # Set counter P >D [02/Oct/2019:16:36:05 +0200] [ -R ] # Reset printer >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query status >D [02/Oct/2019:16:36:05 +0200] [ -x num ] # Set USB iSerialNumber Reporting (1 on, 0 off) >D [02/Oct/2019:16:36:05 +0200] [ -X ] # Cancel current print job >D [02/Oct/2019:16:36:05 +0200] [CGI] BACKEND=citizencw01\t# Citizen CW-01 version 0.12 >D [02/Oct/2019:16:36:05 +0200] [ -i ] # Query printer info >D [02/Oct/2019:16:36:05 +0200] [ -s ] # Query status >D [02/Oct/2019:16:36:05 +0200] [ -n ] # Query counters >D [02/Oct/2019:16:36:05 +0200] [CGI] libusb_get_device_list=10 >D [02/Oct/2019:16:36:05 +0200] [ -N A|B|M ] # Clear counter A/B/M >D [02/Oct/2019:16:36:05 +0200] [Client 5] CGI data ready to be sent. >D [02/Oct/2019:16:36:05 +0200] [CGI] Flushed attributes... >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Found device \"serial:/dev/ttyS0?baud=115200\"... >D [02/Oct/2019:16:36:05 +0200] [Client 5] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:05 +0200] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=2147483647, response=(nil)(), pipe_pid=20166, file=16 >D [02/Oct/2019:16:36:05 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:05 +0200] [Client 5] Script header: Content-Type: application/ipp >D [02/Oct/2019:16:36:05 +0200] [Client 5] Script header: >D [02/Oct/2019:16:36:05 +0200] [Client 5] Sending status 200 for CGI. >D [02/Oct/2019:16:36:05 +0200] [Client 5] cupsdSendHeader: code=200, type="(null)", auth_type=0 >D [02/Oct/2019:16:36:05 +0200] [Client 5] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:05 +0200] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=20166, file=16 >D [02/Oct/2019:16:36:05 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] PID 20170 (serial) exited with no errors. >E [02/Oct/2019:16:36:05 +0200] [cups-deviced] PID 20172 (gutenprint52+usb) stopped with status 1! >D [02/Oct/2019:16:36:05 +0200] [Client 5] CGI data ready to be sent. >D [02/Oct/2019:16:36:05 +0200] [CGI] Flushed attributes... >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Found device \"usb://Brother/HL-2030%20series?serial=H8J161792\"... >D [02/Oct/2019:16:36:05 +0200] [Client 5] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:05 +0200] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=20166, file=16 >D [02/Oct/2019:16:36:05 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:05 +0200] [Client 5] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:05 +0200] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=20166, file=16 >D [02/Oct/2019:16:36:05 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] PID 20169 (usb) exited with no errors. >D [02/Oct/2019:16:36:05 +0200] [Client 5] CGI data ready to be sent. >D [02/Oct/2019:16:36:05 +0200] [CGI] Flushed attributes... >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] Found device \"ipps\"... >D [02/Oct/2019:16:36:05 +0200] [Client 5] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:05 +0200] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=20166, file=16 >D [02/Oct/2019:16:36:05 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:05 +0200] [Client 5] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:05 +0200] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=20166, file=16 >D [02/Oct/2019:16:36:05 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:05 +0200] [cups-deviced] PID 20173 (ipps) exited with no errors. >I [02/Oct/2019:16:36:06 +0200] Saving subscriptions.conf... >D [02/Oct/2019:16:36:06 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Active clients and dirty files" >I [02/Oct/2019:16:36:06 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:07 +0200] [Client 5] CGI data ready to be sent. >D [02/Oct/2019:16:36:07 +0200] [CGI] PID 20175 (ippfind) was terminated normally with signal 0! >I [02/Oct/2019:16:36:07 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:07 +0200] PID 20166 (/usr/lib/cups/daemon/cups-deviced) exited with no errors. >D [02/Oct/2019:16:36:07 +0200] [Client 5] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:07 +0200] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=20166, file=16 >D [02/Oct/2019:16:36:07 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:07 +0200] [Client 5] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:07 +0200] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=20166, file=16 >D [02/Oct/2019:16:36:07 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:07 +0200] [Client 5] CGI data ready to be sent. >D [02/Oct/2019:16:36:07 +0200] [Client 5] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:07 +0200] [Client 5] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=20166, file=16 >D [02/Oct/2019:16:36:07 +0200] [Client 5] Waiting for CGI data. >D [02/Oct/2019:16:36:07 +0200] [Client 5] Sending 0-length chunk. >D [02/Oct/2019:16:36:07 +0200] [Client 5] Flushing write buffer. >D [02/Oct/2019:16:36:07 +0200] [Client 5] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:07 +0200] [Client 5] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [02/Oct/2019:16:36:07 +0200] [Client 5] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:07 +0200] [Client 5] Closing connection. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Not busy" >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [02/Oct/2019:16:36:07 +0200] [Client 6] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:07 +0200] [Client 6] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:07 +0200] [Client 6] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] [Client 6] POST / HTTP/1.1 >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Active clients" >D [02/Oct/2019:16:36:07 +0200] [Client 6] Read: status=200, state=6 >D [02/Oct/2019:16:36:07 +0200] [Client 6] No authentication data provided. >D [02/Oct/2019:16:36:07 +0200] [Client 6] 2.0 CUPS-Get-Printers 2 >D [02/Oct/2019:16:36:07 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:07 +0200] [Client 6] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:07 +0200] [Client 6] Content-Length: 408 >D [02/Oct/2019:16:36:07 +0200] [Client 6] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:07 +0200] [Client 6] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:07 +0200] [Client 6] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=408, response=0x5559a90f7950(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:07 +0200] [Client 6] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:07 +0200] [Client 6] bytes=0, http_state=0, data_remaining=408 >D [02/Oct/2019:16:36:07 +0200] [Client 6] Flushing write buffer. >D [02/Oct/2019:16:36:07 +0200] [Client 6] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:07 +0200] [Client 6] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [02/Oct/2019:16:36:07 +0200] [CGI] PID 20176 (Post-processing) exited with no errors. >D [02/Oct/2019:16:36:07 +0200] [Client 6] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:07 +0200] [Client 6] Closing connection. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Not busy" >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [02/Oct/2019:16:36:07 +0200] [Client 7] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:07 +0200] [Client 7] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:07 +0200] [Client 7] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] [Client 7] POST /admin/ HTTP/1.1 >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Active clients" >D [02/Oct/2019:16:36:07 +0200] [Client 7] Read: status=200, state=6 >D [02/Oct/2019:16:36:07 +0200] [Client 7] No authentication data provided. >D [02/Oct/2019:16:36:07 +0200] [Client 7] 2.0 Resume-Printer 3 >D [02/Oct/2019:16:36:07 +0200] Resume-Printer ipp://localhost/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:07 +0200] cupsdIsAuthorized: username="" >D [02/Oct/2019:16:36:07 +0200] [Client 7] Returning HTTP Non autorizzato for Resume-Printer (ipp://localhost/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:07 +0200] [Client 7] cupsdSendHeader: code=401, type="text/html", auth_type=1 >D [02/Oct/2019:16:36:07 +0200] [Client 7] WWW-Authenticate: Basic realm=\"CUPS\", PeerCred, Local trc=\"y\" >D [02/Oct/2019:16:36:07 +0200] [Client 7] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:07 +0200] [Client 7] Closing connection. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [02/Oct/2019:16:36:07 +0200] [Client 8] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:07 +0200] [Client 8] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:07 +0200] [Client 8] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Active clients" >D [02/Oct/2019:16:36:07 +0200] [Client 9] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:07 +0200] [Client 9] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:07 +0200] [Client 9] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] [Client 8] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:07 +0200] [Client 8] Closing connection. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [02/Oct/2019:16:36:07 +0200] [Client 10] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:07 +0200] [Client 10] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:07 +0200] [Client 10] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] [Client 9] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:07 +0200] [Client 9] Closing connection. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [02/Oct/2019:16:36:07 +0200] [Client 10] POST /admin/ HTTP/1.1 >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [02/Oct/2019:16:36:07 +0200] [Client 10] Read: status=200, state=6 >D [02/Oct/2019:16:36:07 +0200] [Client 10] Authorized as root using Local. >D [02/Oct/2019:16:36:07 +0200] [Client 10] 2.0 Resume-Printer 3 >D [02/Oct/2019:16:36:07 +0200] Resume-Printer ipp://localhost/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:07 +0200] cupsdIsAuthorized: username="root" >D [02/Oct/2019:16:36:07 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients" >D [02/Oct/2019:16:36:07 +0200] cupsdMarkDirty(P----) >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:07 +0200] cupsdRegisterPrinter(p=0x5559a8fcfa30(Brother_HL_2037)) >D [02/Oct/2019:16:36:07 +0200] cupsdMarkDirty(P----) >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >I [02/Oct/2019:16:36:07 +0200] Printer "Brother_HL_2037" started by "root". >D [02/Oct/2019:16:36:07 +0200] [Client 10] Returning IPP successful-ok for Resume-Printer (ipp://localhost/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:07 +0200] [Client 10] Content-Length: 75 >D [02/Oct/2019:16:36:07 +0200] [Client 10] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:07 +0200] [Client 10] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:07 +0200] [Client 10] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x5559a9106070(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:07 +0200] [Client 10] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:07 +0200] [Client 10] bytes=0, http_state=0, data_remaining=75 >D [02/Oct/2019:16:36:07 +0200] [Client 10] Flushing write buffer. >D [02/Oct/2019:16:36:07 +0200] [Client 10] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:07 +0200] [Client 10] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:07 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:07 +0200] [Notifier] PrinterStateChanged >D [02/Oct/2019:16:36:07 +0200] [Client 10] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:07 +0200] [Client 10] Closing connection. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:07 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:07 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:07 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:07 +0200] [Client 1] 2.0 Get-Printer-Attributes 50 >D [02/Oct/2019:16:36:07 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:07 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:07 +0200] [Client 1] Content-Length: 514 >D [02/Oct/2019:16:36:07 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:07 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:07 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=514, response=0x5559a90f79c0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:07 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:07 +0200] [Client 1] bytes=0, http_state=0, data_remaining=514 >D [02/Oct/2019:16:36:07 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:07 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:07 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:07 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:07 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:07 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:07 +0200] [Client 1] 2.0 Get-Printer-Attributes 51 >D [02/Oct/2019:16:36:07 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:07 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:07 +0200] [Client 1] Content-Length: 514 >D [02/Oct/2019:16:36:07 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:07 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:07 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=514, response=0x5559a9106070(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:07 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:07 +0200] [Client 1] bytes=0, http_state=0, data_remaining=514 >D [02/Oct/2019:16:36:07 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:07 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:07 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:07 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >I [02/Oct/2019:16:36:08 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 11] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:11 +0200] [Client 11] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:11 +0200] [Client 11] Waiting for request. >I [02/Oct/2019:16:36:11 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 12] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:11 +0200] [Client 12] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:11 +0200] [Client 12] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] [Client 11] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:11 +0200] [Client 11] Closing connection. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 12] POST / HTTP/1.1 >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=200, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] No authentication data provided. >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 12] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:11 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:11 +0200] [Client 12] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:11 +0200] [Client 12] Content-Length: 1738 >D [02/Oct/2019:16:36:11 +0200] [Client 12] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:11 +0200] [Client 12] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:11 +0200] [Client 12] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:11 +0200] [Client 12] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:11 +0200] [Client 12] Flushing write buffer. >D [02/Oct/2019:16:36:11 +0200] [Client 12] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:11 +0200] [Client 12] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 13] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:11 +0200] [Client 13] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:11 +0200] [Client 13] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] [Client 12] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:11 +0200] [Client 12] Closing connection. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 13] GET /printers/Brother_HL_2037.ppd HTTP/1.1 >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 13] Read: status=200, state=3 >D [02/Oct/2019:16:36:11 +0200] [Client 13] No authentication data provided. >D [02/Oct/2019:16:36:11 +0200] [Client 13] Processing GET /printers/Brother_HL_2037.ppd >D [02/Oct/2019:16:36:11 +0200] [Client 13] filename="/etc/cups/ppd/Brother_HL_2037.ppd", type=application/vnd.cups-ppd >D [02/Oct/2019:16:36:11 +0200] [Client 13] cupsdSendHeader: code=200, type="application/vnd.cups-ppd", auth_type=0 >D [02/Oct/2019:16:36:11 +0200] [Client 13] Sending file. >D [02/Oct/2019:16:36:11 +0200] [Client 13] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:11 +0200] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=13525, response=(nil)(), pipe_pid=0, file=16 >D [02/Oct/2019:16:36:11 +0200] [Client 13] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:11 +0200] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=13525, response=(nil)(), pipe_pid=0, file=16 >D [02/Oct/2019:16:36:11 +0200] [Client 13] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:11 +0200] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=13525, response=(nil)(), pipe_pid=0, file=16 >D [02/Oct/2019:16:36:11 +0200] [Client 13] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:11 +0200] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=13525, response=(nil)(), pipe_pid=0, file=16 >D [02/Oct/2019:16:36:11 +0200] [Client 13] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:11 +0200] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=13525, response=(nil)(), pipe_pid=0, file=16 >D [02/Oct/2019:16:36:11 +0200] [Client 13] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:11 +0200] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=13525, response=(nil)(), pipe_pid=0, file=16 >D [02/Oct/2019:16:36:11 +0200] [Client 13] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:11 +0200] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=13525, response=(nil)(), pipe_pid=0, file=16 >D [02/Oct/2019:16:36:11 +0200] [Client 13] Flushing write buffer. >D [02/Oct/2019:16:36:11 +0200] [Client 13] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:11 +0200] [Client 13] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 13] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:11 +0200] [Client 13] Closing connection. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 14] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:11 +0200] [Client 14] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:11 +0200] [Client 14] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 15] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:11 +0200] [Client 15] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:11 +0200] [Client 15] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] [Client 14] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:11 +0200] [Client 14] Closing connection. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 15] POST / HTTP/1.1 >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=200, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] No authentication data provided. >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Read: status=100, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 15] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:11 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:11 +0200] [Client 15] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:11 +0200] [Client 15] Content-Length: 1738 >D [02/Oct/2019:16:36:11 +0200] [Client 15] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:11 +0200] [Client 15] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:11 +0200] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:11 +0200] [Client 15] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:11 +0200] [Client 15] Flushing write buffer. >D [02/Oct/2019:16:36:11 +0200] [Client 15] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:11 +0200] [Client 15] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 15] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:11 +0200] [Client 15] Closing connection. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 16] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:11 +0200] [Client 16] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:11 +0200] [Client 16] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 17] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:11 +0200] [Client 17] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:11 +0200] [Client 17] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] [Client 16] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:11 +0200] [Client 16] Closing connection. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 17] POST / HTTP/1.1 >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 17] Read: status=200, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 17] No authentication data provided. >D [02/Oct/2019:16:36:11 +0200] [Client 17] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:11 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:11 +0200] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:11 +0200] [Client 17] Content-Length: 1738 >D [02/Oct/2019:16:36:11 +0200] [Client 17] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:11 +0200] [Client 17] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:11 +0200] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:11 +0200] [Client 17] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:11 +0200] [Client 17] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:11 +0200] [Client 17] Flushing write buffer. >D [02/Oct/2019:16:36:11 +0200] [Client 17] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:11 +0200] [Client 17] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 17] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:11 +0200] [Client 17] Closing connection. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 18] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:11 +0200] [Client 18] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:11 +0200] [Client 18] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 19] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:11 +0200] [Client 19] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:11 +0200] [Client 19] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] [Client 18] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:11 +0200] [Client 18] Closing connection. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 19] POST / HTTP/1.1 >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 19] Read: status=200, state=6 >D [02/Oct/2019:16:36:11 +0200] [Client 19] No authentication data provided. >D [02/Oct/2019:16:36:11 +0200] [Client 19] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:11 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:11 +0200] [Client 19] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:11 +0200] [Client 19] Content-Length: 1738 >D [02/Oct/2019:16:36:11 +0200] [Client 19] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:11 +0200] [Client 19] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:11 +0200] [Client 19] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:11 +0200] [Client 19] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:11 +0200] [Client 19] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:11 +0200] [Client 19] Flushing write buffer. >D [02/Oct/2019:16:36:11 +0200] [Client 19] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:11 +0200] [Client 19] Waiting for request. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:11 +0200] [Client 19] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:11 +0200] [Client 19] Closing connection. >D [02/Oct/2019:16:36:11 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 20] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 20] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 20] Waiting for request. >I [02/Oct/2019:16:36:12 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 21] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 21] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 21] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] [Client 20] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 20] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 21] POST / HTTP/1.1 >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 21] Read: status=200, state=6 >D [02/Oct/2019:16:36:12 +0200] [Client 21] No authentication data provided. >D [02/Oct/2019:16:36:12 +0200] [Client 21] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:12 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:12 +0200] [Client 21] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:12 +0200] [Client 21] Content-Length: 1738 >D [02/Oct/2019:16:36:12 +0200] [Client 21] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:12 +0200] [Client 21] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:12 +0200] [Client 21] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:12 +0200] [Client 21] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:12 +0200] [Client 21] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:12 +0200] [Client 21] Flushing write buffer. >D [02/Oct/2019:16:36:12 +0200] [Client 21] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:12 +0200] [Client 21] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 21] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 21] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 22] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 22] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 22] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 23] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 23] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 23] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] [Client 22] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 22] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 23] POST / HTTP/1.1 >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 23] Read: status=200, state=6 >D [02/Oct/2019:16:36:12 +0200] [Client 23] No authentication data provided. >D [02/Oct/2019:16:36:12 +0200] [Client 23] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:12 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:12 +0200] [Client 23] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:12 +0200] [Client 23] Content-Length: 1738 >D [02/Oct/2019:16:36:12 +0200] [Client 23] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:12 +0200] [Client 23] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:12 +0200] [Client 23] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:12 +0200] [Client 23] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:12 +0200] [Client 23] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:12 +0200] [Client 23] Flushing write buffer. >D [02/Oct/2019:16:36:12 +0200] [Client 23] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:12 +0200] [Client 23] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 23] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 23] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 24] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 24] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 24] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 25] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 25] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 25] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] [Client 24] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 24] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 25] POST / HTTP/1.1 >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 25] Read: status=200, state=6 >D [02/Oct/2019:16:36:12 +0200] [Client 25] No authentication data provided. >D [02/Oct/2019:16:36:12 +0200] [Client 25] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:12 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:12 +0200] [Client 25] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:12 +0200] [Client 25] Content-Length: 1738 >D [02/Oct/2019:16:36:12 +0200] [Client 25] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:12 +0200] [Client 25] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:12 +0200] [Client 25] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:12 +0200] [Client 25] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:12 +0200] [Client 25] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:12 +0200] [Client 25] Flushing write buffer. >D [02/Oct/2019:16:36:12 +0200] [Client 25] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:12 +0200] [Client 25] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 25] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 25] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 26] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 26] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 26] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 27] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 27] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 27] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] [Client 26] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 26] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 27] POST / HTTP/1.1 >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 27] Read: status=200, state=6 >D [02/Oct/2019:16:36:12 +0200] [Client 27] No authentication data provided. >D [02/Oct/2019:16:36:12 +0200] [Client 27] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:12 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:12 +0200] [Client 27] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:12 +0200] [Client 27] Content-Length: 1738 >D [02/Oct/2019:16:36:12 +0200] [Client 27] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:12 +0200] [Client 27] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:12 +0200] [Client 27] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:12 +0200] [Client 27] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:12 +0200] [Client 27] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:12 +0200] [Client 27] Flushing write buffer. >D [02/Oct/2019:16:36:12 +0200] [Client 27] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:12 +0200] [Client 27] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 27] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 27] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 28] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 28] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 28] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 29] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:12 +0200] [Client 29] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:12 +0200] [Client 29] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] [Client 28] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 28] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 29] POST / HTTP/1.1 >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 29] Read: status=200, state=6 >D [02/Oct/2019:16:36:12 +0200] [Client 29] No authentication data provided. >D [02/Oct/2019:16:36:12 +0200] [Client 29] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:12 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:12 +0200] [Client 29] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:12 +0200] [Client 29] Content-Length: 1738 >D [02/Oct/2019:16:36:12 +0200] [Client 29] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:12 +0200] [Client 29] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:12 +0200] [Client 29] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:12 +0200] [Client 29] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:12 +0200] [Client 29] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:12 +0200] [Client 29] Flushing write buffer. >D [02/Oct/2019:16:36:12 +0200] [Client 29] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:12 +0200] [Client 29] Waiting for request. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:12 +0200] [Client 29] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:12 +0200] [Client 29] Closing connection. >D [02/Oct/2019:16:36:12 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 30] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 30] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 30] Waiting for request. >I [02/Oct/2019:16:36:13 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 31] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 31] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 31] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] [Client 30] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 30] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 31] POST / HTTP/1.1 >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 31] Read: status=200, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 31] No authentication data provided. >D [02/Oct/2019:16:36:13 +0200] [Client 31] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:13 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:13 +0200] [Client 31] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:13 +0200] [Client 31] Content-Length: 1738 >D [02/Oct/2019:16:36:13 +0200] [Client 31] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:13 +0200] [Client 31] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:13 +0200] [Client 31] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:13 +0200] [Client 31] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:13 +0200] [Client 31] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:13 +0200] [Client 31] Flushing write buffer. >D [02/Oct/2019:16:36:13 +0200] [Client 31] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:13 +0200] [Client 31] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 31] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 31] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 32] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 32] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 32] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 33] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 33] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 33] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] [Client 32] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 32] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 33] POST / HTTP/1.1 >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=200, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] No authentication data provided. >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 33] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:13 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:13 +0200] [Client 33] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:13 +0200] [Client 33] Content-Length: 1738 >D [02/Oct/2019:16:36:13 +0200] [Client 33] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:13 +0200] [Client 33] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:13 +0200] [Client 33] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:13 +0200] [Client 33] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:13 +0200] [Client 33] Flushing write buffer. >D [02/Oct/2019:16:36:13 +0200] [Client 33] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:13 +0200] [Client 33] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 33] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 33] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 34] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 34] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 34] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 35] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 35] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 35] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] [Client 34] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 34] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 35] POST / HTTP/1.1 >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=200, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] No authentication data provided. >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Read: status=100, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 35] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:13 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:13 +0200] [Client 35] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:13 +0200] [Client 35] Content-Length: 1738 >D [02/Oct/2019:16:36:13 +0200] [Client 35] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:13 +0200] [Client 35] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:13 +0200] [Client 35] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:13 +0200] [Client 35] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:13 +0200] [Client 35] Flushing write buffer. >D [02/Oct/2019:16:36:13 +0200] [Client 35] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:13 +0200] [Client 35] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 35] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 35] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 36] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 36] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 36] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 37] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 37] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 37] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] [Client 36] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 36] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 37] POST / HTTP/1.1 >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 37] Read: status=200, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 37] No authentication data provided. >D [02/Oct/2019:16:36:13 +0200] [Client 37] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:13 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:13 +0200] [Client 37] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:13 +0200] [Client 37] Content-Length: 1738 >D [02/Oct/2019:16:36:13 +0200] [Client 37] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:13 +0200] [Client 37] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:13 +0200] [Client 37] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:13 +0200] [Client 37] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:13 +0200] [Client 37] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:13 +0200] [Client 37] Flushing write buffer. >D [02/Oct/2019:16:36:13 +0200] [Client 37] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:13 +0200] [Client 37] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 37] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 37] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 38] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 38] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 38] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 39] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:13 +0200] [Client 39] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:13 +0200] [Client 39] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] [Client 38] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 38] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 39] POST / HTTP/1.1 >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 39] Read: status=200, state=6 >D [02/Oct/2019:16:36:13 +0200] [Client 39] No authentication data provided. >D [02/Oct/2019:16:36:13 +0200] [Client 39] 2.0 CUPS-Get-Printers 1 >D [02/Oct/2019:16:36:13 +0200] CUPS-Get-Printers >D [02/Oct/2019:16:36:13 +0200] [Client 39] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [02/Oct/2019:16:36:13 +0200] [Client 39] Content-Length: 1738 >D [02/Oct/2019:16:36:13 +0200] [Client 39] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:13 +0200] [Client 39] con->http=0x5559a910d1b0 >D [02/Oct/2019:16:36:13 +0200] [Client 39] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1738, response=0x5559a91060b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:13 +0200] [Client 39] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:13 +0200] [Client 39] bytes=0, http_state=0, data_remaining=1738 >D [02/Oct/2019:16:36:13 +0200] [Client 39] Flushing write buffer. >D [02/Oct/2019:16:36:13 +0200] [Client 39] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:13 +0200] [Client 39] Waiting for request. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:13 +0200] [Client 39] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:13 +0200] [Client 39] Closing connection. >D [02/Oct/2019:16:36:13 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >I [02/Oct/2019:16:36:14 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 40] Server address is "/run/cups/cups.sock". >D [02/Oct/2019:16:36:15 +0200] [Client 40] Accepted from localhost (Domain) >D [02/Oct/2019:16:36:15 +0200] [Client 40] Waiting for request. >I [02/Oct/2019:16:36:15 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:15 +0200] [Client 40] POST /printers/Brother_HL_2037 HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 40] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 40] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 40] 2.1 Print-Job 1 >D [02/Oct/2019:16:36:15 +0200] [Client 40] Read: status=100, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 40] Read: status=100, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 40] Read: status=100, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 40] Read: status=100, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 40] Read: status=100, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 40] Read: status=100, state=6 >D [02/Oct/2019:16:36:15 +0200] Print-Job ipp://localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Job ???] Auto-typing file... >I [02/Oct/2019:16:36:15 +0200] [Job ???] Request file type is application/pdf. >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(---J-) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Job 221] Applying default options... >D [02/Oct/2019:16:36:15 +0200] add_job: requesting-user-name="user" >I [02/Oct/2019:16:36:15 +0200] [Job 221] Adding start banner page "none". >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(---J-) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >I [02/Oct/2019:16:36:15 +0200] [Job 221] Adding end banner page "none". >I [02/Oct/2019:16:36:15 +0200] [Job 221] File of type application/pdf queued by "user". >D [02/Oct/2019:16:36:15 +0200] [Job 221] hold_until=0 >I [02/Oct/2019:16:36:15 +0200] [Job 221] Queued on "Brother_HL_2037" by "user". >D [02/Oct/2019:16:36:15 +0200] [Job 221] time-at-processing=1570026975 >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(---J-) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Job 221] 2 filters for job: >D [02/Oct/2019:16:36:15 +0200] [Job 221] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66) >D [02/Oct/2019:16:36:15 +0200] [Job 221] foomatic-rip (application/vnd.cups-pdf to printer/Brother_HL_2037, cost 0) >D [02/Oct/2019:16:36:15 +0200] [Job 221] job-sheets=none,none >D [02/Oct/2019:16:36:15 +0200] [Job 221] argv[0]="Brother_HL_2037" >D [02/Oct/2019:16:36:15 +0200] [Job 221] argv[1]="221" >D [02/Oct/2019:16:36:15 +0200] [Job 221] argv[2]="user" >D [02/Oct/2019:16:36:15 +0200] [Job 221] argv[3]="(Centro resi)" >D [02/Oct/2019:16:36:15 +0200] [Job 221] argv[4]="1" >D [02/Oct/2019:16:36:15 +0200] [Job 221] argv[5]="InputSlot=auto number-up=1 MediaType=plain EconoMode=off noCollate Resolution=600x600dpi PageSize=A4 job-uuid=urn:uuid:5244bed1-ec6a-3f19-6493-7c26639cacde job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1570026975 time-at-processing=1570026975" >D [02/Oct/2019:16:36:15 +0200] [Job 221] argv[6]="/var/spool/cups/d00221-001" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[0]="CUPS_CACHEDIR=/var/cache/cups" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[1]="CUPS_DATADIR=/usr/share/cups" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[6]="CUPS_SERVERROOT=/etc/cups" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[7]="CUPS_STATEDIR=/run/cups" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[8]="HOME=/var/spool/cups/tmp" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[10]="SERVER_ADMIN=root@myhost.mydomain" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[11]="SOFTWARE=CUPS/2.2.7" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[12]="TMPDIR=/var/spool/cups/tmp" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[13]="USER=root" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[14]="CUPS_MAX_MESSAGE=2047" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[15]="CUPS_SERVER=/run/cups/cups.sock" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[16]="CUPS_ENCRYPTION=IfRequested" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[17]="IPP_PORT=631" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[18]="CHARSET=utf-8" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[19]="LANG=it_IT.UTF-8" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[20]="PPD=/etc/cups/ppd/Brother_HL_2037.ppd" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[21]="RIP_MAX_CACHE=128m" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[22]="CONTENT_TYPE=application/pdf" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[23]="DEVICE_URI=usb://Brother/HL-2030%20series?serial=H8J161792" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[24]="PRINTER_INFO=Brother HL-2030 series with driver Brother HL-2030 Foomatic/hl1250 (recommended)" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[25]="PRINTER_LOCATION=" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[26]="PRINTER=Brother_HL_2037" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[27]="PRINTER_STATE_REASONS=none" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[28]="CUPS_FILETYPE=document" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-pdf" >D [02/Oct/2019:16:36:15 +0200] [Job 221] envp[30]="AUTH_I****" >I [02/Oct/2019:16:36:15 +0200] [Job 221] Started filter /usr/lib/cups/filter/pdftopdf (PID 20271) >I [02/Oct/2019:16:36:15 +0200] [Job 221] Started filter /usr/lib/cups/filter/foomatic-rip (PID 20272) >I [02/Oct/2019:16:36:15 +0200] [Job 221] Started backend /usr/lib/cups/backend/usb (PID 20273) >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 40] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 40] Content-Length: 193 >D [02/Oct/2019:16:36:15 +0200] [Client 40] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 40] con->http=0x5559a9106d20 >D [02/Oct/2019:16:36:15 +0200] [Client 40] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=193, response=0x5559a90e7680(IPP_STATE_IDLE), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 40] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 40] bytes=0, http_state=0, data_remaining=193 >D [02/Oct/2019:16:36:15 +0200] [Client 40] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 40] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 40] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] JobCreated >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] PrinterStateChanged >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 52 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=514, response=0x5559a90fae30(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Jobs 53 >D [02/Oct/2019:16:36:15 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 1690 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] JobState >D [02/Oct/2019:16:36:15 +0200] [Client 40] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [02/Oct/2019:16:36:15 +0200] [Client 40] Closing connection. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1690, response=0x5559a90e7680(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1690 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Jobs 54 >D [02/Oct/2019:16:36:15 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 1690 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1690, response=0x5559a90e6f60(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1690 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 55 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=514, response=0x5559a90e7680(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Job 221] Loading USB quirks from \"/usr/share/cups/usb\". >D [02/Oct/2019:16:36:15 +0200] [Job 221] Loaded 161 quirks. >D [02/Oct/2019:16:36:15 +0200] [Job 221] Printing on printer with URI: usb://Brother/HL-2030%20series?serial=H8J161792 >D [02/Oct/2019:16:36:15 +0200] [Job 221] pdftopdf: Last filter determined by the PPD: foomatic-rip; FINAL_CONTENT_TYPE: application/vnd.cups-pdf => pdftopdf will log pages in page_log. >D [02/Oct/2019:16:36:15 +0200] [Job 221] PAGE: 1 1 >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(---J-) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(---J-) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] JobProgress >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Jobs 56 >D [02/Oct/2019:16:36:15 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 1690 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1690, response=0x5559a90fae30(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1690 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Jobs 57 >D [02/Oct/2019:16:36:15 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 1690 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1690, response=0x5559a90e6f60(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1690 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Job 221] libusb_get_device_list=10 >D [02/Oct/2019:16:36:15 +0200] [Job 221] STATE: +connecting-to-device >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(---J-) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:15 +0200] [Job 221] STATE: -connecting-to-device >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(---J-) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] PrinterStateChanged >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] PrinterStateChanged >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 58 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=514, response=0x5559a91065e0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 59 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=514, response=0x5559a9106560(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 60 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=514, response=0x5559a91065e0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 61 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=514, response=0x5559a9106560(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=514 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Job 221] Device protocol: 2 >D [02/Oct/2019:16:36:15 +0200] [Job 221] Calling FindDeviceById(cups-Brother_HL_2037) >D [02/Oct/2019:16:36:15 +0200] [Job 221] Failed to send: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files >D [02/Oct/2019:16:36:15 +0200] [Job 221] Failed to get find device cups-Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Job 221] \'CM Color Calibration\' Mode in SPOOLER-LESS: Off >D [02/Oct/2019:16:36:15 +0200] [Job 221] Getting input from file >D [02/Oct/2019:16:36:15 +0200] [Job 221] foomatic-rip version 1.20.3 running... >D [02/Oct/2019:16:36:15 +0200] [Job 221] Parsing PPD file ... >D [02/Oct/2019:16:36:15 +0200] [Job 221] Added option ColorSpace >D [02/Oct/2019:16:36:15 +0200] [Job 221] Added option PageSize >D [02/Oct/2019:16:36:15 +0200] [Job 221] Added option ImageableArea >D [02/Oct/2019:16:36:15 +0200] [Job 221] Added option PaperDimension >D [02/Oct/2019:16:36:15 +0200] [Job 221] Added option EconoMode >D [02/Oct/2019:16:36:15 +0200] [Job 221] Added option InputSlot >D [02/Oct/2019:16:36:15 +0200] [Job 221] Added option Resolution >D [02/Oct/2019:16:36:15 +0200] [Job 221] Added option MediaType >D [02/Oct/2019:16:36:15 +0200] [Job 221] Added option Font >D [02/Oct/2019:16:36:15 +0200] [Job 221] Parameter Summary >D [02/Oct/2019:16:36:15 +0200] [Job 221] ----------------- >D [02/Oct/2019:16:36:15 +0200] [Job 221] Spooler: cups >D [02/Oct/2019:16:36:15 +0200] [Job 221] Printer: Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Job 221] Shell: /bin/bash >D [02/Oct/2019:16:36:15 +0200] [Job 221] PPD file: /etc/cups/ppd/Brother_HL_2037.ppd >D [02/Oct/2019:16:36:15 +0200] [Job 221] ATTR file: >D [02/Oct/2019:16:36:15 +0200] [Job 221] Printer model: Brother HL-2030 Foomatic/hl1250 (recommended) >D [02/Oct/2019:16:36:15 +0200] [Job 221] Job title: Centro resi >D [02/Oct/2019:16:36:15 +0200] [Job 221] File(s) to be printed: >D [02/Oct/2019:16:36:15 +0200] [Job 221] <STDIN> >D [02/Oct/2019:16:36:15 +0200] [Job 221] Ghostscript extra search path (\'GS_LIB\'): /usr/share/cups/fonts >D [02/Oct/2019:16:36:15 +0200] [Job 221] Printing system options: >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'number-up=1\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Unknown option number-up=1. >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'noCollate\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Unknown boolean option \"noCollate\". >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'job-uuid=urn:uuid:5244bed1-ec6a-3f19-6493-7c26639cacde\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Unknown option job-uuid=urn:uuid:5244bed1-ec6a-3f19-6493-7c26639cacde. >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'job-originating-host-name=localhost\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Unknown option job-originating-host-name=localhost. >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'date-time-at-creation=\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Unknown option date-time-at-creation=. >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'date-time-at-processing=\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Unknown option date-time-at-processing=. >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'time-at-creation=1570026975\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Unknown option time-at-creation=1570026975. >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'time-at-processing=1570026975\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Unknown option time-at-processing=1570026975. >D [02/Oct/2019:16:36:15 +0200] [Job 221] CM Color Calibration Mode in CUPS: Off >D [02/Oct/2019:16:36:15 +0200] [Job 221] Options from the PPD file: >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'InputSlot=auto\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'MediaType=plain\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'EconoMode=off\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'Resolution=600x600dpi\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] Pondering option \'PageSize=A4\' >D [02/Oct/2019:16:36:15 +0200] [Job 221] ================================================ >D [02/Oct/2019:16:36:15 +0200] [Job 221] File: <STDIN> >D [02/Oct/2019:16:36:15 +0200] [Job 221] ================================================ >D [02/Oct/2019:16:36:15 +0200] [Job 221] Filetype: PDF >D [02/Oct/2019:16:36:15 +0200] [Job 221] PID 20271 (/usr/lib/cups/filter/pdftopdf) exited with no errors. >D [02/Oct/2019:16:36:15 +0200] [Job 221] Storing temporary files in /var/spool/cups/tmp >D [02/Oct/2019:16:36:15 +0200] [Job 221] Invio dei dati alla stampante. >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(---J-) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Job 221] Set job-printer-state-message to "Invio dei dati alla stampante.", current level=INFO >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] JobProgress >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] PrinterStateChanged >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 62 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 544 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=544, response=0x5559a90e5d10(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=544 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Jobs 63 >D [02/Oct/2019:16:36:15 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 1750 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1750, response=0x5559a90e5c90(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1750 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Jobs 64 >D [02/Oct/2019:16:36:15 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 1750 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1750, response=0x5559a9103920(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1750 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 65 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 544 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=544, response=0x5559a90e5c90(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=544 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Job 221] GPL Ghostscript 9.27: Unrecoverable error, exit code 1 >D [02/Oct/2019:16:36:15 +0200] [Job 221] Process is dying with \"Unable to determine number of pages, page count: -1 >D [02/Oct/2019:16:36:15 +0200] [Job 221] \", exit stat 3 >D [02/Oct/2019:16:36:15 +0200] [Job 221] Cleaning up... >D [02/Oct/2019:16:36:15 +0200] [Job 221] Sent 0 bytes... >D [02/Oct/2019:16:36:15 +0200] [Job 221] Waiting for read thread to exit... >D [02/Oct/2019:16:36:15 +0200] [Job 221] PID 20272 (/usr/lib/cups/filter/foomatic-rip) stopped with status 3. >D [02/Oct/2019:16:36:15 +0200] [Job 221] PID 20273 (/usr/lib/cups/backend/usb) exited with no errors. >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >E [02/Oct/2019:16:36:15 +0200] [Job 221] Job stopped due to filter errors; please consult the error_log file for details. >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(---J-) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] cupsdMarkDirty(----S) >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Job 221] The following messages were recorded from 16:36:15 to 16:36:15 >D [02/Oct/2019:16:36:15 +0200] [Job 221] Printer found with device ID: MFG:Brother;CMD:PJL,HBP;MDL:HL-2030 series;CLS:PRINTER; Device URI: usb://Brother/HL-2030%20series?serial=H8J161792 >D [02/Oct/2019:16:36:15 +0200] [Job 221] End of messages >D [02/Oct/2019:16:36:15 +0200] [Job 221] printer-state=3(idle) >D [02/Oct/2019:16:36:15 +0200] [Job 221] printer-state-message="Filter failed" >D [02/Oct/2019:16:36:15 +0200] [Job 221] printer-state-reasons=none >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] JobState >D [02/Oct/2019:16:36:15 +0200] [Notifier] state=3 >D [02/Oct/2019:16:36:15 +0200] [Notifier] PrinterStateChanged >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 66 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 527 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=527, response=0x5559a90f4100(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=527 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Jobs 67 >D [02/Oct/2019:16:36:15 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 1752 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1752, response=0x5559a90e5d10(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1752 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Jobs 68 >D [02/Oct/2019:16:36:15 +0200] Get-Jobs ipp://user@localhost:631/printers/ >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://user@localhost:631/printers/) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 1752 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1752, response=0x5559a90f4100(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=1752 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] POST / HTTP/1.1 >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [02/Oct/2019:16:36:15 +0200] [Client 1] Read: status=200, state=6 >D [02/Oct/2019:16:36:15 +0200] [Client 1] No authentication data provided. >D [02/Oct/2019:16:36:15 +0200] [Client 1] 2.0 Get-Printer-Attributes 69 >D [02/Oct/2019:16:36:15 +0200] Get-Printer-Attributes ipp://user@localhost:631/printers/Brother_HL_2037 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Returning IPP successful-ok for Get-Printer-Attributes (ipp://user@localhost:631/printers/Brother_HL_2037) from localhost >D [02/Oct/2019:16:36:15 +0200] [Client 1] Content-Length: 527 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] con->http=0x5559a90fb670 >D [02/Oct/2019:16:36:15 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=527, response=0x5559a90e5d10(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [02/Oct/2019:16:36:15 +0200] [Client 1] bytes=0, http_state=0, data_remaining=527 >D [02/Oct/2019:16:36:15 +0200] [Client 1] Flushing write buffer. >D [02/Oct/2019:16:36:15 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [02/Oct/2019:16:36:15 +0200] [Client 1] Waiting for request. >D [02/Oct/2019:16:36:15 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >I [02/Oct/2019:16:36:16 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:16 +0200] [Job 221] Unloading... >I [02/Oct/2019:16:36:38 +0200] Saving printers.conf... >I [02/Oct/2019:16:36:38 +0200] Saving job.cache... >I [02/Oct/2019:16:36:38 +0200] Saving subscriptions.conf... >D [02/Oct/2019:16:36:38 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files" >I [02/Oct/2019:16:36:38 +0200] Expiring subscriptions... >D [02/Oct/2019:16:36:38 +0200] [Job 211] Unloading... >D [02/Oct/2019:16:36:38 +0200] [Job 212] Unloading... >D [02/Oct/2019:16:36:38 +0200] [Job 213] Unloading... >D [02/Oct/2019:16:36:38 +0200] Report: clients=1 >D [02/Oct/2019:16:36:38 +0200] Report: jobs=211 >D [02/Oct/2019:16:36:38 +0200] Report: jobs-active=4 >D [02/Oct/2019:16:36:38 +0200] Report: printers=2 >D [02/Oct/2019:16:36:38 +0200] Report: stringpool-string-count=5353 >D [02/Oct/2019:16:36:38 +0200] Report: stringpool-alloc-bytes=13320 >D [02/Oct/2019:16:36:38 +0200] Report: stringpool-total-bytes=98688
<b>You cannot view the attachment while viewing its details because your browser does not support IFRAMEs. <a href="attachment.cgi?id=820270">View the attachment on a separate page</a>.</b>
Actions:
View
Attachments on
bug 1152720
: 820270 |
820501
|
820533