[Samba] print issue with 2.2.4a on FreeBSD

David Bear David.Bear at asu.edu
Wed Jan 8 04:21:01 GMT 2003


I have installed samba 2.2.7 on freebsd from the ports collections.  I had a previous installation of samba 2.0 and I used my old smb.conf file to duplicate the funcationality I had.  Trouble is, printing from winNT/2K clients doesn't work.  Printing from win9x machines still does.

I've been through the docs on samba.org and looked in chap6 of HOWTO collection on printing and the differences.  Either I'm too dense or missing something.  v2.2 implements rpc based printing but did it removed the older pipe/share based printing as well?

I was usings a [printers] section in my older smb.conf file to grab all printcap printers -- which worked flawlessly for a very long time under 2.0x.  This is broken on 2.2 form me..  So I tried to just create a named printer section in my smb.conf file.  The relevent section is below.  Still, when attempting to access the \\servername\printername win2k gives me an access denied.   I've tried adding a printer using both the network and local versions in the wizard (i've kludge adding network printer to a system by telling the wizard it was local and then changing the port to a unc) but this didn't work  -- access denied message on windows.  The funny thing is I never am denied by samba -- meaning I can't see where samba denies the action of using the share.  I turned log level to 5 and have attached those as well.  Please, any advice is appreciated.

<====== smb.conf snippet ==============>

[urbanhp1]
   path = /home/printers/urbanhp1
   comment = Urban Inquiry HP4050 AG312
   printable = yes
   printer name = urbanhp1
   valid users = @samba

<======= files/dire and perms =========>

ls -l /home/printers 
total 12
drwxrw-rw-  2 iddwb  samba  512 Jan  7 17:31 aishp1
drwxrw-rw-  2 iddwb  samba  512 Jan  7 17:32 aishp2
drwxrw-rw-  2 iddwb  samba  512 Jan  7 17:32 apashp1
drwxrw-rw-  2 iddwb  samba  512 Jan  7 17:32 apashp2
drwxrw-rw-  2 iddwb  samba  512 Jan  7 17:32 rmthp2
drwxrw-rw-  2 iddwb  samba  512 Jan  7 17:31 urbanhp1


<======== snippet from log file created while attempting to add
the printer =======================>

[2003/01/07 17:42:52, 3] smbd/process.c:process_smb(878)
  Transaction 1 of length 137
[2003/01/07 17:42:52, 3] smbd/process.c:switch_message(685)
  switch message SMBnegprot (pid 93569)
[2003/01/07 17:42:52, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2003/01/07 17:42:52, 3] smbd/negprot.c:reply_negprot(342)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2003/01/07 17:42:52, 3] smbd/negprot.c:reply_negprot(342)
  Requested protocol [LANMAN1.0]
[2003/01/07 17:42:52, 3] smbd/negprot.c:reply_negprot(342)
  Requested protocol [Windows for Workgroups 3.1a]
[2003/01/07 17:42:52, 3] smbd/negprot.c:reply_negprot(342)
  Requested protocol [LM1.2X002]
[2003/01/07 17:42:52, 3] smbd/negprot.c:reply_negprot(342)
  Requested protocol [LANMAN2.1]
[2003/01/07 17:42:52, 3] smbd/negprot.c:reply_negprot(342)
  Requested protocol [NT LM 0.12]
[2003/01/07 17:42:52, 3] libsmb/namequery.c:resolve_wins(709)
  resolve_wins: Attempting wins lookup for name ASURITE1<0x20>
[2003/01/07 17:42:52, 3] libsmb/namequery.c:resolve_wins(727)
  resolve_wins: WINS server == <129.219.13.105>
[2003/01/07 17:42:52, 3] lib/util_sock.c:open_socket_in(813)
  bind succeeded on port 0
[2003/01/07 17:42:52, 2] libsmb/namequery.c:name_query(421)
  Got a positive name query response from 129.219.13.105 ( 129.219.10.212 )
[2003/01/07 17:42:52, 3] lib/util_sock.c:open_socket_out(845)
  Connecting to 129.219.10.212 at port 445
[2003/01/07 17:42:53, 3] smbd/password.c:server_cryptkey(1045)
  connected to password server ASURITE1
[2003/01/07 17:42:53, 3] smbd/password.c:server_cryptkey(1064)
  got session
[2003/01/07 17:42:53, 3] smbd/password.c:server_cryptkey(1079)
  password server OK
[2003/01/07 17:42:53, 3] smbd/negprot.c:reply_nt1(179)
  using password server validation
[2003/01/07 17:42:53, 3] smbd/negprot.c:reply_negprot(426)
  Selected protocol NT LM 0.12
[2003/01/07 17:42:53, 3] smbd/process.c:process_smb(878)
  Transaction 2 of length 199
[2003/01/07 17:42:53, 3] smbd/process.c:switch_message(685)
  switch message SMBsesssetupX (pid 93569)
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2003/01/07 17:42:53, 3] smbd/reply.c:reply_sesssetup_and_X(858)
  Domain=[PP120144]  NativeOS=[Windows 2000 2195] NativeLanMan=[Windows 2000 5.0]
[2003/01/07 17:42:53, 3] smbd/reply.c:reply_sesssetup_and_X(868)
  sesssetupX:name=[iddwb]
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:push_sec_ctx(297)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2003/01/07 17:42:53, 3] smbd/uid.c:push_conn_ctx(286)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:get_current_groups(172)
  get_current_groups: user is in 3 groups: 1000, 1000, 0
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:pop_sec_ctx(436)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:get_current_groups(172)
  get_current_groups: user is in 3 groups: 1000, 1000, 0
[2003/01/07 17:42:53, 3] smbd/password.c:register_vuid(336)
  uid 1000 registered to name iddwb
[2003/01/07 17:42:53, 3] smbd/password.c:register_vuid(338)
  Clearing default real name
[2003/01/07 17:42:53, 3] smbd/password.c:register_vuid(340)
  User name: iddwb	Real name: David Bear
[2003/01/07 17:42:53, 3] smbd/process.c:chain_reply(1023)
  Chained message
[2003/01/07 17:42:53, 3] smbd/process.c:switch_message(685)
  switch message SMBtconX (pid 93569)
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2003/01/07 17:42:53, 3] lib/access.c:check_access(318)
  check_access: no hostnames in host allow/deny list.
[2003/01/07 17:42:53, 2] lib/access.c:check_access(329)
  Allowed connection from  (129.219.120.144)
[2003/01/07 17:42:53, 3] smbd/password.c:authorise_login(736)
  authorise_login: ACCEPTED: validated uid ok as non-guest (user=iddwb)
[2003/01/07 17:42:53, 3] smbd/service.c:make_connection(487)
  Connect path is /tmp
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:push_sec_ctx(297)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2003/01/07 17:42:53, 3] smbd/uid.c:push_conn_ctx(286)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:get_current_groups(172)
  get_current_groups: user is in 3 groups: 1000, 1000, 0
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:pop_sec_ctx(436)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:get_current_groups(172)
  get_current_groups: user is in 3 groups: 1000, 1000, 0
[2003/01/07 17:42:53, 3] lib/util_seaccess.c:se_access_check(269)
  se_access_check: user sid is S-1-5-21-1657254385-762952478-2043729924-3000
[2003/01/07 17:42:53, 3] lib/util_seaccess.c:se_access_check(273)
  se_access_check: also S-1-5-21-1657254385-762952478-2043729924-3001
[2003/01/07 17:42:53, 3] lib/util_seaccess.c:se_access_check(273)
  se_access_check: also S-1-5-21-1657254385-762952478-2043729924-1001
[2003/01/07 17:42:53, 3] lib/util_seaccess.c:se_access_check(273)
  se_access_check: also S-1-1-0
[2003/01/07 17:42:53, 3] lib/util_seaccess.c:se_access_check(273)
  se_access_check: also S-1-5-2
[2003/01/07 17:42:53, 3] lib/util_seaccess.c:se_access_check(273)
  se_access_check: also S-1-5-11
[2003/01/07 17:42:53, 3] smbd/vfs.c:vfs_init_default(123)
  Initialising default vfs hooks
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:set_sec_ctx(334)
  3 user groups: 
  1000 1000 0 
[2003/01/07 17:42:53, 3] smbd/vfs.c:vfs_ChDir(574)
  vfs_ChDir to /tmp
[2003/01/07 17:42:53, 3] smbd/service.c:make_connection(636)
  pp120144 (129.219.120.144) connect to service IPC$ as user iddwb (uid=1000, gid=1000) (pid 93569)
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2003/01/07 17:42:53, 3] smbd/reply.c:reply_tcon_and_X(395)
  tconX service=ipc$ user=iddwb
[2003/01/07 17:42:53, 3] smbd/process.c:process_smb(878)
  Transaction 3 of length 96
[2003/01/07 17:42:53, 3] smbd/process.c:switch_message(685)
  switch message SMBntcreateX (pid 93569)
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0
[2003/01/07 17:42:53, 3] smbd/sec_ctx.c:set_sec_ctx(334)
  3 user groups: 
  1000 1000 0 
[2003/01/07 17:42:53, 3] smbd/nttrans.c:nt_open_pipe(559)
  nt_open_pipe: Known pipe spoolss opening.
[2003/01/07 17:42:53, 3] smbd/process.c:process_smb(878)
  Transaction 4 of length 140
[2003/01/07 17:42:53, 3] smbd/process.c:switch_message(685)
  switch message SMBwriteX (pid 93569)
[2003/01/07 17:42:53, 3] rpc_server/srv_pipe.c:api_pipe_bind_req(751)
  api_pipe_bind_req: \PIPE\spoolss -> \PIPE\spoolss
[2003/01/07 17:42:53, 3] smbd/pipes.c:reply_pipe_write_and_X(198)
  writeX-IPC pnum=718c nwritten=72
[2003/01/07 17:42:53, 3] smbd/process.c:process_smb(878)
  Transaction 5 of length 63
[2003/01/07 17:42:53, 3] smbd/process.c:switch_message(685)
  switch message SMBreadX (pid 93569)
[2003/01/07 17:42:53, 3] smbd/pipes.c:reply_pipe_read_and_X(239)
  readX-IPC pnum=718c min=1024 max=1024 nread=68
[2003/01/07 17:42:53, 3] smbd/process.c:process_smb(878)
  Transaction 6 of length 280
[2003/01/07 17:42:53, 3] smbd/process.c:switch_message(685)
  switch message SMBtrans (pid 93569)
[2003/01/07 17:42:53, 3] smbd/ipc.c:reply_trans(480)
  trans <\PIPE\> data=200 params=0 setup=2
[2003/01/07 17:42:53, 3] smbd/ipc.c:named_pipe(334)
  named pipe command on <> name
[2003/01/07 17:42:53, 3] smbd/ipc.c:api_fd_reply(296)
  Got API command 0x26 on pipe "spoolss" (pnum 718c)free_pipe_context: destroying talloc pool of size 0
[2003/01/07 17:42:53, 3] rpc_server/srv_pipe.c:api_pipe_request(1148)
  Doing \PIPE\spoolss
[2003/01/07 17:42:53, 3] rpc_server/srv_pipe.c:api_rpcTNP(1180)
  api_rpcTNP: pipe 29068 rpc command: SPOOLSS_OPENPRINTEREX
  checking name: \\urbansrv1\urbanhp1
[2003/01/07 17:42:53, 3] rpc_server/srv_spoolss_nt.c:set_printer_hnd_printertype(394)
  Setting printer type=\\urbansrv1\urbanhp1
[2003/01/07 17:42:53, 3] rpc_server/srv_spoolss_nt.c:_spoolss_open_printer_ex(1181)
  access DENIED for printer open
[2003/01/07 17:42:53, 3] rpc_server/srv_lsa_hnd.c:close_policy_hnd(205)
  Closed policy
[2003/01/07 17:42:53, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(444)
  free_pipe_context: destroying talloc pool of size 76
[2003/01/07 17:43:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2003/01/07 17:44:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2003/01/07 17:45:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2003/01/07 17:46:53, 3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0

-- 
David Bear
College of Public Programs/ASU
Mail Code 0803



More information about the samba mailing list