[cups] cups 2.0.2 on OpenWRT - no error but no print either

Sun Apr 12 10:08:06 PDT 2015

Maybe you used the wrong PPD (as it specifies the brlpdwrapper7820N  
filter)
There is a PPD from BROTHER without this filter specification. You may  
download it from
http://openprinting.org/ppd-o-matic.php?driver=Postscript-Brother&printer=Brother-MFC-7820N
Please try again with this PPD and let us know what happened.

Helge

Am 12.04.2015 um 15:25 schrieb Gerrit Einhoff:

> Hi,
>
> I am relatively new to cups, so apologies if I'm missing something  
> basic.
> I'm trying to get a simple setup working, with cups 2.0.2 installed  
> on my
> router (under OpenWRT) with just one network printer (Brother  
> MFC7820n)
> connected via AppSocket on a fixed IP (socket://192.168.1.206:9100).
>
> cups is setup correctly and I installed the printer via the web- 
> interface
> without any problem. The printer is also reachable/working, I can  
> print out
> PS-files if I just netcat them to port 9100.
>
> However, if I try to print via cups (e.g., "lp -d BiS-socket  
> letter.ps"),
> the job is received and completes without errors but also without a
> printout. A "tcpdump host 192.168.1.206" shows a bunch of UDP- 
> packets with
> SNMP requests being sent and answered but no TCP-data stream being  
> opened
> to port 9100.
>
> I've set LogLevel to debug2 but the error.log doesn't seem to show  
> anything
> unusual. Any hints what I could be missing?
>
> Below the abbreviated log-output (just the [Job x] part because it's  
> very
> long otherwise). I have also tried using the IPP-backend with  
> identical
> results.
>
> Many thanks!
> -Gerrit
>
>
> root at OpenWrt:~# lp -d BiS-socket letter.ps
> request id is BiS-socket-9 (1 file(s))
> root at OpenWrt:~# grep "\[Job" /var/log/cups/error_log
> I [12/Apr/2015:13:17:21 +0000] [Job 9] Adding start banner page  
> "none".
> I [12/Apr/2015:13:17:21 +0000] [Job 9] Queued on "BiS-socket" by  
> "root".
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Auto-typing file...
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Request file type is
> application/postscript.
> I [12/Apr/2015:13:17:21 +0000] [Job 9] File of type application/ 
> postscript
> queued by "root".
> I [12/Apr/2015:13:17:21 +0000] [Job 9] Adding end banner page "none".
> D [12/Apr/2015:13:17:21 +0000] [Job 9] time-at-processing=1428844641
> D [12/Apr/2015:13:17:21 +0000] [Job 9] 2 filters for job:
> D [12/Apr/2015:13:17:21 +0000] [Job 9] pstops (application/ 
> postscript to
> application/vnd.cups-postscript, cost 66)
> D [12/Apr/2015:13:17:21 +0000] [Job 9] brlpdwrapperMFC7820N
> (application/vnd.cups-postscript to printer/BiS-socket, cost 0)
> D [12/Apr/2015:13:17:21 +0000] [Job 9] job-sheets=none,none
> D [12/Apr/2015:13:17:21 +0000] [Job 9] argv[0]="BiS-socket"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] argv[1]="9"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] argv[2]="root"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] argv[3]="letter.ps"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] argv[4]="1"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] argv[5]="finishings=3 number- 
> up=1
> job-uuid=urn:uuid:3540c722-5b95-3a0b-55b4-9ecf47843567
> job-originating-host-name=localhost time-at-creation=1428844641
> time-at-processing=1428844641"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] argv[6]="/var/spool/cups/ 
> d00009-001"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[0]="CUPS_CACHEDIR=/var/cache/cups"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[1]="CUPS_DATADIR=/usr/share/cups"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[2]="CUPS_DOCROOT=/usr/share/doc/cups"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[6]="CUPS_SERVERROOT=/etc/ 
> cups"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[7]="CUPS_STATEDIR=/var/ 
> run/cups"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[8]="HOME=/var/spool/cups/ 
> tmp"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]  
> envp[10]="SERVER_ADMIN=root at OpenWrt"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[11]="SOFTWARE=CUPS/2.0.2"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[12]="TMPDIR=/var/spool/ 
> cups/tmp"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[13]="USER=root"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]  
> envp[14]="CUPS_MAX_MESSAGE=2047"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]  
> envp[15]="CUPS_SERVER=localhost"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[16]="CUPS_ENCRYPTION=IfRequested"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[17]="IPP_PORT=631"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[18]="CHARSET=utf-8"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[19]="LANG=en_US.UTF-8"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[20]="PPD=/etc/cups/ppd/BiS-socket.ppd"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[21]="RIP_MAX_CACHE=auto"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[22]="CONTENT_TYPE=application/postscript"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[23]="DEVICE_URI=socket://
> 192.168.1.206:9100"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[24]="PRINTER_INFO=BiS- 
> socket"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[25]="PRINTER_LOCATION="
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[26]="PRINTER=BiS-socket"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]  
> envp[27]="PRINTER_STATE_REASONS=none"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]  
> envp[28]="CUPS_FILETYPE=document"
> D [12/Apr/2015:13:17:21 +0000] [Job 9]
> envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] envp[30]="AUTH_I****"
> I [12/Apr/2015:13:17:21 +0000] [Job 9] Started filter
> /usr/lib/cups/filter/pstops (PID 12706)
> I [12/Apr/2015:13:17:21 +0000] [Job 9] Started filter
> /usr/lib/cups/filter/brlpdwrapperMFC7820N (PID 12707)
> I [12/Apr/2015:13:17:21 +0000] [Job 9] Started backend
> /usr/lib/cups/backend/socket (PID 12708)
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Page = 595x842; 18,12 to  
> 577,830
> D [12/Apr/2015:13:17:21 +0000] [Job 9] slow_collate=0, slow_duplex=0,
> slow_order=0
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Before copy_comments - %!PS- 
> Adobe-2.0
> D [12/Apr/2015:13:17:21 +0000] [Job 9] %!PS-Adobe-2.0
> D [12/Apr/2015:13:17:21 +0000] [Job 9] %%Creator: dvipsk 5.58f  
> Copyright
> 1986, 1994 XXX
> D [12/Apr/2015:13:17:21 +0000] [Job 9] %%Title: letter.dvi
> D [12/Apr/2015:13:17:21 +0000] [Job 9] %%Pages: 1
> D [12/Apr/2015:13:17:21 +0000] [Job 9] %%PageOrder: Ascend
> D [12/Apr/2015:13:17:21 +0000] [Job 9] %%BoundingBox: 0 0 612 792
> D [12/Apr/2015:13:17:21 +0000] [Job 9] %%DocumentPaperSizes: Letter
> D [12/Apr/2015:13:17:21 +0000] [Job 9] %%EndComments
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Before copy_prolog -
> %DVIPSCommandLine: dvips -o letter.ps letter.dvi
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: +connecting-to-device
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Looking up "192.168.1.206"...
> d [12/Apr/2015:13:17:21 +0000] [Job 9] hrDeviceDesc="Brother  
> MFC-7820N"
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtGeneralCurrentLocalization=1
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtLocalizationCharacterSet=4
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Before copy_setup - % 
> %BeginSetup
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Before page loop - %%Page: 53 1
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Copying page 1...
> D [12/Apr/2015:13:17:21 +0000] [Job 9] pagew = 559.0, pagel = 818.0
> D [12/Apr/2015:13:17:21 +0000] [Job 9] bboxx = 0, bboxy = 0, bboxw =  
> 595,
> bboxl = 842
> D [12/Apr/2015:13:17:21 +0000] [Job 9] PageLeft = 18.0, PageRight =  
> 577.0
> D [12/Apr/2015:13:17:21 +0000] [Job 9] PageTop = 830.0, PageBottom =  
> 12.0
> D [12/Apr/2015:13:17:21 +0000] [Job 9] PageWidth = 595.0, PageLength  
> = 842.0
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Wrote 1 pages...
> D [12/Apr/2015:13:17:21 +0000] [Job 9] PID 12706
> (/usr/lib/cups/filter/pstops) exited with no errors.
> d [12/Apr/2015:13:17:21 +0000] [Job 9]  
> prtMarkerSuppliesColorantIndex.1.1 =
> 1
> D [12/Apr/2015:13:17:21 +0000] [Job 9] PID 12707
> (/usr/lib/cups/filter/brlpdwrapperMFC7820N) exited with no errors.
> d [12/Apr/2015:13:17:21 +0000] [Job 9]  
> prtMarkerSuppliesColorantIndex.1.2 =
> 1
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesClass.1.1 = 3
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesClass.1.2 = 3
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesType.1.1 = 3
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesType.1.2 = 9
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesDescription. 
> 1.1 =
> "TN-350/TN-2000/TN-2025/TN-2075"
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesDescription. 
> 1.2 =
> "DR-350/DR-2000/DR-2025/DR-2075"
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesSupplyUnit. 
> 1.1 = 13
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesSupplyUnit. 
> 1.2 = 7
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesMaxCapacity. 
> 1.1 = -2
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesMaxCapacity. 
> 1.2 = -2
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesLevel.1.1 = -3
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerSuppliesLevel.1.2 = -3
> d [12/Apr/2015:13:17:21 +0000] [Job 9] prtMarkerColorantValue.1.1 =  
> "black"
> D [12/Apr/2015:13:17:21 +0000] [Job 9] ATTR: marker- 
> colors=#000000,#000000
> D [12/Apr/2015:13:17:21 +0000] [Job 9] ATTR:
> marker-names='"TN-350/TN-2000/TN-2025/TN-2075"','"DR-350/DR-2000/ 
> DR-2025/DR-2075"'
> D [12/Apr/2015:13:17:21 +0000] [Job 9] ATTR: marker-types=toner,opc
> D [12/Apr/2015:13:17:21 +0000] [Job 9] ATTR: marker-levels=-1,-1
> D [12/Apr/2015:13:17:21 +0000] [Job 9] new_supply_state=0,  
> change_state=ffff
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -developer-low-report
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -developer-empty-warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -marker-supply-low- 
> report
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -marker-supply-empty- 
> warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -opc-near-eol-report
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -opc-life-over-warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -toner-low-report
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -toner-empty-warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE:
> -waste-receptacle-almost-full-report
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -waste-receptacle-full- 
> warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE:
> -cleaner-life-almost-over-report
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -cleaner-life-over- 
> warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] new_state=0, change_state=ffff
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -media-empty-warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -door-open-report
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -media-jam-warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -input-tray-missing- 
> warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -output-tray-missing- 
> warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -marker-supply-missing- 
> warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE:
> -output-area-almost-full-report
> D [12/Apr/2015:13:17:21 +0000] [Job 9] STATE: -output-area-full- 
> warning
> D [12/Apr/2015:13:17:21 +0000] [Job 9] backendWaitLoop(snmp_fd=5,
> addr=0xb7172a84, side_cb=0xb6f37520)
> D [12/Apr/2015:13:17:21 +0000] [Job 9] PID 12708
> (/usr/lib/cups/backend/socket) exited with no errors.
> D [12/Apr/2015:13:17:21 +0000] [Job 9] time-at-completed=1428844641
> I [12/Apr/2015:13:17:21 +0000] [Job 9] Job completed.
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Removing from history.
> D [12/Apr/2015:13:17:21 +0000] [Job 9] Unloading...
> _______________________________________________
> cups mailing list
> cups at cups.org
> https://www.cups.org/mailman/listinfo/cups