myuseraccount@myuseraccount-System-Product-Name:~$ ifconfig
enp3s0: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1500
inet 192.168.1.66 netmask 255.255.255.0 broadcast 192.168.1.255
inet6 2600:1700:5270:9c00:180c:2f00:4a3d:95e0 prefixlen 64 scopeid
0x0<global>
inet6 2600:1700:5270:9c00:87a4:1cae:bf0:552f prefixlen 64 scopeid
0x0<global>
inet6 fe80::776:f004:4e65:db1d prefixlen 64 scopeid 0x20<link>
ether 10:bf:48:b6:dd:3f txqueuelen 1000 (Ethernet)
RX packets 49910 bytes 10437067 (10.4 MB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 11245 bytes 1359731 (1.3 MB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
lo: flags=73<UP,LOOPBACK,RUNNING> mtu 65536
inet 127.0.0.1 netmask 255.0.0.0
inet6 ::1 prefixlen 128 scopeid 0x10<host>
loop txqueuelen 1000 (Local Loopback)
RX packets 912 bytes 87131 (87.1 KB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 912 bytes 87131 (87.1 KB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
myuseraccount@myuseraccount-System-Product-Name:~$ route
Kernel IP routing table
Destination Gateway Genmask Flags Metric Ref Use Iface
default homeportal 0.0.0.0 UG 100 0 0 enp3s0
link-local 0.0.0.0 255.255.0.0 U 1000 0 0 enp3s0
192.168.1.0 0.0.0.0 255.255.255.0 U 100 0 0 enp3s0
myuseraccount@myuseraccount-System-Product-Name:~$
Unknown Withheld 1k Unknown canceled at
Wed 17 Jan 2018 04:43:41 PM CST
"src = bidiCommon.c, line = 1200, err = 0¥nDEBUG2: prtMarkerSuppliesLevel.1.1 =
100"
Canon_MF8300C_Series-77 Unknown Withheld 1k Unknown
canceled at
Wed 17 Jan 2018 04:46:03 PM CST
Canon_MF8300C_Series-78 Unknown Withheld 1k 1
completed at
Wed 17 Jan 2018 05:16:46 PM CST
Canon_MF8300C_Series-79 Unknown Withheld 1k 1
completed at
Wed 17 Jan 2018 05:16:47 PM CST
Canon_MF8300C_Series-80 Unknown Withheld 1k 1
completed at
Wed 17 Jan 2018 05:20:46 PM CST
Canon_MF8300C_Series-81 Unknown Withheld 1k 1
completed at
Wed 17 Jan 2018 05:22:12 PM CST
Canon_MF8300C_Series-82 Unknown Withheld 1k 1
completed at
Wed 17 Jan 2018 05:23:54 PM CST
Canon_MF8300C_Series-83 Unknown Withheld 1k 1
completed at
Wed 17 Jan 2018 05:26:05 PM CST
Canon_MF8300C_Series-84 Unknown Withheld 1k 1
completed at
Wed 17 Jan 2018 05:28:14 PM CST
I have installed both drivers from canon 34-2 and 340 and still will not
print.
E [17/Jan/2018:00:10:34 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:00:10:34 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:00:10:34 -0600] Unknown: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:21:56 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:21:56 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:21:56 -0600] Unknown: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:42:40 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:42:40 -0600] [Job 69] Unable to start filter "pstoufr2cpca" -
Success.
E [17/Jan/2018:04:42:40 -0600] [Job 69] Stopping job because the scheduler
could not execute a filter.
E [17/Jan/2018:04:43:02 -0600] [cups-deviced] PID 3396 (gutenprint52+usb)
stopped with status 1!
W [17/Jan/2018:04:45:49 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:04:45:49 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
E [17/Jan/2018:04:45:49 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:47:15 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:47:15 -0600] [Job 72] Unable to start filter "pstoufr2cpca" -
Success.
E [17/Jan/2018:04:47:15 -0600] [Job 72] Stopping job because the scheduler
could not execute a filter.
E [17/Jan/2018:16:32:52 -0600] [cups-deviced] PID 8299 (gutenprint52+usb)
stopped with status 1!
W [17/Jan/2018:16:34:11 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:34:11 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
E [17/Jan/2018:16:34:21 -0600] [Job 73] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG2: prtMarkerSuppliesLevel.1.1 = 100
W [17/Jan/2018:16:35:03 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:35:03 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
E [17/Jan/2018:16:35:09 -0600] [Job 73] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG2: prtMarkerSuppliesLevel.1.1 = 100
E [17/Jan/2018:16:35:17 -0600] [Job 74] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG: Resolved as \"socket://Canon0f2ec4.local:9100/\"...
W [17/Jan/2018:16:35:52 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:35:52 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
E [17/Jan/2018:16:35:56 -0600] [Job 74] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG: Resolved as \"socket://Canon0f2ec4.local:9100/\"...
E [17/Jan/2018:16:36:06 -0600] [Job 75] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG: Resolved as \"socket://Canon0f2ec4.local:9100/\"...
E [17/Jan/2018:16:42:58 -0600] [Job 76] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG2: prtMarkerSuppliesLevel.1.1 = 100
E [17/Jan/2018:16:43:44 -0600] [cups-deviced] PID 8556 (gutenprint52+usb)
stopped with status 1!
W [17/Jan/2018:16:44:33 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:44:33 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:16:45:53 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:45:53 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:16:38 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:16:38 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:20:40 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:20:40 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:21:59 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:21:59 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:22:08 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:22:08 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:23:49 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:23:49 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:25:59 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:28:06 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
E [17/Jan/2018:21:51:16 -0600] [cups-deviced] PID 2897 (gutenprint52+usb)
stopped with status 1!
E [17/Jan/2018:22:17:21 -0600] Scheduler shutting down due to program error.
I [17/Jan/2018:22:17:37 -0600] Listening to 0.0.0.0:631 (IPv4)
I [17/Jan/2018:22:17:37 -0600] Listening to [v1.::]:631 (IPv6)
I [17/Jan/2018:22:17:37 -0600] Listening to /run/cups/cups.sock (Domain)
I [17/Jan/2018:22:17:37 -0600] Remote access is enabled.
D [17/Jan/2018:22:17:37 -0600] Added auto ServerAlias
sstehno-System-Product-Name
I [17/Jan/2018:22:17:37 -0600] Loaded configuration file "/etc/cups/cupsd.conf"
D [17/Jan/2018:22:17:37 -0600] Using keychain "/etc/cups/ssl" for server name
"sstehno-System-Product-Name".
I [17/Jan/2018:22:17:37 -0600] Using default TempDir of /var/spool/cups/tmp...
I [17/Jan/2018:22:17:37 -0600] Configured for up to 100 clients.
I [17/Jan/2018:22:17:37 -0600] Allowing up to 100 client connections per host.
I [17/Jan/2018:22:17:37 -0600] Using policy "default" as the default.
I [17/Jan/2018:22:17:37 -0600] Full reload is required.
I [17/Jan/2018:22:17:37 -0600] Loaded MIME database from "/usr/share/cups/mime"
and "/etc/cups": 76 types, 116 filters...
D [17/Jan/2018:22:17:37 -0600] Loading printer Canon_MF8300C_Series...
:
E [16/Jan/2018:00:06:30 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [16/Jan/2018:00:06:30 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [16/Jan/2018:00:06:30 -0600] Unknown: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [16/Jan/2018:16:02:09 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [16/Jan/2018:16:02:09 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [16/Jan/2018:16:02:09 -0600] Unknown: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [16/Jan/2018:17:01:27 -0600] [cups-deviced] PID 3121 (gutenprint52+usb)
stopped with status 1!
E [16/Jan/2018:17:06:38 -0600] [cups-deviced] PID 3873 (gutenprint52+usb)
stopped with status 1!
E [17/Jan/2018:00:10:34 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:00:10:34 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:00:10:34 -0600] Unknown: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:21:56 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:21:56 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:21:56 -0600] Unknown: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:42:40 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:42:40 -0600] [Job 69] Unable to start filter "pstoufr2cpca" -
Success.
E [17/Jan/2018:04:42:40 -0600] [Job 69] Stopping job because the scheduler
could not execute a filter.
E [17/Jan/2018:04:43:02 -0600] [cups-deviced] PID 3396 (gutenprint52+usb)
stopped with status 1!
W [17/Jan/2018:04:45:49 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:04:45:49 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
E [17/Jan/2018:04:45:49 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:47:15 -0600] Canon_MF8300C_Series: File
\"/usr/lib/cups/filter/pstoufr2cpca\" not available: No such file or directory
E [17/Jan/2018:04:47:15 -0600] [Job 72] Unable to start filter "pstoufr2cpca" -
Success.
E [17/Jan/2018:04:47:15 -0600] [Job 72] Stopping job because the scheduler
could not execute a filter.
E [17/Jan/2018:16:32:52 -0600] [cups-deviced] PID 8299 (gutenprint52+usb)
stopped with status 1!
W [17/Jan/2018:16:34:11 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:34:11 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
E [17/Jan/2018:16:34:21 -0600] [Job 73] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG2: prtMarkerSuppliesLevel.1.1 = 100
W [17/Jan/2018:16:35:03 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:35:03 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
E [17/Jan/2018:16:35:09 -0600] [Job 73] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG2: prtMarkerSuppliesLevel.1.1 = 100
E [17/Jan/2018:16:35:17 -0600] [Job 74] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG: Resolved as \"socket://Canon0f2ec4.local:9100/\"...
W [17/Jan/2018:16:35:52 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:35:52 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
E [17/Jan/2018:16:35:56 -0600] [Job 74] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG: Resolved as \"socket://Canon0f2ec4.local:9100/\"...
E [17/Jan/2018:16:36:06 -0600] [Job 75] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG: Resolved as \"socket://Canon0f2ec4.local:9100/\"...
E [17/Jan/2018:16:42:58 -0600] [Job 76] src = bidiCommon.c, line = 1200, err =
0¥nDEBUG2: prtMarkerSuppliesLevel.1.1 = 100
E [17/Jan/2018:16:43:44 -0600] [cups-deviced] PID 8556 (gutenprint52+usb)
stopped with status 1!
W [17/Jan/2018:16:44:33 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:44:33 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:16:45:53 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:16:45:53 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:16:38 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:16:38 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:20:40 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:20:40 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:21:59 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:21:59 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:22:08 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:22:08 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:23:49 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:23:49 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-RGB..\' already exists
W [17/Jan/2018:17:25:59 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
W [17/Jan/2018:17:28:06 -0600] CreateProfile failed:
org.freedesktop.ColorManager.AlreadyExists:profile id
\'Canon_MF8300C_Series-Gray..\' already exists
E [17/Jan/2018:21:51:16 -0600] [cups-deviced] PID 2897 (gutenprint52+usb)
stopped with status 1!
E [17/Jan/2018:22:17:21 -0600] Scheduler shutting down due to program error.
I [17/Jan/2018:22:17:37 -0600] Listening to 0.0.0.0:631 (IPv4)
I [17/Jan/2018:22:17:37 -0600] Listening to [v1.::]:631 (IPv6)
I [17/Jan/2018:22:17:37 -0600] Listening to /run/cups/cups.sock (Domain)
I [17/Jan/2018:22:17:37 -0600] Remote access is enabled.
D [17/Jan/2018:22:17:37 -0600] Added auto ServerAlias
sstehno-System-Product-Name
I [17/Jan/2018:22:17:37 -0600] Loaded configuration file "/etc/cups/cupsd.conf"
D [17/Jan/2018:22:17:37 -0600] Using keychain "/etc/cups/ssl" for server name
"sstehno-System-Product-Name".
I [17/Jan/2018:22:17:37 -0600] Using default TempDir of /var/spool/cups/tmp...
I [17/Jan/2018:22:17:37 -0600] Configured for up to 100 clients.
I [17/Jan/2018:22:17:37 -0600] Allowing up to 100 client connections per host.
I [17/Jan/2018:22:17:37 -0600] Using policy "default" as the default.
I [17/Jan/2018:22:17:37 -0600] Full reload is required.
I [17/Jan/2018:22:17:37 -0600] Loaded MIME database from "/usr/share/cups/mime"
and "/etc/cups": 76 types, 116 filters...
D [17/Jan/2018:22:17:37 -0600] Loading printer Canon_MF8300C_Series...
D [17/Jan/2018:22:17:37 -0600] load_ppd: Loading
/var/cache/cups/Canon_MF8300C_Series.data...
D [17/Jan/2018:22:17:37 -0600]
cupsdRegisterPrinter(p=0x55cb2fe545d0(Canon_MF8300C_Series))
D [17/Jan/2018:22:17:37 -0600] load_ppd: Loading
/var/cache/cups/Canon_MF8300C_Series.data...
D [17/Jan/2018:22:17:37 -0600]
cupsdRegisterPrinter(p=0x55cb2fe545d0(Canon_MF8300C_Series))
D [17/Jan/2018:22:17:37 -0600] Loading printer PDF...
D [17/Jan/2018:22:17:37 -0600] load_ppd: Loading /var/cache/cups/PDF.data...
D [17/Jan/2018:22:17:37 -0600] cupsdRegisterPrinter(p=0x55cb2fe895e0(PDF))
I [17/Jan/2018:22:17:37 -0600] Loading job cache file
"/var/cache/cups/job.cache"...
D [17/Jan/2018:22:17:37 -0600] [Job 50] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 70] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 71] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 76] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 77] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 78] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 79] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 80] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 81] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 82] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 83] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 84] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] cupsdAddSubscription(mask=0, dest=(nil)(),
job=(nil)(0), uri="(null)")
D [17/Jan/2018:22:17:37 -0600] cupsdAddSubscription(mask=0, dest=(nil)(),
job=(nil)(0), uri="(null)")
D [17/Jan/2018:22:17:37 -0600] cupsdAddSubscription(mask=0, dest=(nil)(),
job=(nil)(0), uri="(null)")
D [17/Jan/2018:22:17:37 -0600] cupsdAddSubscription(mask=0, dest=(nil)(),
job=(nil)(0), uri="(null)")
I [17/Jan/2018:22:17:37 -0600] Full reload complete.
D [17/Jan/2018:22:17:37 -0600] cupsdCleanFiles(path="/var/spool/cups/tmp",
pattern="(null)")
I [17/Jan/2018:22:17:37 -0600] Cleaning out old files in "/var/spool/cups/tmp".
D [17/Jan/2018:22:17:37 -0600]
cupsdCleanFiles(path="/var/spool/cups/tmp/.hplip", pattern="(null)")
I [17/Jan/2018:22:17:37 -0600] Cleaning out old files in
"/var/spool/cups/tmp/.hplip".
D [17/Jan/2018:22:17:37 -0600] cupsdCleanFiles(path="/var/cache/cups",
pattern="*.ipp")
I [17/Jan/2018:22:17:37 -0600] Cleaning out old files in "/var/cache/cups".
D [17/Jan/2018:22:17:37 -0600] service_checkin: pid=4509
D [17/Jan/2018:22:17:37 -0600] service_checkin: 1 listeners.
D [17/Jan/2018:22:17:37 -0600] service_add_listener: Listener #1 at fd 3,
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] service_add_listener: Matched existing listener
#1 to /run/cups/cups.sock.
D [17/Jan/2018:22:17:37 -0600] Creating keep-alive file
"/var/cache/cups/org.cups.cupsd".
D [17/Jan/2018:22:17:37 -0600] Calling FindDeviceById(cups-Canon_MF8300C_Series)
D [17/Jan/2018:22:17:37 -0600] FindDeviceById failed:
org.freedesktop.ColorManager.NotFound:device id \'cups-Canon_MF8300C_Series\'
does not exist
D [17/Jan/2018:22:17:37 -0600] Using profile ID "Canon_MF8300C_Series-Gray..".
D [17/Jan/2018:22:17:37 -0600] Calling
CreateProfile(Canon_MF8300C_Series-Gray..,temp)
D [17/Jan/2018:22:17:37 -0600] Created profile
"/org/freedesktop/ColorManager/profiles/Canon_MF8300C_Series_Gray__".
I [17/Jan/2018:22:17:37 -0600] Registering ICC color profiles for
"Canon_MF8300C_Series".
D [17/Jan/2018:22:17:37 -0600] Calling
CreateDevice(cups-Canon_MF8300C_Series,temp)
D [17/Jan/2018:22:17:37 -0600] Created device
"/org/freedesktop/ColorManager/devices/cups_Canon_MF8300C_Series".
D [17/Jan/2018:22:17:37 -0600] Calling
/org/freedesktop/ColorManager/devices/cups_Canon_MF8300C_Series:AddProfile(/org/freedesktop/ColorManager/profiles/Canon_MF8300C_Series_Gray__)
[soft]
D [17/Jan/2018:22:17:37 -0600] Calling FindDeviceById(cups-PDF)
D [17/Jan/2018:22:17:37 -0600] FindDeviceById failed:
org.freedesktop.ColorManager.NotFound:device id \'cups-PDF\' does not exist
D [17/Jan/2018:22:17:37 -0600] Using profile ID "PDF-Gray..".
D [17/Jan/2018:22:17:37 -0600] Calling CreateProfile(PDF-Gray..,temp)
D [17/Jan/2018:22:17:37 -0600] Created profile
"/org/freedesktop/ColorManager/profiles/PDF_Gray__".
D [17/Jan/2018:22:17:37 -0600] Using profile ID "PDF-RGB..".
D [17/Jan/2018:22:17:37 -0600] Calling CreateProfile(PDF-RGB..,temp)
D [17/Jan/2018:22:17:37 -0600] Created profile
"/org/freedesktop/ColorManager/profiles/PDF_RGB__".
I [17/Jan/2018:22:17:37 -0600] Registering ICC color profiles for "PDF".
D [17/Jan/2018:22:17:37 -0600] Calling CreateDevice(cups-PDF,temp)
D [17/Jan/2018:22:17:37 -0600] Created device
"/org/freedesktop/ColorManager/devices/cups_PDF".
D [17/Jan/2018:22:17:37 -0600] Calling
/org/freedesktop/ColorManager/devices/cups_PDF:AddProfile(/org/freedesktop/ColorManager/profiles/PDF_Gray__)
[soft]
D [17/Jan/2018:22:17:37 -0600] Calling
/org/freedesktop/ColorManager/devices/cups_PDF:AddProfile(/org/freedesktop/ColorManager/profiles/PDF_RGB__)
[soft]
I [17/Jan/2018:22:17:37 -0600] Listening to 0.0.0.0:631 on fd 7...
I [17/Jan/2018:22:17:37 -0600] Listening to [v1.::]:631 on fd 8...
I [17/Jan/2018:22:17:37 -0600] Listening to /run/cups/cups.sock on fd 3...
I [17/Jan/2018:22:17:37 -0600] Resuming new connection processing...
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Not busy", busy="Not
busy"
D [17/Jan/2018:22:17:37 -0600] cupsdAddCert: Adding certificate for PID 0
D [17/Jan/2018:22:17:37 -0600] Notifier dbus started - PID = 4511
D [17/Jan/2018:22:17:37 -0600] Notifier dbus started - PID = 4512
D [17/Jan/2018:22:17:37 -0600] Notifier dbus started - PID = 4513
D [17/Jan/2018:22:17:37 -0600] cupsdMarkDirty(----S)
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Not busy"
D [17/Jan/2018:22:17:37 -0600] [Client 1] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 1] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 1] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] Report: clients=1
D [17/Jan/2018:22:17:37 -0600] Report: jobs=12
D [17/Jan/2018:22:17:37 -0600] Report: jobs-active=0
D [17/Jan/2018:22:17:37 -0600] Report: printers=2
D [17/Jan/2018:22:17:37 -0600] Report: stringpool-string-count=2573
D [17/Jan/2018:22:17:37 -0600] Report: stringpool-alloc-bytes=13272
D [17/Jan/2018:22:17:37 -0600] Report: stringpool-total-bytes=49584
D [17/Jan/2018:22:17:37 -0600] [Client 1] GET /admin/conf/cupsd.conf HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 1] Read: status=200, state=3
D [17/Jan/2018:22:17:37 -0600] [Client 1] No authentication data provided.
D [17/Jan/2018:22:17:37 -0600] cupsdIsAuthorized: username=""
D [17/Jan/2018:22:17:37 -0600] [Client 1] cupsdSendHeader: code=401,
type="text/html", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 1] WWW-Authenticate: Basic
realm=\"CUPS\", trc=\"y\"
D [17/Jan/2018:22:17:37 -0600] [Client 1] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 2] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 2] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 2] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 3] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 3] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 3] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 2] HTTP_STATE_WAITING Closing for error
32 (Broken pipe)
D [17/Jan/2018:22:17:37 -0600] [Client 2] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 4] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 4] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 4] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 3] HTTP_STATE_WAITING Closing for error
32 (Broken pipe)
D [17/Jan/2018:22:17:37 -0600] [Client 3] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 4] GET /admin/conf/cupsd.conf HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 4] Read: status=200, state=3
D [17/Jan/2018:22:17:37 -0600] [Client 4] Authorized as sstehno using PeerCred.
D [17/Jan/2018:22:17:37 -0600] cupsdIsAuthorized: username="sstehno"
D [17/Jan/2018:22:17:37 -0600] [Client 4] Processing GET /admin/conf/cupsd.conf
D [17/Jan/2018:22:17:37 -0600] [Client 4] filename="/etc/cups/cupsd.conf",
type=text/plain
D [17/Jan/2018:22:17:37 -0600] [Client 4] cupsdSendHeader: code=200,
type="text/plain", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 4] Sending file.
D [17/Jan/2018:22:17:37 -0600] [Client 4] con->http=0x55cb2fedddc0
D [17/Jan/2018:22:17:37 -0600] [Client 4] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=4639, response=(nil)(), pipe_pid=0, file=18
D [17/Jan/2018:22:17:37 -0600] [Client 4] con->http=0x55cb2fedddc0
D [17/Jan/2018:22:17:37 -0600] [Client 4] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=4639, response=(nil)(), pipe_pid=0, file=18
D [17/Jan/2018:22:17:37 -0600] [Client 4] con->http=0x55cb2fedddc0
D [17/Jan/2018:22:17:37 -0600] [Client 4] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=4639, response=(nil)(), pipe_pid=0, file=18
D [17/Jan/2018:22:17:37 -0600] [Client 4] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 4] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 4] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 4] GET /admin/conf/cupsd.conf HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 4] Read: status=200, state=3
D [17/Jan/2018:22:17:37 -0600] [Client 4] Authorized as sstehno using PeerCred.
D [17/Jan/2018:22:17:37 -0600] cupsdIsAuthorized: username="sstehno"
D [17/Jan/2018:22:17:37 -0600] [Client 4] Processing GET /admin/conf/cupsd.conf
D [17/Jan/2018:22:17:37 -0600] [Client 4] filename="/etc/cups/cupsd.conf",
type=text/plain
D [17/Jan/2018:22:17:37 -0600] [Client 4] cupsdSendHeader: code=200,
type="text/plain", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 4] Sending file.
D [17/Jan/2018:22:17:37 -0600] [Client 4] con->http=0x55cb2fedddc0
D [17/Jan/2018:22:17:37 -0600] [Client 4] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=4639, response=(nil)(), pipe_pid=0, file=18
D [17/Jan/2018:22:17:37 -0600] [Client 4] con->http=0x55cb2fedddc0
D [17/Jan/2018:22:17:37 -0600] [Client 4] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=4639, response=(nil)(), pipe_pid=0, file=18
D [17/Jan/2018:22:17:37 -0600] [Client 4] con->http=0x55cb2fedddc0
D [17/Jan/2018:22:17:37 -0600] [Client 4] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=4639, response=(nil)(), pipe_pid=0, file=18
D [17/Jan/2018:22:17:37 -0600] [Client 4] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 4] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 4] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 4] PUT /admin/conf/cupsd.conf HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 4] Read: status=200, state=9
D [17/Jan/2018:22:17:37 -0600] [Client 4] Authorized as sstehno using PeerCred.
D [17/Jan/2018:22:17:37 -0600] cupsdIsAuthorized: username="sstehno"
D [17/Jan/2018:22:17:37 -0600] [Client 4] Read: status=100, state=9
I [17/Jan/2018:22:17:37 -0600] [Client 4] Installing config file
"/etc/cups/cupsd.conf"...
D [17/Jan/2018:22:17:37 -0600] [Client 4] cupsdSendHeader: code=201,
type="(null)", auth_type=0
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 4] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
E [17/Jan/2018:22:17:37 -0600] Scheduler shutting down due to program error.
D [17/Jan/2018:22:17:37 -0600] cupsdMarkDirty(----S)
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
I [17/Jan/2018:22:17:37 -0600] Saving subscriptions.conf...
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Not busy",
busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] Creating keep-alive file
"/var/cache/cups/org.cups.cupsd".
I [17/Jan/2018:22:17:37 -0600] Saving job.cache...
D [17/Jan/2018:22:17:37 -0600] cupsdStopSelect()
I [17/Jan/2018:22:17:37 -0600] Listening to 0.0.0.0:631 (IPv4)
I [17/Jan/2018:22:17:37 -0600] Listening to [v1.::]:631 (IPv6)
I [17/Jan/2018:22:17:37 -0600] Listening to /run/cups/cups.sock (Domain)
I [17/Jan/2018:22:17:37 -0600] Remote access is enabled.
D [17/Jan/2018:22:17:37 -0600] Added auto ServerAlias
sstehno-System-Product-Name
I [17/Jan/2018:22:17:37 -0600] Loaded configuration file "/etc/cups/cupsd.conf"
D [17/Jan/2018:22:17:37 -0600] Using keychain "/etc/cups/ssl" for server name
"sstehno-System-Product-Name".
I [17/Jan/2018:22:17:37 -0600] Using default TempDir of /var/spool/cups/tmp...
I [17/Jan/2018:22:17:37 -0600] Configured for up to 100 clients.
I [17/Jan/2018:22:17:37 -0600] Allowing up to 100 client connections per host.
I [17/Jan/2018:22:17:37 -0600] Using policy "default" as the default.
I [17/Jan/2018:22:17:37 -0600] Full reload is required.
I [17/Jan/2018:22:17:37 -0600] Loaded MIME database from "/usr/share/cups/mime"
and "/etc/cups": 76 types, 116 filters...
D [17/Jan/2018:22:17:37 -0600] Loading printer Canon_MF8300C_Series...
D [17/Jan/2018:22:17:37 -0600] load_ppd: Loading
/var/cache/cups/Canon_MF8300C_Series.data...
D [17/Jan/2018:22:17:37 -0600]
cupsdRegisterPrinter(p=0x557b59c9e5d0(Canon_MF8300C_Series))
D [17/Jan/2018:22:17:37 -0600] load_ppd: Loading
/var/cache/cups/Canon_MF8300C_Series.data...
D [17/Jan/2018:22:17:37 -0600]
cupsdRegisterPrinter(p=0x557b59c9e5d0(Canon_MF8300C_Series))
D [17/Jan/2018:22:17:37 -0600] Loading printer PDF...
D [17/Jan/2018:22:17:37 -0600] load_ppd: Loading /var/cache/cups/PDF.data...
D [17/Jan/2018:22:17:37 -0600] cupsdRegisterPrinter(p=0x557b59cd35e0(PDF))
I [17/Jan/2018:22:17:37 -0600] Loading job cache file
"/var/cache/cups/job.cache"...
D [17/Jan/2018:22:17:37 -0600] [Job 50] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 70] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 71] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 76] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 77] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 78] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 79] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 80] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 81] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 82] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 83] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] [Job 84] Loading from cache...
D [17/Jan/2018:22:17:37 -0600] cupsdAddSubscription(mask=0, dest=(nil)(),
job=(nil)(0), uri="(null)")
D [17/Jan/2018:22:17:37 -0600] cupsdAddSubscription(mask=0, dest=(nil)(),
job=(nil)(0), uri="(null)")
D [17/Jan/2018:22:17:37 -0600] cupsdAddSubscription(mask=0, dest=(nil)(),
job=(nil)(0), uri="(null)")
D [17/Jan/2018:22:17:37 -0600] cupsdAddSubscription(mask=0, dest=(nil)(),
job=(nil)(0), uri="(null)")
I [17/Jan/2018:22:17:37 -0600] Full reload complete.
D [17/Jan/2018:22:17:37 -0600] cupsdCleanFiles(path="/var/spool/cups/tmp",
pattern="(null)")
I [17/Jan/2018:22:17:37 -0600] Cleaning out old files in "/var/spool/cups/tmp".
D [17/Jan/2018:22:17:37 -0600] cupsdCleanFiles(path="/var/cache/cups",
pattern="*.ipp")
I [17/Jan/2018:22:17:37 -0600] Cleaning out old files in "/var/cache/cups".
D [17/Jan/2018:22:17:37 -0600] service_checkin: pid=4514
D [17/Jan/2018:22:17:37 -0600] service_checkin: 1 listeners.
D [17/Jan/2018:22:17:37 -0600] service_add_listener: Listener #1 at fd 3,
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] service_add_listener: Matched existing listener
#1 to /run/cups/cups.sock.
D [17/Jan/2018:22:17:37 -0600] Creating keep-alive file
"/var/cache/cups/org.cups.cupsd".
D [17/Jan/2018:22:17:37 -0600] Calling FindDeviceById(cups-Canon_MF8300C_Series)
D [17/Jan/2018:22:17:37 -0600] FindDeviceById failed:
org.freedesktop.ColorManager.NotFound:device id \'cups-Canon_MF8300C_Series\'
does not exist
D [17/Jan/2018:22:17:37 -0600] Using profile ID "Canon_MF8300C_Series-Gray..".
D [17/Jan/2018:22:17:37 -0600] Calling
CreateProfile(Canon_MF8300C_Series-Gray..,temp)
D [17/Jan/2018:22:17:37 -0600] Created profile
"/org/freedesktop/ColorManager/profiles/Canon_MF8300C_Series_Gray__".
I [17/Jan/2018:22:17:37 -0600] Registering ICC color profiles for
"Canon_MF8300C_Series".
D [17/Jan/2018:22:17:37 -0600] Calling
CreateDevice(cups-Canon_MF8300C_Series,temp)
D [17/Jan/2018:22:17:37 -0600] Created device
"/org/freedesktop/ColorManager/devices/cups_Canon_MF8300C_Series".
D [17/Jan/2018:22:17:37 -0600] Calling
/org/freedesktop/ColorManager/devices/cups_Canon_MF8300C_Series:AddProfile(/org/freedesktop/ColorManager/profiles/Canon_MF8300C_Series_Gray__)
[soft]
D [17/Jan/2018:22:17:37 -0600] Calling FindDeviceById(cups-PDF)
D [17/Jan/2018:22:17:37 -0600] FindDeviceById failed:
org.freedesktop.ColorManager.NotFound:device id \'cups-PDF\' does not exist
D [17/Jan/2018:22:17:37 -0600] Using profile ID "PDF-Gray..".
D [17/Jan/2018:22:17:37 -0600] Calling CreateProfile(PDF-Gray..,temp)
D [17/Jan/2018:22:17:37 -0600] Created profile
"/org/freedesktop/ColorManager/profiles/PDF_Gray__".
D [17/Jan/2018:22:17:37 -0600] Using profile ID "PDF-RGB..".
D [17/Jan/2018:22:17:37 -0600] Calling CreateProfile(PDF-RGB..,temp)
D [17/Jan/2018:22:17:37 -0600] Created profile
"/org/freedesktop/ColorManager/profiles/PDF_RGB__".
I [17/Jan/2018:22:17:37 -0600] Registering ICC color profiles for "PDF".
D [17/Jan/2018:22:17:37 -0600] Calling CreateDevice(cups-PDF,temp)
D [17/Jan/2018:22:17:37 -0600] Created device
"/org/freedesktop/ColorManager/devices/cups_PDF".
D [17/Jan/2018:22:17:37 -0600] Calling
/org/freedesktop/ColorManager/devices/cups_PDF:AddProfile(/org/freedesktop/ColorManager/profiles/PDF_Gray__)
[soft]
D [17/Jan/2018:22:17:37 -0600] Calling
/org/freedesktop/ColorManager/devices/cups_PDF:AddProfile(/org/freedesktop/ColorManager/profiles/PDF_RGB__)
[soft]
I [17/Jan/2018:22:17:37 -0600] Listening to 0.0.0.0:631 on fd 7...
I [17/Jan/2018:22:17:37 -0600] Listening to [v1.::]:631 on fd 8...
I [17/Jan/2018:22:17:37 -0600] Listening to /run/cups/cups.sock on fd 3...
I [17/Jan/2018:22:17:37 -0600] Resuming new connection processing...
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Not busy", busy="Not
busy"
D [17/Jan/2018:22:17:37 -0600] cupsdAddCert: Adding certificate for PID 0
D [17/Jan/2018:22:17:37 -0600] Notifier dbus started - PID = 4515
D [17/Jan/2018:22:17:37 -0600] Notifier dbus started - PID = 4516
D [17/Jan/2018:22:17:37 -0600] Notifier dbus started - PID = 4517
D [17/Jan/2018:22:17:37 -0600] cupsdMarkDirty(----S)
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Not busy"
D [17/Jan/2018:22:17:37 -0600] [Client 1] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 1] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 1] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] Report: clients=1
D [17/Jan/2018:22:17:37 -0600] Report: jobs=12
D [17/Jan/2018:22:17:37 -0600] Report: jobs-active=0
D [17/Jan/2018:22:17:37 -0600] Report: printers=2
D [17/Jan/2018:22:17:37 -0600] Report: stringpool-string-count=2573
D [17/Jan/2018:22:17:37 -0600] Report: stringpool-alloc-bytes=13272
D [17/Jan/2018:22:17:37 -0600] Report: stringpool-total-bytes=49584
D [17/Jan/2018:22:17:37 -0600] [Client 2] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 2] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 2] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 1] POST / HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 1] Read: status=200, state=6
D [17/Jan/2018:22:17:37 -0600] [Client 1] No authentication data provided.
D [17/Jan/2018:22:17:37 -0600] [Client 1] 2.0 CUPS-Get-Printers 4
D [17/Jan/2018:22:17:37 -0600] CUPS-Get-Printers
D [17/Jan/2018:22:17:37 -0600] [Client 1] Returning IPP successful-ok for
CUPS-Get-Printers (no URI) from localhost
D [17/Jan/2018:22:17:37 -0600] [Client 1] Content-Length: 1090
D [17/Jan/2018:22:17:37 -0600] [Client 1] cupsdSendHeader: code=200,
type="application/ipp", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 1] con->http=0x557b59d27dc0
D [17/Jan/2018:22:17:37 -0600] [Client 1] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=1090, response=0x557b59d1d580(IPP_STATE_DATA), pipe_pid=0,
file=-1
D [17/Jan/2018:22:17:37 -0600] [Client 1] Writing IPP response,
ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [17/Jan/2018:22:17:37 -0600] [Client 1] bytes=0, http_state=0,
data_remaining=1090
D [17/Jan/2018:22:17:37 -0600] [Client 1] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 1] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 1] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 2] POST / HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 2] Read: status=200, state=6
D [17/Jan/2018:22:17:37 -0600] [Client 2] No authentication data provided.
D [17/Jan/2018:22:17:37 -0600] [Client 2] 2.0 Get-Jobs 4
D [17/Jan/2018:22:17:37 -0600] Get-Jobs ipp://sstehno@localhost:631/printers/
D [17/Jan/2018:22:17:37 -0600] [Client 2] Returning IPP successful-ok for
Get-Jobs (ipp://sstehno@localhost:631/printers/) from localhost
D [17/Jan/2018:22:17:37 -0600] [Client 2] Content-Length: 75
D [17/Jan/2018:22:17:37 -0600] [Client 2] cupsdSendHeader: code=200,
type="application/ipp", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 1] HTTP_STATE_WAITING Closing for error
32 (Broken pipe)
D [17/Jan/2018:22:17:37 -0600] [Client 1] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 2] con->http=0x557b59d35760
D [17/Jan/2018:22:17:37 -0600] [Client 2] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=75, response=0x557b59d1e9e0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [17/Jan/2018:22:17:37 -0600] [Client 2] Writing IPP response,
ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [17/Jan/2018:22:17:37 -0600] [Client 2] bytes=0, http_state=0,
data_remaining=75
D [17/Jan/2018:22:17:37 -0600] [Client 2] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 2] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 2] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 3] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 3] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 3] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 2] POST / HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 2] Read: status=200, state=6
D [17/Jan/2018:22:17:37 -0600] [Client 2] No authentication data provided.
D [17/Jan/2018:22:17:37 -0600] [Client 2] 2.0 Get-Jobs 5
D [17/Jan/2018:22:17:37 -0600] Get-Jobs ipp://sstehno@localhost:631/printers/
D [17/Jan/2018:22:17:37 -0600] [Client 2] Returning IPP successful-ok for
Get-Jobs (ipp://sstehno@localhost:631/printers/) from localhost
D [17/Jan/2018:22:17:37 -0600] [Client 2] Content-Length: 75
D [17/Jan/2018:22:17:37 -0600] [Client 2] cupsdSendHeader: code=200,
type="application/ipp", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 3] GET /admin/conf/cupsd.conf HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 3] Read: status=200, state=3
D [17/Jan/2018:22:17:37 -0600] [Client 3] No authentication data provided.
D [17/Jan/2018:22:17:37 -0600] cupsdIsAuthorized: username=""
D [17/Jan/2018:22:17:37 -0600] [Client 3] cupsdSendHeader: code=401,
type="text/html", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 3] WWW-Authenticate: Basic
realm=\"CUPS\", trc=\"y\"
D [17/Jan/2018:22:17:37 -0600] [Client 3] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 2] con->http=0x557b59d35760
D [17/Jan/2018:22:17:37 -0600] [Client 2] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=75, response=0x557b59d25410(IPP_STATE_DATA), pipe_pid=0, file=-1
D [17/Jan/2018:22:17:37 -0600] [Client 2] Writing IPP response,
ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [17/Jan/2018:22:17:37 -0600] [Client 2] bytes=0, http_state=0,
data_remaining=75
D [17/Jan/2018:22:17:37 -0600] [Client 2] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 2] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 2] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 4] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 4] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 4] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 5] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 5] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 5] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 4] HTTP_STATE_WAITING Closing for error
32 (Broken pipe)
D [17/Jan/2018:22:17:37 -0600] [Client 4] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 6] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 6] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 6] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 5] HTTP_STATE_WAITING Closing for error
32 (Broken pipe)
D [17/Jan/2018:22:17:37 -0600] [Client 5] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 6] GET /admin/conf/cupsd.conf HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 6] Read: status=200, state=3
D [17/Jan/2018:22:17:37 -0600] [Client 6] Authorized as sstehno using PeerCred.
D [17/Jan/2018:22:17:37 -0600] cupsdIsAuthorized: username="sstehno"
D [17/Jan/2018:22:17:37 -0600] [Client 6] Processing GET /admin/conf/cupsd.conf
D [17/Jan/2018:22:17:37 -0600] [Client 6] filename="/etc/cups/cupsd.conf",
type=text/plain
D [17/Jan/2018:22:17:37 -0600] [Client 6] cupsdSendHeader: code=200,
type="text/plain", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 6] Sending file.
D [17/Jan/2018:22:17:37 -0600] [Client 6] con->http=0x557b59d27dc0
D [17/Jan/2018:22:17:37 -0600] [Client 6] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=4662, response=(nil)(), pipe_pid=0, file=19
D [17/Jan/2018:22:17:37 -0600] [Client 6] con->http=0x557b59d27dc0
D [17/Jan/2018:22:17:37 -0600] [Client 6] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=4662, response=(nil)(), pipe_pid=0, file=19
D [17/Jan/2018:22:17:37 -0600] [Notifier] state=3
D [17/Jan/2018:22:17:37 -0600] [Client 6] con->http=0x557b59d27dc0
D [17/Jan/2018:22:17:37 -0600] [Client 6] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=4662, response=(nil)(), pipe_pid=0, file=19
D [17/Jan/2018:22:17:37 -0600] [Client 6] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 6] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 6] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 6] POST / HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 6] Read: status=200, state=6
D [17/Jan/2018:22:17:37 -0600] [Client 6] Authorized as sstehno using PeerCred.
D [17/Jan/2018:22:17:37 -0600] [Client 6] 2.0 CUPS-Get-Printers 5
D [17/Jan/2018:22:17:37 -0600] CUPS-Get-Printers
D [17/Jan/2018:22:17:37 -0600] [Client 6] Returning IPP successful-ok for
CUPS-Get-Printers (no URI) from localhost
D [17/Jan/2018:22:17:37 -0600] [Client 6] Content-Length: 1090
D [17/Jan/2018:22:17:37 -0600] [Client 6] cupsdSendHeader: code=200,
type="application/ipp", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 6] con->http=0x557b59d27dc0
D [17/Jan/2018:22:17:37 -0600] [Client 6] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=1090, response=0x557b59cdf5c0(IPP_STATE_DATA), pipe_pid=0,
file=-1
D [17/Jan/2018:22:17:37 -0600] [Client 6] Writing IPP response,
ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [17/Jan/2018:22:17:37 -0600] [Client 6] bytes=0, http_state=0,
data_remaining=1090
D [17/Jan/2018:22:17:37 -0600] [Client 6] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 6] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 6] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Notifier] state=3
D [17/Jan/2018:22:17:37 -0600] [Notifier] Connected to D-BUS
D [17/Jan/2018:22:17:37 -0600] [Notifier] ServerStarted
D [17/Jan/2018:22:17:37 -0600] [Client 2] POST / HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 2] Read: status=200, state=6
D [17/Jan/2018:22:17:37 -0600] [Client 2] No authentication data provided.
D [17/Jan/2018:22:17:37 -0600] [Client 2] 2.0 Get-Jobs 6
D [17/Jan/2018:22:17:37 -0600] Get-Jobs ipp://sstehno@localhost:631/printers/
D [17/Jan/2018:22:17:37 -0600] [Client 2] Returning IPP successful-ok for
Get-Jobs (ipp://sstehno@localhost:631/printers/) from localhost
D [17/Jan/2018:22:17:37 -0600] [Client 2] Content-Length: 75
D [17/Jan/2018:22:17:37 -0600] [Client 2] cupsdSendHeader: code=200,
type="application/ipp", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 2] con->http=0x557b59d35760
D [17/Jan/2018:22:17:37 -0600] [Client 2] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=75, response=0x557b59d23c50(IPP_STATE_DATA), pipe_pid=0, file=-1
D [17/Jan/2018:22:17:37 -0600] [Client 2] Writing IPP response,
ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [17/Jan/2018:22:17:37 -0600] [Client 2] bytes=0, http_state=0,
data_remaining=75
D [17/Jan/2018:22:17:37 -0600] [Client 2] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 2] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 2] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 2] POST / HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 2] Read: status=200, state=6
D [17/Jan/2018:22:17:37 -0600] [Client 2] No authentication data provided.
D [17/Jan/2018:22:17:37 -0600] [Client 2] 2.0 Get-Jobs 7
D [17/Jan/2018:22:17:37 -0600] Get-Jobs ipp://sstehno@localhost:631/printers/
D [17/Jan/2018:22:17:37 -0600] [Client 2] Returning IPP successful-ok for
Get-Jobs (ipp://sstehno@localhost:631/printers/) from localhost
D [17/Jan/2018:22:17:37 -0600] [Client 2] Content-Length: 75
D [17/Jan/2018:22:17:37 -0600] [Client 2] cupsdSendHeader: code=200,
type="application/ipp", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Notifier] state=3
D [17/Jan/2018:22:17:37 -0600] [Notifier] Connected to D-BUS
D [17/Jan/2018:22:17:37 -0600] [Client 2] con->http=0x557b59d35760
D [17/Jan/2018:22:17:37 -0600] [Client 2] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=75, response=0x557b59cdf5c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [17/Jan/2018:22:17:37 -0600] [Client 2] Writing IPP response,
ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [17/Jan/2018:22:17:37 -0600] [Client 2] bytes=0, http_state=0,
data_remaining=75
D [17/Jan/2018:22:17:37 -0600] [Client 2] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 2] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 2] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Notifier] Connected to D-BUS
D [17/Jan/2018:22:17:37 -0600] [Client 6] POST / HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 6] Read: status=200, state=6
D [17/Jan/2018:22:17:37 -0600] [Client 6] Authorized as sstehno using PeerCred.
D [17/Jan/2018:22:17:37 -0600] [Client 6] 2.0 CUPS-Get-Printers 6
D [17/Jan/2018:22:17:37 -0600] CUPS-Get-Printers
D [17/Jan/2018:22:17:37 -0600] [Client 6] Returning IPP successful-ok for
CUPS-Get-Printers (no URI) from localhost
D [17/Jan/2018:22:17:37 -0600] [Client 6] Content-Length: 1090
D [17/Jan/2018:22:17:37 -0600] [Client 6] cupsdSendHeader: code=200,
type="application/ipp", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 6] con->http=0x557b59d27dc0
D [17/Jan/2018:22:17:37 -0600] [Client 6] cupsdWriteClient error=0, used=0,
state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=1090, response=0x557b59d23c50(IPP_STATE_DATA), pipe_pid=0,
file=-1
D [17/Jan/2018:22:17:37 -0600] [Client 6] Writing IPP response,
ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [17/Jan/2018:22:17:37 -0600] [Client 6] bytes=0, http_state=0,
data_remaining=1090
D [17/Jan/2018:22:17:37 -0600] [Client 6] Flushing write buffer.
D [17/Jan/2018:22:17:37 -0600] [Client 6] New state is HTTP_STATE_WAITING
D [17/Jan/2018:22:17:37 -0600] [Client 6] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 6] HTTP_STATE_WAITING Closing for error
32 (Broken pipe)
D [17/Jan/2018:22:17:37 -0600] [Client 6] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 7] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 7] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 7] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 7] GET /admin/conf/cupsd.conf HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 7] Read: status=200, state=3
D [17/Jan/2018:22:17:37 -0600] [Client 7] No authentication data provided.
D [17/Jan/2018:22:17:37 -0600] cupsdIsAuthorized: username=""
D [17/Jan/2018:22:17:37 -0600] [Client 7] cupsdSendHeader: code=401,
type="text/html", auth_type=0
D [17/Jan/2018:22:17:37 -0600] [Client 7] WWW-Authenticate: Basic
realm=\"CUPS\", trc=\"y\"
D [17/Jan/2018:22:17:37 -0600] [Client 7] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 8] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 8] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 8] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 9] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 9] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 9] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 8] HTTP_STATE_WAITING Closing for error
32 (Broken pipe)
D [17/Jan/2018:22:17:37 -0600] [Client 8] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 10] Server address is
"/run/cups/cups.sock".
D [17/Jan/2018:22:17:37 -0600] [Client 10] Accepted from localhost (Domain)
D [17/Jan/2018:22:17:37 -0600] [Client 10] Waiting for request.
D [17/Jan/2018:22:17:37 -0600] [Client 9] HTTP_STATE_WAITING Closing for error
32 (Broken pipe)
D [17/Jan/2018:22:17:37 -0600] [Client 9] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 10] GET /admin/conf/cupsd.conf HTTP/1.1
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Active clients and
dirty files", busy="Dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 10] Read: status=200, state=3
D [17/Jan/2018:22:17:37 -0600] [Client 10] Authorized as sstehno using PeerCred.
D [17/Jan/2018:22:17:37 -0600] cupsdIsAuthorized: username="sstehno"
D [17/Jan/2018:22:17:37 -0600] [Client 10] Processing GET /admin/conf/cupsd.conf
D [17/Jan/2018:22:17:37 -0600] [Client 10] filename="/etc/cups/cupsd.conf",
type=text/plain
D [17/Jan/2018:22:17:37 -0600] [Client 10] cupsdSendHeader: code=304,
type="(null)", auth_type=0
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Active clients and dirty files"
D [17/Jan/2018:22:17:37 -0600] [Client 10] HTTP_STATE_WAITING Closing for error
32 (Broken pipe)
D [17/Jan/2018:22:17:37 -0600] [Client 10] Closing connection.
D [17/Jan/2018:22:17:37 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
I [17/Jan/2018:22:17:38 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:09 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:10 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:11 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:12 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:13 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:14 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:15 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:16 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:17 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:18 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:19 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:20 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:21 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:22 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:23 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:24 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:25 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:26 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:27 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:28 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:29 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:30 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:31 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:32 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:33 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:34 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:35 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:36 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:37 -0600] Expiring subscriptions...
D [17/Jan/2018:22:18:37 -0600] Report: clients=1
D [17/Jan/2018:22:18:37 -0600] Report: jobs=12
D [17/Jan/2018:22:18:37 -0600] Report: jobs-active=0
D [17/Jan/2018:22:18:37 -0600] Report: printers=2
D [17/Jan/2018:22:18:37 -0600] Report: stringpool-string-count=2575
D [17/Jan/2018:22:18:37 -0600] Report: stringpool-alloc-bytes=13336
D [17/Jan/2018:22:18:37 -0600] Report: stringpool-total-bytes=49632
I [17/Jan/2018:22:18:38 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:39 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:40 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:41 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:42 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:43 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:44 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:45 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:46 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:47 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:48 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:49 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:50 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:51 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:52 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:53 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:54 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:55 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:56 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:57 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:58 -0600] Expiring subscriptions...
I [17/Jan/2018:22:18:59 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:00 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:01 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:02 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:03 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:04 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:05 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:06 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:07 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:08 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:09 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:10 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:11 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:12 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:13 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:14 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:15 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:16 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:17 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:18 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:19 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:20 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:21 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:22 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:23 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:24 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:25 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:26 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:27 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:28 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:29 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:30 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:31 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:32 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:33 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:34 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:35 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:36 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:37 -0600] Expiring subscriptions...
D [17/Jan/2018:22:19:37 -0600] Report: clients=1
D [17/Jan/2018:22:19:37 -0600] Report: jobs=12
D [17/Jan/2018:22:19:37 -0600] Report: jobs-active=0
D [17/Jan/2018:22:19:37 -0600] Report: printers=2
D [17/Jan/2018:22:19:37 -0600] Report: stringpool-string-count=2575
D [17/Jan/2018:22:19:37 -0600] Report: stringpool-alloc-bytes=13336
D [17/Jan/2018:22:19:37 -0600] Report: stringpool-total-bytes=49632
I [17/Jan/2018:22:19:38 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:39 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:40 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:41 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:42 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:43 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:44 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:45 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:46 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:47 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:48 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:49 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:50 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:51 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:52 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:53 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:54 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:55 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:56 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:57 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:58 -0600] Expiring subscriptions...
I [17/Jan/2018:22:19:59 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:00 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:01 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:02 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:03 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:04 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:05 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:06 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:07 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:08 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:09 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:10 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:11 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:12 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:13 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:14 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:15 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:16 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:17 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:18 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:19 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:20 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:21 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:22 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:23 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:24 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:25 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:26 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:27 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:28 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:29 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:30 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:31 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:32 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:33 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:34 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:35 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:36 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:37 -0600] Expiring subscriptions...
D [17/Jan/2018:22:20:37 -0600] Report: clients=1
D [17/Jan/2018:22:20:37 -0600] Report: jobs=12
D [17/Jan/2018:22:20:37 -0600] Report: jobs-active=0
D [17/Jan/2018:22:20:37 -0600] Report: printers=2
D [17/Jan/2018:22:20:37 -0600] Report: stringpool-string-count=2575
D [17/Jan/2018:22:20:37 -0600] Report: stringpool-alloc-bytes=13336
D [17/Jan/2018:22:20:37 -0600] Report: stringpool-total-bytes=49632
I [17/Jan/2018:22:20:38 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:39 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:40 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:41 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:42 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:43 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:44 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:45 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:46 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:47 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:48 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:49 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:50 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:51 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:52 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:53 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:54 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:55 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:56 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:57 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:58 -0600] Expiring subscriptions...
I [17/Jan/2018:22:20:59 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:00 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:01 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:02 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:03 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:04 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:05 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:06 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:07 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:08 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:09 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:10 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:11 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:12 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:13 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:14 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:15 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:16 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:17 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:18 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:19 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:20 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:21 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:22 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:23 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:24 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:25 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:26 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:27 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:28 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:29 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:30 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:31 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:32 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:33 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:34 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:35 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:36 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:37 -0600] Expiring subscriptions...
D [17/Jan/2018:22:21:37 -0600] Report: clients=1
D [17/Jan/2018:22:21:37 -0600] Report: jobs=12
D [17/Jan/2018:22:21:37 -0600] Report: jobs-active=0
D [17/Jan/2018:22:21:37 -0600] Report: printers=2
D [17/Jan/2018:22:21:37 -0600] Report: stringpool-string-count=2575
D [17/Jan/2018:22:21:37 -0600] Report: stringpool-alloc-bytes=13336
D [17/Jan/2018:22:21:37 -0600] Report: stringpool-total-bytes=49632
I [17/Jan/2018:22:21:38 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:39 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:40 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:41 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:42 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:43 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:44 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:45 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:46 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:47 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:48 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:49 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:50 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:51 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:52 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:53 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:54 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:55 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:56 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:57 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:58 -0600] Expiring subscriptions...
I [17/Jan/2018:22:21:59 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:00 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:01 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:02 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:03 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:04 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:05 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:06 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:07 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:08 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:09 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:10 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:11 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:12 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:13 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:14 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:15 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:16 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:17 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:18 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:19 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:20 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:21 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:22 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:23 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:24 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:25 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:26 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:27 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:28 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:29 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:30 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:31 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:32 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:33 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:34 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:35 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:36 -0600] Expiring subscriptions...
I [17/Jan/2018:22:22:37 -0600] Expiring subscriptions...
D [17/Jan/2018:22:22:37 -0600] cupsdAddCert: Adding certificate for PID 0
D [17/Jan/2018:22:22:37 -0600] Report: clients=1
D [17/Jan/2018:22:22:37 -0600] Report: jobs=12
D [17/Jan/2018:22:22:37 -0600] Report: jobs-active=0
D [17/Jan/2018:22:22:37 -0600] Report: printers=2
D [17/Jan/2018:22:22:37 -0600] Report: stringpool-string-count=2575
D [17/Jan/2018:22:22:37 -0600] Report: stringpool-alloc-bytes=13336
D [17/Jan/2018:22:22:37 -0600] Report: stringpool-total-bytes=49632
I [17/Jan/2018:22:22:38 -0600] Expiring subscriptions...
D [17/Jan/2018:22:22:38 -0600] Closing client 2 after 300 seconds of inactivity.
D [17/Jan/2018:22:22:38 -0600] [Client 2] Closing connection.
D [17/Jan/2018:22:22:38 -0600] cupsdSetBusyState: newbusy="Dirty files",
busy="Dirty files"
I [17/Jan/2018:22:22:39 -0600] Saving subscriptions.conf...
D [17/Jan/2018:22:22:39 -0600] cupsdSetBusyState: newbusy="Not busy",
busy="Dirty files"
I [17/Jan/2018:22:22:39 -0600] Expiring subscriptions...
Thank you for any assistance that you can offer. I think that I have all the
log files and details that was requested. If not just let me know and I will
run an commands and post the log files.
** Description changed:
- myuseraccount@myuseraccount-System-Product-Name:~$ /usr/lib/cups/backend/snmp
+ A Canon MF8380CDW printer will not print any thing after upgrading to
+ 17.10. I ran all the steps from this
+ https://wiki.ubuntu.com/DebuggingPrintingProblems web site.
+
+ I have attached a lot of log files. Not sure which one is needed. The
+ printer did work back under 15.10 or 16.04 but took a lot to get it
+ fixed to work then. I have tried to print from 18.04 and it has the
+ same problem with this printer.
+
+
+
+
+
+
+ myuseraccount@myuseraccount-System-Product-Name:~$ /usr/lib/cups/backend/snmp
network socket://192.168.1.100 "Canon MF8300C Series" "Canon MF8300C Series"
"MFG:Canon;MDL:MF8300C Series;CLS:PRINTER;DES:Canon MF8300
- C Series;CID:;CMD:LIPSLX,CPCA;" ""
- myuseraccount@myuseraccount-System-Product-Name:~$ sudo
/usr/lib/cups/backend/dnssd
- [sudo] password for myuseraccount:
- DEBUG: sent=0, count=0
- DEBUG: Querying "Canon\032MF8300C\032Series._printer._tcp.local"...
- DEBUG: Querying "Canon\032MF8300C\032Series._pdl-datastream._tcp.local"...
- DEBUG: sent=0, count=2
+ C Series;CID:;CMD:LIPSLX,CPCA;" ""
+ myuseraccount@myuseraccount-System-Product-Name:~$ sudo
/usr/lib/cups/backend/dnssd
+ [sudo] password for myuseraccount:
+ DEBUG: sent=0, count=0
+ DEBUG: Querying "Canon\032MF8300C\032Series._printer._tcp.local"...
+ DEBUG: Querying "Canon\032MF8300C\032Series._pdl-datastream._tcp.local"...
+ DEBUG: sent=0, count=2
DEBUG2: query_callback(browser=0x556cd4f96420, interfaceIndex=2, protocol=0,
event=0, fullName="Canon\032MF8300C\032Series._printer._tcp.local", rrclass=1,
rrtype=16, rdata=0x
- 556cd4f97854, rdlen=338, flags=5, context=0x556cd4f95900)
- DEBUG2: query_callback: "txtvers=1".
- DEBUG2: query_callback: "note=".
- DEBUG2: query_callback: "qtotal=1".
- DEBUG2: query_callback: "priority=20".
- DEBUG2: query_callback: "ty=Canon MF8300C Series".
- DEBUG2: query_callback: "product=(CNMF8300C Series)".
- DEBUG2: query_callback: "pdl=application/octet-stream".
- DEBUG2: query_callback:
"adminurl=http://Canon0f2ec4.local/m_network_tcpip.html";.
- DEBUG2: query_callback: "usb_MFG=Canon".
- DEBUG2: query_callback: "usb_MDL=MF8300C Series".
- DEBUG2: query_callback: "Transparent=F".
- DEBUG2: query_callback: "Binary=F".
- DEBUG2: query_callback: "TBCP=F".
- DEBUG2: query_callback: "Color=T".
- DEBUG2: query_callback: "Copies=T".
- DEBUG2: query_callback: "Duplex=T".
- DEBUG2: query_callback: "PaperCustom=T".
- DEBUG2: query_callback: "Bind=F".
- DEBUG2: query_callback: "Collate=T".
- DEBUG2: query_callback: "Sort=T".
- DEBUG2: query_callback: "Staple=F".
- DEBUG2: query_callback: "Punch=0".
- DEBUG2: query_callback: "PaperMax=legal-A4".
+ 556cd4f97854, rdlen=338, flags=5, context=0x556cd4f95900)
+ DEBUG2: query_callback: "txtvers=1".
+ DEBUG2: query_callback: "note=".
+ DEBUG2: query_callback: "qtotal=1".
+ DEBUG2: query_callback: "priority=20".
+ DEBUG2: query_callback: "ty=Canon MF8300C Series".
+ DEBUG2: query_callback: "product=(CNMF8300C Series)".
+ DEBUG2: query_callback: "pdl=application/octet-stream".
+ DEBUG2: query_callback:
"adminurl=http://Canon0f2ec4.local/m_network_tcpip.html";.
+ DEBUG2: query_callback: "usb_MFG=Canon".
+ DEBUG2: query_callback: "usb_MDL=MF8300C Series".
+ DEBUG2: query_callback: "Transparent=F".
+ DEBUG2: query_callback: "Binary=F".
+ DEBUG2: query_callback: "TBCP=F".
+ DEBUG2: query_callback: "Color=T".
+ DEBUG2: query_callback: "Copies=T".
+ DEBUG2: query_callback: "Duplex=T".
+ DEBUG2: query_callback: "PaperCustom=T".
+ DEBUG2: query_callback: "Bind=F".
+ DEBUG2: query_callback: "Collate=T".
+ DEBUG2: query_callback: "Sort=T".
+ DEBUG2: query_callback: "Staple=F".
+ DEBUG2: query_callback: "Punch=0".
+ DEBUG2: query_callback: "PaperMax=legal-A4".
DEBUG2: query_callback(browser=0x556cd4f96420, interfaceIndex=-1,
protocol=-1, event=2,
fullName="Canon\032MF8300C\032Series._printer._tcp.local", rrclass=1,
rrtype=16, rdata=
- (nil), rdlen=0, flags=0, context=0x556cd4f95900)
+ (nil), rdlen=0, flags=0, context=0x556cd4f95900)
DEBUG2: query_callback(browser=0x556cd4f95aa0, interfaceIndex=2, protocol=0,
event=0, fullName="Canon\032MF8300C\032Series._pdl-datastream._tcp.local",
rrclass=1, rrtype=16, r
- data=0x556cd4f97a0c, rdlen=338, flags=5, context=0x556cd4f95780)
- DEBUG2: query_callback: "txtvers=1".
- DEBUG2: query_callback: "note=".
- DEBUG2: query_callback: "qtotal=1".
- DEBUG2: query_callback: "priority=10".
- DEBUG2: query_callback: "ty=Canon MF8300C Series".
- DEBUG2: query_callback: "product=(CNMF8300C Series)".
- DEBUG2: query_callback: "pdl=application/octet-stream".
- DEBUG2: query_callback:
"adminurl=http://Canon0f2ec4.local/m_network_tcpip.html";.
- DEBUG2: query_callback: "usb_MFG=Canon".
- DEBUG2: query_callback: "usb_MDL=MF8300C Series".
- DEBUG2: query_callback: "Transparent=F".
- DEBUG2: query_callback: "Binary=F".
- DEBUG2: query_callback: "TBCP=F".
- DEBUG2: query_callback: "Color=T".
- DEBUG2: query_callback: "Copies=T".
- DEBUG2: query_callback: "Duplex=T".
- DEBUG2: query_callback: "PaperCustom=T".
- DEBUG2: query_callback: "Bind=F".
- DEBUG2: query_callback: "Collate=T".
- DEBUG2: query_callback: "Sort=T".
- DEBUG2: query_callback: "Staple=F".
- DEBUG2: query_callback: "Punch=0".
- DEBUG2: query_callback: "PaperMax=legal-A4".
- network dnssd://Canon%20MF8300C%20Series._pdl-datastream._tcp.local/ "Canon
MF8300C Series" "Canon MF8300C Series" "MFG:Canon;MDL:MF8300C Series;" ""
- DEBUG: sent=2, count=2
- myuseraccount@myuseraccount-System-Product-Name:~$ /usr/lib/cups/backend/snmp
192.168.1.100
- network socket://192.168.1.100 "Canon MF8300C Series" "Canon MF8300C Series"
"MFG:Canon;MDL:MF8300C Series;CLS:PRINTER;DES:Canon MF8300C
Series;CID:;CMD:LIPSLX,CPCA;" ""
- myuseraccount@myuseraccount-System-Product-Name:~$ lpinfo -v
- network ipp
- network https
- network ipps
- network http
- file cups-brf:/
- network beh
- direct hp
- serial serial:/dev/ttyS0?baud=115200
- network socket
- network lpd
- direct parallel:/dev/lp0
- file cups-pdf:/
- network bjnp
- direct hpfax
- network dnssd://Canon%20MF8300C%20Series._pdl-datastream._tcp.local/
- network socket://192.168.1.100
- myuseraccount@myuseraccount-System-Product-Name:~$ avahi-browse -a -v -t -r
- Server version: avahi 0.6.32; Host name:
myuseraccount-System-Product-Name.local
- E Ifce Prot Name Type
Domain
- : Cache exhausted
- : All for now
- myuseraccount@myuseraccount-System-Product-Name:~$ avahi-browse -a -v -c -r
- Server version: avahi 0.6.32; Host name:
myuseraccount-System-Product-Name.local
- E Ifce Prot Name Type
Domain
+ data=0x556cd4f97a0c, rdlen=338, flags=5, context=0x556cd4f95780)
+ DEBUG2: query_callback: "txtvers=1".
+ DEBUG2: query_callback: "note=".
+ DEBUG2: query_callback: "qtotal=1".
+ DEBUG2: query_callback: "priority=10".
+ DEBUG2: query_callback: "ty=Canon MF8300C Series".
+ DEBUG2: query_callback: "product=(CNMF8300C Series)".
+ DEBUG2: query_callback: "pdl=application/octet-stream".
+ DEBUG2: query_callback:
"adminurl=http://Canon0f2ec4.local/m_network_tcpip.html";.
+ DEBUG2: query_callback: "usb_MFG=Canon".
+ DEBUG2: query_callback: "usb_MDL=MF8300C Series".
+ DEBUG2: query_callback: "Transparent=F".
+ DEBUG2: query_callback: "Binary=F".
+ DEBUG2: query_callback: "TBCP=F".
+ DEBUG2: query_callback: "Color=T".
+ DEBUG2: query_callback: "Copies=T".
+ DEBUG2: query_callback: "Duplex=T".
+ DEBUG2: query_callback: "PaperCustom=T".
+ DEBUG2: query_callback: "Bind=F".
+ DEBUG2: query_callback: "Collate=T".
+ DEBUG2: query_callback: "Sort=T".
+ DEBUG2: query_callback: "Staple=F".
+ DEBUG2: query_callback: "Punch=0".
+ DEBUG2: query_callback: "PaperMax=legal-A4".
+ network dnssd://Canon%20MF8300C%20Series._pdl-datastream._tcp.local/ "Canon
MF8300C Series" "Canon MF8300C Series" "MFG:Canon;MDL:MF8300C Series;" ""
+ DEBUG: sent=2, count=2
+ myuseraccount@myuseraccount-System-Product-Name:~$ /usr/lib/cups/backend/snmp
192.168.1.100
+ network socket://192.168.1.100 "Canon MF8300C Series" "Canon MF8300C Series"
"MFG:Canon;MDL:MF8300C Series;CLS:PRINTER;DES:Canon MF8300C
Series;CID:;CMD:LIPSLX,CPCA;" ""
+ myuseraccount@myuseraccount-System-Product-Name:~$ lpinfo -v
+ network ipp
+ network https
+ network ipps
+ network http
+ file cups-brf:/
+ network beh
+ direct hp
+ serial serial:/dev/ttyS0?baud=115200
+ network socket
+ network lpd
+ direct parallel:/dev/lp0
+ file cups-pdf:/
+ network bjnp
+ direct hpfax
+ network dnssd://Canon%20MF8300C%20Series._pdl-datastream._tcp.local/
+ network socket://192.168.1.100
+ myuseraccount@myuseraccount-System-Product-Name:~$ avahi-browse -a -v -t -r
+ Server version: avahi 0.6.32; Host name:
myuseraccount-System-Product-Name.local
+ E Ifce Prot Name Type
Domain
+ : Cache exhausted
+ : All for now
+ myuseraccount@myuseraccount-System-Product-Name:~$ avahi-browse -a -v -c -r
+ Server version: avahi 0.6.32; Host name:
myuseraccount-System-Product-Name.local
+ E Ifce Prot Name Type
Domain
: Cache exhausted
ProblemType: Bug
DistroRelease: Ubuntu 17.10
Package: cups 2.2.4-7ubuntu3
ProcVersionSignature: Ubuntu 4.13.0-30.33-generic 4.13.13
Uname: Linux 4.13.0-30-generic x86_64
NonfreeKernelModules: nvidia_uvm nvidia
ApportVersion: 2.20.7-0ubuntu3.7
Architecture: amd64
CurrentDesktop: KDE
Date: Wed Jan 17 22:09:47 2018
InstallationDate: Installed on 2017-10-14 (96 days ago)
InstallationMedia: Kubuntu 17.10 "Artful Aardvark" - Alpha amd64 (20170926)
Lpstat:
- device for Canon_MF8300C_Series: socket://192.168.1.100:9100
- device for PDF: cups-pdf:/
+ device for Canon_MF8300C_Series: socket://192.168.1.100:9100
+ device for PDF: cups-pdf:/
MachineType: System manufacturer System Product Name
Papersize: letter
PpdFiles:
- Error: command ['fgrep', '-H', '*NickName',
'/etc/cups/ppd/Canon_MF8300C_Series.ppd', '/etc/cups/ppd/PDF.ppd'] failed with
exit code 2: grep: /etc/cups/ppd/Canon_MF8300C_Series.ppd: Permission denied
- grep: /etc/cups/ppd/PDF.ppd: Permission denied
+ Error: command ['fgrep', '-H', '*NickName',
'/etc/cups/ppd/Canon_MF8300C_Series.ppd', '/etc/cups/ppd/PDF.ppd'] failed with
exit code 2: grep: /etc/cups/ppd/Canon_MF8300C_Series.ppd: Permission denied
+ grep: /etc/cups/ppd/PDF.ppd: Permission denied
ProcKernelCmdLine: BOOT_IMAGE=/boot/vmlinuz-4.13.0-30-generic
root=UUID=0c254e78-bfe6-4030-8e03-92691867118b ro quiet splash
SourcePackage: cups
UpgradeStatus: No upgrade log present (probably fresh install)
dmi.bios.date: 05/10/2013
dmi.bios.vendor: American Megatrends Inc.
dmi.bios.version: 4501
dmi.board.asset.tag: To be filled by O.E.M.
dmi.board.name: P8H61-M LE/CSM
dmi.board.vendor: ASUSTeK COMPUTER INC.
dmi.board.version: Rev x.0x
dmi.chassis.asset.tag: Asset-1234567890
dmi.chassis.type: 3
dmi.chassis.vendor: Chassis Manufacture
dmi.chassis.version: Chassis Version
dmi.modalias:
dmi:bvnAmericanMegatrendsInc.:bvr4501:bd05/10/2013:svnSystemmanufacturer:pnSystemProductName:pvrSystemVersion:rvnASUSTeKCOMPUTERINC.:rnP8H61-MLE/CSM:rvrRevx.0x:cvnChassisManufacture:ct3:cvrChassisVersion:
dmi.product.family: To be filled by O.E.M.
dmi.product.name: System Product Name
dmi.product.version: System Version
dmi.sys.vendor: System manufacturer
--
You received this bug notification because you are a member of Ubuntu
Bugs, which is subscribed to Ubuntu.
https://bugs.launchpad.net/bugs/1743939
Title:
Canon MF8380 Wireless Network Not Printing
To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/cups/+bug/1743939/+subscriptions
--
ubuntu-bugs mailing list
[email protected]
https://lists.ubuntu.com/mailman/listinfo/ubuntu-bugs
