I am sending this again here, as I did not get any reply for some time, and haven't yet figured it out by myself:
Hi there. Leaving the idea of not providing driver files on the server for a while (only specifying the name, as in my previous thread here), I was trying the SPOOLSS adddriver RPC from rpcclient with Samba. The server runs Samba 3.0 post-HEAD from CVS checked out on the 3rd of March. rpcclient is from the same version of Samba. I went to try it with the HP LaserJet 5Si/5Si MX PS driver. I put all the files in the print share at (\\dev\print$\w32x86). The files are from Windows XP Professional SP1. The files are, as reported by the printer test page: pscript.ntf pscript.hlp ps5ui.dll hplj5si1.ppd pscript5.dll I issued the following command from rpcclient: adddriver "Windows NT x86" "HP LaserJet 5Si/5Si MX PS":pscript5.dll:hplj5si1.ppd:ps5ui.dll:pscript.hlp::pscript.ntf At first it gave a segmentation fault, which should not happen. I assumed there is something wrong deeper than this, but anyway I traced this to be a NULL pointer dereference of the return value of get_driver_3_param. After applying the following patch to rpcclient/cmd_spoolss.c, just to get it not to seg-fault in that case so I can get some more details: --- cmd_spoolss.c.orig Wed Mar 12 12:36:05 2003 +++ cmd_spoolss.c Wed Mar 12 12:35:52 2003 @@ -1149,6 +1149,9 @@ { char *ptr; + if (!str) + return ""; + /* get the next token */ ptr = strtok(str, delim); -- END OF PATCH So now it just gives: result was NT_STATUS_UNSUCCESSFUL Attached is a relevant snippet of the log file in debug level 4. I did not yet manage to figure out the problem from it. Any idea what the trace to this problem is? Any help appreciated, -- Tom -- Tom Alsberg - hacker (being the best description fitting this space) Web page: http://www.cs.huji.ac.il/~alsbergt/ DISCLAIMER: The above message does not even necessarily represent what my fingers have typed on the keyboard, save anything further.
[2003/03/12 12:52:21, 3] ../source/auth/auth.c:check_ntlm_password(192) check_ntlm_password: Checking password for unmapped user [EMAIL PROTECTED] with the new password interface [2003/03/12 12:52:21, 3] ../source/auth/auth.c:check_ntlm_password(195) check_ntlm_password: mapped user is: [EMAIL PROTECTED] [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2003/03/12 12:52:21, 3] ../source/smbd/uid.c:push_conn_ctx(287) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2003/03/12 12:52:21, 4] ../source/auth/auth_sam.c:sam_account_ok(321) sam_account_ok: Checking SMB password for user alsbergt [2003/03/12 12:52:21, 3] ../source/auth/auth_sam.c:sam_password_ok(177) sam_password_ok: NO NT password stored for user alsbergt. [2003/03/12 12:52:21, 3] ../source/auth/auth_sam.c:sam_password_ok(240) sam_password_ok: NO LanMan password set for user alsbergt (and no NT password supplied) [2003/03/12 12:52:21, 4] ../source/auth/auth_sam.c:sam_password_ok(254) sam_password_ok: LM password check failed for user, no NT password alsbergt [2003/03/12 12:52:21, 3] ../source/auth/auth_idng.c:check_idng_security(138) check_idng_security called: user="alsbergt" (alsbergt), auth succeeded [2003/03/12 12:52:21, 3] ../source/smbd/uid.c:fetch_sid_from_gid_cache(654) fetch sid from gid cache 6 -> S-1-5-21-2763996366-3983801899-2901956018-1013 [2003/03/12 12:52:21, 3] ../source/auth/auth.c:check_ntlm_password(229) check_ntlm_password: idng authentication for user [alsbergt] suceeded [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2003/03/12 12:52:21, 3] ../source/smbd/uid.c:push_conn_ctx(287) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2003/03/12 12:52:21, 2] ../source/auth/auth.c:check_ntlm_password(270) check_ntlm_password: authentication for user [alsbergt] -> [alsbergt] -> [alsbergt] suceeded [2003/03/12 12:52:21, 3] ../source/smbd/password.c:register_vuid(198) User name: alsbergt Real name: Tom Alsberg [2003/03/12 12:52:21, 3] ../source/smbd/password.c:register_vuid(216) UNIX uid 3228 is UNIX user alsbergt, and will be vuid 100 [2003/03/12 12:52:21, 3] ../source/smbd/password.c:register_vuid(232) Adding/updating homes service for user 'alsbergt' using home direcotry: '/cs/system/alsbergt' [2003/03/12 12:52:21, 3] ../source/param/loadparm.c:lp_add_home(2227) adding home's share [alsbergt] for user 'alsbergt' at '/cs/system/alsbergt' [2003/03/12 12:52:21, 3] ../source/smbd/process.c:process_smb(882) Transaction 3 of length 62 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:switch_message(676) switch message SMBtconX (pid 63090) [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2003/03/12 12:52:21, 4] ../source/smbd/reply.c:reply_tcon_and_X(255) Got device type IPC [2003/03/12 12:52:21, 3] ../source/lib/access.c:check_access(311) check_access: no hostnames in host allow/deny list. [2003/03/12 12:52:21, 2] ../source/lib/access.c:check_access(322) Allowed connection from (132.65.80.139) [2003/03/12 12:52:21, 3] ../source/smbd/service.c:make_connection_snum(525) Connect path is '/tmp' for service [IPC$] [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_srvsvc_nt.c:get_share_security(217) get_share_security: using default secdesc for IPC$ [2003/03/12 12:52:21, 3] ../source/lib/util_seaccess.c:se_access_check(267) [2003/03/12 12:52:21, 3] ../source/lib/util_seaccess.c:se_access_check(268) se_access_check: user sid is S-1-5-21-2763996366-3983801899-2901956018-7456 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1013 se_access_check: also S-1-1-0 se_access_check: also S-1-5-2 se_access_check: also S-1-5-11 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1011 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1061 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1081 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1085 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1169 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1211 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21419 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21457 [2003/03/12 12:52:21, 3] ../source/smbd/vfs.c:vfs_init_default(136) Initialising default vfs hooks [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_srvsvc_nt.c:get_share_security(217) get_share_security: using default secdesc for IPC$ [2003/03/12 12:52:21, 3] ../source/lib/util_seaccess.c:se_access_check(267) [2003/03/12 12:52:21, 3] ../source/lib/util_seaccess.c:se_access_check(268) se_access_check: user sid is S-1-5-21-2763996366-3983801899-2901956018-7456 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1013 se_access_check: also S-1-1-0 se_access_check: also S-1-5-2 se_access_check: also S-1-5-11 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1011 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1061 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1081 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1085 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1169 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1211 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21419 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21457 [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (3228, 6) - sec_ctx_stack_ndx = 0 [2003/03/12 12:52:21, 3] ../source/smbd/service.c:make_connection_snum(681) lurch (132.65.80.139) connect to service IPC$ initially as user alsbergt (uid=3228, gid=6) (pid 63090) [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2003/03/12 12:52:21, 3] ../source/smbd/reply.c:reply_tcon_and_X(296) tconX service=IPC$ [2003/03/12 12:52:21, 3] ../source/smbd/process.c:process_smb(882) Transaction 4 of length 104 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:switch_message(676) switch message SMBntcreateX (pid 63090) [2003/03/12 12:52:21, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (3228, 6) - sec_ctx_stack_ndx = 0 [2003/03/12 12:52:21, 3] ../source/smbd/vfs.c:vfs_ChDir(650) vfs_ChDir to /tmp [2003/03/12 12:52:21, 4] ../source/smbd/nttrans.c:nt_open_pipe(465) nt_open_pipe: Opening pipe \lsarpc. [2003/03/12 12:52:21, 3] ../source/smbd/nttrans.c:nt_open_pipe(482) nt_open_pipe: Known pipe lsarpc opening. [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:open_rpc_pipe_p(178) Open pipe requested lsarpc (pipes_open=0) [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:make_internal_rpc_pipe_p(279) Create pipe requested lsarpc [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:make_internal_rpc_pipe_p(372) Created internal pipe lsarpc (pipes_open=0) [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:open_rpc_pipe_p(258) Opened pipe lsarpc with handle 7717 (pipes_open=1) [2003/03/12 12:52:21, 3] ../source/smbd/process.c:process_smb(882) Transaction 5 of length 158 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:switch_message(676) switch message SMBtrans (pid 63090) [2003/03/12 12:52:21, 4] ../source/smbd/uid.c:change_to_user(122) change_to_user: Skipping user change - already user [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:reply_trans(472) trans <\PIPE\> data=72 params=0 setup=2 [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:named_pipe(326) named pipe command on <> name [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:get_rpc_pipe(1142) search for pipe pnum=7717 [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:api_fd_reply(288) Got API command 0x26 on pipe "lsarpc" (pnum 7717)api_pipe_bind_req: \PIPE\lsarpc -> \PIPE\lsass [2003/03/12 12:52:21, 3] ../source/rpc_server/srv_pipe.c:check_bind_req(712) check_bind_req for \PIPE\lsarpc [2003/03/12 12:52:21, 3] ../source/smbd/process.c:process_smb(882) Transaction 6 of length 154 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:switch_message(676) switch message SMBtrans (pid 63090) [2003/03/12 12:52:21, 4] ../source/smbd/uid.c:change_to_user(122) change_to_user: Skipping user change - already user [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:reply_trans(472) trans <\PIPE\> data=68 params=0 setup=2 [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:named_pipe(326) named pipe command on <> name [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:get_rpc_pipe(1142) search for pipe pnum=7717 [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:api_fd_reply(288) Got API command 0x26 on pipe "lsarpc" (pnum 7717)free_pipe_context: destroying talloc pool of size 0 [2003/03/12 12:52:21, 3] ../source/rpc_server/srv_pipe.c:api_pipe_request(1264) Doing \PIPE\lsarpc [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe.c:api_rpcTNP(1319) api_rpcTNP: lsarpc op 0x6 - api_rpcTNP: rpc command: LSA_OPENPOLICY [2003/03/12 12:52:21, 3] ../source/rpc_parse/parse_lsa.c:lsa_io_sec_qos(186) lsa_io_sec_qos: length c does not match size 8 [2003/03/12 12:52:21, 3] ../source/lib/util_seaccess.c:se_access_check(267) [2003/03/12 12:52:21, 3] ../source/lib/util_seaccess.c:se_access_check(268) se_access_check: user sid is S-1-5-21-2763996366-3983801899-2901956018-7456 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1013 se_access_check: also S-1-1-0 se_access_check: also S-1-5-2 se_access_check: also S-1-5-11 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1011 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1061 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1081 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1085 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1169 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1211 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21419 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21457 [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_lsa_hnd.c:create_policy_hnd(142) Opened policy hnd[1] [000] 00 00 00 00 01 00 00 00 00 00 00 00 65 11 6F 3E ........ ....e.o> [010] 72 F6 00 00 r... [2003/03/12 12:52:21, 3] ../source/rpc_server/srv_pipe_hnd.c:free_pipe_context(544) free_pipe_context: destroying talloc pool of size 808 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:process_smb(882) Transaction 7 of length 132 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:switch_message(676) switch message SMBtrans (pid 63090) [2003/03/12 12:52:21, 4] ../source/smbd/uid.c:change_to_user(122) change_to_user: Skipping user change - already user [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:reply_trans(472) trans <\PIPE\> data=46 params=0 setup=2 [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:named_pipe(326) named pipe command on <> name [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:get_rpc_pipe(1142) search for pipe pnum=7717 [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:api_fd_reply(288) Got API command 0x26 on pipe "lsarpc" (pnum 7717)free_pipe_context: destroying talloc pool of size 0 [2003/03/12 12:52:21, 3] ../source/rpc_server/srv_pipe.c:api_pipe_request(1264) Doing \PIPE\lsarpc [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe.c:api_rpcTNP(1319) api_rpcTNP: lsarpc op 0x7 - api_rpcTNP: rpc command: LSA_QUERYINFOPOLICY [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_lsa_hnd.c:find_policy_by_hnd_internal(162) Found policy hnd[0] [000] 00 00 00 00 01 00 00 00 00 00 00 00 65 11 6F 3E ........ ....e.o> [010] 72 F6 00 00 r... [2003/03/12 12:52:21, 3] ../source/rpc_server/srv_pipe_hnd.c:free_pipe_context(544) free_pipe_context: destroying talloc pool of size 512 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:process_smb(882) Transaction 8 of length 130 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:switch_message(676) switch message SMBtrans (pid 63090) [2003/03/12 12:52:21, 4] ../source/smbd/uid.c:change_to_user(122) change_to_user: Skipping user change - already user [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:reply_trans(472) trans <\PIPE\> data=44 params=0 setup=2 [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:named_pipe(326) named pipe command on <> name [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:get_rpc_pipe(1142) search for pipe pnum=7717 [2003/03/12 12:52:21, 3] ../source/smbd/ipc.c:api_fd_reply(288) Got API command 0x26 on pipe "lsarpc" (pnum 7717)free_pipe_context: destroying talloc pool of size 0 [2003/03/12 12:52:21, 3] ../source/rpc_server/srv_pipe.c:api_pipe_request(1264) Doing \PIPE\lsarpc [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe.c:api_rpcTNP(1319) api_rpcTNP: lsarpc op 0x0 - api_rpcTNP: rpc command: LSA_CLOSE [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_lsa_hnd.c:find_policy_by_hnd_internal(162) Found policy hnd[0] [000] 00 00 00 00 01 00 00 00 00 00 00 00 65 11 6F 3E ........ ....e.o> [010] 72 F6 00 00 r... [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_lsa_hnd.c:find_policy_by_hnd_internal(162) Found policy hnd[0] [000] 00 00 00 00 01 00 00 00 00 00 00 00 65 11 6F 3E ........ ....e.o> [010] 72 F6 00 00 r... [2003/03/12 12:52:21, 3] ../source/rpc_server/srv_lsa_hnd.c:close_policy_hnd(200) Closed policy [2003/03/12 12:52:21, 3] ../source/rpc_server/srv_pipe_hnd.c:free_pipe_context(544) free_pipe_context: destroying talloc pool of size 0 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:process_smb(882) Transaction 9 of length 45 [2003/03/12 12:52:21, 3] ../source/smbd/process.c:switch_message(676) switch message SMBclose (pid 63090) [2003/03/12 12:52:21, 4] ../source/smbd/uid.c:change_to_user(122) change_to_user: Skipping user change - already user [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:get_rpc_pipe(1142) search for pipe pnum=7717 [2003/03/12 12:52:21, 4] ../source/rpc_server/srv_pipe_hnd.c:close_rpc_pipe_hnd(1074) closed pipe name lsarpc pnum=7717 (pipes_open=0) [2003/03/12 12:52:25, 3] ../source/smbd/process.c:process_smb(882) Transaction 10 of length 106 [2003/03/12 12:52:25, 3] ../source/smbd/process.c:switch_message(676) switch message SMBntcreateX (pid 63090) [2003/03/12 12:52:25, 4] ../source/smbd/uid.c:change_to_user(122) change_to_user: Skipping user change - already user [2003/03/12 12:52:25, 4] ../source/smbd/nttrans.c:nt_open_pipe(465) nt_open_pipe: Opening pipe \spoolss. [2003/03/12 12:52:25, 3] ../source/smbd/nttrans.c:nt_open_pipe(482) nt_open_pipe: Known pipe spoolss opening. [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_pipe_hnd.c:open_rpc_pipe_p(178) Open pipe requested spoolss (pipes_open=0) [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_pipe_hnd.c:make_internal_rpc_pipe_p(279) Create pipe requested spoolss [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_pipe_hnd.c:make_internal_rpc_pipe_p(372) Created internal pipe spoolss (pipes_open=0) [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_pipe_hnd.c:open_rpc_pipe_p(258) Opened pipe spoolss with handle 7718 (pipes_open=1) [2003/03/12 12:52:25, 3] ../source/smbd/process.c:process_smb(882) Transaction 11 of length 158 [2003/03/12 12:52:25, 3] ../source/smbd/process.c:switch_message(676) switch message SMBtrans (pid 63090) [2003/03/12 12:52:25, 4] ../source/smbd/uid.c:change_to_user(122) change_to_user: Skipping user change - already user [2003/03/12 12:52:25, 3] ../source/smbd/ipc.c:reply_trans(472) trans <\PIPE\> data=72 params=0 setup=2 [2003/03/12 12:52:25, 3] ../source/smbd/ipc.c:named_pipe(326) named pipe command on <> name [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_pipe_hnd.c:get_rpc_pipe(1142) search for pipe pnum=7718 [2003/03/12 12:52:25, 3] ../source/smbd/ipc.c:api_fd_reply(288) Got API command 0x26 on pipe "spoolss" (pnum 7718)api_pipe_bind_req: \PIPE\spoolss -> \PIPE\spoolss [2003/03/12 12:52:25, 3] ../source/rpc_server/srv_pipe.c:check_bind_req(712) check_bind_req for \PIPE\spoolss [2003/03/12 12:52:25, 3] ../source/smbd/process.c:process_smb(882) Transaction 12 of length 310 [2003/03/12 12:52:25, 3] ../source/smbd/process.c:switch_message(676) switch message SMBtrans (pid 63090) [2003/03/12 12:52:25, 4] ../source/smbd/uid.c:change_to_user(122) change_to_user: Skipping user change - already user [2003/03/12 12:52:25, 3] ../source/smbd/ipc.c:reply_trans(472) trans <\PIPE\> data=224 params=0 setup=2 [2003/03/12 12:52:25, 3] ../source/smbd/ipc.c:named_pipe(326) named pipe command on <> name [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_pipe_hnd.c:get_rpc_pipe(1142) search for pipe pnum=7718 [2003/03/12 12:52:25, 3] ../source/smbd/ipc.c:api_fd_reply(288) Got API command 0x26 on pipe "spoolss" (pnum 7718)free_pipe_context: destroying talloc pool of size 0 [2003/03/12 12:52:25, 3] ../source/rpc_server/srv_pipe.c:api_pipe_request(1264) Doing \PIPE\spoolss [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_pipe.c:api_rpcTNP(1319) api_rpcTNP: spoolss op 0x9 - api_rpcTNP: rpc command: SPOOLSS_ADDPRINTERDRIVER [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(3228, 6) : sec_ctx_stack_ndx = 1 [2003/03/12 12:52:25, 3] ../source/smbd/uid.c:push_conn_ctx(287) push_conn_ctx(100) : conn_ctx_stack_ndx = 0 [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2003/03/12 12:52:25, 3] ../source/lib/access.c:check_access(311) check_access: no hostnames in host allow/deny list. [2003/03/12 12:52:25, 2] ../source/lib/access.c:check_access(322) Allowed connection from (132.65.80.139) [2003/03/12 12:52:25, 3] ../source/smbd/service.c:make_connection_snum(525) Connect path is '/v1/samba-test/share/print' for service [print$] [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_srvsvc_nt.c:get_share_security(217) get_share_security: using default secdesc for print$ [2003/03/12 12:52:25, 3] ../source/lib/util_seaccess.c:se_access_check(267) [2003/03/12 12:52:25, 3] ../source/lib/util_seaccess.c:se_access_check(268) se_access_check: user sid is S-1-5-21-2763996366-3983801899-2901956018-7456 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1013 se_access_check: also S-1-1-0 se_access_check: also S-1-5-2 se_access_check: also S-1-5-11 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1011 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1061 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1081 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1085 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1169 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1211 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21419 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21457 [2003/03/12 12:52:25, 3] ../source/smbd/vfs.c:vfs_init_default(136) Initialising default vfs hooks [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_srvsvc_nt.c:get_share_security(217) get_share_security: using default secdesc for print$ [2003/03/12 12:52:25, 3] ../source/lib/util_seaccess.c:se_access_check(267) [2003/03/12 12:52:25, 3] ../source/lib/util_seaccess.c:se_access_check(268) se_access_check: user sid is S-1-5-21-2763996366-3983801899-2901956018-7456 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1013 se_access_check: also S-1-1-0 se_access_check: also S-1-5-2 se_access_check: also S-1-5-11 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1011 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1061 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1081 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1085 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1169 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-1211 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21419 se_access_check: also S-1-5-21-2763996366-3983801899-2901956018-21457 [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (3228, 6) - sec_ctx_stack_ndx = 1 [2003/03/12 12:52:25, 1] ../source/smbd/service.c:make_connection_snum(681) lurch (132.65.80.139) connect to service print$ initially as user alsbergt (uid=3228, gid=6) (pid 63090) [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2003/03/12 12:52:25, 3] ../source/smbd/vfs.c:vfs_ChDir(650) vfs_ChDir to /v1/samba-test/share/print [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (3228, 6) - sec_ctx_stack_ndx = 0 [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(3228, 6) : sec_ctx_stack_ndx = 1 [2003/03/12 12:52:25, 3] ../source/smbd/uid.c:push_conn_ctx(287) push_conn_ctx(100) : conn_ctx_stack_ndx = 0 [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (3228, 6) - sec_ctx_stack_ndx = 1 [2003/03/12 12:52:25, 3] ../source/lib/util.c:unix_clean_name(580) unix_clean_name [W32X86/] [2003/03/12 12:52:25, 3] ../source/lib/util.c:unix_clean_name(580) unix_clean_name [w32x86] [2003/03/12 12:52:25, 4] ../source/smbd/open.c:open_file_shared1(969) calling open_file with flags=0x0 flags2=0x0 mode=00 [2003/03/12 12:52:25, 3] ../source/printing/nt_printing.c:get_correct_cversion(1130) get_correct_cversion: Can't open file [w32x86], errno = 21 [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2003/03/12 12:52:25, 1] ../source/smbd/service.c:close_cnum(861) lurch (132.65.80.139) closed connection to service print$ [2003/03/12 12:52:25, 3] ../source/smbd/connection.c:yield_connection(61) Yielding connection to print$ [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2003/03/12 12:52:25, 3] ../source/smbd/vfs.c:vfs_ChDir(650) vfs_ChDir to / [2003/03/12 12:52:25, 3] ../source/smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (3228, 6) - sec_ctx_stack_ndx = 0 [2003/03/12 12:52:25, 3] ../source/rpc_server/srv_pipe_hnd.c:free_pipe_context(544) free_pipe_context: destroying talloc pool of size 278 [2003/03/12 12:52:25, 3] ../source/smbd/process.c:process_smb(882) Transaction 13 of length 45 [2003/03/12 12:52:25, 3] ../source/smbd/process.c:switch_message(676) switch message SMBclose (pid 63090) [2003/03/12 12:52:25, 4] ../source/smbd/uid.c:change_to_user(122) change_to_user: Skipping user change - already user [2003/03/12 12:52:25, 3] ../source/smbd/vfs.c:vfs_ChDir(650) vfs_ChDir to /tmp [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_pipe_hnd.c:get_rpc_pipe(1142) search for pipe pnum=7718 [2003/03/12 12:52:25, 4] ../source/rpc_server/srv_pipe_hnd.c:close_rpc_pipe_hnd(1074) closed pipe name spoolss pnum=7718 (pipes_open=0)