OK, apport-collected as requested. Here's the snippet from CupsErrorLog.txt for when the error occurs:
----
D [14/Dec/2009:00:35:07 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [14/Dec/2009:00:35:07 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Dec/2009:00:35:07 -0500] cupsdCloseClient: 14
D [14/Dec/2009:00:35:07 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Dec/2009:00:35:07 -0500] cupsdReadClient: 12 GET /printers/mp160.ppd HTTP/1.1
D [14/Dec/2009:00:35:07 -0500] cupsdSetBusyState: Active clients
D [14/Dec/2009:00:35:07 -0500] cupsdAuthorize: No authentication data provided.
D [14/Dec/2009:00:35:07 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Dec/2009:00:35:07 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Dec/2009:00:35:07 -0500] cupsdCloseClient: 14
D [14/Dec/2009:00:35:07 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Dec/2009:00:35:07 -0500] cupsdAuthorize: No authentication data provided.
E [14/Dec/2009:00:35:17 -0500] cupsdReadClient: 16 IPP Read Error!
D [14/Dec/2009:00:35:17 -0500] cupsdCloseClient: 16
D [14/Dec/2009:00:35:17 -0500] cupsdSetBusyState: Not busy
D [14/Dec/2009:00:35:18 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [14/Dec/2009:00:35:18 -0500] cupsdCloseClient: 12
D [14/Dec/2009:00:35:18 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [14/Dec/2009:00:35:18 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Dec/2009:00:35:18 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [14/Dec/2009:00:35:18 -0500] cupsdCloseClient: 12
----
As you can see, exactly a 10s delay. Some kind of timeout problem.
OK, apport-collected as requested. Here's the snippet from CupsErrorLog.txt for when the error occurs:
---- 2009:00: 35:07 -0500] cupsdAcceptClient: 12 from localhost (Domain) 2009:00: 35:07 -0500] cupsdReadClient: 14 WAITING Closing on EOF 2009:00: 35:07 -0500] cupsdCloseClient: 14 2009:00: 35:07 -0500] cupsdAcceptClient: 14 from localhost (Domain) 2009:00: 35:07 -0500] cupsdReadClient: 12 GET /printers/mp160.ppd HTTP/1.1 2009:00: 35:07 -0500] cupsdSetBusyState: Active clients 2009:00: 35:07 -0500] cupsdAuthorize: No authentication data provided. 2009:00: 35:07 -0500] cupsdAcceptClient: 16 from localhost (Domain) 2009:00: 35:07 -0500] cupsdReadClient: 14 WAITING Closing on EOF 2009:00: 35:07 -0500] cupsdCloseClient: 14 2009:00: 35:07 -0500] cupsdReadClient: 16 POST / HTTP/1.1 2009:00: 35:07 -0500] cupsdAuthorize: No authentication data provided. 2009:00: 35:17 -0500] cupsdReadClient: 16 IPP Read Error! 2009:00: 35:17 -0500] cupsdCloseClient: 16 2009:00: 35:17 -0500] cupsdSetBusyState: Not busy 2009:00: 35:18 -0500] cupsdReadClient: 12 WAITING Closing on EOF 2009:00: 35:18 -0500] cupsdCloseClient: 12 2009:00: 35:18 -0500] cupsdAcceptClient: 12 from localhost (Domain) 2009:00: 35:18 -0500] cupsdAcceptClient: 14 from localhost (Domain) 2009:00: 35:18 -0500] cupsdReadClient: 12 WAITING Closing on EOF 2009:00: 35:18 -0500] cupsdCloseClient: 12
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
E [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
D [14/Dec/
----
As you can see, exactly a 10s delay. Some kind of timeout problem.