On Mon, Oct 30, 2000 at 06:05:46PM +0100, Bodo Moeller wrote:
[...]
> The new Write_read_timeout function insists on writing all of the
> buffer in one timeout interval (usually 300 seconds), or it will
> report an error -- its return value is either 0 (success) or -1 (error),
> it's no longer possible to report that some data could be read
> but not all data could be written.
[...]
This explains the problem with print jobs that take a long time,
but not our problem with duplicate banner pages.
Fortunately (?), the problem occured again and this time I saved the
'lpq -L' output; see below. What happens is that a one-page
postscript file is printed, preceded by two copies of the banner
page. I've never seen this with the old version of ifhp,
so I guess this is due to the changes made in the program
(this time it's Do_sync, not Do_waitend). sync_interval
is set to 20 seconds, and that's the value we have been using
all the time.
Status: printing job 'skrobic@cdc23+235' at 10:42:43.236
Status: creating banner at 10:42:43.240
Status: Filter_file: pgm '/opt/LPRng/libexec/filters/psbanner' exited with status
'JSUCC' at 10:42:48.398
Status: printing 'skrobic@cdc23+235' starting OF 'ifhp' at 10:42:48.401
Status: OF filter suspended at 10:42:53.384
Status: processing 'dfA235cdc23.cdc.informatik.tu-darmstadt.de', size 147816, format
'f', IF filter 'ifhp' at 10:42:53.388
Status: IF filter 'ifhp' filter finished at 10:43:35.783
Status: OF filter finished at 10:43:39.563
Status: printing finished at 10:43:39.665
Status: subserver pid 21779 exit status 'JSUCC' at 10:43:39.739
Status: hplj@cdc-intern: job 'skrobic@cdc23+235' printed at 10:43:39.748
Status: job 'skrobic@cdc23+235' removed at 10:43:39.975
Status: waiting for subserver to exit at 10:44:23.876
Status: subserver pid 21861 starting at 10:44:23.961
Status: accounting at start at 10:44:23.962
Status: opening device 'cdc-lj5%9100' at 10:44:23.966
Status: printing job 'skrobic@cdc23+251' at 10:44:24.023
Status: creating banner at 10:44:24.026
Status: Filter_file: pgm '/opt/LPRng/libexec/filters/psbanner' exited with status
'JSUCC' at 10:44:29.213
Status: printing 'skrobic@cdc23+251' starting OF 'ifhp' at 10:44:29.217
Status: OF filter suspended at 10:44:33.417
Status: processing 'dfA251cdc23.cdc.informatik.tu-darmstadt.de', size 147816, format
'f', IF filter 'ifhp' at 10:44:33.422
Status: IF filter 'ifhp' filter msg - 'ifhp 10:44:53.459 [21937] Do_sync: no response
from printer' at 10:44:53.472
Status: IF filter 'ifhp' filter exit status 'JFAIL' at 10:44:53.475
Status: OF filter finished at 10:44:56.949
Status: printing finished at 10:44:56.951
Status: accounting at end at 10:44:56.959
Status: finished 'skrobic@cdc23+251', status 'JFAIL' at 10:44:56.963
Status: subserver pid 21861 exit status 'JFAIL' at 10:44:57.038
Status: job 'skrobic@cdc23+251' attempt 1 of 30, retrying at 10:44:57.149
Status: waiting for subserver to exit at 10:44:57.428
Status: attempt 2, sleeping 10 before retry at 10:44:57.550
Status: subserver pid 21938 starting at 10:45:07.559
Status: accounting at start at 10:45:07.561
Status: opening device 'cdc-lj5%9100' at 10:45:07.563
Status: printing job 'skrobic@cdc23+251' at 10:45:07.616
Status: creating banner at 10:45:07.619
Status: Filter_file: pgm '/opt/LPRng/libexec/filters/psbanner' exited with status
'JSUCC' at 10:45:12.967
Status: printing 'skrobic@cdc23+251' starting OF 'ifhp' at 10:45:12.970
Status: OF filter suspended at 10:45:17.775
Status: processing 'dfA251cdc23.cdc.informatik.tu-darmstadt.de', size 147816, format
'f', IF filter 'ifhp' at 10:45:17.780
Status: IF filter 'ifhp' filter finished at 10:45:58.283
Status: OF filter finished at 10:46:02.073
Status: printing finished at 10:46:02.075
Status: accounting at end at 10:46:02.084
Status: finished 'skrobic@cdc23+251', status 'JSUCC' at 10:46:02.087
Status: subserver pid 21938 exit status 'JSUCC' at 10:46:02.146
Status: hplj@cdc-intern: job 'skrobic@cdc23+251' printed at 10:46:02.156
Status: job 'skrobic@cdc23+251' removed at 10:46:02.373
Filter_status: initial job type 'POSTSCRIPT' at 10:43:15.021
Filter_status: decoded job type 'POSTSCRIPT' at 10:43:15.023
Filter_status: job type 'POSTSCRIPT' at 10:43:15.024
Filter_status: transferring 147816 bytes at 10:43:15.031
Filter_status: code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:43:15.091
Filter_status: 27 percent done at 10:43:15.206
Filter_status: 55 percent done at 10:43:15.382
Filter_status: 83 percent done at 10:43:15.555
Filter_status: data sent at 10:43:15.669
Filter_status: sent job file at 10:43:15.670
Filter_status: getting end using 'pjl job/eoj' at 10:43:15.675
Filter_status: code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:43:19.566
Filter_status: end of job detected at 10:43:34.475
Filter_status: pagecounter 243615 at 10:43:35.765
Filter_status: pagecounter 243615, pages 1 at 10:43:35.767
Filter_status: done at 10:43:35.770
Filter_status: (of) OF process running at 10:43:35.787
Filter_status: (of) getting end using 'pjl job/eoj' at 10:43:35.824
Filter_status: (of) code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:43:37.615
Filter_status: (of) end of job detected at 10:43:37.645
Filter_status: (of) pagecounter 243615 at 10:43:39.544
Filter_status: (of) pagecounter 243615, pages 2 at 10:43:39.547
Filter_status: (of) ending OF mode passthrough at 10:43:39.549
Filter_status: (of) done at 10:43:39.551
Filter_status: (of) using model 'hp5m' at 10:44:29.424
Filter_status: (of) pagecount using 'pjl info pagecount' at 10:44:29.446
Filter_status: (of) setting up printer at 10:44:29.447
Filter_status: (of) starting OF mode passthrough at 10:44:29.483
Filter_status: (of) getting sync using 'pjl echo' at 10:44:29.484
Filter_status: (of) code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:44:29.491
Filter_status: (of) sync done at 10:44:30.501
Filter_status: (of) pagecounter 243615 at 10:44:30.504
Filter_status: (of) pagecounter 243615 at 10:44:30.505
Filter_status: (of) getting sync using 'pjl echo' at 10:44:31.795
Filter_status: (of) code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:44:31.975
Filter_status: (of) code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:44:33.323
Filter_status: (of) sync done at 10:44:33.381
Filter_status: (of) sending 8737 bytes of OF input at 10:44:33.389
Filter_status: (of) starting transfer at 10:44:33.391
Filter_status: (of) initial job type 'POSTSCRIPT' at 10:44:33.393
Filter_status: (of) decoded job type 'POSTSCRIPT' at 10:44:33.395
Filter_status: (of) job type 'POSTSCRIPT' at 10:44:33.396
Filter_status: (of) transferring 8737 bytes at 10:44:33.401
Filter_status: (of) 100 percent done at 10:44:33.406
Filter_status: (of) data sent at 10:44:33.408
Filter_status: (of) OF process suspending at 10:44:33.414
Filter_status: using model 'hp5m' at 10:44:33.628
Filter_status: pagecount using 'pjl info pagecount' at 10:44:33.648
Filter_status: setting up printer at 10:44:33.649
Filter_status: getting sync using 'pjl echo' at 10:44:33.651
Filter_status: code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:44:33.657
Filter_status: no response from printer at 10:44:53.460
Filter_status: (of) OF process running at 10:44:53.477
Filter_status: (of) getting end using 'pjl job/eoj' at 10:44:53.509
Filter_status: (of) code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:44:53.947
Filter_status: (of) code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:44:54.993
Filter_status: (of) end of job detected at 10:44:55.027
Filter_status: (of) pagecounter 243616 at 10:44:56.930
Filter_status: (of) pagecounter 243616, pages 1 at 10:44:56.932
Filter_status: (of) ending OF mode passthrough at 10:44:56.935
Filter_status: (of) done at 10:44:56.936
Filter_status: (of) using model 'hp5m' at 10:45:13.176
Filter_status: (of) pagecount using 'pjl info pagecount' at 10:45:13.197
Filter_status: (of) setting up printer at 10:45:13.198
Filter_status: (of) starting OF mode passthrough at 10:45:13.243
Filter_status: (of) getting sync using 'pjl echo' at 10:45:13.245
Filter_status: (of) sync done at 10:45:14.868
Filter_status: (of) pagecounter 243616 at 10:45:14.871
Filter_status: (of) pagecounter 243616 at 10:45:14.872
Filter_status: (of) getting sync using 'pjl echo' at 10:45:16.173
Filter_status: (of) code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:45:16.332
Filter_status: (of) code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:45:17.679
Filter_status: (of) sync done at 10:45:17.738
Filter_status: (of) sending 8737 bytes of OF input at 10:45:17.746
Filter_status: (of) starting transfer at 10:45:17.748
Filter_status: (of) initial job type 'POSTSCRIPT' at 10:45:17.749
Filter_status: (of) decoded job type 'POSTSCRIPT' at 10:45:17.752
Filter_status: (of) job type 'POSTSCRIPT' at 10:45:17.753
Filter_status: (of) transferring 8737 bytes at 10:45:17.758
Filter_status: (of) 100 percent done at 10:45:17.763
Filter_status: (of) data sent at 10:45:17.765
Filter_status: (of) OF process suspending at 10:45:17.771
Filter_status: using model 'hp5m' at 10:45:17.986
Filter_status: pagecount using 'pjl info pagecount' at 10:45:18.007
Filter_status: setting up printer at 10:45:18.008
Filter_status: getting sync using 'pjl echo' at 10:45:18.009
Filter_status: code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:45:18.016
Filter_status: code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:45:37.528
Filter_status: sync done at 10:45:37.567
Filter_status: pagecounter 243617 at 10:45:37.569
Filter_status: pagecounter 243617 at 10:45:37.570
Filter_status: sending job file at 10:45:37.580
Filter_status: starting transfer at 10:45:37.581
Filter_status: initial job type 'POSTSCRIPT' at 10:45:37.583
Filter_status: decoded job type 'POSTSCRIPT' at 10:45:37.585
Filter_status: job type 'POSTSCRIPT' at 10:45:37.587
Filter_status: transferring 147816 bytes at 10:45:37.594
Filter_status: code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:45:37.653
Filter_status: 27 percent done at 10:45:37.767
Filter_status: 55 percent done at 10:45:37.942
Filter_status: 83 percent done at 10:45:38.118
Filter_status: data sent at 10:45:38.232
Filter_status: sent job file at 10:45:38.233
Filter_status: getting end using 'pjl job/eoj' at 10:45:38.238
Filter_status: code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:45:42.139
Filter_status: end of job detected at 10:45:56.746
Filter_status: pagecounter 243618 at 10:45:58.266
Filter_status: pagecounter 243618, pages 1 at 10:45:58.268
Filter_status: done at 10:45:58.270
Filter_status: (of) OF process running at 10:45:58.286
Filter_status: (of) getting end using 'pjl job/eoj' at 10:45:58.309
Filter_status: (of) code = 11004, 'MP/Tray1/DuplexTray - A4 Paper' at 10:46:00.118
Filter_status: (of) end of job detected at 10:46:00.148
Filter_status: (of) pagecounter 243618 at 10:46:02.056
Filter_status: (of) pagecounter 243618, pages 2 at 10:46:02.058
Filter_status: (of) ending OF mode passthrough at 10:46:02.060
Filter_status: (of) done at 10:46:02.062
--
Bodo M�ller <[EMAIL PROTECTED]>
PGP http://www.informatik.tu-darmstadt.de/TI/Mitarbeiter/moeller/0x36d2c658.html
* TU Darmstadt, Theoretische Informatik, Alexanderstr. 10, D-64283 Darmstadt
* Tel. +49-6151-16-6628, Fax +49-6151-16-6036
-----------------------------------------------------------------------------
YOU MUST BE A LIST MEMBER IN ORDER TO POST TO THE LPRNG MAILING LIST
The address you post from MUST be your subscription address
If you need help, send email to [EMAIL PROTECTED] (or lprng-requests
or lprng-digest-requests) with the word 'help' in the body. For the impatient,
to subscribe to a list with name LIST, send mail to [EMAIL PROTECTED]
with: | example:
subscribe LIST <mailaddr> | subscribe lprng-digest [EMAIL PROTECTED]
unsubscribe LIST <mailaddr> | unsubscribe lprng [EMAIL PROTECTED]
If you have major problems, send email to [EMAIL PROTECTED] with the word
LPRNGLIST in the SUBJECT line.
-----------------------------------------------------------------------------