Built-in Microsoft user Administrator is able to acess print server with priveleged authorities. That include administrators from domains having no trust with the one where print server belongs to and even local PC administrator user.
Are you really using version 3.0.1? If so, could you please try to reproduce this against a more recent release such as 3.0.14a? Are you running with drivers installed on the Samba host? We'll need a lot more details here.
*** Bug 2852 has been marked as a duplicate of this bug. ***
The version of samba being used is 3.0.13. The drivers are installed in the Samba host. The user is able to choose between the drivers already installed. However, the "New Driver" button of Add printer wizard is disabled. The account used to create the printer is part of a group configured as cups admin group in samba server.
I need to see a lvel 10 debug log of the user from the trusted domain getting administartive access to the printer. I also need to see your smb.conf. Also, are you running winbindd on the samba box? I don't think this is a bug, but rather a misconfiguration where the trusted user named Administrator is getting mapped to a unix user by the same name.
(In reply to comment #4) > I need to see a lvel 10 debug log of the user from the trusted > domain getting administartive access to the printer. I also > need to see your smb.conf. Level 10 logs ==================================== [2005/07/19 13:16:09, 5] printing/print_cups.c:cups_queue_get(723) cups_queue_get(new_pr2, 0xbffff4f4, 0xbffff3e0) [2005/07/19 13:16:09, 10] printing/print_cups.c:cups_server(51) cups server left to default localhost [2005/07/19 13:16:09, 3] printing/printing.c:print_queue_update_internal(1094) print_queue_update_internal: 0 jobs in queue for new_pr2 [2005/07/19 13:16:09, 10] printing/printing.c:print_queue_update_internal(1159) print_queue_update_internal: printer new_pr2 INFO/total_jobs = 0 [2005/07/19 13:16:09, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: not updating lpq cache for print share new_pr2 [2005/07/19 13:16:12, 10] nsswitch/winbindd.c:winbind_client_read(470) client_read: read 1824 bytes. Need 0 more for a full request. [2005/07/19 13:16:12, 10] nsswitch/winbindd.c:process_request(321) process_request: request fn GETPWUID [2005/07/19 13:16:12, 3] nsswitch/winbindd_user.c:winbindd_getpwuid(224) [ 9809]: getpwuid 70002 [2005/07/19 13:16:12, 4] nsswitch/winbindd_acct.c:wb_getpwuid(414) wb_getpwuid: failed to locate uid == 70002 [2005/07/19 13:16:12, 10] sam/idmap_util.c:idmap_uid_to_sid(108) idmap_uid_to_sid: uid = [70002] [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:db_get_sid_from_id(283) db_get_sid_from_id: id_type_in = 0x1 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_sid_from_id(190) internal_get_sid_from_id: fetching record UID 70002 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_sid_from_id(196) internal_get_sid_from_id: fetching record UID 70002 -> S-1-5-21-606747145-630328440-682003330-500 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(221) internal_get_id_from_sid: fetching record S-1-5-21-606747145-630328440-682003330-500 of type 0x1 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(228) internal_get_id_from_sid: record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(241) internal_get_id_from_sid: ID_USERID fetching record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(356) refresh_sequence_number: DOMAIN2000 time ok [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(386) refresh_sequence_number: DOMAIN2000 seq number is now 14555 [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:centry_expired(410) centry_expired: Key SN/S-1-5-21-606747145-630328440-682003330-500 for domain DOMAIN2000 is good. [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:wcache_fetch(489) wcache_fetch: returning entry SN/S-1-5-21-606747145-630328440-682003330-500 for domain DOMAIN2000 [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:sid_to_name(1023) sid_to_name: [Cached] - cached name for domain DOMAIN2000 status Success [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(356) refresh_sequence_number: DOMAIN2000 time ok [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(386) refresh_sequence_number: DOMAIN2000 seq number is now 14555 [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:centry_expired(410) centry_expired: Key U/S-1-5-21-606747145-630328440-682003330-500 for domain DOMAIN2000 is good. [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:wcache_fetch(489) wcache_fetch: returning entry U/S-1-5-21-606747145-630328440-682003330-500 for domain DOMAIN2000 [2005/07/19 13:16:12, 10] nsswitch/winbindd_cache.c:query_user(1096) query_user: [Cached] - cached info for domain DOMAIN2000 status Success [2005/07/19 13:16:12, 10] sam/idmap_util.c:idmap_sid_to_gid(179) sid_to_gid: sid = [S-1-5-21-606747145-630328440-682003330-513] [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:db_get_id_from_sid(315) db_get_id_from_sid [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(221) internal_get_id_from_sid: fetching record S-1-5-21-606747145-630328440-682003330-513 of type 0x2 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(228) internal_get_id_from_sid: record S-1-5-21-606747145-630328440-682003330-513 -> GID 70001 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(260) internal_get_id_from_sid: ID_GROUPID fetching record S-1-5-21-606747145-630328440-682003330-513 -> GID 70001 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_sid_from_id(190) internal_get_sid_from_id: fetching record GID 70001 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_sid_from_id(196) internal_get_sid_from_id: fetching record GID 70001 -> S-1-5-21-606747145-630328440-682003330-513 [2005/07/19 13:16:12, 10] sam/idmap_util.c:idmap_sid_to_gid(187) idmap_sid_to_gid: gid = [70001] [2005/07/19 13:16:12, 10] sam/idmap_util.c:idmap_sid_to_uid(150) idmap_sid_to_uid: sid = [S-1-5-21-606747145-630328440-682003330-500] [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:db_get_id_from_sid(315) db_get_id_from_sid [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(221) internal_get_id_from_sid: fetching record S-1-5-21-606747145-630328440-682003330-500 of type 0x1 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(228) internal_get_id_from_sid: record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(241) internal_get_id_from_sid: ID_USERID fetching record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_sid_from_id(190) internal_get_sid_from_id: fetching record UID 70002 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_sid_from_id(196) internal_get_sid_from_id: fetching record UID 70002 -> S-1-5-21-606747145-630328440-682003330-500 [2005/07/19 13:16:12, 10] sam/idmap_util.c:idmap_sid_to_uid(157) idmap_sid_to_uid: uid = [70002] [2005/07/19 13:16:12, 10] sam/idmap_util.c:idmap_sid_to_gid(179) sid_to_gid: sid = [S-1-5-21-606747145-630328440-682003330-513] [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:db_get_id_from_sid(315) db_get_id_from_sid [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(221) internal_get_id_from_sid: fetching record S-1-5-21-606747145-630328440-682003330-513 of type 0x2 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(228) internal_get_id_from_sid: record S-1-5-21-606747145-630328440-682003330-513 -> GID 70001 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_id_from_sid(260) internal_get_id_from_sid: ID_GROUPID fetching record S-1-5-21-606747145-630328440-682003330-513 -> GID 70001 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_sid_from_id(190) internal_get_sid_from_id: fetching record GID 70001 [2005/07/19 13:16:12, 10] sam/idmap_tdb.c:internal_get_sid_from_id(196) internal_get_sid_from_id: fetching record GID 70001 -> S-1-5-21-606747145-630328440-682003330-513 [2005/07/19 13:16:12, 10] sam/idmap_util.c:idmap_sid_to_gid(187) idmap_sid_to_gid: gid = [70001] [2005/07/19 13:16:12, 10] nsswitch/winbindd.c:client_write(524) client_write: wrote 1300 bytes. [2005/07/19 13:16:12, 10] printing/printing.c:start_background_queue(1362) start_background_queue: background LPQ thread got a message [2005/07/19 13:16:12, 10] lib/messages.c:message_dispatch(433) message_dispatch: received_signal = 1 [2005/07/19 13:16:12, 10] lib/messages.c:message_dispatch(441) message_dispatch: received msg_type=2103 src_pid=9809 [2005/07/19 13:16:12, 10] lib/messages.c:message_dispatch(446) message_dispatch: processing message of type 2103. [2005/07/19 13:16:12, 5] printing/printing.c:print_queue_update_with_lock(1216) print_queue_update_with_lock: printer share = new_pr2 [2005/07/19 13:16:12, 4] printing/printing.c:print_cache_expired(1025) print_cache_expired: cache expired for queue new_pr2 (last_qscan_time = 1121778969, time now = 1121778972, qcachetime = 0) [2005/07/19 13:16:12, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: updating lpq cache for print share new_pr2 [2005/07/19 13:16:12, 5] printing/printing.c:print_queue_update_internal(1075) print_queue_update_internal: printer = new_pr2, type = 8, lpq command = [new_pr2] [2005/07/19 13:16:12, 5] printing/print_cups.c:cups_queue_get(723) cups_queue_get(new_pr2, 0xbffff4f4, 0xbffff3e0) [2005/07/19 13:16:12, 10] printing/print_cups.c:cups_server(51) cups server left to default localhost [2005/07/19 13:16:13, 3] printing/printing.c:print_queue_update_internal(1094) print_queue_update_internal: 0 jobs in queue for new_pr2 [2005/07/19 13:16:13, 10] printing/printing.c:print_queue_update_internal(1159) print_queue_update_internal: printer new_pr2 INFO/total_jobs = 0 [2005/07/19 13:16:13, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: not updating lpq cache for print share new_pr2 [2005/07/19 13:16:13, 10] printing/printing.c:start_background_queue(1362) start_background_queue: background LPQ thread got a message [2005/07/19 13:16:13, 10] lib/messages.c:message_dispatch(433) message_dispatch: received_signal = 1 [2005/07/19 13:16:13, 10] lib/messages.c:message_dispatch(441) message_dispatch: received msg_type=2103 src_pid=9809 [2005/07/19 13:16:13, 10] lib/messages.c:message_dispatch(446) message_dispatch: processing message of type 2103. [2005/07/19 13:16:13, 5] printing/printing.c:print_queue_update_with_lock(1216) print_queue_update_with_lock: printer share = new_pr2 [2005/07/19 13:16:13, 4] printing/printing.c:print_cache_expired(1025) print_cache_expired: cache expired for queue new_pr2 (last_qscan_time = 1121778973, time now = 1121778973, qcachetime = 0) [2005/07/19 13:16:13, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: updating lpq cache for print share new_pr2 [2005/07/19 13:16:13, 5] printing/printing.c:print_queue_update_internal(1075) print_queue_update_internal: printer = new_pr2, type = 8, lpq command = [new_pr2] [2005/07/19 13:16:13, 5] printing/print_cups.c:cups_queue_get(723) cups_queue_get(new_pr2, 0xbffff4f4, 0xbffff3e0) [2005/07/19 13:16:13, 10] printing/print_cups.c:cups_server(51) cups server left to default localhost [2005/07/19 13:16:13, 3] printing/printing.c:print_queue_update_internal(1094) print_queue_update_internal: 0 jobs in queue for new_pr2 [2005/07/19 13:16:13, 10] printing/printing.c:print_queue_update_internal(1159) print_queue_update_internal: printer new_pr2 INFO/total_jobs = 0 [2005/07/19 13:16:13, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: not updating lpq cache for print share new_pr2 [2005/07/19 13:16:17, 10] nsswitch/winbindd.c:winbind_client_read(470) client_read: read 1824 bytes. Need 0 more for a full request. [2005/07/19 13:16:17, 10] nsswitch/winbindd.c:process_request(321) process_request: request fn GETPWUID [2005/07/19 13:16:17, 3] nsswitch/winbindd_user.c:winbindd_getpwuid(224) [ 9809]: getpwuid 70002 [2005/07/19 13:16:17, 4] nsswitch/winbindd_acct.c:wb_getpwuid(414) wb_getpwuid: failed to locate uid == 70002 [2005/07/19 13:16:17, 10] sam/idmap_util.c:idmap_uid_to_sid(108) idmap_uid_to_sid: uid = [70002] [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:db_get_sid_from_id(283) db_get_sid_from_id: id_type_in = 0x1 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_sid_from_id(190) internal_get_sid_from_id: fetching record UID 70002 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_sid_from_id(196) internal_get_sid_from_id: fetching record UID 70002 -> S-1-5-21-606747145-630328440-682003330-500 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(221) internal_get_id_from_sid: fetching record S-1-5-21-606747145-630328440-682003330-500 of type 0x1 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(228) internal_get_id_from_sid: record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(241) internal_get_id_from_sid: ID_USERID fetching record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(356) refresh_sequence_number: DOMAIN2000 time ok [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(386) refresh_sequence_number: DOMAIN2000 seq number is now 14555 [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:centry_expired(410) centry_expired: Key SN/S-1-5-21-606747145-630328440-682003330-500 for domain DOMAIN2000 is good. [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:wcache_fetch(489) wcache_fetch: returning entry SN/S-1-5-21-606747145-630328440-682003330-500 for domain DOMAIN2000 [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:sid_to_name(1023) sid_to_name: [Cached] - cached name for domain DOMAIN2000 status Success [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(356) refresh_sequence_number: DOMAIN2000 time ok [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:refresh_sequence_number(386) refresh_sequence_number: DOMAIN2000 seq number is now 14555 [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:centry_expired(410) centry_expired: Key U/S-1-5-21-606747145-630328440-682003330-500 for domain DOMAIN2000 is good. [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:wcache_fetch(489) wcache_fetch: returning entry U/S-1-5-21-606747145-630328440-682003330-500 for domain DOMAIN2000 [2005/07/19 13:16:17, 10] nsswitch/winbindd_cache.c:query_user(1096) query_user: [Cached] - cached info for domain DOMAIN2000 status Success [2005/07/19 13:16:17, 10] sam/idmap_util.c:idmap_sid_to_gid(179) sid_to_gid: sid = [S-1-5-21-606747145-630328440-682003330-513] [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:db_get_id_from_sid(315) db_get_id_from_sid [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(221) internal_get_id_from_sid: fetching record S-1-5-21-606747145-630328440-682003330-513 of type 0x2 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(228) internal_get_id_from_sid: record S-1-5-21-606747145-630328440-682003330-513 -> GID 70001 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(260) internal_get_id_from_sid: ID_GROUPID fetching record S-1-5-21-606747145-630328440-682003330-513 -> GID 70001 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_sid_from_id(190) internal_get_sid_from_id: fetching record GID 70001 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_sid_from_id(196) internal_get_sid_from_id: fetching record GID 70001 -> S-1-5-21-606747145-630328440-682003330-513 [2005/07/19 13:16:17, 10] sam/idmap_util.c:idmap_sid_to_gid(187) idmap_sid_to_gid: gid = [70001] [2005/07/19 13:16:17, 10] sam/idmap_util.c:idmap_sid_to_uid(150) idmap_sid_to_uid: sid = [S-1-5-21-606747145-630328440-682003330-500] [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:db_get_id_from_sid(315) db_get_id_from_sid [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(221) internal_get_id_from_sid: fetching record S-1-5-21-606747145-630328440-682003330-500 of type 0x1 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(228) internal_get_id_from_sid: record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(241) internal_get_id_from_sid: ID_USERID fetching record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_sid_from_id(190) internal_get_sid_from_id: fetching record UID 70002 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_sid_from_id(196) internal_get_sid_from_id: fetching record UID 70002 -> S-1-5-21-606747145-630328440-682003330-500 [2005/07/19 13:16:17, 10] sam/idmap_util.c:idmap_sid_to_uid(157) idmap_sid_to_uid: uid = [70002] [2005/07/19 13:16:17, 10] sam/idmap_util.c:idmap_sid_to_gid(179) sid_to_gid: sid = [S-1-5-21-606747145-630328440-682003330-513] [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:db_get_id_from_sid(315) db_get_id_from_sid [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(221) internal_get_id_from_sid: fetching record S-1-5-21-606747145-630328440-682003330-513 of type 0x2 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(228) internal_get_id_from_sid: record S-1-5-21-606747145-630328440-682003330-513 -> GID 70001 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_id_from_sid(260) internal_get_id_from_sid: ID_GROUPID fetching record S-1-5-21-606747145-630328440-682003330-513 -> GID 70001 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_sid_from_id(190) internal_get_sid_from_id: fetching record GID 70001 [2005/07/19 13:16:17, 10] sam/idmap_tdb.c:internal_get_sid_from_id(196) internal_get_sid_from_id: fetching record GID 70001 -> S-1-5-21-606747145-630328440-682003330-513 [2005/07/19 13:16:17, 10] sam/idmap_util.c:idmap_sid_to_gid(187) idmap_sid_to_gid: gid = [70001] [2005/07/19 13:16:17, 10] nsswitch/winbindd.c:client_write(524) client_write: wrote 1300 bytes. [2005/07/19 13:16:17, 10] printing/printing.c:start_background_queue(1362) start_background_queue: background LPQ thread got a message [2005/07/19 13:16:17, 10] lib/messages.c:message_dispatch(433) message_dispatch: received_signal = 1 [2005/07/19 13:16:17, 10] lib/messages.c:message_dispatch(441) message_dispatch: received msg_type=2103 src_pid=9809 [2005/07/19 13:16:17, 10] lib/messages.c:message_dispatch(446) message_dispatch: processing message of type 2103. [2005/07/19 13:16:17, 5] printing/printing.c:print_queue_update_with_lock(1216) print_queue_update_with_lock: printer share = new_pr2 [2005/07/19 13:16:17, 4] printing/printing.c:print_cache_expired(1025) print_cache_expired: cache expired for queue new_pr2 (last_qscan_time = 1121778973, time now = 1121778977, qcachetime = 0) [2005/07/19 13:16:17, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: updating lpq cache for print share new_pr2 [2005/07/19 13:16:17, 5] printing/printing.c:print_queue_update_internal(1075) print_queue_update_internal: printer = new_pr2, type = 8, lpq command = [new_pr2] [2005/07/19 13:16:17, 5] printing/print_cups.c:cups_queue_get(723) cups_queue_get(new_pr2, 0xbffff4f4, 0xbffff3e0) [2005/07/19 13:16:17, 10] printing/print_cups.c:cups_server(51) cups server left to default localhost [2005/07/19 13:16:18, 3] printing/printing.c:print_queue_update_internal(1094) print_queue_update_internal: 0 jobs in queue for new_pr2 [2005/07/19 13:16:18, 10] printing/printing.c:print_queue_update_internal(1159) print_queue_update_internal: printer new_pr2 INFO/total_jobs = 0 [2005/07/19 13:16:18, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: not updating lpq cache for print share new_pr2 [2005/07/19 13:16:18, 10] printing/printing.c:start_background_queue(1362) start_background_queue: background LPQ thread got a message [2005/07/19 13:16:18, 10] lib/messages.c:message_dispatch(433) message_dispatch: received_signal = 1 [2005/07/19 13:16:18, 10] lib/messages.c:message_dispatch(441) message_dispatch: received msg_type=2103 src_pid=9809 [2005/07/19 13:16:18, 10] lib/messages.c:message_dispatch(446) message_dispatch: processing message of type 2103. [2005/07/19 13:16:18, 5] printing/printing.c:print_queue_update_with_lock(1216) print_queue_update_with_lock: printer share = new_pr2 [2005/07/19 13:16:18, 4] printing/printing.c:print_cache_expired(1025) print_cache_expired: cache expired for queue new_pr2 (last_qscan_time = 1121778978, time now = 1121778978, qcachetime = 0) [2005/07/19 13:16:18, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: updating lpq cache for print share new_pr2 [2005/07/19 13:16:18, 5] printing/printing.c:print_queue_update_internal(1075) print_queue_update_internal: printer = new_pr2, type = 8, lpq command = [new_pr2] [2005/07/19 13:16:18, 5] printing/print_cups.c:cups_queue_get(723) cups_queue_get(new_pr2, 0xbffff4f4, 0xbffff3e0) [2005/07/19 13:16:18, 10] printing/print_cups.c:cups_server(51) cups server left to default localhost [2005/07/19 13:16:18, 3] printing/printing.c:print_queue_update_internal(1094) print_queue_update_internal: 0 jobs in queue for new_pr2 [2005/07/19 13:16:18, 10] printing/printing.c:print_queue_update_internal(1159) print_queue_update_internal: printer new_pr2 INFO/total_jobs = 0 [2005/07/19 13:16:18, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: not updating lpq cache for print share new_pr2 [2005/07/19 13:16:22, 10] nsswitch/winbindd.c:winbind_client_read(470) client_read: read 1824 bytes. Need 0 more for a full request. [2005/07/19 13:16:22, 10] nsswitch/winbindd.c:process_request(321) process_request: request fn GETPWUID [2005/07/19 13:16:22, 3] nsswitch/winbindd_user.c:winbindd_getpwuid(224) [ 9809]: getpwuid 70002 [2005/07/19 13:16:22, 4] nsswitch/winbindd_acct.c:wb_getpwuid(414) wb_getpwuid: failed to locate uid == 70002 [2005/07/19 13:16:22, 10] sam/idmap_util.c:idmap_uid_to_sid(108) idmap_uid_to_sid: uid = [70002] [2005/07/19 13:16:22, 10] sam/idmap_tdb.c:db_get_sid_from_id(283) db_get_sid_from_id: id_type_in = 0x1 [2005/07/19 13:16:22, 10] sam/idmap_tdb.c:internal_get_sid_from_id(190) internal_get_sid_from_id: fetching record UID 70002 [2005/07/19 13:16:22, 10] sam/idmap_tdb.c:internal_get_sid_from_id(196) internal_get_sid_from_id: fetching record UID 70002 -> S-1-5-21-606747145-630328440-682003330-500 [2005/07/19 13:16:22, 10] sam/idmap_tdb.c:internal_get_id_from_sid(221) internal_get_id_from_sid: fetching record S-1-5-21-606747145-630328440-682003330-500 of type 0x1 [2005/07/19 13:16:22, 10] sam/idmap_tdb.c:internal_get_id_from_sid(228) internal_get_id_from_sid: record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:22, 10] sam/idmap_tdb.c:internal_get_id_from_sid(241) internal_get_id_from_sid: ID_USERID fetching record S-1-5-21-606747145-630328440-682003330-500 -> UID 70002 [2005/07/19 13:16:22, 10] nsswitch/winbindd_cache.c:fetch_cache_seqnum(286) fetch_cache_seqnum: timeout [DOMAIN2000][14555 @ 1121778968] [2005/07/19 13:16:22, 10] nsswitch/winbindd_rpc.c:sequence_number(878) rpc: fetch sequence_number for DOMAIN2000 [2005/07/19 13:16:22, 10] rpc_client/cli_samr.c:cli_samr_open_domain(186) cli_samr_open_domain with sid S-1-5-21-606747145-630328440-682003330 [2005/07/19 13:16:22, 5] rpc_parse/parse_samr.c:init_samr_q_open_domain(250) samr_init_samr_q_open_domain [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_debug(82) 000000 samr_io_q_open_domain [2005/07/19 13:16:22, 6] rpc_parse/parse_prs.c:prs_debug(82) 000000 smb_io_pol_hnd pol [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0000 data1: 00000000 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0004 data2: 6e36647c [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0008 data3: 9b54 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint16(613) 000a data4: 4695 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 000c data5: a9 26 95 05 fa 64 7e 5b [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0014 flags: 02000000 [2005/07/19 13:16:22, 6] rpc_parse/parse_prs.c:prs_debug(82) 000018 smb_io_dom_sid2 sid [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0018 num_auths: 00000004 [2005/07/19 13:16:22, 7] rpc_parse/parse_prs.c:prs_debug(82) 00001c smb_io_dom_sid sid [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 001c sid_rev_num: 01 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 001d num_auths : 04 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 001e id_auth[0] : 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 001f id_auth[1] : 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0020 id_auth[2] : 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0021 id_auth[3] : 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0022 id_auth[4] : 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0023 id_auth[5] : 05 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint32s(869) 0024 sub_auths : 00000015 242a3a09 25920c78 28a68b82 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_debug(82) 000038 smb_io_rpc_hdr_auth hdr_auth [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0038 auth_type : 44 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0039 auth_level : 05 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 003a padding : 04 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 003b reserved : 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint32(642) 003c auth_context : 00000001 [2005/07/19 13:16:22, 10] rpc_client/cli_pipe.c:rpc_api_pipe_req(1034) SCHANNEL seq_num=4232 [2005/07/19 13:16:22, 10] rpc_parse/parse_prs.c:netsec_encode(1481) SCHANNEL: netsec_encode seq_num=4232 data_len=56 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_debug(82) 000040 smb_io_rpc_auth_netsec_chk [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0040 sig : 77 00 ff ff ff ff 00 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0048 seq_num: 61 0d cb ca 30 25 2a 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0050 packet_digest: 14 05 4b 43 d0 d7 96 f3 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0058 confounder: 62 2d 86 e4 bb 48 e5 ad [2005/07/19 13:16:22, 5] rpc_client/cli_pipe.c:create_rpc_request(852) create_rpc_request: opnum: 0x7 data_len: 0x78 [2005/07/19 13:16:22, 10] rpc_client/cli_pipe.c:create_rpc_request(868) create_rpc_request: data_len: 78 auth_len: 20 alloc_hint: 40 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_debug(82) 000000 smb_io_rpc_hdr hdr [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0000 major : 05 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0001 minor : 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0002 pkt_type : 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0003 flags : 03 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0004 pack_type0: 10 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0005 pack_type1: 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0006 pack_type2: 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0007 pack_type3: 00 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0008 frag_len : 0078 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint16(613) 000a auth_len : 0020 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint32(642) 000c call_id : 000008e6 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_debug(82) 000010 smb_io_rpc_hdr_req hdr_req [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0010 alloc_hint: 00000040 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0014 context_id: 0000 [2005/07/19 13:16:22, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0016 opnum : 0007 [2005/07/19 13:16:22, 5] rpc_client/cli_pipe.c:rpc_api_pipe(421) rpc_api_pipe: fnum:8004 [2005/07/19 13:16:22, 5] lib/util.c:show_msg(464) [2005/07/19 13:16:22, 5] lib/util.c:show_msg(467) size=202 smb_com=0x25 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=55297 smb_tid=16385 smb_pid=1905 smb_uid=28674 smb_mid=2126 smt_wct=16 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 120 (0x78) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 4280 (0x10B8) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 82 (0x52) smb_vwv[11]= 120 (0x78) smb_vwv[12]= 82 (0x52) smb_vwv[13]= 2 (0x2) smb_vwv[14]= 38 (0x26) smb_vwv[15]=32772 (0x8004) smb_bcc=135 [2005/07/19 13:16:22, 10] lib/util.c:dump_data(1995) [000] 00 5C 00 50 00 49 00 50 00 45 00 5C 00 00 00 05 .\.P.I.P .E.\.... [010] 00 00 03 10 00 00 00 78 00 20 00 E6 08 00 00 40 .......x . .....@ [020] 00 00 00 00 00 07 00 00 00 00 00 7C 64 36 6E 54 ........ ...|d6nT [030] 9B 95 46 A9 26 95 05 FA 64 7E 5B 00 00 00 02 04 ..F.&... d~[..... [040] 00 00 00 01 04 00 00 00 00 00 05 15 00 00 00 09 ........ ........ [050] 3A 2A 24 78 0C 92 25 82 8B A6 28 00 00 00 00 44 :*$x..%. ..(....D [060] 05 04 00 01 00 00 00 77 00 FF FF FF FF 00 00 61 .......w .......a [070] 0D CB CA 30 25 2A 00 14 05 4B 43 D0 D7 96 F3 62 ...0%*.. .KC....b [080] 2D 86 E4 BB 48 E5 AD -...H.. [2005/07/19 13:16:22, 6] lib/util_sock.c:write_socket(449) write_socket(17,206) [2005/07/19 13:16:22, 6] lib/util_sock.c:write_socket(452) write_socket(17,206) wrote 206 [2005/07/19 13:16:23, 10] lib/util_sock.c:read_smb_length_return_keepalive(505) got smb length of 152 [2005/07/19 13:16:23, 5] lib/util.c:show_msg(464) [2005/07/19 13:16:23, 5] lib/util.c:show_msg(467) size=152 smb_com=0x25 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=55297 smb_tid=16385 smb_pid=1905 smb_uid=28674 smb_mid=2126 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 96 (0x60) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 96 (0x60) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=97 [2005/07/19 13:16:23, 10] lib/util.c:dump_data(1995) [000] 00 05 00 02 03 10 00 00 00 60 00 20 00 E6 08 00 ........ .`. .... [010] 00 18 00 00 00 00 00 00 00 00 00 00 00 34 08 18 ........ .....4.. [020] 87 1E F9 62 41 97 6A C8 29 D7 79 9D 14 00 00 00 ...bA.j. ).y..... [030] 00 41 00 64 00 6D 00 69 00 44 05 08 00 01 00 00 .A.d.m.i .D...... [040] 00 77 00 FF FF FF FF 00 00 EC A5 C6 94 CA 7E D9 .w...... ......~. [050] 00 15 A1 A5 FC 16 EA 7F 43 00 00 00 00 00 00 00 ........ C....... [060] 00 . [2005/07/19 13:16:23, 5] lib/util.c:show_msg(464) [2005/07/19 13:16:23, 5] lib/util.c:show_msg(467) size=152 smb_com=0x25 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=55297 smb_tid=16385 smb_pid=1905 smb_uid=28674 smb_mid=2126 smt_wct=10 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 96 (0x60) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 96 (0x60) smb_vwv[ 7]= 56 (0x38) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=97 [2005/07/19 13:16:23, 10] lib/util.c:dump_data(1995) [000] 00 05 00 02 03 10 00 00 00 60 00 20 00 E6 08 00 ........ .`. .... [010] 00 18 00 00 00 00 00 00 00 00 00 00 00 34 08 18 ........ .....4.. [020] 87 1E F9 62 41 97 6A C8 29 D7 79 9D 14 00 00 00 ...bA.j. ).y..... [030] 00 41 00 64 00 6D 00 69 00 44 05 08 00 01 00 00 .A.d.m.i .D...... [040] 00 77 00 FF FF FF FF 00 00 EC A5 C6 94 CA 7E D9 .w...... ......~. [050] 00 15 A1 A5 FC 16 EA 7F 43 00 00 00 00 00 00 00 ........ C....... [060] 00 . [2005/07/19 13:16:23, 5] rpc_client/cli_pipe.c:rpc_check_hdr(134) rpc_check_hdr: rdata->data_size = 96 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000000 smb_io_rpc_hdr rpc_hdr [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0000 major : 05 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0001 minor : 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0002 pkt_type : 02 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0003 flags : 03 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0004 pack_type0: 10 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0005 pack_type1: 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0006 pack_type2: 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0007 pack_type3: 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0008 frag_len : 0060 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 000a auth_len : 0020 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 000c call_id : 000008e6 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000010 smb_io_rpc_hdr_resp rpc_hdr_resp [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0010 alloc_hint: 00000018 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0014 context_id: 0000 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0016 cancel_ct : 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0017 reserved : 00 [2005/07/19 13:16:23, 5] rpc_client/cli_pipe.c:rpc_api_pipe(493) rpc_api_pipe: len left: 0 smbtrans read: 96 [2005/07/19 13:16:23, 5] rpc_client/cli_pipe.c:rpc_auth_pipe(207) rpc_auth_pipe: pkt_type: 2 len: 96 auth_len: 32 NTLMSSP No schannel Yes sign Yes seal No [2005/07/19 13:16:23, 10] rpc_client/cli_pipe.c:rpc_auth_pipe(219) rpc_auth_pipe: packet: [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000000 smb_io_rpc_hdr_auth auth_hdr [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0000 auth_type : 44 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0001 auth_level : 05 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0002 padding : 08 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0003 reserved : 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0004 auth_context : 00000001 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000008 smb_io_rpc_auth_netsec_chk schannel_auth_sign [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0008 sig : 77 00 ff ff ff ff 00 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0010 seq_num: ec a5 c6 94 ca 7e d9 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0018 packet_digest: 15 a1 a5 fc 16 ea 7f 43 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0020 confounder: 00 00 00 00 00 00 00 00 [2005/07/19 13:16:23, 10] rpc_parse/parse_prs.c:netsec_decode(1558) SCHANNEL: netsec_encode seq_num=4233 data_len=32 [2005/07/19 13:16:23, 10] rpc_parse/parse_prs.c:netsec_decode(1578) SCHANNEL: netsec_decode seq_num=4233 data_len=32 [2005/07/19 13:16:23, 6] rpc_client/cli_pipe.c:rpc_api_pipe(536) rpc_api_pipe: fragment first and last both set [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000018 samr_io_r_open_domain [2005/07/19 13:16:23, 6] rpc_parse/parse_prs.c:prs_debug(82) 000018 smb_io_pol_hnd domain_pol [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0018 data1: 00000000 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 001c data2: 87180834 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0020 data3: f91e [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0022 data4: 4162 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0024 data5: 97 6a c8 29 d7 79 9d 14 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_ntstatus(671) 002c status: NT_STATUS_OK [2005/07/19 13:16:23, 10] rpc_client/cli_samr.c:cli_samr_query_dom_info(1380) cli_samr_query_dom_info [2005/07/19 13:16:23, 5] rpc_parse/parse_samr.c:init_samr_q_query_dom_info(468) samr_init_samr_q_query_dom_info [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000000 samr_io_q_query_dom_info [2005/07/19 13:16:23, 6] rpc_parse/parse_prs.c:prs_debug(82) 000000 smb_io_pol_hnd domain_pol [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0000 data1: 00000000 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0004 data2: 87180834 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0008 data3: f91e [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 000a data4: 4162 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 000c data5: 97 6a c8 29 d7 79 9d 14 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0014 switch_value: 0008 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000018 smb_io_rpc_hdr_auth hdr_auth [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0018 auth_type : 44 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0019 auth_level : 05 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 001a padding : 02 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 001b reserved : 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 001c auth_context : 00000001 [2005/07/19 13:16:23, 10] rpc_client/cli_pipe.c:rpc_api_pipe_req(1034) SCHANNEL seq_num=4234 [2005/07/19 13:16:23, 10] rpc_parse/parse_prs.c:netsec_encode(1481) SCHANNEL: netsec_encode seq_num=4234 data_len=24 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000020 smb_io_rpc_auth_netsec_chk [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0020 sig : 77 00 ff ff ff ff 00 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0028 seq_num: bc 8a 70 22 52 bf b6 c1 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0030 packet_digest: aa 23 46 b2 43 fd 3d c9 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8s(729) 0038 confounder: 59 6c 71 75 dd c2 1c 69 [2005/07/19 13:16:23, 5] rpc_client/cli_pipe.c:create_rpc_request(852) create_rpc_request: opnum: 0x8 data_len: 0x58 [2005/07/19 13:16:23, 10] rpc_client/cli_pipe.c:create_rpc_request(868) create_rpc_request: data_len: 58 auth_len: 20 alloc_hint: 20 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000000 smb_io_rpc_hdr hdr [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0000 major : 05 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0001 minor : 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0002 pkt_type : 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0003 flags : 03 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0004 pack_type0: 10 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0005 pack_type1: 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0006 pack_type2: 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint8(584) 0007 pack_type3: 00 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0008 frag_len : 0058 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 000a auth_len : 0020 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 000c call_id : 000008e7 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_debug(82) 000010 smb_io_rpc_hdr_req hdr_req [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint32(642) 0010 alloc_hint: 00000020 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0014 context_id: 0000 [2005/07/19 13:16:23, 5] rpc_parse/parse_prs.c:prs_uint16(613) 0016 opnum : 0008 [2005/07/19 13:16:23, 5] rpc_client/cli_pipe.c:rpc_api_pipe(421) rpc_api_pipe: fnum:8004 [2005/07/19 13:16:23, 5] lib/util.c:show_msg(464) [2005/07/19 13:16:23, 5] lib/util.c:show_msg(467) size=170 smb_com=0x25 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=55297 smb_tid=16385 smb_pid=1905 smb_uid=28674 smb_mid=2127 smt_wct=16 smb_vwv[ 0]= 0 (0x0) smb_vwv[ 1]= 88 (0x58) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 4280 (0x10B8) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 82 (0x52) smb_vwv[11]= 88 (0x58) smb_vwv[12]= 82 (0x52) smb_vwv[13]= 2 (0x2) smb_vwv[14]= 38 (0x26) smb_vwv[15]=32772 (0x8004) smb_bcc=103 [2005/07/19 13:16:23, 10] lib/util.c:dump_data(1995) [000] 00 5C 00 50 00 49 00 50 00 45 00 5C 00 00 00 05 .\.P.I.P .E.\.... [010] 00 00 03 10 00 00 00 58 00 20 00 E7 08 00 00 20 .......X . ..... [020] 00 00 00 00 00 08 00 00 00 00 00 34 08 18 87 1E ........ ...4.... [030] F9 62 41 97 6A C8 29 D7 79 9D 14 08 00 00 00 44 .bA.j.). y......D [040] 05 02 00 01 00 00 00 77 00 FF FF FF FF 00 00 BC .......w ........ [050] 8A 70 22 52 BF B6 C1 AA 23 46 B2 43 FD 3D C9 59 .p"R.... #F.C.=.Y [060] 6C 71 75 DD C2 1C 69 lqu...i [2005/07/19 13:16:23, 6] lib/util_sock.c:write_socket(449) write_socket(17,174) [2005/07/19 13:16:23, 6] lib/util_sock.c:write_socket(452) write_socket(17,174) wrote 174 [2005/07/19 13:16:23, 10] lib/util_sock.c:read_smb_length_return_keepalive(505) got smb length of 152 [2005/07/19 13:16:23, 10] printing/printing.c:start_background_queue(1362) start_background_queue: background LPQ thread got a message [2005/07/19 13:16:23, 10] lib/messages.c:message_dispatch(433) message_dispatch: received_signal = 1 [2005/07/19 13:16:23, 10] lib/messages.c:message_dispatch(441) message_dispatch: received msg_type=2103 src_pid=9809 [2005/07/19 13:16:23, 10] lib/messages.c:message_dispatch(446) message_dispatch: processing message of type 2103. [2005/07/19 13:16:23, 5] printing/printing.c:print_queue_update_with_lock(1216) print_queue_update_with_lock: printer share = new_pr2 [2005/07/19 13:16:23, 4] printing/printing.c:print_cache_expired(1025) print_cache_expired: cache expired for queue new_pr2 (last_qscan_time = 1121778978, time now = 1121778983, qcachetime = 0) [2005/07/19 13:16:23, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: updating lpq cache for print share new_pr2 [2005/07/19 13:16:23, 5] printing/printing.c:print_queue_update_internal(1075) print_queue_update_internal: printer = new_pr2, type = 8, lpq command = [new_pr2] [2005/07/19 13:16:23, 5] printing/print_cups.c:cups_queue_get(723) cups_queue_get(new_pr2, 0xbffff4f4, 0xbffff3e0) [2005/07/19 13:16:23, 10] printing/print_cups.c:cups_server(51) cups server left to default localhost [2005/07/19 13:16:24, 3] printing/printing.c:print_queue_update_internal(1094) print_queue_update_internal: 0 jobs in queue for new_pr2 [2005/07/19 13:16:24, 10] printing/printing.c:print_queue_update_internal(1159) print_queue_update_internal: printer new_pr2 INFO/total_jobs = 0 [2005/07/19 13:16:24, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: not updating lpq cache for print share new_pr2 [2005/07/19 13:16:24, 10] printing/printing.c:start_background_queue(1362) start_background_queue: background LPQ thread got a message [2005/07/19 13:16:24, 10] lib/messages.c:message_dispatch(433) message_dispatch: received_signal = 1 [2005/07/19 13:16:24, 10] lib/messages.c:message_dispatch(441) message_dispatch: received msg_type=2103 src_pid=9809 [2005/07/19 13:16:24, 10] lib/messages.c:message_dispatch(446) message_dispatch: processing message of type 2103. [2005/07/19 13:16:24, 5] printing/printing.c:print_queue_update_with_lock(1216) print_queue_update_with_lock: printer share = new_pr2 [2005/07/19 13:16:24, 4] printing/printing.c:print_cache_expired(1025) print_cache_expired: cache expired for queue new_pr2 (last_qscan_time = 1121778984, time now = 1121778984, qcachetime = 0) [2005/07/19 13:16:24, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: updating lpq cache for print share new_pr2 [2005/07/19 13:16:24, 5] printing/printing.c:print_queue_update_internal(1075) print_queue_update_internal: printer = new_pr2, type = 8, lpq command = [new_pr2] [2005/07/19 13:16:24, 5] printing/print_cups.c:cups_queue_get(723) cups_queue_get(new_pr2, 0xbffff4f4, 0xbffff3e0) [2005/07/19 13:16:24, 10] printing/print_cups.c:cups_server(51) cups server left to default localhost [2005/07/19 13:16:24, 3] printing/printing.c:print_queue_update_internal(1094) print_queue_update_internal: 0 jobs in queue for new_pr2 [2005/07/19 13:16:24, 10] printing/printing.c:print_queue_update_internal(1159) print_queue_update_internal: printer new_pr2 INFO/total_jobs = 0 [2005/07/19 13:16:24, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: not updating lpq cache for print share new_pr2 [2005/07/19 13:16:28, 10] printing/printing.c:start_background_queue(1362) start_background_queue: background LPQ thread got a message [2005/07/19 13:16:28, 10] lib/messages.c:message_dispatch(433) message_dispatch: received_signal = 1 [2005/07/19 13:16:28, 10] lib/messages.c:message_dispatch(441) message_dispatch: received msg_type=2103 src_pid=9809 [2005/07/19 13:16:28, 10] lib/messages.c:message_dispatch(446) message_dispatch: processing message of type 2103. [2005/07/19 13:16:28, 5] printing/printing.c:print_queue_update_with_lock(1216) print_queue_update_with_lock: printer share = new_pr2 [2005/07/19 13:16:28, 4] printing/printing.c:print_cache_expired(1025) print_cache_expired: cache expired for queue new_pr2 (last_qscan_time = 1121778984, time now = 1121778988, qcachetime = 0) [2005/07/19 13:16:28, 5] printing/printing.c:set_updating_pid(864) set_updating_pid: updating lpq cache for print share new_pr2 [2005/07/19 13:16:28, 5] printing/printing.c:print_queue_update_internal(1075) print_queue_update_internal: printer = new_pr2, type = 8, lpq command = [new_pr2] [2005/07/19 13:16:28, 5] printing/print_cups.c:cups_queue_get(723) cups_queue_get(new_pr2, 0xbffff4f4, 0xbffff3e0) [2005/07/19 13:16:28, 10] printing/print_cups.c:cups_server(51) cups server left to default localhost ========================================= smb.conf ========================================= [global] idmap uid = 70000-200000 idmap gid = 70000-200000 winbind enum users = no winbind enum groups = no winbind cache time = 10 winbind use default domain = yes printcap name = cups load printers = yes printing = cups cups options = "raw" force printername = yes lpq cache time = 0 log file = /local/local1/errorlog/samba.log max log size = 50 socket options = TCP_NODELAY SO_RCVBUF=8192 SO_SNDBUF=8192 smb ports = 50139 local master = no domain master = no preferred master = no dns proxy = no template homedir = /local/local1/ template shell = /admin-shell printer admin = @adminGroup1 addprinter command = /usr/bin/addprinter deleteprinter command = /usr/bin/removeprinter show add printer wizard = yes workgroup = DOMAIN2000 netbios name = ODI-MGT-CE1 wins server = 10.86.41.210 password server = 10.86.41.210 security = domain [print$] path = /state/samba/printers guest ok = yes browseable = yes read only = yes write list = @adminGroup1 force user = root force group = root [printers] comment = All Printers path = /local/local1/spool/samba browseable = no guest ok = yes writable = no printable = yes ======================================= > > Also, are you running winbindd on the samba box? Yes, We are running winbind in the same box. > > I don't think this is a bug, but rather a misconfiguration > where the trusted user named Administrator is getting mapped > to a unix user by the same name.
in the future, please attach the logs and files as attachments and not inline. Thanks.
There no evidence here to support your claim. Please retest against 3.0.20 and provide real level 10 debug logs for smbd (not a mixture of smbd and winbindd) and a raw ethereal trace.