Re: Problem with Samba on Squeeze
> From: Camaleón <noelamac@gmail.com>
> To: debian-user@lists.debian.org
> Sent: Sun, May 1, 2011 8:15:10 PM
> Subject: Re: Problem with Samba on Squeeze
>
> On Sun, 01 May 2011 10:58:01 -0700, Roger Morgan wrote:
>
> >> From: Camaleón
> >
> >> It looks something related to authentication.
> >>
> >> Is there anything interesting at samba logs? I know samba logs are
> >> pretty hard to understand :-) but maybe there is something in there
> >> that give you any clue.
> >>
> > Here are the logs for the relevant time.
>
> (...)
>
> Sadly those are pretty generic errors and don't tell much about the cause
> of the failure. Try by increasing samba log level¹ ("log level = 3"),
> restart samba daemons, run smbclient again and review again the logs.
>
> P.S. 1 - Don't forget to restore to the previous samba log level or your
> disk will be quickly flooded :-)
>
> P.S. 2 - Before sending the logs, review the content to avoid sending
> sensible data (replace/delete anything you don't want to be viewed by
After setting log level = 3, rebooting, and running smbclient again,
there are 4 logfiles. The extra 2 are log.lyra and log.__fff_127.0.0.1
All four are copied below ....
----start log.nmbd-------------------------
[2011/05/02 11:03:53, 0] nmbd/nmbd.c:857(main)
nmbd version 3.5.6 started.
Copyright Andrew Tridgell and the Samba Team 1992-2010
[2011/05/02 11:03:53.585807, 2] lib/tallocmsg.c:106(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2011/05/02 11:03:53.585855, 2] lib/dmallocmsg.c:77(register_dmalloc_msgs)
Registered MSG_REQ_DMALLOC_MARK and LOG_CHANGED
[2011/05/02 11:03:53.585904, 3] param/loadparm.c:9158(lp_load_ex)
lp_load_ex: refreshing parameters
Initialising global parameters
rlimit_max: rlimit_max (1024) below minimum Windows limit (16384)
[2011/05/02 11:03:53.586029, 3] ../lib/util/params.c:550(pm_process)
params.c:pm_process() - Processing configuration file "/etc/samba/smb.conf"
[2011/05/02 11:03:53.586067, 3] param/loadparm.c:7842(do_section)
Processing section "[global]"
[2011/05/02 11:03:53.586524, 3] nmbd/nmbd.c:383(reload_nmbd_services)
services not loaded
[2011/05/02 11:03:53.596088, 2] nmbd/nmbd.c:890(main)
Becoming a daemon.
[2011/05/02 11:03:53.599547, 3] nmbd/nmbd.c:951(main)
Opening sockets 137
[2011/05/02 11:03:53.599695, 3]
../lib/util/util_net.c:68(interpret_string_addr_internal)
interpret_string_addr_internal: getaddrinfo failed for name 0.0.0.0 [Address
family for hostname not supported]
[2011/05/02 11:03:53.599750, 0] nmbd/nmbd.c:696(open_sockets)
[2011/05/02 11:04:04, 0] nmbd/nmbd.c:857(main)
nmbd version 3.5.6 started.
Copyright Andrew Tridgell and the Samba Team 1992-2010
[2011/05/02 11:04:04.655530, 2] lib/tallocmsg.c:106(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2011/05/02 11:04:04.655571, 2] lib/dmallocmsg.c:77(register_dmalloc_msgs)
Registered MSG_REQ_DMALLOC_MARK and LOG_CHANGED
[2011/05/02 11:04:04.655620, 3] param/loadparm.c:9158(lp_load_ex)
lp_load_ex: refreshing parameters
Initialising global parameters
rlimit_max: rlimit_max (1024) below minimum Windows limit (16384)
[2011/05/02 11:04:04.655740, 3] ../lib/util/params.c:550(pm_process)
params.c:pm_process() - Processing configuration file "/etc/samba/smb.conf"
[2011/05/02 11:04:04.655777, 3] param/loadparm.c:7842(do_section)
Processing section "[global]"
[2011/05/02 11:04:04.656233, 3] nmbd/nmbd.c:383(reload_nmbd_services)
services not loaded
[2011/05/02 11:04:04.656294, 2] nmbd/nmbd.c:890(main)
Becoming a daemon.
[2011/05/02 11:04:04.659356, 3] nmbd/nmbd.c:951(main)
Opening sockets 137
[2011/05/02 11:04:04.659551, 3] nmbd/nmbd.c:739(open_sockets)
open_sockets: Broadcast sockets opened.
[2011/05/02 11:04:04.659675, 2] lib/interface.c:340(add_interface)
added interface eth1 ip=fe80::211:43ff:fea5:5e0e%eth1
bcast=fe80::ffff:ffff:ffff:ffff%eth1 netmask=ffff:ffff:ffff:ffff::
[2011/05/02 11:04:04.659792, 2] lib/interface.c:340(add_interface)
added interface eth1 ip=192.168.1.3 bcast=192.168.1.255 netmask=255.255.255.0
[2011/05/02 11:04:04.659896, 2] nmbd/nmbd_subnetdb.c:171(make_subnet)
making subnet name:192.168.1.3 Broadcast address:192.168.1.255 Subnet
mask:255.255.255.0
[2011/05/02 11:04:04.659931, 2] nmbd/nmbd_subnetdb.c:288(create_subnets)
create_subnets: ignoring non IPv4 interface.
[2011/05/02 11:04:04.659958, 2] nmbd/nmbd_subnetdb.c:171(make_subnet)
making subnet name:UNICAST_SUBNET Broadcast address:0.0.0.0 Subnet
mask:0.0.0.0
[2011/05/02 11:04:04.659988, 2] nmbd/nmbd_subnetdb.c:171(make_subnet)
making subnet name:REMOTE_BROADCAST_SUBNET Broadcast address:0.0.0.0 Subnet
mask:0.0.0.0
[2011/05/02 11:04:04.744805, 2] nmbd/nmbd_lmhosts.c:41(load_lmhosts_file)
load_lmhosts_file: Can't open lmhosts file /etc/samba/lmhosts. Error was No
such file or directory
[2011/05/02 11:04:04.744903, 3] nmbd/nmbd.c:973(main)
Loaded hosts file /etc/samba/lmhosts
[2011/05/02 11:04:04.745293, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<00> with first IP 192.168.1.3 ttl=0
nb_flags= 0 to subnet 192.168.1.3
[2011/05/02 11:04:04.745339, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<20> with first IP 192.168.1.3 ttl=0
nb_flags= 0 to subnet 192.168.1.3
[2011/05/02 11:04:04.745380, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name __SAMBA__<20> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet 192.168.1.3
[2011/05/02 11:04:04.745418, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name __SAMBA__<00> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet 192.168.1.3
[2011/05/02 11:04:04.745661, 3]
nmbd/nmbd_serverlistdb.c:156(create_server_on_workgroup)
create_server_on_workgroup: Created server entry LYRA of type 40819a03 (lyra
server) on workgroup GALAXY.
[2011/05/02 11:04:04.745700, 3]
nmbd/nmbd_workgroupdb.c:264(initiate_myworkgroup_startup)
initiate_myworkgroup_startup: Added server name entry LYRA on subnet
192.168.1.3
[2011/05/02 11:04:04.745750, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<00> with first IP 192.168.1.3 ttl=0
nb_flags= 0 to subnet UNICAST_SUBNET
[2011/05/02 11:04:04.745787, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<20> with first IP 192.168.1.3 ttl=0
nb_flags= 0 to subnet UNICAST_SUBNET
[2011/05/02 11:04:04.745828, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name __SAMBA__<20> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2011/05/02 11:04:04.745865, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name __SAMBA__<00> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2011/05/02 11:04:04.745908, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name LYRA<20> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2011/05/02 11:04:04.745947, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name LYRA<03> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2011/05/02 11:04:04.745985, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name LYRA<00> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2011/05/02 11:04:04.746025, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name GALAXY<00> with first IP 192.168.1.3
ttl=0 nb_flags=80 to subnet UNICAST_SUBNET
[2011/05/02 11:04:04.746064, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name GALAXY<1e> with first IP 192.168.1.3
ttl=0 nb_flags=80 to subnet UNICAST_SUBNET
[2011/05/02 11:04:04.746099, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<00> with first IP 192.168.1.3 ttl=0
nb_flags= 0 to subnet REMOTE_BROADCAST_SUBNET
[2011/05/02 11:04:04.746135, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<20> with first IP 192.168.1.3 ttl=0
nb_flags= 0 to subnet REMOTE_BROADCAST_SUBNET
[2011/05/02 11:04:04.746171, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name __SAMBA__<20> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet REMOTE_BROADCAST_SUBNET
[2011/05/02 11:04:04.746207, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name __SAMBA__<00> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet REMOTE_BROADCAST_SUBNET
[2011/05/02 11:04:04.746394, 3]
nmbd/nmbd_sendannounce.c:207(send_host_announcement)
send_host_announcement: type 819a03 for host LYRA on subnet 192.168.1.3 for
workgroup GALAXY
[2011/05/02 11:04:08.760260, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name LYRA<20> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet 192.168.1.3
[2011/05/02 11:04:08.760357, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name LYRA<03> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet 192.168.1.3
[2011/05/02 11:04:08.760399, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name LYRA<00> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet 192.168.1.3
[2011/05/02 11:04:08.760438, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name GALAXY<00> with first IP 192.168.1.3
ttl=0 nb_flags=80 to subnet 192.168.1.3
[2011/05/02 11:04:08.760478, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name GALAXY<1e> with first IP 192.168.1.3
ttl=0 nb_flags=80 to subnet 192.168.1.3
[2011/05/02 11:04:08.760515, 2]
nmbd/nmbd_elections.c:107(check_for_master_browser_fail)
check_for_master_browser_fail: Forcing election on workgroup GALAXY subnet
192.168.1.3
[2011/05/02 11:04:08.760553, 3] nmbd/nmbd_elections.c:364(check_elections)
check_elections: >>> Starting election for workgroup GALAXY on subnet
192.168.1.3 <<<
[2011/05/02 11:04:11.330976, 3] nmbd/nmbd_serverlistdb.c:423(write_browse_list)
write_browse_list: Wrote browse list into file /var/cache/samba/browse.dat
[2011/05/02 11:04:12.332068, 2] nmbd/nmbd_elections.c:40(send_election_dgram)
send_election_dgram: Sending election packet for workgroup GALAXY on subnet
192.168.1.3
[2011/05/02 11:04:14.333657, 2] nmbd/nmbd_elections.c:40(send_election_dgram)
send_election_dgram: Sending election packet for workgroup GALAXY on subnet
192.168.1.3
[2011/05/02 11:04:16.336179, 2] nmbd/nmbd_elections.c:40(send_election_dgram)
send_election_dgram: Sending election packet for workgroup GALAXY on subnet
192.168.1.3
[2011/05/02 11:04:18.337661, 2] nmbd/nmbd_elections.c:40(send_election_dgram)
send_election_dgram: Sending election packet for workgroup GALAXY on subnet
192.168.1.3
[2011/05/02 11:04:20.339996, 2] nmbd/nmbd_elections.c:40(send_election_dgram)
send_election_dgram: Sending election packet for workgroup GALAXY on subnet
192.168.1.3
[2011/05/02 11:04:20.340115, 2] nmbd/nmbd_elections.c:200(run_elections)
run_elections: >>> Won election for workgroup GALAXY on subnet 192.168.1.3 <<<
[2011/05/02 11:04:20.340151, 2]
nmbd/nmbd_become_lmb.c:536(become_local_master_browser)
become_local_master_browser: Starting to become a master browser for workgroup
GALAXY on subnet 192.168.1.3
[2011/05/02 11:04:20.340181, 3]
nmbd/nmbd_become_lmb.c:538(become_local_master_browser)
become_local_master_browser: first stage - attempt to register
^1^2__MSBROWSE__^2^1
[2011/05/02 11:04:20.340417, 3] nmbd/nmbd_serverlistdb.c:423(write_browse_list)
write_browse_list: Wrote browse list into file /var/cache/samba/browse.dat
[2011/05/02 11:04:24.343952, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name __MSBROWSE__<01> with first IP
192.168.1.3 ttl=0 nb_flags=80 to subnet 192.168.1.3
[2011/05/02 11:04:24.344055, 3]
nmbd/nmbd_become_lmb.c:451(become_local_master_stage1)
become_local_master_stage1: go to stage 2: register the GALAXY<1d> name.
[2011/05/02 11:04:24.344093, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name __MSBROWSE__<01> with first IP
192.168.1.3 ttl=0 nb_flags=80 to subnet UNICAST_SUBNET
[2011/05/02 11:04:28.348592, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name GALAXY<1d> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet 192.168.1.3
[2011/05/02 11:04:28.348698, 3]
nmbd/nmbd_become_lmb.c:352(become_local_master_stage2)
become_local_master_stage2: registered as master browser for workgroup GALAXY
on subnet 192.168.1.3
[2011/05/02 11:04:28.348752, 3]
nmbd/nmbd_sendannounce.c:68(broadcast_announce_request)
broadcast_announce_request: sending announce request for workgroup GALAXY to
subnet 192.168.1.3
[2011/05/02 11:04:28.348810, 3] nmbd/nmbd_namelistdb.c:250(add_name_to_subnet)
add_name_to_subnet: Added netbios name GALAXY<1d> with first IP 192.168.1.3
ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2011/05/02 11:04:28.348844, 0]
nmbd/nmbd_become_lmb.c:395(become_local_master_stage2)
*****
Samba name server LYRA is now a local master browser for workgroup GALAXY on
subnet 192.168.1.3
*****
[2011/05/02 11:04:28.348938, 3]
nmbd/nmbd_sendannounce.c:165(send_local_master_announcement)
send_local_master_announcement: type 849a03 for name LYRA on subnet
192.168.1.3 for workgroup GALAXY
[2011/05/02 11:04:28.348986, 3]
nmbd/nmbd_sendannounce.c:184(send_workgroup_announcement)
send_workgroup_announcement: on subnet 192.168.1.3 for workgroup GALAXY
[2011/05/02 11:04:48.369400, 3] nmbd/nmbd_serverlistdb.c:423(write_browse_list)
write_browse_list: Wrote browse list into file /var/cache/samba/browse.dat
[2011/05/02 11:06:38.469664, 3]
nmbd/nmbd_sendannounce.c:165(send_local_master_announcement)
send_local_master_announcement: type 849a03 for name LYRA on subnet
192.168.1.3 for workgroup GALAXY
[2011/05/02 11:06:38.469800, 3]
nmbd/nmbd_sendannounce.c:184(send_workgroup_announcement)
send_workgroup_announcement: on subnet 192.168.1.3 for workgroup GALAXY
-----end of log.nmbd-----
-----start log.smbd------
[2011/05/02 11:03:53, 0] smbd/server.c:1123(main)
smbd version 3.5.6 started.
Copyright Andrew Tridgell and the Samba Team 1992-2010
[2011/05/02 11:03:54.013782, 2] lib/tallocmsg.c:106(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2011/05/02 11:03:54.014115, 2] lib/dmallocmsg.c:77(register_dmalloc_msgs)
Registered MSG_REQ_DMALLOC_MARK and LOG_CHANGED
[2011/05/02 11:03:54.014174, 3] param/loadparm.c:9158(lp_load_ex)
lp_load_ex: refreshing parameters
Initialising global parameters
rlimit_max: rlimit_max (1024) below minimum Windows limit (16384)
[2011/05/02 11:03:54.014307, 3] ../lib/util/params.c:550(pm_process)
params.c:pm_process() - Processing configuration file "/etc/samba/smb.conf"
[2011/05/02 11:03:54.014342, 3] param/loadparm.c:7842(do_section)
Processing section "[global]"
[2011/05/02 11:03:54.014562, 2] param/loadparm.c:7859(do_section)
Processing section "[homes]"
[2011/05/02 11:03:54.037271, 2] param/loadparm.c:7859(do_section)
Processing section "[printers]"
[2011/05/02 11:03:54.037410, 2] param/loadparm.c:7859(do_section)
Processing section "[print$]"
[2011/05/02 11:03:54.037512, 2] param/loadparm.c:7859(do_section)
Processing section "[Samsung1510]"
[2011/05/02 11:03:54.037586, 2] param/loadparm.c:7859(do_section)
Processing section "[common]"
[2011/05/02 11:03:54.037784, 3] param/loadparm.c:6313(lp_add_ipc)
adding IPC service
[2011/05/02 11:03:54.127975, 3] printing/pcap.c:136(pcap_cache_reload)
reloading printcap cache
[2011/05/02 11:03:54.160703, 3] printing/pcap.c:243(pcap_cache_reload)
reload status: ok
[2011/05/02 11:03:54.160845, 3] param/loadparm.c:6352(lp_add_printer)
adding printer service Samsung_ML-1510_700
[2011/05/02 11:03:54.161041, 2] lib/interface.c:340(add_interface)
added interface eth1 ip=fe80::211:43ff:fea5:5e0e%eth1
bcast=fe80::ffff:ffff:ffff:ffff%eth1 netmask=ffff:ffff:ffff:ffff::
[2011/05/02 11:03:54.299969, 3] smbd/server.c:1165(main)
loaded services
[2011/05/02 11:03:54.300020, 3] smbd/server.c:1180(main)
Becoming a daemon.
[2011/05/02 11:03:54.543360, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.543446, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.543479, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.543590, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:03:54.543620, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:03:54.543646, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:03:54.544698, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2011/05/02 11:03:54.544737, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2011/05/02 11:03:54.544763, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2011/05/02 11:03:54.553470, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:03:54.553533, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.553570, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.553703, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.553732, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.553758, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661005, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661122, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661152, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661179, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661286, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661316, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661343, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661370, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661412, 3] auth/token_util.c:436(create_local_nt_token)
Failed to fetch domain sid for GALAXY
[2011/05/02 11:03:54.661446, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661501, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661528, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661554, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661675, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661706, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661733, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661758, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661798, 3] auth/token_util.c:467(create_local_nt_token)
Failed to fetch domain sid for GALAXY
[2011/05/02 11:03:54.661829, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661856, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.661885, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.661910, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.662233, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.662286, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID
[S-1-5-21-38502757-452903869-1500568620-1000]
[2011/05/02 11:03:54.662339, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID [S-1-5-2]
[2011/05/02 11:03:54.662374, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID [S-1-5-11]
[2011/05/02 11:03:54.729672, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.729731, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.729759, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.729914, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730161, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.730214, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730241, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.730323, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730372, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.730399, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730425, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.730490, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730537, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.730564, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730590, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.730667, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730714, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.730743, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730770, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.730833, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730880, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.730907, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.730934, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731065, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731141, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731169, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731195, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731281, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731310, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731336, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731361, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731402, 3] auth/token_util.c:436(create_local_nt_token)
Failed to fetch domain sid for GALAXY
[2011/05/02 11:03:54.731433, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731486, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731515, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731541, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731628, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731658, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731684, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731710, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731748, 3] auth/token_util.c:467(create_local_nt_token)
Failed to fetch domain sid for GALAXY
[2011/05/02 11:03:54.731779, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731820, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.731847, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.731872, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.732424, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.732463, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID
[S-1-5-21-38502757-452903869-1500568620-501]
[2011/05/02 11:03:54.732501, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID [S-1-22-2-1001]
[2011/05/02 11:03:54.732542, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID [S-1-5-2]
[2011/05/02 11:03:54.732578, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID [S-1-5-32-546]
[2011/05/02 11:03:54.732613, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID [S-1-22-2-0]
[2011/05/02 11:03:54.732647, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID [S-1-22-2-7]
[2011/05/02 11:03:54.732682, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID [S-1-22-2-24]
[2011/05/02 11:03:54.732716, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID [S-1-22-2-29]
[2011/05/02 11:03:54.732757, 3] lib/privileges.c:63(get_privileges)
get_privileges: No privileges assigned to SID
[S-1-5-21-38502757-452903869-1500568620-3003]
[2011/05/02 11:03:54.732811, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.732838, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.732865, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.732943, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.732994, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.733021, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.733046, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.733121, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.733173, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.733200, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:03:54.733226, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:03:54.733303, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:03:54.743967, 3]
printing/printing.c:1412(start_background_queue)
start_background_queue: Starting background LPQ thread
[2011/05/02 11:03:54.744550, 3]
../lib/util/util_net.c:68(interpret_string_addr_internal)
interpret_string_addr_internal: getaddrinfo failed for name 0.0.0.0 [Address
family for hostname not supported]
[2011/05/02 11:03:54.744630, 3]
../lib/util/util_net.c:68(interpret_string_addr_internal)
interpret_string_addr_internal: getaddrinfo failed for name 0.0.0.0 [Address
family for hostname not supported]
[2011/05/02 11:03:54.745308, 2] smbd/server.c:721(smbd_parent_loop)
waiting for connections
-----end log.smbd-----
----start log.lyra -----
[2011/05/02 11:05:52.748104, 3] auth/auth.c:216(check_ntlm_password)
check_ntlm_password: Checking password for unmapped user
[GALAXY]\[roger]@[LYRA] with the new password interface
[2011/05/02 11:05:52.748160, 3] auth/auth.c:219(check_ntlm_password)
check_ntlm_password: mapped user is: [LYRA]\[roger]@[LYRA]
[2011/05/02 11:05:52.748201, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.748232, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:05:52.748264, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.748384, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.748413, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.748439, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.748497, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.748539, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.748565, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.748591, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.748632, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.748836, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.748866, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.748892, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.749038, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.749105, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.749134, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.749160, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.749204, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.749258, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.749285, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.749311, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.749355, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.749429, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.749457, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.749484, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.749523, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2011/05/02 11:05:52.749549, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2011/05/02 11:05:52.749575, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2011/05/02 11:05:52.749707, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.749743, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.749778, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:05:52.749904, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.749931, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:05:52.749957, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750017, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:05:52.750047, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750073, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:05:52.750099, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750275, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.750304, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750330, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.750403, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750452, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.750479, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750505, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.750572, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750619, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.750647, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750674, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.750738, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750785, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.750812, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750838, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.750899, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750946, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.750973, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.750999, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.751061, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751108, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.751135, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751161, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.751222, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751269, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.751296, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751322, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.751389, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751436, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.751463, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751489, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.751553, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751600, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.751643, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751669, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2011/05/02 11:05:52.751729, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751766, 3] smbd/sec_ctx.c:418(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:05:52.751795, 3] auth/auth.c:265(check_ntlm_password)
check_ntlm_password: sam authentication for user [roger] succeeded
[2011/05/02 11:05:52.751822, 3] smbd/sec_ctx.c:210(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2011/05/02 11:05:52.751849, 3] smbd/uid.c:429(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2011/05/02 11:05:52.751875, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
---end log.lyra------
----start log.__ffff_127.0.0.1
[2011/05/02 11:05:52.666521, 3] smbd/oplock.c:895(init_oplocks)
init_oplocks: initializing messages.
[2011/05/02 11:05:52.672795, 3]
smbd/oplock_linux.c:224(linux_init_kernel_oplocks)
Linux kernel oplocks enabled
[2011/05/02 11:05:52.672920, 3] smbd/process.c:1485(process_smb)
Transaction 0 of length 194 (0 toread)
[2011/05/02 11:05:52.672960, 3] smbd/process.c:1294(switch_message)
switch message SMBnegprot (pid 2421) conn 0x0
[2011/05/02 11:05:52.672996, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:05:52.683800, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [PC NETWORK PROGRAM 1.0]
[2011/05/02 11:05:52.683838, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [MICROSOFT NETWORKS 1.03]
[2011/05/02 11:05:52.683866, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [MICROSOFT NETWORKS 3.0]
[2011/05/02 11:05:52.683893, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [LANMAN1.0]
[2011/05/02 11:05:52.683919, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [LM1.2X002]
[2011/05/02 11:05:52.683946, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [DOS LANMAN2.1]
[2011/05/02 11:05:52.683973, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [LANMAN2.1]
[2011/05/02 11:05:52.683999, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [Samba]
[2011/05/02 11:05:52.684026, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [NT LANMAN 1.0]
[2011/05/02 11:05:52.684053, 3] smbd/negprot.c:586(reply_negprot)
Requested protocol [NT LM 0.12]
[2011/05/02 11:05:52.696005, 3] smbd/negprot.c:404(reply_nt1)
using SPNEGO
[2011/05/02 11:05:52.696039, 3] smbd/negprot.c:691(reply_negprot)
Selected protocol NT LANMAN 1.0
[2011/05/02 11:05:52.709103, 3] smbd/process.c:1485(process_smb)
Transaction 1 of length 162 (0 toread)
[2011/05/02 11:05:52.709145, 3] smbd/process.c:1294(switch_message)
switch message SMBsesssetupX (pid 2421) conn 0x0
[2011/05/02 11:05:52.709173, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:05:52.736147, 3] smbd/sesssetup.c:1436(reply_sesssetup_and_X)
wct=12 flg2=0xc801
[2011/05/02 11:05:52.736188, 3]
smbd/sesssetup.c:1190(reply_sesssetup_and_X_spnego)
Doing spnego session setup
[2011/05/02 11:05:52.736220, 3]
smbd/sesssetup.c:1232(reply_sesssetup_and_X_spnego)
NativeOS=[Unix] NativeLanMan=[Samba] PrimaryDomain=[]
[2011/05/02 11:05:52.736283, 3] smbd/sesssetup.c:806(reply_spnego_negotiate)
reply_spnego_negotiate: Got secblob of size 42
[2011/05/02 11:05:52.746851, 3] libsmb/ntlmssp.c:65(debug_ntlmssp_flags)
Got NTLMSSP neg_flags=0x60088215
[2011/05/02 11:05:52.747801, 3] smbd/process.c:1485(process_smb)
Transaction 2 of length 254 (0 toread)
[2011/05/02 11:05:52.747846, 3] smbd/process.c:1294(switch_message)
switch message SMBsesssetupX (pid 2421) conn 0x0
[2011/05/02 11:05:52.747874, 3] smbd/sec_ctx.c:310(set_sec_ctx)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2011/05/02 11:05:52.747910, 3] smbd/sesssetup.c:1436(reply_sesssetup_and_X)
wct=12 flg2=0xc801
[2011/05/02 11:05:52.747937, 3]
smbd/sesssetup.c:1190(reply_sesssetup_and_X_spnego)
Doing spnego session setup
[2011/05/02 11:05:52.747966, 3]
smbd/sesssetup.c:1232(reply_sesssetup_and_X_spnego)
NativeOS=[Unix] NativeLanMan=[Samba] PrimaryDomain=[]
[2011/05/02 11:05:52.748014, 3] libsmb/ntlmssp.c:747(ntlmssp_server_auth)
Got user=[roger] domain=[GALAXY] workstation=[LYRA] len1=24 len2=24
----end log.__ffff_127.0.0.1
I hope you can see something useful here!
Roger
Reply to: