[Samba] Citrix trigging printing bug??

Thu Nov 14 08:17:00 GMT 2002

Hi 

We have a mystical error occurring in a special case. When we run a
citrix client on the Windows client we will not receive any printouts -
no printer dialogue box are opened either. From windows we get nothing -
no message box no nothing.

* We are running SAMBA 2.2.6 on solaris 7
* We are running a citrix client on Windows 2000 Pro SP3 connected to
  the SAMBA without domain. The Citrix client tries to make a 
  connection to the users default printer and it seems like it fails.
* We have device drivers uploaded to the samba server for some of the
  printers but it does not make any difference if we remove nt*.tdb 
  files. 
* This was working before, but all of a sudden it stoped working,
  possebly trigged by upploading new printer drivers, possebly by
  something else.

In the logs we find this on level 1 when we start the citrix connection
on the windows client "130.240.3.45" with the default printer "lwdup".

[2002/11/11 13:55:08, 1] lib/util_sock.c:open_socket_out(860)
  timeout connecting to 130.240.3.200:139
[2002/11/11 13:55:08, 1] libsmb/cliconnect.c:cli_connect(787)
  Error connecting to 130.240.3.200 (Operation already in progress)
 [2002/11/11 13:55:22, 0] smbd/service.c:make_connection(251)
  sm-pc255 (130.240.3.45) couldn't find service lwdup,winspool,ne13:
... (a lot of the same)
[2002/11/11 13:55:22, 0] smbd/service.c:make_connection(251)
  sm-pc255 (130.240.3.45) couldn't find service lwdup,winspool,ne13:

And in the logs from the same Windows client under the same
circumstances we find:

[2002/11/11 14:29:55, 3] smbd/service.c:find_service(140)
  checking for home directory lwdup,winspool,ne13: gave (NULL)
[2002/11/11 14:29:55, 3] smbd/service.c:find_service(209)
  find_service() failed to find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 0] smbd/service.c:make_connection(251)
  sm-pc255 (130.240.3.45) couldn't find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 3] smbd/error.c:error_packet(106)
  error packet at smbd/reply.c(164) cmd=117 (SMBtconX)
NT_STATUS_BAD_NETWORK_NAME
[2002/11/11 14:29:55, 3] smbd/process.c:process_smb(878)
  Transaction 59758 of length 85
[2002/11/11 14:29:55, 3] smbd/process.c:switch_message(685)
  switch message SMBtconX (pid 1694)
[2002/11/11 14:29:55, 3] smbd/sec_ctx.c:set_sec_ctx(328)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2002/11/11 14:29:55, 3] smbd/service.c:find_service(140)
  checking for home directory lwdup,winspool,ne13: gave (NULL)
[2002/11/11 14:29:55, 3] smbd/service.c:find_service(209)
  find_service() failed to find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 0] smbd/service.c:make_connection(251)
  sm-pc255 (130.240.3.45) couldn't find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 3] smbd/error.c:error_packet(106)
  error packet at smbd/reply.c(164) cmd=117 (SMBtconX)
NT_STATUS_BAD_NETWORK_NAME
[2002/11/11 14:29:55, 3] smbd/process.c:process_smb(878)
  Transaction 59759 of length 85
[2002/11/11 14:29:55, 3] smbd/process.c:switch_message(685)
  switch message SMBtconX (pid 1694)
[2002/11/11 14:29:55, 3] smbd/sec_ctx.c:set_sec_ctx(328)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2002/11/11 14:29:55, 3] smbd/service.c:find_service(140)
  checking for home directory lwdup,winspool,ne13: gave (NULL)
[2002/11/11 14:29:55, 3] smbd/service.c:find_service(209)
  find_service() failed to find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 0] smbd/service.c:make_connection(251)
  sm-pc255 (130.240.3.45) couldn't find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 3] smbd/error.c:error_packet(106)
  error packet at smbd/reply.c(164) cmd=117 (SMBtconX)
NT_STATUS_BAD_NETWORK_NAME
[2002/11/11 14:29:55, 3] smbd/process.c:process_smb(878)
  Transaction 59760 of length 85
[2002/11/11 14:29:55, 3] smbd/process.c:switch_message(685)
  switch message SMBtconX (pid 1694)
[2002/11/11 14:29:55, 3] smbd/process.c[:2002/11/11 14:29:55process_smb,
3(878] )
smbd/sec_ctx.c  Transaction 114179 of length 96
:set_sec_ctx(328)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2002/11/11 14:29:55, 3] smbd/process.c:switch_message(685)
  switch message SMBntcreateX (pid 10223)
[2002/11/11 14:29:55, 3] smbd/sec_ctx.c:set_sec_ctx(328)
  setting sec ctx (250, 10) - sec_ctx_stack_ndx = 0
[2002/11/11 14:29:55, 3] smbd/service.c[:2002/11/11
14:29:55find_service, 3(140] )
smbd/sec_ctx.c  checking for home directory lwdup,winspool,ne13: gave
(NULL)
:set_sec_ctx(334)
  9 user groups: 
  10 2254 6001 42 0 31 47 6002 6010 
[2002/11/11 14:29:55, 3] smbd/service.c:find_service[(2092002/11/11
14:29:55)
, 3  find_service() failed to find service lwdup,winspool,ne13:
] smbd/vfs.c:vfs_ChDir(569)
[  vfs_ChDir to /tmp
2002/11/11 14:29:55, 0] smbd/service.c:make_connection(251)
[2002/11/11 14:29:55, 3] smbd/nttrans.c  sm-pc255 (130.240.3.45)
couldn't find service lwdup,winspool,ne13:
:nt_open_pipe(559)
  nt_open_pipe: Known pipe spoolss opening.
[2002/11/11 14:29:55, 3] smbd/error.c:error_packet(106)
  error packet at smbd/reply.c(164) cmd=117 (SMBtconX)
NT_STATUS_BAD_NETWORK_NAME
[2002/11/11 14:29:55, 3] smbd/process.c:process_smb(878)
  Transaction 114180 of length 152
[2002/11/11 14:29:55, 3] smbd/process.c:switch_message(685)
  switch message SMBtrans (pid 10223)
[2002/11/11 14:29:55, 3] smbd/ipc.c:reply_trans(479)
  trans <\PIPE\> data=72 params=0 setup=2
[2002/11/11 14:29:55, 3] smbd/ipc.c:named_pipe(334)
  named pipe command on <> name
[2002/11/11 14:29:55, 3] smbd/ipc.c:api_fd_reply(296)
  Got API command 0x26 on pipe "spoolss" (pnum 73d4)api_pipe_bind_req:
\PIPE\spoolss -> \PIPE\spoolss
[2002/11/11 14:29:55, 3] smbd/process.c:process_smb(878)
  Transaction 114181 of length 272
[2002/11/11 14:29:55, 3] smbd/process.c:switch_message(685)
  switch message SMBtrans (pid 10223)
[2002/11/11 14:29:55, 3] smbd/ipc.c:reply_trans(479)
  trans <\PIPE\> data=192 params=0 setup=2
[2002/11/11 14:29:55, 3] smbd/ipc.c:named_pipe(334)
  named pipe command on <> name
[2002/11/11 14:29:55, 3] smbd/ipc.c:api_fd_reply(296)
  Got API command 0x26 on pipe "spoolss" (pnum 73d4)free_pipe_context:
destroying talloc pool of size 0
[2002/11/11 14:29:55, 3] rpc_server/srv_pipe.c:api_pipe_request(1148)
  Doing \PIPE\spoolss
[2002/11/11 14:29:55, 3] rpc_server/srv_pipe.c:api_rpcTNP(1180)
  api_rpcTNP: pipe 29652 rpc command: SPOOLSS_OPENPRINTEREX
  checking name: \\SM_LISA\lw30
[2002/11/11 14:29:55, 3]
rpc_server/srv_spoolss_nt.c:set_printer_hnd_printertype(394)
  Setting printer type=\\SM_LISA\lw30
[2002/11/11 14:29:55, 3] smbd/process.c:process_smb(878)
  Transaction 59761 of length 85
[2002/11/11 14:29:55, 3] smbd/process.c:switch_message(685)
  switch message SMBtconX (pid 1694)
[2002/11/11 14:29:55, 3] smbd/sec_ctx.c:set_sec_ctx(328)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2002/11/11 14:29:55, 3] smbd/service.c:find_service(140)
  checking for home directory lwdup,winspool,ne13: gave (NULL)
[2002/11/11 14:29:55, 3] smbd/service.c:find_service(209)
  find_service() failed to find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 0] smbd/service.c:make_connection(251)
  sm-pc255 (130.240.3.45) couldn't find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 3] smbd/error.c:error_packet(106)
  error packet at smbd/reply.c(164) cmd=117 (SMBtconX)
NT_STATUS_BAD_NETWORK_NAME
[2002/11/11 14:29:55, 3] smbd/process.c:process_smb(878)
  Transaction 59762 of length 85
[2002/11/11 14:29:55, 3] smbd/process.c:switch_message(685)
  switch message SMBtconX (pid 1694)
[2002/11/11 14:29:55, 3] smbd/sec_ctx.c:set_sec_ctx(328)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2002/11/11 14:29:55, 3] smbd/service.c:find_service(140)
  checking for home directory lwdup,winspool,ne13: gave (NULL)
[2002/11/11 14:29:55, 3] smbd/service.c:find_service(209)
  find_service() failed to find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 0] smbd/service.c:make_connection(251)
  sm-pc255 (130.240.3.45) couldn't find service lwdup,winspool,ne13:
[2002/11/11 14:29:55, 3] smbd/error.c:error_packet(106)
  error packet at smbd/reply.c(164) cmd=117 (SMBtconX)
NT_STATUS_BAD_NETWORK_NAME

We have tried to provoke the SAMBA connection to create the same entries
in the log when we did things in windows. But the only way to receive
those entries in the log was to start citrix
 * Printing from applications like Excel, Word Notepad to the default
   printer does not trig the event,
 * Net use h: \\server\share from command.com does not trig the event
 * copy postscriptfile.ps \\server\printer from command.com does not
   trig the event
 * Viewing properties on the printers locally on the windows client does
   not trig the event.
 * Viewing properties on the printers on the server's shared printers
from the windows client does not trig the event.

We have ran out of ideas on how to go further from this - does anyone
have any idea?

Sincerely,
Andreas
-- 
Andreas Nilsson                     
Systemtekniks datordrift (CSEE Computer Support, LTU)
Tel: 0920 49 2890
----