Printer queue problem (LPRng 3.4.2, Samba 1.9.18p4, Solaris 2.5.1/2.6)

Steen Jensen sj at kom.auc.dk
Wed Apr 15 19:10:50 GMT 1998


On Wed, 15 Apr 1998, Steen Jensen wrote:

sj> 
sj> I've got the same problem with SysV printing, it goes wrong every time, if
sj> there is more then 12 jobs in the printer queue. I think that Jeremy
sj> Allison is working on a patch (the first one didn't fix it), until it's
sj> fixed you can use something like this in your smb.conf:
sj> 
sj> 	lpq command = lpq -P%p | head -12

Ups.. I was to slow, the second patch from Jeremy is working. See Jeremy's
reply.

/Steen.


sj> 
sj> People on Windows clients can only see the first 12 jobs, but it
sj> saves the server...
sj> 
sj> BTW, There is no problem with NT 4.0 clients.
sj> 
sj> Best,
sj> 
sj> Steen Jensen                                 System & net administrator
sj> -- 
sj> Aalborg University			     e-mail: sj at kom.auc.dk
sj> Institute of Electronic Systems
sj> Department of Communication Technology
sj> 
sj> 
sj> On Tue, 14 Apr 1998, Owen L. Magee wrote:
sj> 
sj> mageeol> I've been having a problem with Win95 clients watching a printer
sj> mageeol> queue on the Samba server (called labserv2).  labserv2 is a
sj> mageeol> Solaris 2.5.1 machine running samba 1.9.18p4.  The printing
sj> mageeol> system is LPRng 3.4.2. 
sj> mageeol> 
sj> mageeol> A user can watch the printer queue from a Win95 client machine. 
sj> mageeol> However, when the printer queue gets backed up (usually about 12
sj> mageeol> jobs), the queue window locks.  The corresponding smbd process on
sj> mageeol> labserv2 starts sucking up lots of CPU time.  Once you have about
sj> mageeol> 10 clients doing this...well, things start slowing down pretty
sj> mageeol> badly (although, to samba's credit, it is still very usable at a
sj> mageeol> load average of 10 :) . 
sj> mageeol> 
sj> mageeol> I managed to reproduce this behavior on labserv1, which is
sj> mageeol> currently unused.  labserv1 runs Solaris 2.6, samba 1.9.18p4, and
sj> mageeol> LPRng 3.4.5.  LPRng is set up so that the printers are served
sj> mageeol> remotely from labserv2.  Using a debug level of 10 and a single
sj> mageeol> client watching a busy printer queue, I was able to capture
sj> mageeol> debugging information.  At the end of this post is the debugging
sj> mageeol> info that just loops over and over again, as fast as it can, on
sj> mageeol> the spazzed smbd process. 
sj> mageeol> 
sj> mageeol> As far as I know, I never had this problem with samba 1.9.17p5
sj> mageeol> (and yes, we were using LPRng at the time).  This only started
sj> mageeol> happening when I upgraded to samba 1.9.18. 
sj> mageeol> 
sj> mageeol> Does anybody have any clues?
sj> mageeol> 
sj> mageeol> Owen Magee
sj> mageeol> mageeol at mail.auburn.edu
sj> mageeol> 
sj> mageeol> -------------------------------------------------------------------------
sj> mageeol> 
sj> mageeol> got message type 0x0 of len 0x83
sj> mageeol> 04/03/1998 10:03:43 Transaction 249 of length 135
sj> mageeol> size=131
sj> mageeol> smb_com=0x25
sj> mageeol> smb_rcls=0
sj> mageeol> smb_reh=0
sj> mageeol> smb_err=0
sj> mageeol> smb_flg=0
sj> mageeol> smb_flg2=0
sj> mageeol> smb_tid=68
sj> mageeol> smb_pid=7487
sj> mageeol> smb_uid=100
sj> mageeol> smb_mid=25730
sj> mageeol> smt_wct=14
sj> mageeol> smb_vwv[0]=55 (0x37)
sj> mageeol> smb_vwv[1]=0 (0x0)
sj> mageeol> smb_vwv[2]=6 (0x6)
sj> mageeol> smb_vwv[3]=0 (0x0)
sj> mageeol> smb_vwv[4]=0 (0x0)
sj> mageeol> smb_vwv[5]=0 (0x0)
sj> mageeol> smb_vwv[6]=5000 (0x1388)
sj> mageeol> smb_vwv[7]=0 (0x0)
sj> mageeol> smb_vwv[8]=0 (0x0)
sj> mageeol> smb_vwv[9]=55 (0x37)
sj> mageeol> smb_vwv[10]=76 (0x4C)
sj> mageeol> smb_vwv[11]=0 (0x0)
sj> mageeol> smb_vwv[12]=0 (0x0)
sj> mageeol> smb_vwv[13]=0 (0x0)
sj> mageeol> smb_bcc=68
sj> mageeol> [000] 5C 50 49 50 45 5C 4C 41  4E 4D 41 4E 00 46 00 7A  \PIPE\LA NMAN.F.z
sj> mageeol> [010] 57 72 4C 68 00 42 31 33  42 57 57 57 7A 7A 7A 7A  WrLh.B13 BWWWzzzz
sj> mageeol> [020] 7A 57 4E 00 50 43 4C 41  42 42 55 53 00 02 00 00  zWN.PCLA BBUS....
sj> mageeol> [030] 00 57 42 32 31 42 42 31  36 42 31 30 7A 57 57 7A  .WB21BB1 6B10zWWz
sj> mageeol> [040] 44 44 7A 00                                       DDz. 
sj> mageeol> switch message SMBtrans (pid 3880)
sj> mageeol> Skipping become_user - already user
sj> mageeol> trans <\PIPE\LANMAN> data=0 params=55 setup=0
sj> mageeol> calling named_pipe
sj> mageeol> named pipe command on <LANMAN> name
sj> mageeol> Got API command 70 of form <zWrLh> <B13BWWWzzzzzWN>
sj> mageeol> (tdscnt=0,tpscnt=55,mdrcnt=0
sj> mageeol> ,mprcnt=6)
sj> mageeol> Doing DosPrintQGetInfo
sj> mageeol> PrintQueue uLevel=2 name=PCLABBUS
sj> mageeol> Using cached lpq output
sj> mageeol> QUEUE2: Printer: pclabbus at labserv2 
sj> mageeol> 
sj> mageeol> QUEUE2:  Queue: 13 printable jobs
sj> mageeol> 
sj> mageeol> QUEUE2:  Server: pid 14995 active
sj> mageeol> 
sj> mageeol> QUEUE2:  Unspooler: pid 21532 active
sj> mageeol> 
sj> mageeol> QUEUE2:  Status: printed all 160850 bytes at 10:03:41
sj> mageeol> 
sj> mageeol> QUEUE2:  Filter_status: ifhp NOTICE - printer status code 10023 -
sj> mageeol> processing job
sj> mageeol>  at Apr  3 10:03:36 
sj> mageeol> 
sj> mageeol> QUEUE2:  Rank   Owner/ID                   Class Job  Files
sj> mageeol> Size T
sj> mageeol> ime    
sj> mageeol> 
sj> mageeol> QUEUE2: active  kingrod at labserv2+198           A  198 busine.a004i.
sj> mageeol> 160850 0
sj> mageeol> 9:57:55
sj> mageeol> 
sj> mageeol> Time reported for job 198 is Fri Apr  3 09:57:55 1998
sj> mageeol> QUEUE2: 2       kingrod at labserv2+218           A  218 busine.a004i.
sj> mageeol> 108888 0
sj> mageeol> 9:58:02
sj> mageeol> 
sj> mageeol> Time reported for job 218 is Fri Apr  3 09:58:02 1998
sj> mageeol> QUEUE2: 3       hardidl at labserv2+821           A  821 busine.a0050n
sj> mageeol> 98349 1
sj> mageeol> 0:00:25
sj> mageeol> 
sj> mageeol> Time reported for job 821 is Fri Apr  3 10:00:25 1998
sj> mageeol> QUEUE2: 4       brownc6 at labserv2+967           A  967 busine.a0051U
sj> mageeol> 98460 1
sj> mageeol> 0:01:11
sj> mageeol> 
sj> mageeol> Time reported for job 967 is Fri Apr  3 10:01:11 1998
sj> mageeol> QUEUE2: 5       adamsj5 at labserv2+993           A  993 busine.a004pz
sj> mageeol> 98819 1
sj> mageeol> 0:01:18
sj> mageeol> 
sj> mageeol> Time reported for job 993 is Fri Apr  3 10:01:18 1998
sj> mageeol> QUEUE2: 6       brownc6 at labserv2+054           A   54 busine.a0051U
sj> mageeol> 160483 1
sj> mageeol> 0:01:30
sj> mageeol> 
sj> mageeol> Time reported for job 54 is Fri Apr  3 10:01:30 1998
sj> mageeol> QUEUE2: 7       mageeol at labserv1+903           A  903 .bash_profile
sj> mageeol> 2959 10
sj> mageeol> :03:02
sj> mageeol> 
sj> mageeol> Time reported for job 903 is Fri Apr  3 10:03:02 1998
sj> mageeol> QUEUE2: 8       mageeol at labserv1+904           A  904 .bash_profile
sj> mageeol> 2959 10
sj> mageeol> :03:04
sj> mageeol> 
sj> mageeol> Time reported for job 904 is Fri Apr  3 10:03:04 1998
sj> mageeol> QUEUE2: 9       mageeol at labserv1+905           A  905 .bash_profile
sj> mageeol> 2959 10
sj> mageeol> :03:06
sj> mageeol> 
sj> mageeol> Time reported for job 905 is Fri Apr  3 10:03:06 1998
sj> mageeol> QUEUE2: 10      mageeol at labserv1+908           A  908 .bash_profile
sj> mageeol> 2959 10
sj> mageeol> :03:21
sj> mageeol> 
sj> mageeol> Time reported for job 908 is Fri Apr  3 10:03:21 1998
sj> mageeol> QUEUE2: 11      mageeol at labserv1+909           A  909 .bash_profile
sj> mageeol> 2959 10
sj> mageeol> :03:22
sj> mageeol> 
sj> mageeol> Time reported for job 909 is Fri Apr  3 10:03:22 1998
sj> mageeol> QUEUE2: 12      mageeol at labserv1+914           A  914 .bash_profile
sj> mageeol> 2959 10
sj> mageeol> :03:39
sj> mageeol> 
sj> mageeol> Time reported for job 914 is Fri Apr  3 10:03:39 1998
sj> mageeol> QUEUE2: 13      mageeol at labserv1+915           A  915 .bash_profile
sj> mageeol> 2959 10
sj> mageeol> :03:40
sj> mageeol> 
sj> mageeol> Time reported for job 915 is Fri Apr  3 10:03:40 1998
sj> mageeol> printqgetinfo: errorcode 2123
sj> mageeol> size=63
sj> mageeol> smb_com=0x25
sj> mageeol> smb_rcls=0
sj> mageeol> smb_reh=0
sj> mageeol> smb_err=0
sj> mageeol> smb_flg=128
sj> mageeol> smb_flg2=1
sj> mageeol> smb_tid=68
sj> mageeol> smb_pid=7487
sj> mageeol> smb_uid=100
sj> mageeol> smb_mid=25730
sj> mageeol> smt_wct=10
sj> mageeol> smb_vwv[0]=6 (0x6)
sj> mageeol> smb_vwv[1]=0 (0x0)
sj> mageeol> smb_vwv[2]=0 (0x0)
sj> mageeol> smb_vwv[3]=6 (0x6)
sj> mageeol> smb_vwv[4]=55 (0x37)
sj> mageeol> smb_vwv[5]=0 (0x0)
sj> mageeol> smb_vwv[6]=0 (0x0)
sj> mageeol> smb_vwv[7]=63 (0x3F)
sj> mageeol> smb_vwv[8]=0 (0x0)
sj> mageeol> smb_vwv[9]=0 (0x0)
sj> mageeol> smb_bcc=8
sj> mageeol> [000] 4B 08 00 00 00 00 00 00                           K....... 
sj> mageeol> write_socket(6,67)
sj> mageeol> write_socket(6,67) wrote 67
sj> mageeol> 
sj> mageeol> 
sj> mageeol> ------------------------------
sj> mageeol> 
sj> 
sj> 



More information about the samba mailing list