User profile for user: John0011010
John0011010 Author
User level: Level 1
0 points

Windows client slow login/logoff, SMB errors

We are setting up an OS X Snow Leopard server environment for a school, a Mac Pro running 10.6.8 server is serving as the OD master for Macs and a PDC for their 100+ Windows XP clients. Macs are able to log in and off just fine and quite quickly, PC's however suddenly take anywhere from 2-7 minutes to log in or out. I believe we have narrowed down the problem to Samba/SMB, more specifically to file syncing/transfers. For example, if I delete a users folder in the "/Users/Profiles/" folder on the server, that users next login by Windows is nearly instant, though logging off is back to the same delay as well as the subsequent login, etc.


Below is a snippet of SMB logs that I believe relates to our issue. This is from a user "jjoyce" attempting a successful but VERY long (nearly 5 minute) login:


[2011/06/30 08:19:50, 0] /SourceCache/samba/samba-235.7/samba/source/smbd/server.c:main(937)

smbd version 3.0.28a-apple started.

Copyright Andrew Tridgell and the Samba Team 1992-2008

[2011/06/30 08:19:50, 0, pid=11603] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:get_peer_addr(1232)

getpeername failed. Error was Invalid argument

[2011/06/30 08:19:50, 0, pid=11606] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:set_socket_options( 261)

Failed to set socket option SO_KEEPALIVE (Error Invalid argument)

[2011/06/30 08:19:50, 0, pid=11606] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:set_socket_options( 261)

Failed to set socket option TCP_NODELAY (Error Invalid argument)

[2011/06/30 08:19:50, 0, pid=11606] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:get_peer_addr(1232)

getpeername failed. Error was Invalid argument

[2011/06/30 08:19:50, 0, pid=11606] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:write_data(568)

write_data: write failure in writing to client 0.0.0.0. Error Broken pipe

[2011/06/30 08:19:50, 0, pid=11606] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:send_smb(767)

Error writing 4 bytes to client. -1. (Broken pipe)

[2011/06/30 08:19:59, 1, pid=11610] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service Users initially as user jjoyce (uid=1025, gid=20) (pid 11610)


Any insight of assistance would be greatly appreciated as we are mid-deployment and none of this showed up in lab testing, only in the last 24 hours as we've been branching it out into the school proper.


Thanks,

John

Mac Pro, Mac OS X (10.6.8), OD / PDC Server

Posted on Jun 30, 2011 5:30 AM

Reply
1 reply
User profile for user: John0011010
John0011010 Author
User level: Level 1
0 points

Jun 30, 2011 5:34 AM in response to John0011010

Also here are some more logs I just received littered with various errors we're having trouble explaining...


[2011/06/30 08:28:54, 0, pid=11882] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:set_socket_options( 261)

Failed to set socket option SO_KEEPALIVE (Error Invalid argument)

[2011/06/30 08:28:54, 0, pid=11882] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:set_socket_options( 261)

Failed to set socket option TCP_NODELAY (Error Invalid argument)

[2011/06/30 08:28:54, 0, pid=11882] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:get_peer_addr(1232)

getpeername failed. Error was Invalid argument

[2011/06/30 08:28:54, 0, pid=11882] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:write_data(568)

write_data: write failure in writing to client 172.16.40.78. Error Broken pipe

[2011/06/30 08:28:54, 0, pid=11882] /SourceCache/samba/samba-235.7/samba/source/lib/util_sock.c:send_smb(767)

Error writing 4 bytes to client. -1. (Broken pipe)

[2011/06/30 08:29:06, 1, pid=11887] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service Users initially as user rvsteele (uid=1056, gid=20) (pid 11887)

[2011/06/30 08:29:06, 0, pid=11887] /SourceCache/samba/samba-235.7/samba/source/modules/vfs_darwin_acls.c:map_perms _nt_to_kauth(377)

darwinacl: mapped NT permissions 0 to Darwin permset 0

[2011/06/30 08:29:06, 0, pid=11887] /SourceCache/samba/samba-235.7/samba/source/modules/vfs_darwin_acls.c:map_perms _nt_to_kauth(377)

darwinacl: mapped NT permissions 0 to Darwin permset 0

[2011/06/30 08:29:07, 1, pid=11885] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service netlogon initially as user rvsteele (uid=1056, gid=20) (pid 11885)

[2011/06/30 08:29:10, 1, pid=11885] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service rvsteele initially as user rvsteele (uid=1056, gid=20) (pid 11885)

[2011/06/30 08:29:16, 1, pid=11887] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:close_cnum(1289)

rm22 (172.16.40.78) closed connection to service Users

[2011/06/30 08:30:44, 1, pid=11933] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service Users initially as user rvsteele (uid=1056, gid=20) (pid 11933)

[2011/06/30 08:30:44, 1, pid=11933] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service Users initially as user rvsteele (uid=1056, gid=20) (pid 11933)

[2011/06/30 08:30:50, 1, pid=11885] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:close_cnum(1289)

rm22 (172.16.40.78) closed connection to service netlogon

[2011/06/30 08:30:50, 1, pid=11885] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:close_cnum(1289)

rm22 (172.16.40.78) closed connection to service rvsteele

[2011/06/30 08:31:49, 1, pid=11933] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:close_cnum(1289)

rm22 (172.16.40.78) closed connection to service Users

[2011/06/30 08:31:49, 1, pid=11933] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:close_cnum(1289)

rm22 (172.16.40.78) closed connection to service Users

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ntl mv2_auth_user(334)

dsDoNodeAuth gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_smb _pwd_check_ntlmv2(450)

opendirectory_ntlmv2_auth_user gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ope ndirectory_ntlm_password_check(526)

opendirectory_smb_pwd_check_ntlmv2 gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ntl mv2_auth_user(334)

dsDoNodeAuth gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_smb _pwd_check_ntlmv2(450)

opendirectory_ntlmv2_auth_user gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ope ndirectory_ntlm_password_check(557)

opendirectory_smb_pwd_check_ntlmv2 gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ntl mv2_auth_user(334)

dsDoNodeAuth gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_smb _pwd_check_ntlmv2(450)

opendirectory_ntlmv2_auth_user gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ope ndirectory_ntlm_password_check(572)

opendirectory_smb_pwd_check_ntlmv2 gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ntl mv2_auth_user(334)

dsDoNodeAuth gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_smb _pwd_check_ntlmv2(450)

opendirectory_ntlmv2_auth_user gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ope ndirectory_ntlm_password_check(526)

opendirectory_smb_pwd_check_ntlmv2 gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ntl mv2_auth_user(334)

dsDoNodeAuth gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_smb _pwd_check_ntlmv2(450)

opendirectory_ntlmv2_auth_user gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ope ndirectory_ntlm_password_check(557)

opendirectory_smb_pwd_check_ntlmv2 gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ntl mv2_auth_user(334)

dsDoNodeAuth gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_smb _pwd_check_ntlmv2(450)

opendirectory_ntlmv2_auth_user gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:07, 0, pid=11953] /SourceCache/samba/samba-235.7/samba/source/auth/auth_odsam.c:opendirectory_ope ndirectory_ntlm_password_check(572)

opendirectory_smb_pwd_check_ntlmv2 gave -14090 [eDSAuthFailed]

[2011/06/30 08:32:27, 1, pid=11956] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service Users initially as user rvsteele (uid=1056, gid=20) (pid 11956)

[2011/06/30 08:32:49, 1, pid=11956] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:close_cnum(1289)

rm22 (172.16.40.78) closed connection to service Users

[2011/06/30 08:32:49, 1, pid=11977] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service netlogon initially as user rvsteele (uid=1056, gid=20) (pid 11977)

[2011/06/30 08:32:49, 1, pid=11977] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service rvsteele initially as user rvsteele (uid=1056, gid=20) (pid 11977)

[2011/06/30 08:33:16, 1, pid=11982] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service Users initially as user rvsteele (uid=1056, gid=20) (pid 11982)

[2011/06/30 08:33:17, 1, pid=11982] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:make_connection_snum (1092)

rm22 (172.16.40.78) connect to service Users initially as user rvsteele (uid=1056, gid=20) (pid 11982)

[2011/06/30 08:33:25, 1, pid=11977] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:close_cnum(1289)

rm22 (172.16.40.78) closed connection to service netlogon

[2011/06/30 08:33:25, 1, pid=11977] /SourceCache/samba/samba-235.7/samba/source/smbd/service.c:close_cnum(1289)

rm22 (172.16.40.78) closed connection to service rvsteele

Reply

This thread has been closed by the system or the community team. You may vote for any posts you find helpful, or search the Community for additional answers.

Windows client slow login/logoff, SMB errors

Welcome to Apple Support Community
A forum where Apple customers help each other with their products. Get started with your Apple Account.
Learn more Sign up