[Samba] Windows VBSscript and test.sh execution in /tmp/public in AIX 5.3

Dan Anna neopreneman at yahoo.com
Mon Apr 25 14:47:23 GMT 2005


Hello,

I am having a very speific problem with my samba
interface.  We just migrated to a new IBM pSeries
server with AIX 5.3.  The older server was a RS6000,
with AIX 5.2 and everything I'm about to describe
below worked without fail. 

We have a Windows 2000 Server that runs IIS.  There is
a web-based program (programmed in VB Script) that
calls test.sh AIX script (through samba) on our AIX
box.  The Windows program then writes another command
to the test.sh file after which time it is supposed to
execute (this is how it worked on the old box).

Samba is working, becuase I can see the AIX directory
structure from a Windows client (logged in as any
user, not just admin).  I can drag (copy) files from
Windows into the AIX directories that have been shared
through Samba and delete them.  Additionally, I can
place the file that the command string in the test.sh
file would normally generate, and the Windows client
can grab the file.  Any user can generate a test.sh
file in /tmp/public, including nobody, and then
execute the shell script to generate the final file
(an ASCII flat file).

I have attached the samba log that includes level 3
debugging of the problem.

Thank you,
Dan


__________________________________________________
Do You Yahoo!?
Tired of spam?  Yahoo! Mail has the best spam protection around 
http://mail.yahoo.com 
-------------- next part --------------
[2005/04/22 12:21:35.865157, 2, pid=19888, effective(0, 0), real(0, 0)] smbd/connection.c:utmp_claim(560)
  utmp_claim: conn NULL
[2005/04/22 12:21:35.866088, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 1 of length 137
[2005/04/22 12:21:35.866179, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBnegprot (pid 19888)
[2005/04/22 12:21:35.866275, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/negprot.c:reply_negprot(341)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2005/04/22 12:21:35.866359, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/negprot.c:reply_negprot(341)
  Requested protocol [LANMAN1.0]
[2005/04/22 12:21:35.866441, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/negprot.c:reply_negprot(341)
  Requested protocol [Windows for Workgroups 3.1a]
[2005/04/22 12:21:35.866523, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/negprot.c:reply_negprot(341)
  Requested protocol [LM1.2X002]
[2005/04/22 12:21:35.866604, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/negprot.c:reply_negprot(341)
  Requested protocol [LANMAN2.1]
[2005/04/22 12:21:35.866687, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/negprot.c:reply_negprot(341)
  Requested protocol [NT LM 0.12]
[2005/04/22 12:21:35.867066, 3, pid=19888, effective(0, 0), real(0, 0)] libsmb/namequery.c:resolve_lmhosts(565)
  resolve_lmhosts: Attempting lmhosts lookup for name HOOK<0x20>
[2005/04/22 12:21:35.867160, 3, pid=19888, effective(0, 0), real(0, 0)] libsmb/namequery.c:resolve_hosts(605)
  resolve_hosts: Attempting host lookup for name HOOK<0x20>
[2005/04/22 12:21:35.867607, 3, pid=19888, effective(0, 0), real(0, 0)] lib/util_sock.c:open_socket_out(907)
  Connecting to 172.26.8.10 at port 139
[2005/04/22 12:21:36.117818, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:server_cryptkey(1018)
  connected to password server HOOK
[2005/04/22 12:21:36.118283, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:server_cryptkey(1033)
  got session
[2005/04/22 12:21:36.118781, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:server_cryptkey(1048)
  password server OK
[2005/04/22 12:21:36.118866, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/negprot.c:reply_nt1(184)
  using password server validation
[2005/04/22 12:21:36.118962, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/negprot.c:reply_negprot(424)
  Selected protocol NT LM 0.12
[2005/04/22 12:21:36.132260, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 2 of length 137
[2005/04/22 12:21:36.132348, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBsesssetupX (pid 19888)
[2005/04/22 12:21:36.132433, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/reply.c:reply_sesssetup_and_X(805)
  Domain=[]  NativeOS=[Windows 2000 2195] NativeLanMan=[Windows 2000 5.0]
[2005/04/22 12:21:36.132530, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/reply.c:reply_sesssetup_and_X(809)
  sesssetupX:name=[]
[2005/04/22 12:21:36.137072, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:setup_groups(192)
  nobody is in 1 groups: -2
[2005/04/22 12:21:36.137158, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:register_vuid(270)
  uid -2 registered to name nobody
[2005/04/22 12:21:36.137241, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:register_vuid(272)
  Clearing default real name
[2005/04/22 12:21:36.137329, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:chain_reply(775)
  Chained message
[2005/04/22 12:21:36.137413, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBtconX (pid 19888)
[2005/04/22 12:21:36.176103, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:authorise_login(816)
  ACCEPTED: guest account and guest ok
[2005/04/22 12:21:36.176396, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/service.c:make_connection(441)
  Connect path is /tmp
[2005/04/22 12:21:36.176500, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/doscalls.c:dos_ChDir(342)
  dos_ChDir to /tmp
[2005/04/22 12:21:36.176963, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/service.c:make_connection(550)
  hopper (172.26.8.11) connect to service IPC$ as user nobody (uid=-2, gid=-2) (pid 19888)
[2005/04/22 12:21:36.177055, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/doscalls.c:dos_ChDir(342)
  dos_ChDir to /
[2005/04/22 12:21:36.177154, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/reply.c:reply_tcon_and_X(358)
  tconX service=ipc$ user=nobody
[2005/04/22 12:21:36.189965, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 3 of length 200
[2005/04/22 12:21:36.190052, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBsesssetupX (pid 19888)
[2005/04/22 12:21:36.190137, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/reply.c:reply_sesssetup_and_X(805)
  Domain=[HFP]  NativeOS=[Windows 2000 2195] NativeLanMan=[Windows 2000 5.0]
[2005/04/22 12:21:36.190221, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/reply.c:reply_sesssetup_and_X(809)
  sesssetupX:name=[IUSR_HOPPER]
[2005/04/22 12:21:36.299344, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/reply.c:smb_create_user(505)
  smb_create_user: Running the command `' gave 0
[2005/04/22 12:21:36.312901, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/reply.c:reply_sesssetup_and_X(952)
  No such user iusr_hopper - using guest account
[2005/04/22 12:21:36.315646, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:setup_groups(192)
  nobody is in 1 groups: -2
[2005/04/22 12:21:36.315737, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:register_vuid(270)
  uid -2 registered to name nobody
[2005/04/22 12:21:36.315821, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:register_vuid(272)
  Clearing default real name
[2005/04/22 12:21:36.315912, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:chain_reply(775)
  Chained message
[2005/04/22 12:21:36.316003, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBtconX (pid 19888)
[2005/04/22 12:21:36.354851, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:authorise_login(816)
  ACCEPTED: guest account and guest ok
[2005/04/22 12:21:36.355159, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/service.c:make_connection(441)
  Connect path is /tmp/public/
[2005/04/22 12:21:36.356763, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/password.c:setup_groups(192)
  nobody is in 1 groups: -2
[2005/04/22 12:21:36.356933, 2, pid=19888, effective(0, 0), real(0, 0)] smbd/connection.c:utmp_claim(565)
  utmp_claim: lp_utmp() NULL
[2005/04/22 12:21:36.357036, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/doscalls.c:dos_ChDir(342)
  dos_ChDir to /tmp/public/
[2005/04/22 12:21:36.357529, 1, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/service.c:make_connection(550)
  hopper (172.26.8.11) connect to service public as user nobody (uid=-2, gid=-2) (pid 19888)
[2005/04/22 12:21:36.357623, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/doscalls.c:dos_ChDir(342)
  dos_ChDir to /
[2005/04/22 12:21:36.357723, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/reply.c:reply_tcon_and_X(358)
  tconX service=public user=nobody
[2005/04/22 12:21:36.359295, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 4 of length 96
[2005/04/22 12:21:36.359387, 3, pid=19888, effective(0, 0), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBntcreateX (pid 19888)
[2005/04/22 12:21:36.359486, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/doscalls.c:dos_ChDir(342)
  dos_ChDir to /tmp/public/
[2005/04/22 12:21:36.359585, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/util.c:unix_clean_name(522)
  unix_clean_name [/test.sh]
[2005/04/22 12:21:36.359727, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/util.c:unix_clean_name(522)
  unix_clean_name [test.sh]
[2005/04/22 12:21:36.359818, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/util.c:unix_clean_name(522)
  unix_clean_name [test.sh]
[2005/04/22 12:21:36.364473, 2, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/open.c:open_file(602)
  iusr_hopper opened file test.sh read=No write=Yes (numopen=1)
[2005/04/22 12:21:36.364579, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] locking/locking_shm.c:shm_set_share_mode(456)
  set_share_mode: Created share record for test.sh (dev a0007 inode 8193)
[2005/04/22 12:21:36.364683, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] locking/locking_shm.c:shm_set_share_mode(495)
  set_share_mode: Created share entry for test.sh with mode 0x21 pid=19888
[2005/04/22 12:21:36.365988, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 5 of length 84
[2005/04/22 12:21:36.366074, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBtrans2 (pid 19888)
[2005/04/22 12:21:36.366163, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/trans2.c:call_trans2qfsinfo(1117)
  call_trans2qfsinfo: level = 1
[2005/04/22 12:21:36.366589, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 6 of length 69
[2005/04/22 12:21:36.366675, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBwriteX (pid 19888)
[2005/04/22 12:21:36.366788, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/reply.c:reply_write_and_X(2609)
  writeX fnum=4960 num=1 wrote=1
[2005/04/22 12:21:36.367184, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 7 of length 84
[2005/04/22 12:21:36.367270, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBtrans2 (pid 19888)
[2005/04/22 12:21:36.367355, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/trans2.c:call_trans2qfilepathinfo(1302)
  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 258
[2005/04/22 12:21:36.367442, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/trans2.c:call_trans2qfilepathinfo(1363)
  call_trans2qfilepathinfo test.sh level=258 call=7 total_data=0
[2005/04/22 12:21:36.367779, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 8 of length 52
[2005/04/22 12:21:36.367864, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBwrite (pid 19888)
[2005/04/22 12:21:36.367953, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/reply.c:reply_write(2533)
  write fnum=4960 num=0 wrote=0
[2005/04/22 12:21:36.368480, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 9 of length 169
[2005/04/22 12:21:36.368565, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBwriteX (pid 19888)
[2005/04/22 12:21:36.368676, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/reply.c:reply_write_and_X(2609)
  writeX fnum=4960 num=101 wrote=101
[2005/04/22 12:21:36.369378, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 10 of length 45
[2005/04/22 12:21:36.369463, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBclose (pid 19888)
[2005/04/22 12:21:36.369547, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/reply.c:reply_close(2791)
  close fd=7 fnum=4960 (numopen=1)
[2005/04/22 12:21:36.369637, 2, pid=19888, effective(4294967294, 4294967294), real(0, 0)] locking/locking_shm.c:shm_del_share_mode(355)
  del_share_modes Deleting share mode entry dev=a0007 ino=8193
[2005/04/22 12:21:36.369725, 2, pid=19888, effective(4294967294, 4294967294), real(0, 0)] locking/locking_shm.c:shm_del_share_mode(376)
  del_share_modes num entries = 0, deleting share_mode dev=a0007 ino=8193
[2005/04/22 12:21:36.369831, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/open.c:fd_attempt_close(162)
  fd_attempt_close fd = 7, dev = a0007, inode = 8193, open_flags = 2, ref_count = 1.
[2005/04/22 12:21:36.382572, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/close.c:check_magic(60)
  Invoking magic command test.sh gave 127
[2005/04/22 12:21:36.384551, 2, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/close.c:close_normal_file(159)
  nobody closed file test.sh (numopen=0) 
[2005/04/22 12:21:36.385564, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:process_smb(618)
  Transaction 11 of length 106
[2005/04/22 12:21:36.385660, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/process.c:switch_message(448)
  switch message SMBntcreateX (pid 19888)
[2005/04/22 12:21:36.385762, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/util.c:unix_clean_name(522)
  unix_clean_name [/gpms2dfout140.991]
[2005/04/22 12:21:36.385932, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/util.c:unix_clean_name(522)
  unix_clean_name [gpms2dfout140.991]
[2005/04/22 12:21:36.386026, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] lib/util.c:unix_clean_name(522)
  unix_clean_name [gpms2dfout140.991]
[2005/04/22 12:21:36.386123, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/open.c:open_file(529)
  Error opening file gpms2dfout140.991 (A file or directory in the path name does not exist.) (flags=0)
[2005/04/22 12:21:36.386306, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/open.c:fd_attempt_close(162)
  fd_attempt_close fd = -1, dev = ffffffff, inode = 18446744073709551616, open_flags = 2, ref_count = 1.
[2005/04/22 12:21:36.386415, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/error.c:error_packet(138)
  error packet at line 878 cmd=162 (SMBntcreateX) eclass=1 ecode=2
[2005/04/22 12:21:36.386514, 3, pid=19888, effective(4294967294, 4294967294), real(0, 0)] smbd/error.c:error_packet(143)
  error string = A file or directory in the path name does not exist.


More information about the samba mailing list