[Samba] Error since upgrade to Version 3.0.23a-1.fc4.1 - URGENT

Thu Dec 14 20:45:23 GMT 2006

And here is the contents of /var/log/samba/winbind.log when I click on that folder from a windows client logged in as gtreceiving:

[2006/12/14 14:48:55, 10] nsswitch/winbindd.c:process_request(287)
  process_request: request fn DOMAIN_INFO
[2006/12/14 14:48:55, 3] nsswitch/winbindd_misc.c:winbindd_domain_info(369)
  [    0]: domain_info [AVMAX]
[2006/12/14 14:48:55, 10] nsswitch/winbindd.c:process_request(287)
  process_request: request fn AUTH_CRAP
[2006/12/14 14:48:55, 3] nsswitch/winbindd_pam.c:winbindd_pam_auth_crap(1423)
  [    0]: pam auth crap domain: [AVMAX] user: GFReceiving
[2006/12/14 14:48:55, 8] lib/util.c:is_myname(2058)
  is_myname("AVMAX") returns 0
[2006/12/14 14:48:55, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(1953)
  Retrieving response for pid 15026
[2006/12/14 14:48:55, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(1975)
  Retrieving extra data length=512
[2006/12/14 14:48:55, 10] nsswitch/winbindd.c:process_request(287)
  process_request: request fn GETPWNAM
[2006/12/14 14:48:55, 3] nsswitch/winbindd_user.c:winbindd_getpwnam(336)
  [    0]: getpwnam avmax+gfreceiving
[2006/12/14 14:48:55, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(1953)
  Retrieving response for pid 15026
[2006/12/14 14:48:55, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(1953)
  Retrieving response for pid 15026
[2006/12/14 14:48:55, 10] sam/idmap_util.c:idmap_sid_to_uid(70)
  idmap_sid_to_uid: sid = [S-1-5-21-1488804738-1547898658-398547282-1794]
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:db_get_id_from_sid(277)
  db_get_id_from_sid
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(183)
  internal_get_id_from_sid: fetching record S-1-5-21-1488804738-1547898658-398547282-1794 of type 0x1
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(190)
  internal_get_id_from_sid: record S-1-5-21-1488804738-1547898658-398547282-1794 -> UID 10005
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(205)
  internal_get_id_from_sid: ID_USERID fetching record S-1-5-21-1488804738-1547898658-398547282-1794 -> UID 10005
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(152)
  internal_get_sid_from_id: fetching record UID 10005
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(158)
  internal_get_sid_from_id: fetching record UID 10005 -> S-1-5-21-1488804738-1547898658-398547282-1794
[2006/12/14 14:48:55, 10] sam/idmap_util.c:idmap_sid_to_uid(77)
  idmap_sid_to_uid: uid = [10005]
[2006/12/14 14:48:55, 10] sam/idmap_util.c:idmap_sid_to_gid(99)
  sid_to_gid: sid = [S-1-5-21-1488804738-1547898658-398547282-513]
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:db_get_id_from_sid(277)
  db_get_id_from_sid
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(183)
  internal_get_id_from_sid: fetching record S-1-5-21-1488804738-1547898658-398547282-513 of type 0x2
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(190)
  internal_get_id_from_sid: record S-1-5-21-1488804738-1547898658-398547282-513 -> GID 10000
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(224)
  internal_get_id_from_sid: ID_GROUPID fetching record S-1-5-21-1488804738-1547898658-398547282-513 -> GID 10000
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(152)
  internal_get_sid_from_id: fetching record GID 10000
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(158)
  internal_get_sid_from_id: fetching record GID 10000 -> S-1-5-21-1488804738-1547898658-398547282-513
[2006/12/14 14:48:55, 10] sam/idmap_util.c:idmap_sid_to_gid(107)
  idmap_sid_to_gid: gid = [10000]
[2006/12/14 14:48:55, 10] nsswitch/winbindd.c:process_request(287)
  process_request: request fn PING
[2006/12/14 14:48:55, 3] nsswitch/winbindd_misc.c:winbindd_ping(453)
  [    0]: ping
[2006/12/14 14:48:55, 10] nsswitch/winbindd.c:process_request(287)
  process_request: request fn GETPWNAM
[2006/12/14 14:48:55, 3] nsswitch/winbindd_user.c:winbindd_getpwnam(336)
  [    0]: getpwnam avmax+gfreceiving
[2006/12/14 14:48:55, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(1953)
  Retrieving response for pid 15026
[2006/12/14 14:48:55, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(1953)
  Retrieving response for pid 15026
[2006/12/14 14:48:55, 10] sam/idmap_util.c:idmap_sid_to_uid(70)
  idmap_sid_to_uid: sid = [S-1-5-21-1488804738-1547898658-398547282-1794]
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:db_get_id_from_sid(277)
  db_get_id_from_sid
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(183)
  internal_get_id_from_sid: fetching record S-1-5-21-1488804738-1547898658-398547282-1794 of type 0x1
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(190)
  internal_get_id_from_sid: record S-1-5-21-1488804738-1547898658-398547282-1794 -> UID 10005
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(205)
  internal_get_id_from_sid: ID_USERID fetching record S-1-5-21-1488804738-1547898658-398547282-1794 -> UID 10005
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(152)
  internal_get_sid_from_id: fetching record UID 10005
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(158)
  internal_get_sid_from_id: fetching record UID 10005 -> S-1-5-21-1488804738-1547898658-398547282-1794
[2006/12/14 14:48:55, 10] sam/idmap_util.c:idmap_sid_to_uid(77)
  idmap_sid_to_uid: uid = [10005]
[2006/12/14 14:48:55, 10] sam/idmap_util.c:idmap_sid_to_gid(99)
  sid_to_gid: sid = [S-1-5-21-1488804738-1547898658-398547282-513]
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:db_get_id_from_sid(277)
  db_get_id_from_sid
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(183)
  internal_get_id_from_sid: fetching record S-1-5-21-1488804738-1547898658-398547282-513 of type 0x2
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(190)
  internal_get_id_from_sid: record S-1-5-21-1488804738-1547898658-398547282-513 -> GID 10000
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_id_from_sid(224)
  internal_get_id_from_sid: ID_GROUPID fetching record S-1-5-21-1488804738-1547898658-398547282-513 -> GID 10000
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(152)
  internal_get_sid_from_id: fetching record GID 10000
[2006/12/14 14:48:55, 10] sam/idmap_tdb.c:internal_get_sid_from_id(158)
  internal_get_sid_from_id: fetching record GID 10000 -> S-1-5-21-1488804738-1547898658-398547282-513
[2006/12/14 14:48:55, 10] sam/idmap_util.c:idmap_sid_to_gid(107)
  idmap_sid_to_gid: gid = [10000]

Perhaps there is some kind of cache that is returning the wrong values here? I don't see any errors in there. 

Cheers,

Travis Bullock
Systems Administrator
Avmax Group Inc.

----- Original Message -----
From: Michael Coburn <mcoburn at jupiterimages.com>
To: Travis Bullock <tbullock at avmax.ca>
Cc: samba <samba at lists.samba.org>
Sent: Thursday, December 14, 2006 12:41:37 PM GMT-0700 US/Mountain
Subject: Re: [Samba] Error since upgrade to Version 3.0.23a-1.fc4.1 - URGENT

Since it failed at the winbind step, could it be related to your Windows 
PDC instead?  Can you create new shares and define new ACLs and confirm 
that they work?
--
Michael Coburn

Travis Bullock wrote:
> My samba shares aren't working with ACL access since the upgrade. Here is an example of the error from /var/log/messages 
>
> Dec 14 12:44:17 gfm-atlas smbd[14365]: [2006/12/14 12:44:17, 0] smbd/service.c:make_connection_snum(911) 
> Dec 14 12:44:17 gfm-atlas smbd[14365]: '/usr/GFM_Shares/Users/Receiving' does not exist or permission denied when connecting to [GF_Receiving] Error was Permission denied 
>
> Here is the detailed ACL on that particular share: 
>
> [root at gfm-atlas Users]# getfacl Receiving/ 
> # file: Receiving 
> # owner: root 
> # group: AVMAX+domain\040admins 
> user::rwx 
> group::rwx 
> other::--- 
> default:user::rwx 
> default:user:AVMAX+gfreceiving:rwx 
> default:group::rwx 
> default:mask::rwx 
> default:other::--- 
>
> Interestingly enough, the group "Domain Admins" can access this share no problem. But the lower level ACL for the user 'avmax+gfreceiving' generates that error in the messages log. 
>
> Some other errors in my /var/log/messages are: 
>
> Dec 14 12:20:22 gfm-atlas winbindd[14097]: [2006/12/14 12:20:22, 0] nsswitch/winbindd_dual.c:child_read_request(49) 
> Dec 14 12:20:22 gfm-atlas winbindd[14097]: Got invalid request length: 0 
> Dec 14 12:20:22 gfm-atlas winbindd[14084]: [2006/12/14 12:20:22, 0] nsswitch/winbindd_dual.c:child_read_request(49) 
> Dec 14 12:20:22 gfm-atlas winbindd[14084]: Got invalid request length: 0 
> Dec 14 12:21:33 gfm-atlas nmbd[14198]: [2006/12/14 12:21:33, 0] nmbd/asyncdns.c:start_async_dns(151) 
> Dec 14 12:21:33 gfm-atlas nmbd[14198]: started asyncdns process 14199 
> Dec 14 12:21:35 gfm-atlas winbindd[14196]: [2006/12/14 12:21:35, 0] rpc_client/cli_pipe.c:cli_rpc_pipe_open_noauth(2265) 
> Dec 14 12:21:35 gfm-atlas winbindd[14196]: cli_rpc_pipe_open_noauth: rpc_pipe_bind for pipe \lsarpc failed with error NT_STATUS_BUFFER_TOO_SMALL 
>
> Please help. 
>
> Cheers, 
>
> Travis Bullock 
> Systems Administrator 
> Avmax Group Inc. 
>
>   
-- 
To unsubscribe from this list go to the following URL and read the
instructions:  https://lists.samba.org/mailman/listinfo/samba