ppr-list-digest volume 2, number 43, message 1

Note: please don't spam any of the e-mail addresses which you see here. Follow this link if you want some addresses to misuse.


From: Andres Aravena Duarte <andres.aravena@cec.unap.cl>
Date: Sun, 19 Mar 2000 12:36:05 -0400
Subject: Re: PPR: Troubles with ppr-1.40 (printer don't work)

Este es un mensaje multipartes en formato MIME.
- --------------2FF4AD23EEBF812284DE2502
Content-Type: text/plain; charset=iso-8859-1
Content-Transfer-Encoding: 8bit

"David S. Chappell" escribió:

> At 12:32 PM 03/16/2000 -0400, you wrote:
> >Hi, I'm using ppr-1.40 in redhat 6.0. My printer is a Lexmark Optra S
> >2450. With ppr-1.30 this printer it work with some problems, specially
> >when printing multiple copies from win95, but now, with ppr-1.40 don't
> >print anything, except the banner page.
>
>
> Probably the PJL handshaking is the problem.  I think it was off by default
> in 1.30.  In 1.40 it is on by default if the interface is "tcpip" and the
> PPD file says that the printer can do PJL.  To turn it off:
>
> $ ppad lexmark jobbreak control-d

I agree this has to be an PJL handshaking problem but it worked fine on 1.32.
Anyway using  jobbreak control-d doesn't solve it. So far, turning off the
banner page seems to correct the problem, the wor prints fine.

I've compiled pprdrv with some debug options. Can somebody  figure out what is
going on? Maybe the printer isn't sending the expected PJL.

partial log file follows:

DEBUG (5132 06:54:22PM 0.07): job_end()
DEBUG (5132 06:54:22PM 0.07): printer_cleanup()
DEBUG (5132 06:54:22PM 0.07): writemon_start(operation="WRITE")
DEBUG (5132 06:54:22PM 0.07):
writemon_sleep_time(sleep_time=-1073743564.1074810
944 (old), timeout=0)
DEBUG (5132 06:54:22PM 0.07): writemon_sleep_time():
my_next_time=953074522.5938
23, now_time=953074462.593823, start_time=953074462.593823
DEBUG (5132 06:54:22PM 0.07): writemon_unstalled("WRITE")
DEBUG (5132 06:54:22PM 0.07): feedback_pjl_wait()
DEBUG (5132 06:54:22PM 0.07): writemon_start(operation="WAIT_PJL")
DEBUG (5132 06:54:22PM 0.07): feedback_pjl_wait(): waiting for PJL job start
DEBUG (5132 06:54:22PM 0.07): feedback_wait(timeout=0, return_on_signal=FALSE)

DEBUG (5132 06:54:22PM 0.07):
writemon_sleep_time(sleep_time=134699040.1074812288 (old), timeout=0)
DEBUG (5132 06:54:22PM 0.07): writemon_sleep_time():
my_next_time=953074522.594733, now_time=953074462.594733,
start_time=953074462.594733
DEBUG (5132 06:54:22PM 0.07): feedback_wait(): sleep_time=60.000000
DEBUG (5132 06:54:22PM 0.43): interface_fault_check()
DEBUG (5132 06:54:22PM 0.43): interface_fault_check(): done
DEBUG (5132 06:54:22PM 0.43): feedback_wait(): data glob ready
DEBUG (5132 06:54:22PM 0.43): feedback_reader()
DEBUG (5132 06:54:22PM 0.43): feedback_reader(): top of loop, already_here=0
DEBUG (5132 06:54:22PM 0.43): feedback_reader(): read 26 new bytes
DEBUG (5132 06:54:22PM 0.43): feedback_reader(): "@PJL USTATUS JOB
START
^L"
DEBUG (5132 06:54:22PM 0.43): CR/LF xlate has changed buffer size from 26 to
24
bytes
DEBUG (5132 06:54:22PM 0.43): 24 bytes now in buffer
DEBUG (5132 06:54:22PM 0.43): feedback_reader(): FF ends PJL block
DEBUG (5132 06:54:22PM 0.43): feedback_reader(): top of loop, already_here=0
DEBUG (5132 06:54:22PM 0.43): feedback_reader(): done, 26 bytes read
DEBUG (5132 06:54:22PM 0.43): feedback_wait(): done, returning 0
DEBUG (5132 06:54:22PM 0.43): feedback_pjl_wait(): waiting for EOJ
DEBUG (5132 06:54:22PM 0.43): feedback_wait(timeout=60,
return_on_signal=FALSE)
DEBUG (5132 06:54:22PM 0.43): writemon_sleep_time(sleep_time=2448.1074210186
(ol
d), timeout=60)
DEBUG (5132 06:54:22PM 0.43): writemon_sleep_time():
my_next_time=953074522.5947
33, now_time=953074462.950723, start_time=953074462.594733
DEBUG (5132 06:54:22PM 0.43): feedback_wait(): sleep_time=59.644010
DEBUG (5132 06:54:23PM 0.93): interface_fault_check()
DEBUG (5132 06:54:23PM 0.93): interface_fault_check(): done
DEBUG (5132 06:54:23PM 0.93): feedback_wait(): data glob ready
DEBUG (5132 06:54:23PM 0.93): feedback_reader()
DEBUG (5132 06:54:23PM 0.93): feedback_reader(): top of loop, already_here=0
DEBUG (5132 06:54:23PM 0.93): feedback_reader(): read 1 new byte
DEBUG (5132 06:54:23PM 0.93): feedback_reader(): "^D"
DEBUG (5132 06:54:23PM 0.93): feedback_reader(): control-d received
DEBUG (5132 06:54:23PM 0.93): CR/LF xlate has changed buffer size from 1 to 0
by
tes
DEBUG (5132 06:54:23PM 0.93): 0 bytes now in buffer
DEBUG (5132 06:54:23PM 0.93): feedback_reader(): top of loop, already_here=0
DEBUG (5132 06:54:23PM 0.93): feedback_reader(): done, 1 bytes read
DEBUG (5132 06:54:23PM 0.93): feedback_wait(): done, returning 0
DEBUG (5132 06:54:23PM 0.93): writemon_start(operation="WRITE")
DEBUG (5132 06:54:23PM 0.93):
writemon_sleep_time(sleep_time=-1073743748.1074191
051 (old), timeout=0)
DEBUG (5132 06:54:23PM 0.93): writemon_sleep_time():
my_next_time=953074523.4479
03, now_time=953074463.447903, start_time=953074463.447903
DEBUG (5132 06:54:23PM 0.93): writemon_unstalled("WRITE")
DEBUG (5132 06:54:23PM 0.93): feedback_pjl_wait(): waiting for EOJ
DEBUG (5132 06:54:23PM 0.93): feedback_wait(timeout=120,
return_on_signal=FALSE)
DEBUG (5132 06:54:23PM 0.93): writemon_sleep_time(sleep_time=2448.1074210186
(ol
d), timeout=120)
DEBUG (5132 06:54:23PM 0.93): writemon_sleep_time():
my_next_time=953074522.5947
33, now_time=953074463.448466, start_time=953074462.594733
DEBUG (5132 06:54:23PM 0.93): feedback_wait(): sleep_time=59.146267
DEBUG (5132 06:54:35PM 12.89): interface_fault_check()
DEBUG (5132 06:54:35PM 12.89): interface_fault_check(): done
DEBUG (5132 06:54:35PM 12.89): feedback_wait(): data glob ready
DEBUG (5132 06:54:35PM 12.90): feedback_reader()
DEBUG (5132 06:54:35PM 12.90): feedback_reader(): top of loop, already_here=0
DEBUG (5132 06:54:35PM 12.90): feedback_reader(): read 23 new bytes
DEBUG (5132 06:54:35PM 12.90): feedback_reader(): "@PJL USTATUS PAGE
1
^L"
DEBUG (5132 06:54:35PM 12.90): CR/LF xlate has changed buffer size from 23 to
21
 bytes
DEBUG (5132 06:54:35PM 12.90): 21 bytes now in buffer
DEBUG (5132 06:54:35PM 12.90): feedback_reader(): FF ends PJL block
DEBUG (5132 06:54:35PM 12.90): feedback_reader(): top of loop, already_here=0
DEBUG (5132 06:54:35PM 12.90): feedback_reader(): done, 23 bytes read
DEBUG (5132 06:54:35PM 12.90): feedback_wait(): done, returning 0
DEBUG (5132 06:54:35PM 12.90): writemon_start(operation="WRITE")
DEBUG (5132 06:54:35PM 12.90):
writemon_sleep_time(sleep_time=-1073743748.107419
1051 (old), timeout=0)
DEBUG (5132 06:54:35PM 12.90): writemon_sleep_time():
my_next_time=953074535.417
502, now_time=953074475.417502, start_time=953074475.417502
DEBUG (5132 06:54:35PM 12.90): writemon_unstalled("WRITE")
DEBUG (5132 06:54:35PM 12.90): feedback_pjl_wait(): waiting for EOJ
DEBUG (5132 06:54:35PM 12.90): writemon_unstalled("WAIT_PJL")
DEBUG (5132 06:54:35PM 12.90): writemon_start(operation="WAIT_PJL")
DEBUG (5132 06:54:35PM 12.90): feedback_wait(timeout=60,
return_on_signal=FALSE)
DEBUG (5132 06:54:35PM 12.90):
writemon_sleep_time(sleep_time=-1073743616.107419
1051 (old), timeout=60)
DEBUG (5132 06:54:35PM 12.90): writemon_sleep_time():
my_next_time=953074535.418
249, now_time=953074475.418249, start_time=953074475.418249
DEBUG (5132 06:54:35PM 12.90): feedback_wait(): sleep_time=60.000000
DEBUG: sigchld_handler(): interface terminated
DEBUG: SIGALRM caught
DEBUG (5132 06:55:00PM 38.32): interface_fault_check()
DEBUG (5132 06:55:00PM 38.32): interface_fault_check(): interface terminated
DEBUG (5132 06:55:00PM 38.33): commentary(category=8, cooked="interface
program
killed", raw1="EXIT_SIGNAL", raw2="", severity=7)
DEBUG (5132 06:55:00PM 38.33): commentary(): job.commentator.interests = 0
DEBUG (5132 06:55:00PM 38.35): kill_interface()
DEBUG (5132 06:55:00PM 38.35): kill_interface(): nothing to kill
DEBUG (5132 06:55:00PM 38.35): kill_interface(): done


- --------------2FF4AD23EEBF812284DE2502
Content-Type: text/x-vcard; charset=us-ascii;
 name="andres.aravena.vcf"
Content-Transfer-Encoding: 7bit
Content-Description: Tarjeta de Andres Aravena Duarte
Content-Disposition: attachment;
 filename="andres.aravena.vcf"

begin:vcard 
n:Aravena;Andres
tel;pager:7801668
tel;fax:+56(57)44 1009
tel;work:+56(57)44 7070
x-mozilla-html:TRUE
url:http://www.unap.cl/~murray
org:Universidad Arturo Prat de Iquique;Unidad de Informática y Comunicaciones
adr:;;Av Arturo Prat 2120;Iquique;;;Chile
version:2.1
email;internet:andres.aravena@cec.unap.cl
title:Jefe Area Administración de Servidores y Redes
x-mozilla-cpt:;0
fn:Andres Aravena
end:vcard

- --------------2FF4AD23EEBF812284DE2502--