You are not logged in.

Pages: 1

#1 2014-01-30 21:02:37

Yaro
Member
Registered: 2009-04-03
Posts: 154

[SOLVED]Canon D1100 Series UFRII LT doesn't print, CUPS thinks it does

Hello everyone,

I have been struggling getting a network printer at work working with my laptop. I installed the driver from Canon's web site, and everything seems to be fine on my end, but the network printer doesn't print anything I give it. I can't find the issue in my log after running the following command:

echo "This is a test. Hello world." | lpr -p

Here's the output from the error log:

D [30/Jan/2014:14:52:31 -0600] [Client 14] 2.0 Create-Job 2
D [30/Jan/2014:14:52:31 -0600] Create-Job ipp://localhost:631/printers/Canon_D1150_D1170
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [30/Jan/2014:14:52:31 -0600] add_job: requesting-user-name="yaro"
I [30/Jan/2014:14:52:31 -0600] [Job 15] Adding start banner page "none".
D [30/Jan/2014:14:52:31 -0600] Discarding unused job-created event...
I [30/Jan/2014:14:52:31 -0600] [Job 15] Queued on "Canon_D1150_D1170" by "yaro".
D [30/Jan/2014:14:52:31 -0600] [Client 14] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/Canon_D1150_D1170) from localhost
D [30/Jan/2014:14:52:31 -0600] [Client 14] Content-Length: 179
D [30/Jan/2014:14:52:31 -0600] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=179, response=0x7f8adff8f1e0(IPP_IDLE), pipe_pid=0, file=-1
D [30/Jan/2014:14:52:31 -0600] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [30/Jan/2014:14:52:31 -0600] [Client 14] bytes=0, http_state=0, data_remaining=0
D [30/Jan/2014:14:52:31 -0600] [Client 14] Waiting for request.
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [30/Jan/2014:14:52:31 -0600] [Client 14] POST /printers/Canon_D1150_D1170 HTTP/1.1
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [30/Jan/2014:14:52:31 -0600] [Client 14] No authentication data provided.
D [30/Jan/2014:14:52:31 -0600] [Client 14] 2.0 Send-Document 3
D [30/Jan/2014:14:52:31 -0600] Send-Document ipp://localhost:631/printers/Canon_D1150_D1170
D [30/Jan/2014:14:52:31 -0600] cupsdIsAuthorized: requesting-user-name="yaro"
D [30/Jan/2014:14:52:31 -0600] [Job 15] Auto-typing file...
D [30/Jan/2014:14:52:31 -0600] [Job 15] Request file type is text/plain.
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [30/Jan/2014:14:52:31 -0600] [Job 15] File of type text/plain queued by "yaro".
I [30/Jan/2014:14:52:31 -0600] [Job 15] Adding end banner page "none".
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [30/Jan/2014:14:52:31 -0600] [Job 15] time-at-processing=1391115151
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [30/Jan/2014:14:52:31 -0600] Discarding unused printer-state-changed event...
D [30/Jan/2014:14:52:31 -0600] [Job 15] 4 filters for job:
D [30/Jan/2014:14:52:31 -0600] [Job 15] texttopdf (text/plain to application/pdf, cost 32)
D [30/Jan/2014:14:52:31 -0600] [Job 15] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [30/Jan/2014:14:52:31 -0600] [Job 15] pdftops (application/vnd.cups-pdf to application/vnd.cups-postscript, cost 100)
D [30/Jan/2014:14:52:31 -0600] [Job 15] pstoufr2cpca (application/vnd.cups-postscript to printer/Canon_D1150_D1170, cost 0)
D [30/Jan/2014:14:52:31 -0600] [Job 15] job-sheets=none,none
D [30/Jan/2014:14:52:31 -0600] [Job 15] argv[0]="Canon_D1150_D1170"
D [30/Jan/2014:14:52:31 -0600] [Job 15] argv[1]="15"
D [30/Jan/2014:14:52:31 -0600] [Job 15] argv[2]="yaro"
D [30/Jan/2014:14:52:31 -0600] [Job 15] argv[3]="(stdin)"
D [30/Jan/2014:14:52:31 -0600] [Job 15] argv[4]="1"
D [30/Jan/2014:14:52:31 -0600] [Job 15] argv[5]="finishings=3 number-up=1 prettyprint job-uuid=urn:uuid:9566668d-244b-32ad-4b26-afeeb081bd7f job-originating-host-name=localhost time-at-creation=1391115151 time-at-processing=1391115151"
D [30/Jan/2014:14:52:31 -0600] [Job 15] argv[6]="/var/spool/cups/d00015-001"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[7]="CUPS_STATEDIR=/run/cups"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[8]="HOME=/var/spool/cups/tmp"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[10]="SERVER_ADMIN=root@spike"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[11]="SOFTWARE=CUPS/1.7.1"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[13]="USER=root"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[14]="CUPS_MAX_MESSAGE=2047"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[15]="CUPS_SERVER=/run/cups/cups.sock"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[17]="IPP_PORT=631"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[18]="CHARSET=utf-8"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[19]="LANG=en.UTF-8"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[20]="PPD=/etc/cups/ppd/Canon_D1150_D1170.ppd"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[21]="RIP_MAX_CACHE=128m"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[22]="CONTENT_TYPE=text/plain"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[23]="DEVICE_URI=socket://192.168.2.51"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[24]="PRINTER_INFO=Canon D1150/D1170"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[25]="PRINTER_LOCATION="
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[26]="PRINTER=Canon_D1150_D1170"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[27]="PRINTER_STATE_REASONS=none"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[28]="CUPS_FILETYPE=document"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[29]="FINAL_CONTENT_TYPE=printer/Canon_D1150_D1170"
D [30/Jan/2014:14:52:31 -0600] [Job 15] envp[30]="AUTH_I****"
I [30/Jan/2014:14:52:31 -0600] [Job 15] Started filter /usr/lib/cups/filter/texttopdf (PID 5140)
I [30/Jan/2014:14:52:31 -0600] [Job 15] Started filter /usr/lib/cups/filter/pdftopdf (PID 5141)
I [30/Jan/2014:14:52:31 -0600] [Job 15] Started filter /usr/lib/cups/filter/pdftops (PID 5142)
I [30/Jan/2014:14:52:31 -0600] [Job 15] Started filter /usr/lib/cups/filter/pstoufr2cpca (PID 5143)
I [30/Jan/2014:14:52:31 -0600] [Job 15] Started backend /usr/lib/cups/backend/socket (PID 5144)
D [30/Jan/2014:14:52:31 -0600] Discarding unused job-state-changed event...
D [30/Jan/2014:14:52:31 -0600] [Client 14] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/Canon_D1150_D1170) from localhost
D [30/Jan/2014:14:52:31 -0600] [Client 14] Content-Length: 171
D [30/Jan/2014:14:52:31 -0600] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=171, response=0x7f8adff825e0(IPP_IDLE), pipe_pid=0, file=-1
D [30/Jan/2014:14:52:31 -0600] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [30/Jan/2014:14:52:31 -0600] [Client 14] bytes=0, http_state=0, data_remaining=0
D [30/Jan/2014:14:52:31 -0600] [Client 14] Waiting for request.
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [30/Jan/2014:14:52:31 -0600] [Client 14] HTTP_STATE_WAITING Closing on EOF
D [30/Jan/2014:14:52:31 -0600] [Client 14] Closing connection.
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [30/Jan/2014:14:52:31 -0600] [Job 15] Page = 612x792; 14,14 to 598,778
D [30/Jan/2014:14:52:31 -0600] [Job 15] STATE: +connecting-to-device
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [30/Jan/2014:14:52:31 -0600] [Job 15] Looking up "192.168.2.51"...
D [30/Jan/2014:14:52:31 -0600] [Job 15] pstoufr2cpca start.
D [30/Jan/2014:14:52:31 -0600] Discarding unused printer-state-changed event...
D [30/Jan/2014:14:52:31 -0600] [Job 15] pdftops - copying to temp print file "/var/spool/cups/tmp/0141652eb6fae"
D [30/Jan/2014:14:52:31 -0600] [Job 15] prtGeneralCurrentLocalization type is 5, expected 2!
D [30/Jan/2014:14:52:31 -0600] [Job 15] backendWaitLoop(snmp_fd=5, addr=0x7f63fcee8c88, side_cb=0x7f63fb5631e0)
D [30/Jan/2014:14:52:31 -0600] [Job 15] PID 5140 (/usr/lib/cups/filter/texttopdf) exited with no errors.
D [30/Jan/2014:14:52:31 -0600] [Job 15] PID 5141 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [30/Jan/2014:14:52:31 -0600] [Job 15] Printer make and model: Canon d1100
D [30/Jan/2014:14:52:31 -0600] [Job 15] Using image rendering resolution 600 dpi
D [30/Jan/2014:14:52:31 -0600] [Job 15] Started filter gs (PID 5149)
D [30/Jan/2014:14:52:31 -0600] [Job 15] Started filter pstops (PID 5150)
D [30/Jan/2014:14:52:31 -0600] [Job 15] Page = 612x792; 14,14 to 598,778
D [30/Jan/2014:14:52:31 -0600] [Job 15] slow_collate=0, slow_duplex=0, slow_order=0
D [30/Jan/2014:14:52:31 -0600] [Job 15] Before copy_comments - %!PS-Adobe-3.0
D [30/Jan/2014:14:52:31 -0600] [Job 15] %!PS-Adobe-3.0
D [30/Jan/2014:14:52:31 -0600] [Job 15] %%BoundingBox: 0 0 612 792
D [30/Jan/2014:14:52:31 -0600] [Job 15] %%HiResBoundingBox: 0 0 612.00 792.00
D [30/Jan/2014:14:52:31 -0600] [Job 15] %%Creator: GPL Ghostscript 910 (ps2write)
D [30/Jan/2014:14:52:31 -0600] [Job 15] %%LanguageLevel: 2
D [30/Jan/2014:14:52:31 -0600] [Job 15] %%CreationDate: D:20140130145231-06'00'
D [30/Jan/2014:14:52:31 -0600] [Job 15] %%Pages: 1
D [30/Jan/2014:14:52:31 -0600] [Job 15] %%EndComments
D [30/Jan/2014:14:52:31 -0600] [Job 15] Before copy_prolog - %%BeginProlog
D [30/Jan/2014:14:52:31 -0600] [Job 15] Before copy_setup - %%Page: 1 1
D [30/Jan/2014:14:52:31 -0600] [Job 15] Before page loop - %%Page: 1 1
D [30/Jan/2014:14:52:31 -0600] [Job 15] Copying page 1...
D [30/Jan/2014:14:52:31 -0600] [Job 15] pagew = 583.7, pagel = 763.7
D [30/Jan/2014:14:52:31 -0600] [Job 15] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [30/Jan/2014:14:52:31 -0600] [Job 15] PageLeft = 14.2, PageRight = 597.8
D [30/Jan/2014:14:52:31 -0600] [Job 15] PageTop = 777.8, PageBottom = 14.2
D [30/Jan/2014:14:52:31 -0600] [Job 15] PageWidth = 612.0, PageLength = 792.0
D [30/Jan/2014:14:52:31 -0600] [Job 15] Wrote 1 pages...
D [30/Jan/2014:14:52:31 -0600] [Job 15] PID 5150 (pstops) exited with no errors.
D [30/Jan/2014:14:52:31 -0600] [Job 15] PID 5149 (gs) exited with no errors.
D [30/Jan/2014:14:52:31 -0600] [Job 15] PID 5142 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [30/Jan/2014:14:52:31 -0600] [Job 15] opvpOpenPrinter(410)
D [30/Jan/2014:14:52:31 -0600] [Job 15] CStubOpenPrinter(349)
D [30/Jan/2014:14:52:31 -0600] [Job 15] Error Response:ReqNo=0, SeqNo=1,opvpErrorNo=-1
D [30/Jan/2014:14:52:31 -0600] [Job 15] Connecting to 192.168.2.51:9100
I [30/Jan/2014:14:52:31 -0600] [Job 15] Connecting to printer.
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [30/Jan/2014:14:52:31 -0600] [Job 15] Set job-printer-state-message to "Connecting to printer.", current level=INFO
D [30/Jan/2014:14:52:31 -0600] Discarding unused job-progress event...
D [30/Jan/2014:14:52:31 -0600] Discarding unused printer-state-changed event...
D [30/Jan/2014:14:52:31 -0600] [Job 15] STATE: -connecting-to-device
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [30/Jan/2014:14:52:31 -0600] Discarding unused printer-state-changed event...
I [30/Jan/2014:14:52:31 -0600] [Job 15] Connected to printer.
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [30/Jan/2014:14:52:31 -0600] [Job 15] Set job-printer-state-message to "Connected to printer.", current level=INFO
D [30/Jan/2014:14:52:31 -0600] [Job 15] Connected to 192.168.2.51:9100...
D [30/Jan/2014:14:52:31 -0600] [Job 15] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x7f63fcee8c88, use_bc=1, side_cb=0x7f63fb5631e0)
D [30/Jan/2014:14:52:31 -0600] Discarding unused job-progress event...
D [30/Jan/2014:14:52:31 -0600] Discarding unused printer-state-changed event...
D [30/Jan/2014:14:52:31 -0600] [Job 15] PID 5143 (/usr/lib/cups/filter/pstoufr2cpca) did not catch or ignore signal 13.
I [30/Jan/2014:14:52:31 -0600] [Job 15] Waiting for printer to finish.
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [30/Jan/2014:14:52:31 -0600] [Job 15] Set job-printer-state-message to "Waiting for printer to finish.", current level=INFO
D [30/Jan/2014:14:52:31 -0600] Discarding unused job-progress event...
D [30/Jan/2014:14:52:31 -0600] Discarding unused printer-state-changed event...
D [30/Jan/2014:14:52:31 -0600] [Job 15] PID 5144 (/usr/lib/cups/backend/socket) exited with no errors.
D [30/Jan/2014:14:52:31 -0600] [Job 15] time-at-completed=1391115151
D [30/Jan/2014:14:52:31 -0600] Discarding unused job-completed event...
I [30/Jan/2014:14:52:31 -0600] [Job 15] Job completed.
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [30/Jan/2014:14:52:31 -0600] Discarding unused printer-state-changed event...
D [30/Jan/2014:14:52:31 -0600] cupsdMarkDirty(---J-)
D [30/Jan/2014:14:52:31 -0600] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [30/Jan/2014:14:52:32 -0600] [Job 15] Unloading...
I [30/Jan/2014:14:53:02 -0600] Saving job.cache...
D [30/Jan/2014:14:53:02 -0600] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files"
D [30/Jan/2014:14:53:02 -0600] Report: clients=0
D [30/Jan/2014:14:53:02 -0600] Report: jobs=8
D [30/Jan/2014:14:53:02 -0600] Report: jobs-active=0
D [30/Jan/2014:14:53:02 -0600] Report: printers=1
D [30/Jan/2014:14:53:02 -0600] Report: stringpool-string-count=2756
D [30/Jan/2014:14:53:02 -0600] Report: stringpool-alloc-bytes=8744
D [30/Jan/2014:14:53:02 -0600] Report: stringpool-total-bytes=49520

I believe this is all the relevant information from the log. I've not had any success finding this issue in the wiki or in the forums. Google's turned up no help. I'd really like getting this printer to work. Any help would be greatly appreciated.

Last edited by Yaro (2014-02-25 19:44:17)

Offline

#2 2014-01-31 10:58:22

Lone_Wolf
Forum Moderator
From: Netherlands, Europe
Registered: 2005-10-04
Posts: 11,928

Re: [SOLVED]Canon D1100 Series UFRII LT doesn't print, CUPS thinks it does

I can't find that printer on the canon eu support website (canon uses model numbers on that site, not series designations) , and canon printers are not easy to get to work well on archlinux.

However there are 2 aur packages that provide the UFRII driver :

- cndrvcups-lb (built from source)
- cndrvcups-lb-bin (uses the binaries)

Disliking systemd intensely, but not satisfied with alternatives so focusing on taming systemd.


(A works at time B)  && (time C > time B ) ≠  (A works at time C)

Offline

#3 2014-02-04 19:48:49

creatid
Member
From: Netherlands
Registered: 2009-12-19
Posts: 75
Website

Re: [SOLVED]Canon D1100 Series UFRII LT doesn't print, CUPS thinks it does

I think D1100 is the US designation of one of the imageRUNNER models. Just not sure which one.

Offline

#4 2014-02-25 19:43:59

Yaro
Member
Registered: 2009-04-03
Posts: 154

Re: [SOLVED]Canon D1100 Series UFRII LT doesn't print, CUPS thinks it does

After a while, I tried the binary package, those worked. The source package does not work.

Offline

Pages: 1

Board footer

Powered by FluxBB