2.2.5 crashes in cli_errstr
Martin Bahlinger
ry42 at rz.uni-karlsruhe.de
Thu Aug 29 05:08:35 GMT 2002
Volker.Lendecke at SerNet.DE wrote:
> I really can't see what's going wrong. I can still not reproduce the
> crash. Could you provide *exact* steps (kernel version, routing table,
> ip addresses, etc) to reproduce this with latest 2.2 CVS code? To get
> the latest 2.2 cvs, see http://www.samba.org/samba/cvs.html.
I set up 2.2cvs on our spare machine, because I don't want to touch
again the other one (which is serving an average of 5GB per day). We
still have to rely on that machine till our new EMC2 Celerra serves SMB
itself. First I thought it's a problem with to many open connections.
But fortunately we see the same effects on the spare machine, although
it is relatively idle.
As you requested:
# uname -a
Linux rz-smb1 2.4.18 #1 SMP Thu May 23 16:41:59 CEST 2002 i686 unknown
# netstat -nr
Kernel IP routing table
Destination Gateway Genmask Flags MSS Window irtt Iface
172.21.0.0 0.0.0.0 255.255.0.0 U 40 0 0 eth0
0.0.0.0 172.21.71.254 0.0.0.0 UG 40 0 0 eth0
# host rz-smb1.rz.uni-karlsruhe.de
rz-smb1.rz.uni-karlsruhe.de A 172.21.70.240
# host stud-dc02.stud.uni-karlsruhe.de
stud-dc02.stud.uni-karlsruhe.de A 172.21.63.142
# host stud-dc01.stud.uni-karlsruhe.de
stud-dc01.stud.uni-karlsruhe.de A 172.21.63.141
# host microat8.microbit.uni-karlsruhe.de
microat8.microbit.uni-karlsruhe.de A 129.13.95.158
# grep "password server" /etc/samba/smb.conf
password server = stud-dc02 stud-dc01
# grep "workgroup" /etc/samba/smb.conf
workgroup = stud
#
I rebooted stud-dc02 and connected from microat8:
# smbclient //rz-smb1/homes -U ur6j -W stud
added interface ip=129.13.95.158 bcast=129.13.255.255 nmask=255.255.0.0
Password:
session setup failed: SUCCESS - 0
#
After the DC was up again I could connect without problems. This was not
the case with the heavily loaded 2.2.4 machine. I had to kill each smbd
process by hand there. Maybe this partial-problem is fixed in 2.2cvs,
maybe it's just because mine was the only connection to the server.
And here is the crashlog of 2.2cvs, loglevel 10:
[2002/08/29 15:11:25, 6, pid=12863]
param/loadparm.c:lp_file_list_changed(2285)
lp_file_list_changed()
file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Thu
Aug 29 15:04:58 2002
[2002/08/29 15:11:25, 3, pid=12863] smbd/oplock.c:init_oplocks(1211)
open_oplock_ipc: opening loopback UDP socket.
[2002/08/29 15:11:25, 3, pid=12863] lib/util_sock.c:open_socket_in(813)
bind succeeded on port 0
[2002/08/29 15:11:25, 3, pid=12863]
smbd/oplock_linux.c:linux_init_kernel_oplocks(298)
Linux kernel oplocks enabled
[2002/08/29 15:11:25, 3, pid=12863] smbd/oplock.c:init_oplocks(1242)
open_oplock ipc: pid = 12863, global_oplock_port = 32812
[2002/08/29 15:11:25, 4, pid=12863] lib/time.c:get_serverzone(114)
Serverzone is -7200
[2002/08/29 15:11:25, 10, pid=12863]
lib/util_sock.c:read_smb_length_return_keepalive(559)
got smb length of 72
[2002/08/29 15:11:25, 10, pid=12863] lib/access.c:check_access(304)
check_access: allow = , deny =
[2002/08/29 15:11:25, 6, pid=12863] smbd/process.c:process_smb(877)
got message type 0x81 of len 0x48
[2002/08/29 15:11:25, 3, pid=12863] smbd/process.c:process_smb(878)
Transaction 0 of length 76
[2002/08/29 15:11:25, 2, pid=12863] smbd/reply.c:reply_special(92)
netbios connect: name1=RZ-SMB1 name2=MICROAT8
[2002/08/29 15:11:25, 2, pid=12863] smbd/reply.c:reply_special(111)
netbios connect: local=rz-smb1 remote=microat8
[2002/08/29 15:11:25, 6, pid=12863]
param/loadparm.c:lp_file_list_changed(2285)
lp_file_list_changed()
file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Thu
Aug 29 15:04:58 2002
[2002/08/29 15:11:25, 5, pid=12863] smbd/connection.c:claim_connection(156)
claiming 0
[2002/08/29 15:11:25, 5, pid=12863] smbd/reply.c:reply_special(152)
init msg_type=0x81 msg_flags=0x0
[2002/08/29 15:11:25, 6, pid=12863] lib/util_sock.c:write_socket(518)
write_socket(7,4)
[2002/08/29 15:11:25, 6, pid=12863] lib/util_sock.c:write_socket(521)
write_socket(7,4) wrote 4
[2002/08/29 15:11:25, 10, pid=12863]
lib/util_sock.c:read_smb_length_return_keepalive(559)
got smb length of 164
[2002/08/29 15:11:25, 6, pid=12863] smbd/process.c:process_smb(877)
got message type 0x0 of len 0xa4
[2002/08/29 15:11:25, 3, pid=12863] smbd/process.c:process_smb(878)
Transaction 1 of length 168
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(275)
size=164
smb_com=0x72
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=8
smb_flg2=1
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(281)
smb_tid=0
smb_pid=7387
smb_uid=0
smb_mid=1
smt_wct=0
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(291)
smb_bcc=129
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1531)
[000] 02 50 43 20 4E 45 54 57 4F 52 4B 20 50 52 4F 47 .PC NETW ORK PROG
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1539)
[010] 52 41 4D 20 31 2E 30 00 02 4D 49 43 52 4F 53 4F RAM 1.0. .MICROSO
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1539)
[020] 46 54 20 4E 45 54 57 4F 52 4B 53 20 31 2E 30 33 FT NETWO RKS 1.03
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1539)
[030] 00 02 4D 49 43 52 4F 53 4F 46 54 20 4E 45 54 57 ..MICROS OFT NETW
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1539)
[040] 4F 52 4B 53 20 33 2E 30 00 02 4C 41 4E 4D 41 4E ORKS 3.0 ..LANMAN
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1539)
[050] 31 2E 30 00 02 4C 4D 31 2E 32 58 30 30 32 00 02 1.0..LM1 .2X002..
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1539)
[060] 53 61 6D 62 61 00 02 4E 54 20 4C 41 4E 4D 41 4E Samba..N T LANMAN
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1539)
[070] 20 31 2E 30 00 02 4E 54 20 4C 4D 20 30 2E 31 32 1.0..NT LM 0.12
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1539)
[080] 00 .
[2002/08/29 15:11:25, 3, pid=12863] smbd/process.c:switch_message(685)
switch message SMBnegprot (pid 12863)
[2002/08/29 15:11:25, 3, pid=12863] smbd/sec_ctx.c:set_sec_ctx(329)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2002/08/29 15:11:25, 5, pid=12863] smbd/uid.c:change_to_root_user(217)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2002/08/29 15:11:25, 3, pid=12863] smbd/negprot.c:reply_negprot(342)
Requested protocol [PC NETWORK PROGRAM 1.0]
[2002/08/29 15:11:25, 3, pid=12863] smbd/negprot.c:reply_negprot(342)
Requested protocol [MICROSOFT NETWORKS 1.03]
[2002/08/29 15:11:25, 3, pid=12863] smbd/negprot.c:reply_negprot(342)
Requested protocol [MICROSOFT NETWORKS 3.0]
[2002/08/29 15:11:25, 3, pid=12863] smbd/negprot.c:reply_negprot(342)
Requested protocol [LANMAN1.0]
[2002/08/29 15:11:25, 3, pid=12863] smbd/negprot.c:reply_negprot(342)
Requested protocol [LM1.2X002]
[2002/08/29 15:11:25, 3, pid=12863] smbd/negprot.c:reply_negprot(342)
Requested protocol [Samba]
[2002/08/29 15:11:25, 6, pid=12863]
param/loadparm.c:lp_file_list_changed(2285)
lp_file_list_changed()
file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Thu
Aug 29 15:04:58 2002
[2002/08/29 15:11:25, 6, pid=12863]
param/loadparm.c:lp_file_list_changed(2285)
lp_file_list_changed()
file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Thu
Aug 29 15:04:58 2002
[2002/08/29 15:11:25, 3, pid=12863] smbd/negprot.c:reply_negprot(426)
Selected protocol NT LANMAN 1.0
[2002/08/29 15:11:25, 5, pid=12863] smbd/negprot.c:reply_negprot(433)
negprot index=6
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(275)
size=82
smb_com=0x72
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=136
smb_flg2=1
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(281)
smb_tid=0
smb_pid=7387
smb_uid=0
smb_mid=1
smt_wct=17
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[0]=6 (0x6)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[1]=12803 (0x3203)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[2]=256 (0x100)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[3]=65280 (0xFF00)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[4]=255 (0xFF)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[5]=0 (0x0)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[6]=256 (0x100)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[7]=16128 (0x3F00)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[8]=50 (0x32)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[9]=61696 (0xF100)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[10]=3 (0x3)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[11]=32768 (0x8000)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[12]=52348 (0xCC7C)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[13]=23955 (0x5D93)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[14]=49743 (0xC24F)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[15]=34817 (0x8801)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[16]=2303 (0x8FF)
[2002/08/29 15:11:25, 5, pid=12863] lib/util.c:show_msg(291)
smb_bcc=13
[2002/08/29 15:11:25, 10, pid=12863] lib/util.c:dump_data(1531)
[000] 4C 94 46 CC D3 DA 76 74 53 54 55 44 00 L.F...vt STUD.
[2002/08/29 15:11:25, 6, pid=12863] lib/util_sock.c:write_socket(518)
write_socket(7,86)
[2002/08/29 15:11:25, 6, pid=12863] lib/util_sock.c:write_socket(521)
write_socket(7,86) wrote 86
[2002/08/29 15:11:27, 10, pid=12863]
lib/util_sock.c:read_smb_length_return_keepalive(559)
got smb length of 130
[2002/08/29 15:11:27, 6, pid=12863] smbd/process.c:process_smb(877)
got message type 0x0 of len 0x82
[2002/08/29 15:11:27, 3, pid=12863] smbd/process.c:process_smb(878)
Transaction 2 of length 134
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(275)
size=130
smb_com=0x73
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=8
smb_flg2=16385
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(281)
smb_tid=0
smb_pid=7387
smb_uid=0
smb_mid=1
smt_wct=13
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[0]=255 (0xFF)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[1]=0 (0x0)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[2]=65535 (0xFFFF)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[3]=2 (0x2)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[4]=7387 (0x1CDB)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[5]=12863 (0x323F)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[6]=0 (0x0)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[7]=24 (0x18)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[8]=24 (0x18)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[9]=0 (0x0)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[10]=0 (0x0)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[11]=80 (0x50)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(286)
smb_vwv[12]=0 (0x0)
[2002/08/29 15:11:27, 5, pid=12863] lib/util.c:show_msg(291)
smb_bcc=69
[2002/08/29 15:11:27, 10, pid=12863] lib/util.c:dump_data(1531)
[000] B3 80 92 2B DB B4 98 41 4A 67 45 64 3A BC A1 0B ...+...A JgEd:...
[2002/08/29 15:11:27, 10, pid=12863] lib/util.c:dump_data(1539)
[010] 0C 4B 30 E3 A7 81 17 A3 1D EA 9C 09 8B C8 D6 2A .K0..... .......*
[2002/08/29 15:11:27, 10, pid=12863] lib/util.c:dump_data(1539)
[020] 16 B9 80 41 6D 90 E5 DD 79 7E 93 9F 59 C9 12 47 ...Am... y~..Y..G
[2002/08/29 15:11:27, 10, pid=12863] lib/util.c:dump_data(1539)
[030] 55 52 36 4A 00 53 54 55 44 00 55 6E 69 78 00 53 UR6J.STU D.Unix.S
[2002/08/29 15:11:27, 10, pid=12863] lib/util.c:dump_data(1539)
[040] 61 6D 62 61 00 amba.
[2002/08/29 15:11:27, 3, pid=12863] smbd/process.c:switch_message(685)
switch message SMBsesssetupX (pid 12863)
[2002/08/29 15:11:27, 3, pid=12863] smbd/sec_ctx.c:set_sec_ctx(329)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2002/08/29 15:11:27, 5, pid=12863] smbd/uid.c:change_to_root_user(217)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2002/08/29 15:11:27, 3, pid=12863] smbd/reply.c:reply_sesssetup_and_X(858)
Domain=[STUD] NativeOS=[Unix] NativeLanMan=[Samba]
[2002/08/29 15:11:27, 3, pid=12863] smbd/reply.c:reply_sesssetup_and_X(868)
sesssetupX:name=[UR6J]
[2002/08/29 15:11:27, 6, pid=12863]
param/loadparm.c:lp_file_list_changed(2285)
lp_file_list_changed()
file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Thu
Aug 29 15:04:58 2002
[2002/08/29 15:11:27, 3, pid=12863] libsmb/namequery.c:resolve_hosts(808)
resolve_hosts: Attempting host lookup for name STUD-DC02<0x20>
[2002/08/29 15:11:27, 10, pid=12863] libsmb/namequery.c:resolve_hosts(813)
1 addresses returned
[2002/08/29 15:11:27, 10, pid=12863]
libsmb/namequery.c:internal_resolve_name(949)
internal_resolve_name: returning 1 addresses: 172.21.63.142
[2002/08/29 15:11:41, 10, pid=12863] lib/messages.c:message_named_mutex(504)
message_named_mutex: got mutex for stud-dc02
[2002/08/29 15:11:41, 3, pid=12863] lib/util_sock.c:open_socket_out(845)
Connecting to 172.21.63.142 at port 445
[2002/08/29 15:11:42, 2, pid=12863] lib/util_sock.c:open_socket_out(874)
error connecting to 172.21.63.142:445 (Connection refused)
[2002/08/29 15:11:42, 3, pid=12863] lib/util_sock.c:open_socket_out(845)
Connecting to 172.21.63.142 at port 139
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option SO_KEEPALIVE = 0
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option SO_REUSEADDR = 0
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option SO_BROADCAST = 0
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option TCP_NODELAY = 1
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option IPTOS_LOWDELAY = 16
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option IPTOS_THROUGHPUT = 16
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option SO_SNDBUF = 16384
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option SO_RCVBUF = 16384
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option SO_SNDLOWAT = 1
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option SO_RCVLOWAT = 1
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option SO_SNDTIMEO = 0
[2002/08/29 15:11:42, 5, pid=12863]
lib/util_sock.c:print_socket_options(111)
socket option SO_RCVTIMEO = 0
[2002/08/29 15:11:42, 6, pid=12863] lib/util_sock.c:write_socket(518)
write_socket(21,72)
[2002/08/29 15:11:42, 6, pid=12863] lib/util_sock.c:write_socket(521)
write_socket(21,72) wrote 72
[2002/08/29 15:11:42, 5, pid=12863]
libsmb/cliconnect.c:cli_session_request(674)
Sent session request
[2002/08/29 15:11:42, 10, pid=12863]
lib/util_sock.c:read_smb_length_return_keepalive(559)
got smb length of 1
[2002/08/29 15:11:42, 5, pid=12863] lib/util.c:show_msg(275)
size=1
smb_com=0x0
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=0
[2002/08/29 15:11:42, 5, pid=12863] lib/util.c:show_msg(281)
smb_tid=0
smb_pid=0
smb_uid=0
smb_mid=0
smt_wct=0
[2002/08/29 15:11:42, 5, pid=12863] lib/util.c:show_msg(291)
smb_bcc=0
[2002/08/29 15:11:42, 3, pid=12863] lib/util_sock.c:open_socket_out(845)
Connecting to 172.21.63.142 at port 445
[2002/08/29 15:11:42, 1, pid=12863] lib/util_sock.c:open_socket_out(860)
timeout connecting to 172.21.63.142:445
[2002/08/29 15:11:42, 3, pid=12863] lib/util_sock.c:open_socket_out(845)
Connecting to 172.21.63.142 at port 139
[2002/08/29 15:11:42, 1, pid=12863] lib/util_sock.c:open_socket_out(860)
timeout connecting to 172.21.63.142:139
[2002/08/29 15:11:42, 1, pid=12863] libsmb/cliconnect.c:cli_connect(782)
Error connecting to 172.21.63.142 (Operation now in progress)
[2002/08/29 15:11:42, 0, pid=12863]
libsmb/cliconnect.c:attempt_netbios_session_request(1098)
[2002/08/29 15:11:42, 0, pid=12863] lib/fault.c:fault_report(38)
===============================================================
[2002/08/29 15:11:42, 0, pid=12863] lib/fault.c:fault_report(39)
INTERNAL ERROR: Signal 11 in pid 12863 (2.2.6pre2)
Please read the file BUGS.txt in the distribution
[2002/08/29 15:11:42, 0, pid=12863] lib/fault.c:fault_report(41)
===============================================================
[2002/08/29 15:11:42, 0, pid=12863] lib/util.c:smb_panic(1094)
PANIC: internal error
--
Martin Bahlinger <bahlinger at rz.uni-karlsruhe.de> (PGP-ID: 0x98C32AC5)
More information about the samba-technical
mailing list