I [06/Dec/2012:20:46:40 +0530] Generating printcap /etc/printcap... D [06/Dec/2012:20:46:40 +0530] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files" I [06/Dec/2012:20:46:42 +0530] Scheduler shutting down normally. D [06/Dec/2012:20:46:42 +0530] Discarding unused server-stopped event... D [06/Dec/2012:20:46:42 +0530] [Client 14] Closing connection. D [06/Dec/2012:20:46:42 +0530] cupsdSetBusyState: newbusy="Not busy", busy="Not busy" I [06/Dec/2012:20:46:42 +0530] Saving job.cache... I [06/Dec/2012:20:46:42 +0530] Remote access is disabled. D [06/Dec/2012:20:46:42 +0530] Added auto ServerAlias laptop I [06/Dec/2012:20:46:42 +0530] Loaded configuration file "/etc/cups/cupsd.conf" I [06/Dec/2012:20:46:42 +0530] Using default TempDir of /var/spool/cups/tmp... I [06/Dec/2012:20:46:42 +0530] Configured for up to 100 clients. I [06/Dec/2012:20:46:42 +0530] Allowing up to 100 client connections per host. I [06/Dec/2012:20:46:42 +0530] Using policy "default" as the default. I [06/Dec/2012:20:46:42 +0530] Full reload is required. I [06/Dec/2012:20:46:42 +0530] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 39 types, 55 filters... D [06/Dec/2012:20:46:42 +0530] Loading printer canon_suse... D [06/Dec/2012:20:46:42 +0530] load_ppd: Loading /var/cache/cups/canon_suse.data... D [06/Dec/2012:20:46:42 +0530] cupsdRegisterPrinter(p=0x7fe16f6b7110(canon_suse)) D [06/Dec/2012:20:46:42 +0530] Loading printer MP250... D [06/Dec/2012:20:46:42 +0530] load_ppd: Loading /var/cache/cups/MP250.data... D [06/Dec/2012:20:46:42 +0530] cupsdRegisterPrinter(p=0x7fe16f6a9380(MP250)) I [06/Dec/2012:20:46:42 +0530] Loading job cache file "/var/cache/cups/job.cache"... D [06/Dec/2012:20:46:42 +0530] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)") D [06/Dec/2012:20:46:42 +0530] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)") I [06/Dec/2012:20:46:42 +0530] Full reload complete. D [06/Dec/2012:20:46:42 +0530] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)") I [06/Dec/2012:20:46:42 +0530] Cleaning out old files in "/var/spool/cups/tmp"... D [06/Dec/2012:20:46:42 +0530] cupsdCleanFiles(path="/var/spool/cups/tmp/.cache", pattern="(null)") I [06/Dec/2012:20:46:42 +0530] Cleaning out old files in "/var/spool/cups/tmp/.cache"... D [06/Dec/2012:20:46:42 +0530] cupsdCleanFiles(path="/var/spool/cups/tmp/.cache/fontconfig", pattern="(null)") I [06/Dec/2012:20:46:42 +0530] Cleaning out old files in "/var/spool/cups/tmp/.cache/fontconfig"... D [06/Dec/2012:20:46:42 +0530] Removed "/var/spool/cups/tmp/.cache/fontconfig/3830d5c3ddfd5cd38a049b759396e72e-le64.cache-3"... D [06/Dec/2012:20:46:42 +0530] Removed "/var/spool/cups/tmp/.cache/fontconfig/CACHEDIR.TAG"... D [06/Dec/2012:20:46:42 +0530] Removed "/var/spool/cups/tmp/.cache/fontconfig/452f1fac34b224105d7acfae3034bcd5-le64.cache-3"... D [06/Dec/2012:20:46:42 +0530] Removed "/var/spool/cups/tmp/.cache/fontconfig"... D [06/Dec/2012:20:46:42 +0530] Removed "/var/spool/cups/tmp/.cache"... D [06/Dec/2012:20:46:42 +0530] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp") I [06/Dec/2012:20:46:42 +0530] Cleaning out old files in "/var/cache/cups"... D [06/Dec/2012:20:46:42 +0530] Calling FindDeviceById(cups-canon_suse) D [06/Dec/2012:20:46:42 +0530] FindDeviceById failed: org.freedesktop.ColorManager.Failed:device id 'cups-canon_suse' does not exists D [06/Dec/2012:20:46:42 +0530] Using profile ID "canon_suse-Gray..". D [06/Dec/2012:20:46:42 +0530] Calling CreateProfile(canon_suse-Gray..,temp) D [06/Dec/2012:20:46:42 +0530] Created profile "/org/freedesktop/ColorManager/profiles/canon_suse_Gray__". D [06/Dec/2012:20:46:42 +0530] Using profile ID "canon_suse-RGB..". D [06/Dec/2012:20:46:42 +0530] Calling CreateProfile(canon_suse-RGB..,temp) D [06/Dec/2012:20:46:42 +0530] Created profile "/org/freedesktop/ColorManager/profiles/canon_suse_RGB__". I [06/Dec/2012:20:46:42 +0530] Registering ICC color profiles for "canon_suse". D [06/Dec/2012:20:46:42 +0530] Calling CreateDevice(cups-canon_suse,temp) D [06/Dec/2012:20:46:42 +0530] Created device "/org/freedesktop/ColorManager/devices/cups_canon_suse". D [06/Dec/2012:20:46:42 +0530] Calling /org/freedesktop/ColorManager/devices/cups_canon_suse:AddProfile(/org/freedesktop/ColorManager/profiles/canon_suse_Gray__) [soft] W [06/Dec/2012:20:46:42 +0530] AddProfile failed: org.freedesktop.DBus.Error.UnknownMethod:No such interface `org.freedesktop.ColorManager' on object at path /org/freedesktop/ColorManager/devices/cups_canon_suse D [06/Dec/2012:20:46:42 +0530] Calling /org/freedesktop/ColorManager/devices/cups_canon_suse:AddProfile(/org/freedesktop/ColorManager/profiles/canon_suse_RGB__) [soft] W [06/Dec/2012:20:46:42 +0530] AddProfile failed: org.freedesktop.DBus.Error.UnknownMethod:No such interface `org.freedesktop.ColorManager' on object at path /org/freedesktop/ColorManager/devices/cups_canon_suse D [06/Dec/2012:20:46:42 +0530] Calling FindDeviceById(cups-MP250) D [06/Dec/2012:20:46:42 +0530] FindDeviceById failed: org.freedesktop.ColorManager.Failed:device id 'cups-MP250' does not exists D [06/Dec/2012:20:46:42 +0530] Using profile ID "MP250-Gray..". D [06/Dec/2012:20:46:42 +0530] Calling CreateProfile(MP250-Gray..,temp) D [06/Dec/2012:20:46:42 +0530] Created profile "/org/freedesktop/ColorManager/profiles/MP250_Gray__". D [06/Dec/2012:20:46:42 +0530] Using profile ID "MP250-RGB..". D [06/Dec/2012:20:46:42 +0530] Calling CreateProfile(MP250-RGB..,temp) D [06/Dec/2012:20:46:42 +0530] Created profile "/org/freedesktop/ColorManager/profiles/MP250_RGB__". I [06/Dec/2012:20:46:42 +0530] Registering ICC color profiles for "MP250". D [06/Dec/2012:20:46:42 +0530] Calling CreateDevice(cups-MP250,temp) D [06/Dec/2012:20:46:43 +0530] Created device "/org/freedesktop/ColorManager/devices/cups_MP250". D [06/Dec/2012:20:46:43 +0530] Calling /org/freedesktop/ColorManager/devices/cups_MP250:AddProfile(/org/freedesktop/ColorManager/profiles/MP250_Gray__) [soft] W [06/Dec/2012:20:46:43 +0530] AddProfile failed: org.freedesktop.DBus.Error.UnknownMethod:No such interface `org.freedesktop.ColorManager' on object at path /org/freedesktop/ColorManager/devices/cups_MP250 D [06/Dec/2012:20:46:43 +0530] Calling /org/freedesktop/ColorManager/devices/cups_MP250:AddProfile(/org/freedesktop/ColorManager/profiles/MP250_RGB__) [soft] W [06/Dec/2012:20:46:43 +0530] AddProfile failed: org.freedesktop.DBus.Error.UnknownMethod:No such interface `org.freedesktop.ColorManager' on object at path /org/freedesktop/ColorManager/devices/cups_MP250 I [06/Dec/2012:20:46:43 +0530] Listening to [v1.::1]:631 on fd 9... I [06/Dec/2012:20:46:43 +0530] Listening to 127.0.0.1:631 on fd 10... I [06/Dec/2012:20:46:43 +0530] Listening to /var/run/cups/cups.sock:631 on fd 11... I [06/Dec/2012:20:46:43 +0530] Resuming new connection processing... D [06/Dec/2012:20:46:43 +0530] cupsdSetBusyState: newbusy="Not busy", busy="Not busy" D [06/Dec/2012:20:46:43 +0530] Discarding unused server-started event... D [06/Dec/2012:20:46:44 +0530] Report: clients=0 D [06/Dec/2012:20:46:44 +0530] Report: jobs=0 D [06/Dec/2012:20:46:44 +0530] Report: jobs-active=0 D [06/Dec/2012:20:46:44 +0530] Report: printers=2 D [06/Dec/2012:20:46:44 +0530] Report: stringpool-string-count=51204 D [06/Dec/2012:20:46:44 +0530] Report: stringpool-alloc-bytes=13440 D [06/Dec/2012:20:46:44 +0530] Report: stringpool-total-bytes=751168 D [06/Dec/2012:20:47:11 +0530] [Client 14] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:11 +0530] [Client 14] POST /printers/MP250 HTTP/1.1 D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" D [06/Dec/2012:20:47:11 +0530] [Client 14] Authorized as root using Basic D [06/Dec/2012:20:47:11 +0530] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[8] = "HOME=/var/spool/cups/tmp" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[10] = "SERVER_ADMIN=root@laptop" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[11] = "SOFTWARE=CUPS/1.6.1" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[13] = "USER=root" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[15] = "CUPS_SERVER=/var/run/cups/cups.sock" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[17] = "IPP_PORT=631" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[18] = "AUTH_TYPE=Basic" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[19] = "LANG=en_US.UTF8" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[20] = "REDIRECT_STATUS=1" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[22] = "SERVER_NAME=localhost" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[23] = "SERVER_PORT=631" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[24] = "REMOTE_ADDR=[v1.::1]" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[25] = "REMOTE_HOST=localhost" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[26] = "SCRIPT_NAME=/printers/MP250" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc/printers/MP250" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[28] = "PATH_INFO=/MP250" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[29] = "REMOTE_USER=root" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[30] = "SERVER_PROTOCOL=HTTP/1.1" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[31] = "HTTP_COOKIE=org.cups.sid=4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[32] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.11 (KHTML, like Gecko) Chrome/23.0.1271.95 Safari/537.11" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[33] = "HTTP_REFERER=http://localhost:631/printers/MP250" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[34] = "REQUEST_METHOD=POST" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[35] = "CONTENT_LENGTH=64" D [06/Dec/2012:20:47:11 +0530] [CGI] envp[36] = "CONTENT_TYPE=application/x-www-form-urlencoded" D [06/Dec/2012:20:47:11 +0530] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 3304) I [06/Dec/2012:20:47:11 +0530] [Client 14] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=3304) D [06/Dec/2012:20:47:11 +0530] [Client 14] file=16 D [06/Dec/2012:20:47:11 +0530] [CGI] org.cups.sid cookie is "4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: org.cups.sid="4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: OP="print-test-page" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: SECTION="printers" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: REFRESH_PAGE="" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: PRINTER_NAME="MP250" D [06/Dec/2012:20:47:11 +0530] [Client 15] Accepted from localhost (Domain) D [06/Dec/2012:20:47:11 +0530] [Client 15] POST /printers/MP250 HTTP/1.1 D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients", busy="Active clients" D [06/Dec/2012:20:47:11 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:11 +0530] [Client 15] 2.0 Print-Job 1 D [06/Dec/2012:20:47:11 +0530] Print-Job ipp://localhost:631/printers/MP250 D [06/Dec/2012:20:47:11 +0530] [Job ???] Auto-typing file... I [06/Dec/2012:20:47:11 +0530] [Job ???] Request file type is application/vnd.cups-pdf-banner. D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients" D [06/Dec/2012:20:47:11 +0530] add_job: requesting-user-name="root" D [06/Dec/2012:20:47:11 +0530] Adding default job-sheets values "none,none"... I [06/Dec/2012:20:47:11 +0530] [Job 85] Adding start banner page "none". D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" I [06/Dec/2012:20:47:11 +0530] [Job 85] Adding end banner page "none". I [06/Dec/2012:20:47:11 +0530] [Job 85] File of type application/vnd.cups-pdf-banner queued by "root". D [06/Dec/2012:20:47:11 +0530] [Job 85] hold_until=0 I [06/Dec/2012:20:47:11 +0530] [Job 85] Queued on "MP250" by "root". D [06/Dec/2012:20:47:11 +0530] [Job 85] time-at-processing=1354807031 D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] job-sheets=none,none D [06/Dec/2012:20:47:11 +0530] [Job 85] argv[0]="MP250" D [06/Dec/2012:20:47:11 +0530] [Job 85] argv[1]="85" D [06/Dec/2012:20:47:11 +0530] [Job 85] argv[2]="root" D [06/Dec/2012:20:47:11 +0530] [Job 85] argv[3]="Test Page" D [06/Dec/2012:20:47:11 +0530] [Job 85] argv[4]="1" D [06/Dec/2012:20:47:11 +0530] [Job 85] argv[5]="job-uuid=urn:uuid:ed5890bc-3bf9-36d5-44f7-c071c66cd2a5 job-originating-host-name=localhost time-at-creation=1354807031 time-at-processing=1354807031" D [06/Dec/2012:20:47:11 +0530] [Job 85] argv[6]="/var/spool/cups/d00085-001" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[1]="CUPS_DATADIR=/usr/share/cups" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[6]="CUPS_SERVERROOT=/etc/cups" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[7]="CUPS_STATEDIR=/var/run/cups" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[8]="HOME=/var/spool/cups/tmp" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[10]="SERVER_ADMIN=root@laptop" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[11]="SOFTWARE=CUPS/1.6.1" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[12]="TMPDIR=/var/spool/cups/tmp" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[13]="USER=root" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[14]="CUPS_MAX_MESSAGE=2047" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[16]="CUPS_ENCRYPTION=IfRequested" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[17]="IPP_PORT=631" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[18]="CHARSET=utf-8" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[19]="LANG=en_US.UTF-8" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[20]="PPD=/etc/cups/ppd/MP250.ppd" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[21]="RIP_MAX_CACHE=128m" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[23]="DEVICE_URI=cnijusb:/dev/usb/lp1" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[24]="PRINTER_INFO=Canon MP250 series" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[25]="PRINTER_LOCATION=Local Printer" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[26]="PRINTER=MP250" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[27]="PRINTER_STATE_REASONS=none" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[28]="CUPS_FILETYPE=document" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[29]="FINAL_CONTENT_TYPE=printer/MP250" D [06/Dec/2012:20:47:11 +0530] [Job 85] envp[30]="AUTH_I****" I [06/Dec/2012:20:47:11 +0530] [Job 85] Started filter /usr/lib/cups/filter/bannertopdf (PID 3310) I [06/Dec/2012:20:47:11 +0530] [Job 85] Started filter /usr/lib/cups/filter/pdftopdf (PID 3311) I [06/Dec/2012:20:47:11 +0530] [Job 85] Started filter /usr/lib/cups/filter/pdftoraster (PID 3312) I [06/Dec/2012:20:47:11 +0530] [Job 85] Started filter /usr/lib/cups/filter/rastertogutenprint.5.2 (PID 3313) I [06/Dec/2012:20:47:11 +0530] [Job 85] Started backend /usr/lib/cups/backend/cnijusb (PID 3314) D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:11 +0530] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/MP250) from localhost D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:11 +0530] PID 3304 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors. D [06/Dec/2012:20:47:11 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:11 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetArray: job_uri[0]="/jobs/85" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetArray: job_id[0]="85" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetArray: job_state[0]="3" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetArray: job_state_reasons[0]="none" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: refresh_page="2;URL=/printers/MP250" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: TITLE="Print Test Page" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:11 +0530] [CGI] cgiSetVariable: PRINTER_NAME="MP250" D [06/Dec/2012:20:47:11 +0530] Script header: Content-Type: text/html;charset=utf-8 D [06/Dec/2012:20:47:11 +0530] Script header: D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" I [06/Dec/2012:20:47:11 +0530] [Job 85] Printer cable not connected or printer power off; will retry in 30 seconds... D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Set job-printer-state-message to "Printer cable not connected or printer power off; will retry in 30 seconds...", current level=INFO D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] PID 3310 (/usr/lib/cups/filter/bannertopdf) exited with no errors. D [06/Dec/2012:20:47:11 +0530] [Job 85] PID 3311 (/usr/lib/cups/filter/pdftopdf) exited with no errors. D [06/Dec/2012:20:47:11 +0530] [Job 85] nprint: Not setting ChannelBitDepth to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting InputImageType to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting STPIOutputType to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting STPIRawChannels to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting SimpleGamma to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set bool LinearContrast to False (0) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting LUTDumpFile to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CyanCurve to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting MagentaCurve to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting YellowCurve to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting BlackCurve to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting RedCurve to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting GreenCurve to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting BlueCurve to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting WhiteCurve to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting HueMap to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting SatMap to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting LumMap to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting GCRCurve to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh0 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh1 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh2 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh3 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh4 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh5 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh6 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh7 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh8 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh9 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh10 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh11 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh12 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh13 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh14 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh15 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh16 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh17 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh18 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh19 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh20 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh21 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh22 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh23 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh24 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh25 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh26 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh27 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh28 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh29 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh30 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting CurveCh31 to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set string DitherAlgorithm to None D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special string DitherAlgorithm to None D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set string ImageType to TextGraphics D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special string ImageType to TextGraphics D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting JobMode to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Not setting PageNumber to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: End options D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: About to start printing loop. D [06/Dec/2012:20:47:11 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:11 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:11 +0530] [Client 15] 2.0 Get-Notifications 182 D [06/Dec/2012:20:47:11 +0530] Get-Notifications / D [06/Dec/2012:20:47:11 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:11 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:11 +0530] [Client 15] 2.0 Get-Job-Attributes 183 D [06/Dec/2012:20:47:11 +0530] Get-Job-Attributes ipp://localhost/jobs/85 D [06/Dec/2012:20:47:11 +0530] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/85) from localhost D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 16] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:11 +0530] [Client 16] POST / HTTP/1.1 D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 16] No authentication data provided. D [06/Dec/2012:20:47:11 +0530] [Client 16] 2.0 Get-Printer-Attributes 184 D [06/Dec/2012:20:47:11 +0530] Get-Printer-Attributes D [06/Dec/2012:20:47:11 +0530] Get-Printer-Attributes client-error-not-found: The printer or class does not exist. D [06/Dec/2012:20:47:11 +0530] Returning IPP client-error-not-found for Get-Printer-Attributes () from localhost D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 16] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:11 +0530] [Client 16] Closing connection. D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:11 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:11 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:11 +0530] [Client 15] 2.0 Get-Notifications 185 D [06/Dec/2012:20:47:11 +0530] Get-Notifications / D [06/Dec/2012:20:47:11 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:11 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:11 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:11 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:11 +0530] [Client 15] 2.0 Get-Notifications 186 D [06/Dec/2012:20:47:11 +0530] Get-Notifications / D [06/Dec/2012:20:47:11 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:11 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:11 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:11 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:11 +0530] [Client 15] 2.0 Get-Notifications 187 D [06/Dec/2012:20:47:11 +0530] Get-Notifications / D [06/Dec/2012:20:47:11 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:11 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:11 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: ================ Printing page 1 ================ D [06/Dec/2012:20:47:11 +0530] [Job 85] PAGE: 1 1 D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Initialize page D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special string ChannelBitDepth to 8 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special string PrintingMode to Color D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special string InputImageType to RGB D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Clear special parameter Resolution D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special parameter Quality to choice 1 (Standard) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special string InputSlot to Rear D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special string MediaType to Plain D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: PageSize = 595x842 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Using page size A4 with (842, 595) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special string PageSize to A4 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Set special string JobMode to Job D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Validating options D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Clearing string CDInnerRadius ((null)) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Clearing string Resolution ((null)) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Setting default string Resolution to 600x600dpi D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Clearing string STPIOutputType ((null)) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Setting default string STPIOutputType to (null) D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Done validating options D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: limits w 595 l 10 r 585 h 842 t 9 b 827 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: max limits l -8 r 603 t -6 b 857 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: left margin 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: right margin 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: top margin 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: bottom margin 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: CUPS settings w 4958 l 83 r 83 h 7016 t 75 b 125 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: adjusted w 4958 h 7016 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: End initialize page D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Interim page settings: D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: === BEGIN GUTENPRINT SETTINGS === D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Driver: bjc-MULTIPASS-MP250 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: L: 10 T: 9 W: 575 H: 818 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Page: 595x842 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Conversion: traditional D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (PageSize) (2) (String) [A4] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (MediaType) (2) (String) [Plain] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (InputSlot) (2) (String) [Rear] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (InkType) (2) (String) [CMYK] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (PrintingMode) (2) (String) [Color] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (InkSet) (2) (String) [Both] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Duplex) (2) (String) [None] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Quality) (2) (String) [Standard] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (ColorCorrection) (2) (String) [None] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (ChannelBitDepth) (2) (String) [8] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (InputImageType) (2) (String) [RGB] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (DitherAlgorithm) (2) (String) [None] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (ImageType) (2) (String) [TextGraphics] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (JobMode) (2) (String) [Job] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Resolution) (2) (String) [600x600dpi] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (STPIRawChannels) (2) (Int) [1] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CUPSShrinkPage) (2) (Int) [1] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (FullBleed) (2) (Bool) [0] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (LinearContrast) (2) (Bool) [0] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Brightness) (2) (Double) [1.000000] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Contrast) (2) (Double) [1.000000] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Saturation) (2) (Double) [1.000000] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (AppGamma) (2) (Double) [1.000000] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CDOuterDiameter) (2) (Dimension) [329] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CDInnerDiameter) (2) (Dimension) [121] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CDXAdjustment) (2) (Dimension) [0] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CDYAdjustment) (2) (Dimension) [0] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: === END GUTENPRINT SETTINGS === D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Page data: D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: MediaClass = "Rear" D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: MediaColor = "" D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: MediaType = "Plain" D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: OutputType = "" D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: AdvanceDistance = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: AdvanceMedia = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Collate = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: CutMedia = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Duplex = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: HWResolution = [ 600 600 ] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: ImagingBoundingBox = [ 0 0 595 842 ] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: InsertSheet = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Jog = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: LeadingEdge = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Margins = [ 0 0 ] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: ManualFeed = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: MediaPosition = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: MediaWeight = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: MirrorPrint = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: NegativePrint = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: NumCopies = 1 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Orientation = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: OutputFaceUp = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: PageSize = [ 595 842 ] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Separations = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: TraySwitch = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Tumble = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsWidth = 4958 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsHeight = 7016 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cups->width = 4958 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cups->height = 7016 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cups->adjusted_width = 4958 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cups->adjusted_height = 7016 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsMediaType = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsBitsPerColor = 8 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsBitsPerPixel = 24 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsBytesPerLine = 14874 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsColorOrder = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsColorSpace = 1 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsCompression = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsRowCount = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsRowFeed = 2 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: cupsRowStep = 0 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: shrink page to fit 1 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: === BEGIN GUTENPRINT SETTINGS === D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Driver: bjc-MULTIPASS-MP250 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: L: 10 T: 9 W: 575 H: 818 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Page: 595x842 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Conversion: traditional D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (PageSize) (2) (String) [A4] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (MediaType) (2) (String) [Plain] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (InputSlot) (2) (String) [Rear] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (InkType) (2) (String) [CMYK] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (PrintingMode) (2) (String) [Color] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (InkSet) (2) (String) [Both] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Duplex) (2) (String) [None] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Quality) (2) (String) [Standard] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (ColorCorrection) (2) (String) [None] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (ChannelBitDepth) (2) (String) [8] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (InputImageType) (2) (String) [RGB] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (DitherAlgorithm) (2) (String) [None] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (ImageType) (2) (String) [TextGraphics] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (JobMode) (2) (String) [Job] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Resolution) (2) (String) [600x600dpi] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (STPIRawChannels) (2) (Int) [1] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CUPSShrinkPage) (2) (Int) [1] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (PageNumber) (2) (Int) [0] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (FullBleed) (2) (Bool) [0] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (LinearContrast) (2) (Bool) [0] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Brightness) (2) (Double) [1.000000] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Contrast) (2) (Double) [1.000000] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Saturation) (2) (Double) [1.000000] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (AppGamma) (2) (Double) [1.000000] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (Gamma) (1) (Double) [1.666667] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CDOuterDiameter) (2) (Dimension) [329] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CDInnerDiameter) (2) (Dimension) [121] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CDXAdjustment) (2) (Dimension) [0] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: (CDYAdjustment) (2) (Dimension) [0] D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: === END GUTENPRINT SETTINGS === D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: End page data I [06/Dec/2012:20:47:11 +0530] [Job 85] Starting page 1... D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Set job-printer-state-message to "Starting page 1...", current level=INFO D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Image_height 7016 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Image_width 4958 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Image_width 4958 D [06/Dec/2012:20:47:11 +0530] [Job 85] Gutenprint: Image_width 4958 I [06/Dec/2012:20:47:11 +0530] [Job 85] Printing page 1, 1% D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 1%", current level=INFO D [06/Dec/2012:20:47:11 +0530] [Job 85] ATTR: job-media-progress=1 D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:11 +0530] [Job 85] Printing page 1, 2% D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 2%", current level=INFO D [06/Dec/2012:20:47:11 +0530] [Job 85] ATTR: job-media-progress=2 D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:11 +0530] [Job 85] Printing page 1, 3% D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 3%", current level=INFO D [06/Dec/2012:20:47:11 +0530] [Job 85] ATTR: job-media-progress=3 D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:11 +0530] [Job 85] Printing page 1, 4% D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 4%", current level=INFO D [06/Dec/2012:20:47:11 +0530] [Job 85] ATTR: job-media-progress=4 D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:11 +0530] [Job 85] Printing page 1, 5% D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 5%", current level=INFO D [06/Dec/2012:20:47:11 +0530] [Job 85] ATTR: job-media-progress=5 D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:11 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:11 +0530] [Client 15] 2.0 Get-Notifications 188 D [06/Dec/2012:20:47:11 +0530] Get-Notifications / D [06/Dec/2012:20:47:11 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:11 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:11 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:11 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:11 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 6% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 6%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=6 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 7% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 7%", current level=INFO D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=7 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 189 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 8% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 8%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=8 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 190 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 9% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 9%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=9 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 191 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 10% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 10%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=10 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 192 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 11% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 11%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=11 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 193 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 12% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 12%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=12 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 194 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 13% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 13%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=13 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 195 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 14% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 14%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=14 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 196 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 15% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 15%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=15 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 197 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 16% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 16%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=16 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 198 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 17% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 17%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=17 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 18% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 18%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=18 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 199 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 19% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 19%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=19 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 200 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 20% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 20%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=20 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 201 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 21% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 21%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=21 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 202 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 22% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 22%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=22 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 203 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [06/Dec/2012:20:47:12 +0530] [Job 85] Printing page 1, 23% D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Job 85] Set job-printer-state-message to "Printing page 1, 23%", current level=INFO D [06/Dec/2012:20:47:12 +0530] [Job 85] ATTR: job-media-progress=23 D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 204 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 205 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 206 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 207 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 208 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 209 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 210 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:12 +0530] [Client 15] POST / HTTP/1.1 D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] No authentication data provided. D [06/Dec/2012:20:47:12 +0530] [Client 15] 2.0 Get-Notifications 211 D [06/Dec/2012:20:47:12 +0530] Get-Notifications / D [06/Dec/2012:20:47:12 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:12 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:12 +0530] [Client 15] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:12 +0530] [Client 15] Closing connection. D [06/Dec/2012:20:47:12 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 14] GET /printers/MP250 HTTP/1.1 D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 14] Authorized as root using Basic D [06/Dec/2012:20:47:13 +0530] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[8] = "HOME=/var/spool/cups/tmp" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[10] = "SERVER_ADMIN=root@laptop" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[11] = "SOFTWARE=CUPS/1.6.1" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[13] = "USER=root" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[15] = "CUPS_SERVER=/var/run/cups/cups.sock" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[17] = "IPP_PORT=631" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[18] = "AUTH_TYPE=Basic" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[19] = "LANG=en_US.UTF8" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[20] = "REDIRECT_STATUS=1" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[22] = "SERVER_NAME=localhost" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[23] = "SERVER_PORT=631" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[24] = "REMOTE_ADDR=[v1.::1]" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[25] = "REMOTE_HOST=localhost" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[26] = "SCRIPT_NAME=/printers/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc/printers/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[28] = "PATH_INFO=/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[29] = "REMOTE_USER=root" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[30] = "SERVER_PROTOCOL=HTTP/1.1" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[31] = "HTTP_COOKIE=org.cups.sid=4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[32] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.11 (KHTML, like Gecko) Chrome/23.0.1271.95 Safari/537.11" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[33] = "HTTP_REFERER=http://localhost:631/printers/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[34] = "REQUEST_METHOD=GET" D [06/Dec/2012:20:47:13 +0530] [CGI] envp[35] = "QUERY_STRING=" D [06/Dec/2012:20:47:13 +0530] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 3318) I [06/Dec/2012:20:47:13 +0530] [Client 14] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=3318) D [06/Dec/2012:20:47:13 +0530] [Client 14] file=15 D [06/Dec/2012:20:47:13 +0530] [CGI] org.cups.sid cookie is "4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: SECTION="printers" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: REFRESH_PAGE="" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: PRINTER_NAME="MP250" D [06/Dec/2012:20:47:13 +0530] [Client 16] Accepted from localhost (Domain) D [06/Dec/2012:20:47:13 +0530] [Client 16] POST / HTTP/1.1 D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 16] No authentication data provided. D [06/Dec/2012:20:47:13 +0530] [Client 16] 2.0 CUPS-Get-Default 1 D [06/Dec/2012:20:47:13 +0530] CUPS-Get-Default D [06/Dec/2012:20:47:13 +0530] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: DEFAULT_NAME="MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: DEFAULT_URI="/printers/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] show_printer(http=0x7f571f55dcd0, printer="MP250") D [06/Dec/2012:20:47:13 +0530] [Client 16] POST / HTTP/1.1 D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 16] No authentication data provided. D [06/Dec/2012:20:47:13 +0530] [Client 16] 2.0 Get-Printer-Attributes 2 D [06/Dec/2012:20:47:13 +0530] Get-Printer-Attributes ipp://localhost/printers/MP250 D [06/Dec/2012:20:47:13 +0530] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/MP250) from localhost D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: printer_is_accepting_jobs[0]="1" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: printer_is_shared[0]="0" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: printer_state[0]="4" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: admin_uri[0]="/admin/" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: printer_uri_supported[0]="/printers/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: printer_name[0]="MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: printer_location[0]="Local Printer" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: printer_info[0]="Canon MP250 series" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: job_sheets_default[0]="none, none" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: device_uri[0]="cnijusb:/dev/usb/lp1" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: color_supported[0]="1" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: printer_make_and_model[0]="Canon PIXMA MP250 - CUPS+Gutenprint v5.2.9" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: media_default[0]="iso_a4_210x297mm" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: sides_supported[0]="one-sided, two-sided-long-edge, two-sided-short-edge" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: sides_default[0]="one-sided" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: printer_commands[0]="none" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: server_is_sharing_printers[0]="0" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: refresh_page="10;URL=/printers/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: TITLE="MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:13 +0530] Script header: Content-Type: text/html;charset=utf-8 D [06/Dec/2012:20:47:13 +0530] Script header: D [06/Dec/2012:20:47:13 +0530] [CGI] Regular expression ".*Clean.*" D [06/Dec/2012:20:47:13 +0530] [CGI] Regular expression ".*PrintSelfTestPage.*" D [06/Dec/2012:20:47:13 +0530] [Client 16] POST / HTTP/1.1 D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 16] No authentication data provided. D [06/Dec/2012:20:47:13 +0530] [Client 16] 2.0 Get-Jobs 3 D [06/Dec/2012:20:47:13 +0530] Get-Jobs ipp://localhost:631/printers/MP250 D [06/Dec/2012:20:47:13 +0530] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/MP250) from localhost D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiClearVariables called. D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: ORDER="asc" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: SECTION="printers" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: TOTAL="1" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: job_printer_name[0]="MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: job_printer_uri[0]="/printers/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: time_at_creation[0]="Thu 06 Dec 2012 08:47:11 PM IST" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: time_at_processing[0]="Thu 06 Dec 2012 08:47:11 PM IST" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: time_at_completed[0]="novalue" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: job_id[0]="85" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: job_state[0]="5" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: job_media_sheets_completed[0]="1" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: job_k_octets[0]="1" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetArray: job_printer_state_message[0]="Printing page 1, 23%" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: PRINTER_NAME="MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: PRINTER_URI_SUPPORTED="/printers/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: THISURL="/printers/MP250" D [06/Dec/2012:20:47:13 +0530] [CGI] cgiSetVariable: SEARCH_DEST="MP250" D [06/Dec/2012:20:47:13 +0530] [Client 16] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:13 +0530] [Client 16] Closing connection. D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] PID 3318 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors. D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 14] GET /cups.css HTTP/1.1 D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 14] Authorized as root using Basic D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 15] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:13 +0530] [Client 16] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:13 +0530] [Client 15] GET /images/left.gif HTTP/1.1 D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 15] Authorized as root using Basic D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 16] GET /images/right.gif HTTP/1.1 D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:13 +0530] [Client 16] Authorized as root using Basic D [06/Dec/2012:20:47:13 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 16] GET /printers/MP250 HTTP/1.1 D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 16] Authorized as root using Basic D [06/Dec/2012:20:47:23 +0530] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[8] = "HOME=/var/spool/cups/tmp" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[10] = "SERVER_ADMIN=root@laptop" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[11] = "SOFTWARE=CUPS/1.6.1" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[13] = "USER=root" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[15] = "CUPS_SERVER=/var/run/cups/cups.sock" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[17] = "IPP_PORT=631" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[18] = "AUTH_TYPE=Basic" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[19] = "LANG=en_US.UTF8" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[20] = "REDIRECT_STATUS=1" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[22] = "SERVER_NAME=localhost" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[23] = "SERVER_PORT=631" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[24] = "REMOTE_ADDR=[v1.::1]" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[25] = "REMOTE_HOST=localhost" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[26] = "SCRIPT_NAME=/printers/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc/printers/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[28] = "PATH_INFO=/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[29] = "REMOTE_USER=root" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[30] = "SERVER_PROTOCOL=HTTP/1.1" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[31] = "HTTP_COOKIE=org.cups.sid=4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[32] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.11 (KHTML, like Gecko) Chrome/23.0.1271.95 Safari/537.11" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[33] = "HTTP_REFERER=http://localhost:631/printers/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[34] = "REQUEST_METHOD=GET" D [06/Dec/2012:20:47:23 +0530] [CGI] envp[35] = "QUERY_STRING=" D [06/Dec/2012:20:47:23 +0530] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 3319) I [06/Dec/2012:20:47:23 +0530] [Client 16] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=3319) D [06/Dec/2012:20:47:23 +0530] [Client 16] file=18 D [06/Dec/2012:20:47:23 +0530] [CGI] org.cups.sid cookie is "4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: SECTION="printers" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: REFRESH_PAGE="" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: PRINTER_NAME="MP250" D [06/Dec/2012:20:47:23 +0530] [Client 19] Accepted from localhost (Domain) D [06/Dec/2012:20:47:23 +0530] [Client 19] POST / HTTP/1.1 D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 19] No authentication data provided. D [06/Dec/2012:20:47:23 +0530] [Client 19] 2.0 CUPS-Get-Default 1 D [06/Dec/2012:20:47:23 +0530] CUPS-Get-Default D [06/Dec/2012:20:47:23 +0530] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: DEFAULT_NAME="MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: DEFAULT_URI="/printers/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] show_printer(http=0x7f80fa324cd0, printer="MP250") D [06/Dec/2012:20:47:23 +0530] [Client 19] POST / HTTP/1.1 D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 19] No authentication data provided. D [06/Dec/2012:20:47:23 +0530] [Client 19] 2.0 Get-Printer-Attributes 2 D [06/Dec/2012:20:47:23 +0530] Get-Printer-Attributes ipp://localhost/printers/MP250 D [06/Dec/2012:20:47:23 +0530] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/MP250) from localhost D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: printer_is_accepting_jobs[0]="1" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: printer_is_shared[0]="0" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: printer_state[0]="4" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: admin_uri[0]="/admin/" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: printer_uri_supported[0]="/printers/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: printer_name[0]="MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: printer_location[0]="Local Printer" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: printer_info[0]="Canon MP250 series" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: job_sheets_default[0]="none, none" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: device_uri[0]="cnijusb:/dev/usb/lp1" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: color_supported[0]="1" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: printer_make_and_model[0]="Canon PIXMA MP250 - CUPS+Gutenprint v5.2.9" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: media_default[0]="iso_a4_210x297mm" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: sides_supported[0]="one-sided, two-sided-long-edge, two-sided-short-edge" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: sides_default[0]="one-sided" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: printer_commands[0]="none" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: server_is_sharing_printers[0]="0" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: refresh_page="10;URL=/printers/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: TITLE="MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:23 +0530] Script header: Content-Type: text/html;charset=utf-8 D [06/Dec/2012:20:47:23 +0530] Script header: D [06/Dec/2012:20:47:23 +0530] [CGI] Regular expression ".*Clean.*" D [06/Dec/2012:20:47:23 +0530] [CGI] Regular expression ".*PrintSelfTestPage.*" D [06/Dec/2012:20:47:23 +0530] [Client 19] POST / HTTP/1.1 D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 19] No authentication data provided. D [06/Dec/2012:20:47:23 +0530] [Client 19] 2.0 Get-Jobs 3 D [06/Dec/2012:20:47:23 +0530] Get-Jobs ipp://localhost:631/printers/MP250 D [06/Dec/2012:20:47:23 +0530] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/MP250) from localhost D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiClearVariables called. D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: ORDER="asc" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: SECTION="printers" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: TOTAL="1" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: job_printer_name[0]="MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: job_printer_uri[0]="/printers/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: time_at_creation[0]="Thu 06 Dec 2012 08:47:11 PM IST" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: time_at_processing[0]="Thu 06 Dec 2012 08:47:11 PM IST" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: time_at_completed[0]="novalue" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: job_id[0]="85" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: job_state[0]="5" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: job_media_sheets_completed[0]="1" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: job_k_octets[0]="1" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetArray: job_printer_state_message[0]="Printing page 1, 23%" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: PRINTER_NAME="MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: PRINTER_URI_SUPPORTED="/printers/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: THISURL="/printers/MP250" D [06/Dec/2012:20:47:23 +0530] [CGI] cgiSetVariable: SEARCH_DEST="MP250" D [06/Dec/2012:20:47:23 +0530] [Client 19] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:23 +0530] [Client 19] Closing connection. D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] PID 3319 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors. D [06/Dec/2012:20:47:23 +0530] [Client 16] GET /cups.css HTTP/1.1 D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 16] Authorized as root using Basic D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 15] GET /images/left.gif HTTP/1.1 D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 15] Authorized as root using Basic D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 14] GET /images/right.gif HTTP/1.1 D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:23 +0530] [Client 14] Authorized as root using Basic D [06/Dec/2012:20:47:23 +0530] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:29 +0530] [Client 14] POST /printers/MP250 HTTP/1.1 D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [06/Dec/2012:20:47:29 +0530] [Client 14] Authorized as root using Basic D [06/Dec/2012:20:47:29 +0530] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[8] = "HOME=/var/spool/cups/tmp" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[10] = "SERVER_ADMIN=root@laptop" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[11] = "SOFTWARE=CUPS/1.6.1" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[13] = "USER=root" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[15] = "CUPS_SERVER=/var/run/cups/cups.sock" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[17] = "IPP_PORT=631" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[18] = "AUTH_TYPE=Basic" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[19] = "LANG=en_US.UTF8" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[20] = "REDIRECT_STATUS=1" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[22] = "SERVER_NAME=localhost" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[23] = "SERVER_PORT=631" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[24] = "REMOTE_ADDR=[v1.::1]" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[25] = "REMOTE_HOST=localhost" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[26] = "SCRIPT_NAME=/printers/MP250" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc/printers/MP250" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[28] = "PATH_INFO=/MP250" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[29] = "REMOTE_USER=root" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[30] = "SERVER_PROTOCOL=HTTP/1.1" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[31] = "HTTP_COOKIE=org.cups.sid=4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[32] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.11 (KHTML, like Gecko) Chrome/23.0.1271.95 Safari/537.11" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[33] = "HTTP_REFERER=http://localhost:631/printers/MP250" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[34] = "REQUEST_METHOD=POST" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[35] = "CONTENT_LENGTH=59" D [06/Dec/2012:20:47:29 +0530] [CGI] envp[36] = "CONTENT_TYPE=application/x-www-form-urlencoded" D [06/Dec/2012:20:47:29 +0530] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 3320) I [06/Dec/2012:20:47:29 +0530] [Client 14] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=3320) D [06/Dec/2012:20:47:29 +0530] [Client 14] file=19 D [06/Dec/2012:20:47:29 +0530] [CGI] org.cups.sid cookie is "4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: org.cups.sid="4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: OP="purge-jobs" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: SECTION="printers" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: REFRESH_PAGE="" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: PRINTER_NAME="MP250" D [06/Dec/2012:20:47:29 +0530] [Client 18] Accepted from localhost (Domain) D [06/Dec/2012:20:47:29 +0530] [Client 18] POST /printers/MP250 HTTP/1.1 D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:29 +0530] [Client 18] No authentication data provided. D [06/Dec/2012:20:47:29 +0530] [Client 18] 2.0 Purge-Jobs 1 D [06/Dec/2012:20:47:29 +0530] Purge-Jobs ipp://localhost/printers/MP250 D [06/Dec/2012:20:47:29 +0530] Returning HTTP Unauthorized for Purge-Jobs (ipp://localhost/printers/MP250) from localhost D [06/Dec/2012:20:47:29 +0530] [Client 18] WWW-Authenticate: Basic realm="CUPS", trc="y" D [06/Dec/2012:20:47:29 +0530] [Client 18] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:29 +0530] [Client 18] Closing connection. D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:29 +0530] [Client 18] Accepted from localhost (Domain) D [06/Dec/2012:20:47:29 +0530] [Client 20] Accepted from localhost (Domain) D [06/Dec/2012:20:47:29 +0530] [Client 18] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:29 +0530] [Client 18] Closing connection. D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:29 +0530] [Client 20] POST /printers/MP250 HTTP/1.1 D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:29 +0530] [Client 20] Authorized as root using Local D [06/Dec/2012:20:47:29 +0530] [Client 20] 2.0 Purge-Jobs 1 D [06/Dec/2012:20:47:29 +0530] Purge-Jobs ipp://localhost/printers/MP250 D [06/Dec/2012:20:47:29 +0530] cupsdIsAuthorized: username="root" D [06/Dec/2012:20:47:29 +0530] [Job 85] time-at-completed=1354807049 D [06/Dec/2012:20:47:29 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" I [06/Dec/2012:20:47:29 +0530] [Job 85] Job purged by user. D [06/Dec/2012:20:47:29 +0530] cupsdMarkDirty(----S) D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:29 +0530] cupsdMarkDirty(---J-) D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients, printing jobs, and dirty files" I [06/Dec/2012:20:47:29 +0530] All jobs on "MP250" were purged by "root". D [06/Dec/2012:20:47:29 +0530] Returning IPP successful-ok for Purge-Jobs (ipp://localhost/printers/MP250) from localhost D [06/Dec/2012:20:47:29 +0530] [Job 85] PID 3314 (/usr/lib/cups/backend/cnijusb) was terminated normally with signal 9. D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: refresh_page="5;URL=/printers/MP250" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: TITLE="Purge Jobs" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:29 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:29 +0530] Script header: Content-Type: text/html;charset=utf-8 D [06/Dec/2012:20:47:29 +0530] Script header: D [06/Dec/2012:20:47:29 +0530] [Client 20] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:29 +0530] [Client 20] Closing connection. D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:29 +0530] [Job 85] PID 3313 (/usr/lib/cups/filter/rastertogutenprint.5.2) was terminated normally with signal 9. D [06/Dec/2012:20:47:29 +0530] [Job 85] PID 3312 (/usr/lib/cups/filter/pdftoraster) was terminated normally with signal 9. D [06/Dec/2012:20:47:29 +0530] PID 3320 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors. D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:29 +0530] [Client 17] Accepted from localhost:631 (IPv6) D [06/Dec/2012:20:47:29 +0530] [Client 17] POST / HTTP/1.1 D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [06/Dec/2012:20:47:29 +0530] [Client 17] No authentication data provided. D [06/Dec/2012:20:47:29 +0530] [Client 17] 2.0 Get-Notifications 212 D [06/Dec/2012:20:47:29 +0530] Get-Notifications / D [06/Dec/2012:20:47:29 +0530] cupsdIsAuthorized: requesting-user-name="phani" D [06/Dec/2012:20:47:29 +0530] Returning IPP successful-ok for Get-Notifications (/) from localhost D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:29 +0530] [Client 17] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:29 +0530] [Client 17] Closing connection. D [06/Dec/2012:20:47:29 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" D [06/Dec/2012:20:47:30 +0530] [Job 85] Unloading... D [06/Dec/2012:20:47:30 +0530] [Client 14] GET /printers/MP250 HTTP/1.1 D [06/Dec/2012:20:47:30 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [06/Dec/2012:20:47:30 +0530] [Client 14] Authorized as root using Basic D [06/Dec/2012:20:47:30 +0530] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[8] = "HOME=/var/spool/cups/tmp" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[10] = "SERVER_ADMIN=root@laptop" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[11] = "SOFTWARE=CUPS/1.6.1" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[13] = "USER=root" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[15] = "CUPS_SERVER=/var/run/cups/cups.sock" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[17] = "IPP_PORT=631" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[18] = "AUTH_TYPE=Basic" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[19] = "LANG=en_US.UTF8" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[20] = "REDIRECT_STATUS=1" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[22] = "SERVER_NAME=localhost" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[23] = "SERVER_PORT=631" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[24] = "REMOTE_ADDR=[v1.::1]" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[25] = "REMOTE_HOST=localhost" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[26] = "SCRIPT_NAME=/printers/MP250" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc/printers/MP250" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[28] = "PATH_INFO=/MP250" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[29] = "REMOTE_USER=root" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[30] = "SERVER_PROTOCOL=HTTP/1.1" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[31] = "HTTP_COOKIE=org.cups.sid=4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[32] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.11 (KHTML, like Gecko) Chrome/23.0.1271.95 Safari/537.11" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[33] = "HTTP_REFERER=http://localhost:631/printers/MP250" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[34] = "REQUEST_METHOD=GET" D [06/Dec/2012:20:47:30 +0530] [CGI] envp[35] = "QUERY_STRING=" D [06/Dec/2012:20:47:30 +0530] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 3321) I [06/Dec/2012:20:47:30 +0530] [Client 14] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=3321) D [06/Dec/2012:20:47:30 +0530] [Client 14] file=17 D [06/Dec/2012:20:47:31 +0530] [CGI] org.cups.sid cookie is "4fb1c3e15a720b96e5bac7e6dba5e186" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: SECTION="printers" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: REFRESH_PAGE="" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: PRINTER_NAME="MP250" D [06/Dec/2012:20:47:31 +0530] [Client 18] Accepted from localhost (Domain) D [06/Dec/2012:20:47:31 +0530] [Client 18] POST / HTTP/1.1 D [06/Dec/2012:20:47:31 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:31 +0530] [Client 18] No authentication data provided. D [06/Dec/2012:20:47:31 +0530] [Client 18] 2.0 CUPS-Get-Default 1 D [06/Dec/2012:20:47:31 +0530] CUPS-Get-Default D [06/Dec/2012:20:47:31 +0530] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost D [06/Dec/2012:20:47:31 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: DEFAULT_NAME="MP250" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: DEFAULT_URI="/printers/MP250" D [06/Dec/2012:20:47:31 +0530] [CGI] show_printer(http=0x7f05f726acd0, printer="MP250") D [06/Dec/2012:20:47:31 +0530] [Client 18] POST / HTTP/1.1 D [06/Dec/2012:20:47:31 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:31 +0530] [Client 18] No authentication data provided. D [06/Dec/2012:20:47:31 +0530] [Client 18] 2.0 Get-Printer-Attributes 2 D [06/Dec/2012:20:47:31 +0530] Get-Printer-Attributes ipp://localhost/printers/MP250 D [06/Dec/2012:20:47:31 +0530] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/MP250) from localhost D [06/Dec/2012:20:47:31 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: printer_is_accepting_jobs[0]="1" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: printer_is_shared[0]="0" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: printer_state[0]="3" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: admin_uri[0]="/admin/" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: printer_uri_supported[0]="/printers/MP250" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: printer_name[0]="MP250" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: printer_location[0]="Local Printer" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: printer_info[0]="Canon MP250 series" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: job_sheets_default[0]="none, none" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: device_uri[0]="cnijusb:/dev/usb/lp1" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: color_supported[0]="1" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: printer_make_and_model[0]="Canon PIXMA MP250 - CUPS+Gutenprint v5.2.9" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: media_default[0]="iso_a4_210x297mm" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: sides_supported[0]="one-sided, two-sided-long-edge, two-sided-short-edge" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: sides_default[0]="one-sided" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: printer_commands[0]="none" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetArray: server_is_sharing_printers[0]="0" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: TITLE="MP250" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: SERVER_NAME="localhost" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: REMOTE_USER="root" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.1" D [06/Dec/2012:20:47:31 +0530] Script header: Content-Type: text/html;charset=utf-8 D [06/Dec/2012:20:47:31 +0530] Script header: D [06/Dec/2012:20:47:31 +0530] [CGI] Regular expression ".*Clean.*" D [06/Dec/2012:20:47:31 +0530] [CGI] Regular expression ".*PrintSelfTestPage.*" D [06/Dec/2012:20:47:31 +0530] [Client 18] POST / HTTP/1.1 D [06/Dec/2012:20:47:31 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:31 +0530] [Client 18] No authentication data provided. D [06/Dec/2012:20:47:31 +0530] [Client 18] 2.0 Get-Jobs 3 D [06/Dec/2012:20:47:31 +0530] Get-Jobs ipp://localhost:631/printers/MP250 D [06/Dec/2012:20:47:31 +0530] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/MP250) from localhost D [06/Dec/2012:20:47:31 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiClearVariables called. D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: ORDER="asc" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: SECTION="printers" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: TOTAL="0" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: PRINTER_NAME="MP250" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: PRINTER_URI_SUPPORTED="/printers/MP250" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: THISURL="/printers/MP250" D [06/Dec/2012:20:47:31 +0530] [CGI] cgiSetVariable: SEARCH_DEST="MP250" D [06/Dec/2012:20:47:31 +0530] [Client 18] HTTP_WAITING Closing on EOF D [06/Dec/2012:20:47:31 +0530] [Client 18] Closing connection. D [06/Dec/2012:20:47:31 +0530] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [06/Dec/2012:20:47:31 +0530] PID 3321 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors. D [06/Dec/2012:20:47:31 +0530] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"