FOLLOWUP Re: [Samba] Isolated printer problem
Misty Stanley-Jones
misty at borkholder.com
Thu Jan 6 17:50:58 GMT 2005
I want to post a followup for this. I solved it and it was not a Samba issue.
It was to do with the printer in question (the instance installed on the
user's computer) was using a "local port" called \\myserver\printername,
rather than the "no visible port" setting that Windows 2000 usually has for
printers accessed via Samba (on NT the printer will be using a "SAMBA port".
It was using this "local port" because of some software that has really bad
network printer support and needs it. My solution will be to make a copy of
the printer in question, in CUPS, and allow THAT copy to use the "local port"
while the normal instance is configured in the standard way for Samba.
As for the other print jobs disappearing so fast, it is ismply because CUPS is
esnding the job to the printer much quickly than my users are used to. It
also looks like CUPS is using the printer's onboard memory where Novell was
not, so between the two things the job disappears really fast. For printers
that rae used for manually feed operations a lot, I may need to disable the
printer's cache so that the job needing attention will still be visible in
the queue.
Thanks for your patience,
Misty
On Tuesday 04 January 2005 17:41, Misty Stanley-Jones wrote:
> On Tuesday 04 January 2005 16:54, John H Terpstra wrote:
> > Is the 10th user a manager of the "printer operators" group?
>
> No. Nobody is.
>
> > At "log level = 5" what do the logs for that 10th machine show has
> > happened. I suspect you will find your answer there.
> >
> > log level = 5
> > max log size = 0
> > log file = /var/log/samba/%m
> >
> > Note: %m gets expanded to the name of the workstation.
>
> Of note -- It turns out through testing (rather than taking the user's word
> for it) that he is not able to see any spooled jobs on any network printer
> of his.
>
> Nothing odd that I can see here except that the message gets sent to the
> plotter 8 times ... maybe that is normal... Spewed here:
>
> [2005/01/04 17:21:11, 5]
> printing/notify.c:print_notify_send_messages_to_printer(169)
> print_notify_send_messages_to_printer: sending 8 print notify messages to
> printer plotter
> [2005/01/04 17:21:46, 3] smbd/process.c:process_smb(1092)
> Transaction 71331 of length 39
> [2005/01/04 17:21:46, 5] lib/util.c:show_msg(461)
> [2005/01/04 17:21:46, 5] lib/util.c:show_msg(471)
> size=35
> smb_com=0x71
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=24
> smb_flg2=51207
> smb_tid=2
> smb_pid=65279
> smb_uid=129
> smb_mid=14665
> smt_wct=0
> smb_bcc=0
> [2005/01/04 17:21:46, 3] smbd/process.c:switch_message(887)
> switch message SMBtdis (pid 25406) conn 0x83dc9c8
> [2005/01/04 17:21:46, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:21:46, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:21:46, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:21:46, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:21:46, 4] smbd/vfs.c:vfs_ChDir(654)
> vfs_ChDir to /data/samba/netlogon
> [2005/01/04 17:21:46, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:21:46, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:21:46, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:21:46, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:21:46, 1] smbd/service.c:close_cnum(836)
> w2kgreg (192.168.1.57) closed connection to service netlogon
> [2005/01/04 17:21:46, 3] smbd/connection.c:yield_connection(69)
> Yielding connection to netlogon
> [2005/01/04 17:21:46, 4] smbd/vfs.c:vfs_ChDir(654)
> vfs_ChDir to /
> [2005/01/04 17:21:46, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:21:46, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:21:46, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:21:46, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:21:46, 5] lib/util.c:show_msg(461)
> [2005/01/04 17:21:46, 5] lib/util.c:show_msg(471)
> size=35
> smb_com=0x71
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=136
> smb_flg2=51201
> smb_tid=2
> smb_pid=65279
> smb_uid=129
> smb_mid=14665
> smt_wct=0
> smb_bcc=0
> [2005/01/04 17:22:20, 3] smbd/process.c:process_smb(1092)
> Transaction 71332 of length 39
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(461)
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(471)
> size=35
> smb_com=0x71
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=24
> smb_flg2=51207
> smb_tid=1
> smb_pid=65279
> smb_uid=163
> smb_mid=14729
> smt_wct=0
> smb_bcc=0
> [2005/01/04 17:22:20, 3] smbd/process.c:switch_message(887)
> switch message SMBtdis (pid 25406) conn 0x840fa48
> [2005/01/04 17:22:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:22:20, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:22:20, 4] smbd/vfs.c:vfs_ChDir(654)
> vfs_ChDir to /tmp
> [2005/01/04 17:22:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:22:20, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:22:20, 3] smbd/service.c:close_cnum(836)
> w2kgreg (192.168.1.57) closed connection to service IPC$
> [2005/01/04 17:22:20, 3] smbd/connection.c:yield_connection(69)
> Yielding connection to IPC$
> [2005/01/04 17:22:20, 4] smbd/vfs.c:vfs_ChDir(654)
> vfs_ChDir to /
> [2005/01/04 17:22:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:22:20, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(461)
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(471)
> size=35
> smb_com=0x71
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=136
> smb_flg2=51201
> smb_tid=1
> smb_pid=65279
> smb_uid=163
> smb_mid=14729
> smt_wct=0
> smb_bcc=0
> [2005/01/04 17:22:20, 3] smbd/process.c:process_smb(1092)
> Transaction 71333 of length 43
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(461)
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(471)
> size=39
> smb_com=0x74
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=24
> smb_flg2=51207
> smb_tid=0
> smb_pid=65279
> smb_uid=163
> smb_mid=14793
> smt_wct=2
> smb_vwv[ 0]= 255 (0xFF)
> smb_vwv[ 1]= 0 (0x0)
> smb_bcc=0
> [2005/01/04 17:22:20, 3] smbd/process.c:switch_message(887)
> switch message SMBulogoffX (pid 25406) conn 0x0
> [2005/01/04 17:22:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:22:20, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:22:20, 5] auth/auth_util.c:free_server_info(1344)
> attempting to free (and zero) a server_info structure
> [2005/01/04 17:22:20, 3] smbd/reply.c:reply_ulogoffX(1249)
> ulogoffX vuid=163
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(461)
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(471)
> size=39
> smb_com=0x74
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=136
> smb_flg2=51201
> smb_tid=0
> smb_pid=65279
> smb_uid=163
> smb_mid=14793
> smt_wct=2
> smb_vwv[ 0]= 255 (0xFF)
> smb_vwv[ 1]= 0 (0x0)
> smb_bcc=0
> [2005/01/04 17:22:20, 3] smbd/process.c:process_smb(1092)
> Transaction 71334 of length 39
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(461)
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(471)
> size=35
> smb_com=0x71
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=24
> smb_flg2=51207
> smb_tid=3
> smb_pid=65279
> smb_uid=129
> smb_mid=14857
> smt_wct=0
> smb_bcc=0
> [2005/01/04 17:22:20, 3] smbd/process.c:switch_message(887)
> switch message SMBtdis (pid 25406) conn 0x8408848
> [2005/01/04 17:22:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:22:20, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:22:20, 4] smbd/vfs.c:vfs_ChDir(654)
> vfs_ChDir to /data/samba/spool
> [2005/01/04 17:22:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:22:20, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:22:20, 1] smbd/service.c:close_cnum(836)
> w2kgreg (192.168.1.57) closed connection to service plotter
> [2005/01/04 17:22:20, 3] smbd/connection.c:yield_connection(69)
> Yielding connection to plotter
> [2005/01/04 17:22:20, 4] smbd/vfs.c:vfs_ChDir(654)
> vfs_ChDir to /
> [2005/01/04 17:22:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:22:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:22:20, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(461)
> [2005/01/04 17:22:20, 5] lib/util.c:show_msg(471)
> size=35
> smb_com=0x71
> smb_rcls=0
> smb_reh=0
> smb_err=0
> smb_flg=136
> smb_flg2=51201
> smb_tid=3
> smb_pid=65279
> smb_uid=129
> smb_mid=14857
> smt_wct=0
> smb_bcc=0
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:23:20, 5] smbd/uid.c:change_to_root_user(296)
> change_to_root_user: now uid=(0,0) gid=(0,0)
> [2005/01/04 17:23:20, 5] lib/smbldap.c:smbldap_close(930)
> The connection to the LDAP server was closed
> [2005/01/04 17:23:20, 3] smbd/process.c:check_reload(1316)
> Printcap cache time expired.
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printername_ok(308)
> cups_printername_ok("acct_hp8500")
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printername_ok(308)
> cups_printername_ok("plotter")
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printername_ok(308)
> cups_printername_ok("engr_hp1300")
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printername_ok(308)
> cups_printername_ok("engr_legacy_printer")
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printername_ok(308)
> cups_printername_ok("FAX")
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printername_ok(308)
> cups_printername_ok("PDFcreator")
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printername_ok(308)
> cups_printername_ok("truss_hp4")
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printername_ok(308)
> cups_printername_ok("truss_hp4050")
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printername_ok(308)
> cups_printername_ok("truss_hp5n")
> [2005/01/04 17:23:20, 5] printing/print_cups.c:cups_printer_fn(79)
> cups_printer_fn(0x807c601)
> [2005/01/04 17:23:20, 3] printing/printing.c:print_cache_expired(1930)
> print cache expired for queue truss_hp4050 (last_qscan_time = 1104877271,
> time now =1104877400, qcachetime = 10)
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:push_sec_ctx(256)
> push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
> [2005/01/04 17:23:20, 3] smbd/uid.c:push_conn_ctx(365)
> push_conn_ctx(0) : conn_ctx_stack_ndx = 0
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
> pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:23:20, 3] printing/printing.c:print_cache_expired(1930)
> print cache expired for queue truss_hp4 (last_qscan_time = 1104877271,
> time now = 1104877400, qcachetime = 10)
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:push_sec_ctx(256)
> push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
> [2005/01/04 17:23:20, 3] smbd/uid.c:push_conn_ctx(365)
> push_conn_ctx(0) : conn_ctx_stack_ndx = 0
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
> pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:23:20, 3] printing/printing.c:print_cache_expired(1930)
> print cache expired for queue engr_hp1300 (last_qscan_time = 1104877271,
> time now = 1104877400, qcachetime = 10)
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:push_sec_ctx(256)
> push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
> [2005/01/04 17:23:20, 3] smbd/uid.c:push_conn_ctx(365)
> push_conn_ctx(0) : conn_ctx_stack_ndx = 0
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
> pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2005/01/04 17:23:20, 3] printing/printing.c:print_cache_expired(1930)
> print cache expired for queue truss_hp5n (last_qscan_time = 1104877271,
> time now = 1104877400, qcachetime = 10)
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:push_sec_ctx(256)
> push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
> [2005/01/04 17:23:20, 3] smbd/uid.c:push_conn_ctx(365)
> push_conn_ctx(0) : conn_ctx_stack_ndx = 0
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:set_sec_ctx(288)
> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_nt_user_token(486)
> NT user token: (NULL)
> [2005/01/04 17:23:20, 5] auth/auth_util.c:debug_unix_user_token(505)
> UNIX token of user 0
> Primary group is 0 and contains 0 supplementary groups
> [2005/01/04 17:23:20, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
> pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>
> > - John T.
> > --
> > John H Terpstra
> > Samba-Team Member
> > Phone: +1 (650) 580-8668
> >
> > Author:
> > The Official Samba-3 HOWTO & Reference Guide, ISBN: 0131453556
> > Samba-3 by Example, ISBN: 0131472216
> > Hardening Linux, ISBN: 0072254971
> > Other books in production.
More information about the samba
mailing list