[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]

Re: Login slowdown [was: Problems with LILO and login]



On Sat, Mar 07, 1998 at 12:43:56PM -0500, Cristian Gafton wrote:
> I'd be interested in those results.

The figures was obtained by applying the attached patch.
For the test I used a system with shadow passwords, with attached pwdb.conf,
and with 5029 users last of which was x1999.
The system has the following packages installed:
	pwdb-0.54pre-D
	pam-0.63-1
	pamapps-su-0.56pre-D
	glibc-2.0.6-9
The test was performed for su.

Could you share your plans to increase the speed of pwdb with us?

Regards
					Andrey V.
					Savochkin
[pwdb/pwdb_start.c:pwdb_start(770), 889289125:606] called.
[pwdb/pwdb_start.c:pwdb_start(789), 889289125:607] reading conf file
[pwdb/pwdb_module.c:_pwdb_read_conf(314), 889289125:608] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:609] called.
[pwdb/pwdb_module.c:fill_buffer(171), 889289125:610] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:610] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:611] called.
[pwdb/pwdb_module.c:grow_buffer(134), 889289125:612] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:612] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:613] called.
[pwdb/pwdb_module.c:grow_list(148), 889289125:614] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:614] called.
[pwdb/pwdb_module.c:grow_list(148), 889289125:615] called.
[pwdb/pwdb_module.c:fill_buffer(171), 889289125:616] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:616] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:617] called.
[pwdb/pwdb_module.c:grow_buffer(134), 889289125:618] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:618] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:619] called.
[pwdb/pwdb_module.c:grow_list(148), 889289125:619] called.
[pwdb/pwdb_module.c:_pwdb_read_token(81), 889289125:620] called.
[pwdb/pwdb_module.c:grow_list(148), 889289125:621] called.
[pwdb/pwdb_module.c:_pwdb_read_conf(381), 889289125:621] seemed to work
[pwdb/pwdb_start.c:pwdb_start(813), 889289125:622] got(count=1): pwdb: task completed successfully
[pwdb/pwdb_start.c:pwdb_start(770), 889289125:638] called.
[pwdb/pwdb_start.c:pwdb_start(774), 889289125:639] opened 2
[posix/pwd.c:transcribe(31), 889289125:639] called.
[posix/pwd.c:transcribe(38), 889289125:640] locating x1999, -3
[pwdb/pwdb_locate.c:pwdb_locate(172), 889289125:641] called.
[pwdb/pwdb_locate.c:_pwdb_do(46), 889289125:641] called.
[pwdb/pwdb_locate.c:_pwdb_do(50), 889289125:642] called: user (nil) (nil) x1999 -3 0xbffffbf4 (nil)
[pwdb/pwdb_locate.c:_pwdb_do(65), 889289125:643] finding class[user] of database
[pwdb/pwdb_module.c:_pwdb_get_policy(282), 889289125:643] called.
[pwdb/pwdb_start.c:pwdb_cached(681), 889289125:644] called.
[pwdb/pwdb_locate.c:_pwdb_do(99), 889289125:645] class:user lp:0 fn:0 name:x1999 id:-3 p:0xbffffbf4 flag_p:(nil)
[pwdb/pwdb_module.c:_pwdb_dispatch(416), 889289125:646] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(417), 889289125:646] user,0,0,x1999,-3,0xbffffbf4,(nil)
[pwdb/pwdb_module.c:_pwdb_db_number(395), 889289125:647] called for class user
[pwdb/pwdb_module.c:_pwdb_dispatch(437), 889289125:648] calling LOCATE
[pwdb/interface/unix/user.c:_pwdb_unix_locate(27), 889289125:648] called.
[unix/passwd.c:__pwdb_getpwnam(224), 889289125:649] called for x1999
[unix/passwd.c:__pwdb_getpwnam(240), 889289127:604] finished
[pwdb/pwdb_start.c:pwdb_new(247), 889289127:604] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289127:605] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289127:606] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289127:606] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289127:607] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289127:608] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289127:609] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289127:609] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289127:610] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289127:611] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289127:611] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289127:612] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289127:613] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289127:613] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289127:614] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289127:615] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289127:615] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289127:616] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289127:617] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(478), 889289127:618] about to return 0 (pwdb: task completed successfully)
[pwdb/pwdb_locate.c:_pwdb_do(101), 889289127:618] -> 0 (pwdb: task completed successfully)
[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289127:619] pwdb *=0x804ca00
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289127:620] pwdb source type:
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289127:621] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289127:621] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289127:622] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289127:623] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289127:624] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289127:625] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_locate.c:_pwdb_do(99), 889289127:625] class:user lp:1 fn:0 name:x1999 id:-3 p:0xbffffbf4 flag_p:(nil)
[pwdb/pwdb_module.c:_pwdb_dispatch(416), 889289127:626] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(417), 889289127:627] user,1,0,x1999,-3,0xbffffbf4,(nil)
[pwdb/pwdb_module.c:_pwdb_db_number(395), 889289127:628] called for class user
[pwdb/pwdb_module.c:_pwdb_dispatch(437), 889289127:628] calling LOCATE
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289129:652] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:653] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:653] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289129:654] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:655] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:655] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289129:656] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:657] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:657] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289129:658] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:659] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:659] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289129:660] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:661] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:661] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289129:662] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:663] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:663] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289129:664] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:665] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:666] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289129:666] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:667] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:668] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289129:668] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:669] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:670] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(478), 889289129:670] about to return 0 (pwdb: task completed successfully)
[pwdb/pwdb_locate.c:_pwdb_do(101), 889289129:671] -> 0 (pwdb: task completed successfully)
[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289129:672] pwdb *=0x804ca00
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289129:672] pwdb source type:
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:673] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:674] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:675] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:676] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:676] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:677] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:678] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:679] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:680] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:680] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:681] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:682] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:683] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:684] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_locate.c:_pwdb_do(132), 889289129:684] p=0xbffffbf4[0x804ca00]

[pwdb/pwdb_locate.c:_pwdb_do(133), 889289129:685] (*p)->source=(nil)

[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289129:686] pwdb *=0x804ca00
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289129:687] pwdb source type:
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:687] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:688] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:689] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:690] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:691] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:691] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:692] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:693] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:694] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:695] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:695] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:696] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:697] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:698] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_start.c:pwdb_source(194), 889289129:699] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:699] called.
[pwdb/pwdb_locate.c:_pwdb_do(143), 889289129:700] pwdb_source -> pwdb: task completed successfully

[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289129:701] pwdb *=0x804ca00
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289129:701] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289129:702] returning unix
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289129:703] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289129:704] returning shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289129:704] pwdb source type: unix shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:705] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:706] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:707] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:707] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:708] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:709] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:710] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:711] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:712] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:712] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:713] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:714] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:715] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289129:716] 	 name=user                      length=  6 value=x1999
[posix/pwd.c:transcribe(47), 889289129:716] need to drop old?
[posix/pwd.c:transcribe(61), 889289129:717] getting entries
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289129:718] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:718] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:719] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289129:720] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:721] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:721] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289129:722] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:723] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:723] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289129:724] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:725] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289129:725] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:726] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289129:727] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:728] called.
[posix/pwd.c:transcribe(85), 889289129:728] identify remaining stuff
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289129:729] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:730] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:730] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289129:731] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:732] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289129:732] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:733] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:734] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289129:734] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:735] called.
[posix/pwd.c:transcribe(116), 889289129:736] copying
[pwdb/pwdb_start.c:pwdb_end(723), 889289129:736] called. (count=2)
[pwdb/pwdb_start.c:pwdb_start(770), 889289129:737] called.
[pwdb/pwdb_start.c:pwdb_start(774), 889289129:738] opened 2
[pwdb/pwdb_locate.c:pwdb_locate(172), 889289129:739] called.
[pwdb/pwdb_locate.c:_pwdb_do(46), 889289129:740] called.
[pwdb/pwdb_locate.c:_pwdb_do(50), 889289129:741] called: user (nil) (nil) x1999 -3 0xbffffbd4 (nil)
[pwdb/pwdb_locate.c:_pwdb_do(65), 889289129:741] finding class[user] of database
[pwdb/pwdb_module.c:_pwdb_get_policy(282), 889289129:742] called.
[pwdb/pwdb_start.c:pwdb_cached(681), 889289129:743] called.
[pwdb/pwdb_start.c:_strsame(569), 889289129:743] called.
[pwdb/pwdb_start.c:_strsame(569), 889289129:744] called.
[pwdb/pwdb_start.c:_pwdb_same_src(546), 889289129:745] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289129:746] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289129:746] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:747] called.
[posix/getlogin.c:pwdb_posix_getlogin(16), 889289129:790] called.
[posix/getlogin.c:pwdb_posix_getlogin(33), 889289129:791] terminal = (null)
[posix/getlogin.c:pwdb_posix_getlogin(16), 889289129:791] called.
[posix/getlogin.c:pwdb_posix_getlogin(33), 889289129:792] terminal = (null)
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289129:793] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:794] called.
[pwdb/pwdb_start.c:pwdb_delete(173), 889289129:794] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289129:795] called.
[pwdb/pwdb_start.c:_pwdb_delete(126), 889289129:796] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:796] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:797] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:798] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:798] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:799] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:800] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:801] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:801] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:802] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:803] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:803] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:804] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:805] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289129:805] called.
[pwdb/pwdb_start.c:pwdb_end(723), 889289129:806] called. (count=2)
[pwdb/pwdb_start.c:pwdb_start(770), 889289129:807] called.
[pwdb/pwdb_start.c:pwdb_start(774), 889289129:808] opened 2
[pwdb/pwdb_locate.c:pwdb_locate(172), 889289129:808] called.
[pwdb/pwdb_locate.c:_pwdb_do(46), 889289129:809] called.
[pwdb/pwdb_locate.c:_pwdb_do(50), 889289129:810] called: user (nil) (nil) x1999 -3 0xbffffc04 (nil)
[pwdb/pwdb_locate.c:_pwdb_do(65), 889289129:811] finding class[user] of database
[pwdb/pwdb_module.c:_pwdb_get_policy(282), 889289129:811] called.
[pwdb/pwdb_start.c:pwdb_cached(681), 889289129:812] called.
[pwdb/pwdb_locate.c:_pwdb_do(99), 889289129:813] class:user lp:0 fn:0 name:x1999 id:-3 p:0xbffffc04 flag_p:(nil)
[pwdb/pwdb_module.c:_pwdb_dispatch(416), 889289129:813] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(417), 889289129:814] user,0,0,x1999,-3,0xbffffc04,(nil)
[pwdb/pwdb_module.c:_pwdb_db_number(395), 889289129:815] called for class user
[pwdb/pwdb_module.c:_pwdb_dispatch(437), 889289129:816] calling LOCATE
[pwdb/interface/unix/user.c:_pwdb_unix_locate(27), 889289129:816] called.
[unix/passwd.c:__pwdb_getpwnam(224), 889289129:817] called for x1999
[unix/passwd.c:__pwdb_getpwnam(240), 889289131:775] finished
[pwdb/pwdb_start.c:pwdb_new(247), 889289131:776] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289131:777] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289131:777] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289131:778] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289131:779] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289131:779] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289131:780] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289131:781] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289131:781] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289131:782] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289131:783] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289131:784] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289131:784] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289131:785] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289131:786] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289131:786] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289131:787] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289131:788] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289131:788] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(478), 889289131:789] about to return 0 (pwdb: task completed successfully)
[pwdb/pwdb_locate.c:_pwdb_do(101), 889289131:790] -> 0 (pwdb: task completed successfully)
[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289131:791] pwdb *=0x804eb98
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289131:791] pwdb source type:
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289131:792] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289131:793] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289131:794] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289131:795] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289131:795] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289131:796] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_locate.c:_pwdb_do(99), 889289131:797] class:user lp:1 fn:0 name:x1999 id:-3 p:0xbffffc04 flag_p:(nil)
[pwdb/pwdb_module.c:_pwdb_dispatch(416), 889289131:798] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(417), 889289131:798] user,1,0,x1999,-3,0xbffffc04,(nil)
[pwdb/pwdb_module.c:_pwdb_db_number(395), 889289131:799] called for class user
[pwdb/pwdb_module.c:_pwdb_dispatch(437), 889289131:800] calling LOCATE
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289133:828] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:828] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:829] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289133:830] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:830] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:831] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289133:832] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:833] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:833] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289133:834] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:835] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:835] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289133:836] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:837] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:837] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289133:838] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:839] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:840] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289133:840] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:841] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:842] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289133:842] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:843] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:844] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289133:844] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:845] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:846] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(478), 889289133:847] about to return 0 (pwdb: task completed successfully)
[pwdb/pwdb_locate.c:_pwdb_do(101), 889289133:847] -> 0 (pwdb: task completed successfully)
[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289133:848] pwdb *=0x804eb98
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289133:849] pwdb source type:
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:850] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:850] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:851] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:852] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:853] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:854] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:854] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:855] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:856] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:857] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:858] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:859] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:859] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:860] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_locate.c:_pwdb_do(132), 889289133:861] p=0xbffffc04[0x804eb98]

[pwdb/pwdb_locate.c:_pwdb_do(133), 889289133:862] (*p)->source=(nil)

[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289133:862] pwdb *=0x804eb98
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289133:863] pwdb source type:
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:864] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:865] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:865] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:866] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:867] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:868] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:869] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:869] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:870] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:871] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:872] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:873] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:874] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:874] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_start.c:pwdb_source(194), 889289133:875] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:876] called.
[pwdb/pwdb_locate.c:_pwdb_do(143), 889289133:876] pwdb_source -> pwdb: task completed successfully

[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289133:877] pwdb *=0x804eb98
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289133:878] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289133:879] returning unix
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289133:879] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289133:880] returning shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289133:881] pwdb source type: unix shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:882] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:883] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:884] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:884] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:885] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:886] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:887] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:888] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:888] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:889] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:890] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:891] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:892] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289133:893] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289133:893] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:894] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:895] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289133:895] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:896] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289133:897] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:897] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:898] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289133:899] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:900] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289133:900] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:901] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:902] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289133:902] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:903] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289133:904] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:904] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:905] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289133:906] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:907] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289133:907] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289133:908] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:909] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289133:909] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:910] called.
[pwdb/pwdb_start.c:pwdb_delete(173), 889289133:911] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289133:911] called.
[pwdb/pwdb_start.c:_pwdb_delete(126), 889289133:912] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:913] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:913] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:914] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:915] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:916] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:916] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:917] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:918] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:918] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:919] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:920] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:920] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:921] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289133:922] called.
[pwdb/pwdb_start.c:pwdb_end(723), 889289133:923] called. (count=2)
[pwdb/pwdb_start.c:pwdb_start(770), 889289133:923] called.
[pwdb/pwdb_start.c:pwdb_start(774), 889289133:924] opened 2
[posix/getlogin.c:pwdb_posix_getlogin(16), 889289133:925] called.
[posix/getlogin.c:pwdb_posix_getlogin(33), 889289133:925] terminal = (null)
[pwdb/pwdb_start.c:pwdb_end(723), 889289133:931] called. (count=2)
[unix/passwd.c:__pwdb_getpwnam(224), 889289133:932] called for x1999
[unix/passwd.c:__pwdb_getpwnam(240), 889289135:899] finished
[pwdb/pwdb_start.c:pwdb_start(770), 889289135:901] called.
[pwdb/pwdb_start.c:pwdb_start(774), 889289135:902] opened 2
[posix/pwd.c:transcribe(31), 889289135:903] called.
[posix/pwd.c:transcribe(38), 889289135:903] locating x1999, -3
[pwdb/pwdb_locate.c:pwdb_locate(172), 889289135:904] called.
[pwdb/pwdb_locate.c:_pwdb_do(46), 889289135:905] called.
[pwdb/pwdb_locate.c:_pwdb_do(50), 889289135:905] called: user (nil) (nil) x1999 -3 0xbffffc54 (nil)
[pwdb/pwdb_locate.c:_pwdb_do(65), 889289135:906] finding class[user] of database
[pwdb/pwdb_module.c:_pwdb_get_policy(282), 889289135:907] called.
[pwdb/pwdb_start.c:pwdb_cached(681), 889289135:908] called.
[pwdb/pwdb_locate.c:_pwdb_do(99), 889289135:908] class:user lp:0 fn:0 name:x1999 id:-3 p:0xbffffc54 flag_p:(nil)
[pwdb/pwdb_module.c:_pwdb_dispatch(416), 889289135:909] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(417), 889289135:910] user,0,0,x1999,-3,0xbffffc54,(nil)
[pwdb/pwdb_module.c:_pwdb_db_number(395), 889289135:910] called for class user
[pwdb/pwdb_module.c:_pwdb_dispatch(437), 889289135:911] calling LOCATE
[pwdb/interface/unix/user.c:_pwdb_unix_locate(27), 889289135:912] called.
[unix/passwd.c:__pwdb_getpwnam(224), 889289135:912] called for x1999
[unix/passwd.c:__pwdb_getpwnam(240), 889289137:865] finished
[pwdb/pwdb_start.c:pwdb_new(247), 889289137:866] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289137:867] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289137:868] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289137:868] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289137:869] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289137:870] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289137:870] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289137:871] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289137:872] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289137:872] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289137:873] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289137:874] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289137:874] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289137:875] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289137:876] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289137:877] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289137:877] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289137:878] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289137:879] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(478), 889289137:879] about to return 0 (pwdb: task completed successfully)
[pwdb/pwdb_locate.c:_pwdb_do(101), 889289137:880] -> 0 (pwdb: task completed successfully)
[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289137:881] pwdb *=0x804e858
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289137:882] pwdb source type:
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289137:882] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289137:883] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289137:884] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289137:885] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289137:886] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289137:886] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_locate.c:_pwdb_do(99), 889289137:887] class:user lp:1 fn:0 name:x1999 id:-3 p:0xbffffc54 flag_p:(nil)
[pwdb/pwdb_module.c:_pwdb_dispatch(416), 889289137:888] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(417), 889289137:889] user,1,0,x1999,-3,0xbffffc54,(nil)
[pwdb/pwdb_module.c:_pwdb_db_number(395), 889289137:889] called for class user
[pwdb/pwdb_module.c:_pwdb_dispatch(437), 889289137:890] calling LOCATE
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289139:915] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:915] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:916] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289139:917] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:917] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:918] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289139:919] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:920] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:920] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289139:921] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:922] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:922] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289139:923] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:924] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:924] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289139:925] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:926] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:927] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289139:927] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:928] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:929] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289139:929] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:930] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:931] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289139:931] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:932] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:933] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(478), 889289139:933] about to return 0 (pwdb: task completed successfully)
[pwdb/pwdb_locate.c:_pwdb_do(101), 889289139:934] -> 0 (pwdb: task completed successfully)
[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289139:935] pwdb *=0x804e858
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289139:936] pwdb source type:
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:936] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:937] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:938] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:939] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:940] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:941] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:941] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:942] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:943] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:944] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:944] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:945] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:946] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:947] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_locate.c:_pwdb_do(132), 889289139:948] p=0xbffffc54[0x804e858]

[pwdb/pwdb_locate.c:_pwdb_do(133), 889289139:948] (*p)->source=(nil)

[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289139:949] pwdb *=0x804e858
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289139:950] pwdb source type:
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:951] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:951] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:952] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:953] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:954] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:955] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:955] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:956] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:957] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:958] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:959] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:959] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:960] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:961] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_start.c:pwdb_source(194), 889289139:962] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:963] called.
[pwdb/pwdb_locate.c:_pwdb_do(143), 889289139:963] pwdb_source -> pwdb: task completed successfully

[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289139:964] pwdb *=0x804e858
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289139:965] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289139:965] returning unix
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289139:966] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289139:967] returning shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289139:968] pwdb source type: unix shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:968] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:969] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:970] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:971] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:972] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:972] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:973] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:974] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:975] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:976] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:976] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:977] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:978] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289139:979] 	 name=user                      length=  6 value=x1999
[posix/pwd.c:transcribe(47), 889289139:980] need to drop old?
[posix/pwd.c:transcribe(49), 889289139:980] droping old pwd
[posix/pwd.c:transcribe(61), 889289139:981] getting entries
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289139:982] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:982] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:983] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289139:984] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:984] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:985] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289139:986] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:986] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:987] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289139:988] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289139:989] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289139:989] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289139:990] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289139:991] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289139:991] called.
[posix/pwd.c:transcribe(85), 889289139:992] identify remaining stuff
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289139:993] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:993] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:994] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289139:995] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289139:995] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289139:996] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289139:997] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289139:998] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289139:998] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289139:999] called.
[posix/pwd.c:transcribe(116), 889289139:1000] copying
[pwdb/pwdb_start.c:pwdb_end(723), 889289140:000] called. (count=2)
[pwdb/pwdb_locate.c:pwdb_locate(172), 889289140:001] called.
[pwdb/pwdb_locate.c:_pwdb_do(46), 889289140:002] called.
[pwdb/pwdb_locate.c:_pwdb_do(50), 889289140:003] called: user (nil) (nil) x1999 -3 0xbffffc94 (nil)
[pwdb/pwdb_locate.c:_pwdb_do(65), 889289140:003] finding class[user] of database
[pwdb/pwdb_module.c:_pwdb_get_policy(282), 889289140:004] called.
[pwdb/pwdb_start.c:pwdb_cached(681), 889289140:005] called.
[pwdb/pwdb_start.c:_strsame(569), 889289140:005] called.
[pwdb/pwdb_start.c:_strsame(569), 889289140:006] called.
[pwdb/pwdb_start.c:_pwdb_same_src(546), 889289140:007] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289140:007] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289140:008] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289140:009] called.
[pwdb/pwdb_locate.c:pwdb_request(211), 889289140:010] called.
[pwdb/pwdb_locate.c:_pwdb_do(46), 889289140:010] called.
[pwdb/pwdb_locate.c:_pwdb_do(50), 889289140:011] called: group (nil) 0x3 groupids -3 0xbffffc94 (nil)
[pwdb/pwdb_locate.c:_pwdb_do(65), 889289140:012] finding class[group] of database
[pwdb/pwdb_module.c:_pwdb_get_policy(282), 889289140:012] called.
[pwdb/pwdb_locate.c:_pwdb_do(99), 889289140:013] class:group lp:0 fn:3 name:groupids id:-3 p:0xbffffc94 flag_p:(nil)
[pwdb/pwdb_module.c:_pwdb_dispatch(416), 889289140:014] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(417), 889289140:014] group,0,3,groupids,-3,0xbffffc94,(nil)
[pwdb/pwdb_module.c:_pwdb_db_number(395), 889289140:015] called for class group
[pwdb/pwdb_module.c:_pwdb_dispatch(452), 889289140:016] calling REQUEST
[pwdb/interface/unix/group.c:_pwdb_unix_grequest(180), 889289140:016] called.
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289140:017] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289140:018] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289140:019] called.
[unix/group.c:__pwdb_setgrent(187), 889289140:019] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:020] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:021] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:022] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:024] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:025] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:026] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:028] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:029] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:029] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:031] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:032] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:033] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:035] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:035] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:036] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:038] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:039] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:040] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:042] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:043] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:043] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:045] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:046] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:047] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:049] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:049] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:050] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:052] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:053] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:054] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:056] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:056] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:057] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:059] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:060] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:061] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:063] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:063] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:064] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:066] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:067] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:068] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:070] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:070] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:071] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:073] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:074] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:075] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:077] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:077] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:078] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:080] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:081] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:082] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:084] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:084] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:085] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:087] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:088] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:089] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:091] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:091] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:092] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:094] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:095] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:096] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:098] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:098] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:099] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:101] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:102] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:102] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:105] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:105] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:106] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:108] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:109] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:110] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:112] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:112] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:113] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:115] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:116] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:116] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:119] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:119] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:120] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:122] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:123] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:123] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:126] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:126] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:127] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:129] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:130] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:130] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:133] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:133] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:134] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:136] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:137] called.
[unix/group.c:__pwdb_sgetgrent(47), 889289140:137] called.
[unix/group.c:__pwdb_getgrent(119), 889289140:140] called.
[unix/group.c:__pwdb_fgetgrent(81), 889289140:140] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289140:141] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:142] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289140:142] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289140:143] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289140:144] called.
[pwdb/pwdb_start.c:pwdb_set_entry(408), 889289140:144] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289140:145] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289140:146] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(478), 889289140:146] about to return 0 (pwdb: task completed successfully)
[pwdb/pwdb_locate.c:_pwdb_do(101), 889289140:147] -> 0 (pwdb: task completed successfully)
[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289140:148] pwdb *=0x804e858
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289140:148] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289140:149] returning unix
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289140:150] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289140:150] returning shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289140:151] pwdb source type: unix shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:152] 	 name=groupids                  length=  0 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:153] 	 name=groups                    length=  0 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:153] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:154] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:155] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:156] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:156] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:157] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:158] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:159] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:160] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:160] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:161] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:162] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:163] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:163] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_locate.c:_pwdb_do(99), 889289140:164] class:group lp:1 fn:3 name:groupids id:-3 p:0xbffffc94 flag_p:(nil)
[pwdb/pwdb_module.c:_pwdb_dispatch(416), 889289140:165] called.
[pwdb/pwdb_module.c:_pwdb_dispatch(417), 889289140:165] group,1,3,groupids,-3,0xbffffc94,(nil)
[pwdb/pwdb_module.c:_pwdb_db_number(395), 889289140:166] called for class group
[pwdb/pwdb_module.c:_pwdb_dispatch(452), 889289140:167] calling REQUEST
[pwdb/pwdb_module.c:_pwdb_dispatch(478), 889289140:168] about to return 6 (pwdb: requested item was not found)
[pwdb/pwdb_locate.c:_pwdb_do(101), 889289140:168] -> 6 (pwdb: requested item was not found)
[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289140:169] pwdb *=0x804e858
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289140:170] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289140:170] returning unix
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289140:171] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289140:172] returning shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289140:172] pwdb source type: unix shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:173] 	 name=groupids                  length=  0 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:174] 	 name=groups                    length=  0 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:175] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:175] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:176] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:177] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:178] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:178] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:179] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:180] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:181] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:182] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:182] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:183] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:184] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:185] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_locate.c:_pwdb_do(132), 889289140:185] p=0xbffffc94[0x804e858]

[pwdb/pwdb_locate.c:_pwdb_do(133), 889289140:186] (*p)->source=0x804f410

[pwdb/pwdb_error.c:debug_pwdb_struct(123), 889289140:187] pwdb *=0x804e858
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289140:187] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289140:188] returning unix
[pwdb/pwdb_module.c:pwdb_db_name(56), 889289140:189] called.
[pwdb/pwdb_module.c:pwdb_db_name(62), 889289140:189] returning shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(133), 889289140:190] pwdb source type: unix shadow
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:191] 	 name=groupids                  length=  0 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:191] 	 name=groups                    length=  0 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:192] 	 name=expire                    length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:193] 	 name=defer_change              length=  4 value=4294967295
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:194] 	 name=warn_change               length=  4 value=7
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:195] 	 name=max_change                length=  4 value=99999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:195] 	 name=min_change                length=  4 value=0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:196] 	 name=last_change               length=  4 value=10292
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:197] 	 name=defer_pass                length=  2 value=x
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:198] 	 name=passwd                    length= 14 value=XXXXXXXXXXXXX
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:200] 	 name=shell                     length= 10 value=/bin/bash
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:201] 	 name=dir                       length= 12 value=/home/x1999
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:201] 	 name=gecos                     length=  1 value=
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:202] 	 name=gid                       length=  4 value=100,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:203] 	 name=uid                       length=  4 value=3002,0
[pwdb/pwdb_error.c:debug_pwdb_struct(170), 889289140:204] 	 name=user                      length=  6 value=x1999
[pwdb/pwdb_start.c:pwdb_get_entry(329), 889289140:204] called.
[pwdb/pwdb_start.c:_pwdb_check(107), 889289140:205] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289140:206] called.
[pwdb/pwdb_start.c:pwdb_start(770), 889289140:207] called.
[pwdb/pwdb_start.c:pwdb_start(774), 889289140:207] opened 2
[pwdb/pwdb_start.c:pwdb_end(723), 889289140:208] called. (count=2)
[pwdb/pwdb_start.c:pwdb_end(723), 889289140:267] called. (count=1)
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289140:269] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:270] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289140:270] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:271] called.
[pwdb/pwdb_start.c:pwdb_delete(173), 889289140:272] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289140:272] called.
[pwdb/pwdb_start.c:_pwdb_delete(126), 889289140:273] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:274] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:274] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:275] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:276] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:276] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:277] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:278] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:280] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:280] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:281] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:282] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:282] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:283] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:284] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:284] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:285] called.
[pwdb/pwdb_module.c:_pwdb_delete_policy(294), 889289140:286] called.
[pwdb/pwdb_start.c:pwdb_end(723), 889289140:286] called. (count=0)
[pwdb/pwdb_start.c:pwdb_start(770), 889289140:378] called.
[pwdb/pwdb_start.c:pwdb_start(774), 889289140:379] opened 2
[pwdb/pwdb_start.c:pwdb_end(723), 889289140:380] called. (count=2)
[pwdb/pwdb_start.c:pwdb_start(770), 889289140:381] called.
[pwdb/pwdb_start.c:pwdb_start(774), 889289140:381] opened 2
[pwdb/pwdb_start.c:pwdb_end(723), 889289140:384] called. (count=2)
[pwdb/pwdb_start.c:pwdb_end(723), 889289140:441] called. (count=1)
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289140:441] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:442] called.
[pwdb/pwdb_start.c:pwdb_entry_delete(524), 889289140:443] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:443] called.
[pwdb/pwdb_start.c:pwdb_delete(173), 889289140:444] called.
[pwdb/pwdb_start.c:_pwdb_list_check(95), 889289140:445] called.
[pwdb/pwdb_start.c:_pwdb_delete(126), 889289140:445] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:446] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:447] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:447] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:448] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:449] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:449] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:450] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:451] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:451] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:452] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:453] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:454] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:454] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:455] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:456] called.
[pwdb/pwdb_start.c:_pwdb_drop_entry(73), 889289140:456] called.
[pwdb/pwdb_module.c:_pwdb_delete_policy(294), 889289140:457] called.
[pwdb/pwdb_start.c:pwdb_end(723), 889289140:458] called. (count=0)
#
# This is a sample pwdb file.
#

user:
	unix+shadow

group:
	unix+shadow

diff -ruN libpwdb-0.54preD/Makefile libpwdb-0.54preD.my/Makefile
--- libpwdb-0.54preD/Makefile	Sun Mar  8 13:21:42 1998
+++ libpwdb-0.54preD.my/Makefile	Sat Mar  7 15:33:36 1998
@@ -19,7 +19,7 @@
 include default.defs
 
 # For extra debugging information
-# EXTRAS += -DDEBUG
+EXTRAS += -DDEBUG
 EXTRAS += -D_GNU_SOURCE
 
 # ////////////////////////////////////////////////////
diff -ruN libpwdb-0.54preD/include/pwdb/_pwdb_macros.h libpwdb-0.54preD.my/include/pwdb/_pwdb_macros.h
--- libpwdb-0.54preD/include/pwdb/_pwdb_macros.h	Tue Dec  3 18:14:31 1996
+++ libpwdb-0.54preD.my/include/pwdb/_pwdb_macros.h	Sat Mar  7 15:36:33 1998
@@ -46,6 +46,7 @@
 #include <stdarg.h>
 #include <stdlib.h>
 #include <errno.h>
+#include <sys/time.h>
 
 /*
  * This is for debugging purposes ONLY. DO NOT use on live systems !!!
@@ -64,12 +65,15 @@
 {
     FILE *logfile;
     int must_close = 1;
+    struct timeval tv;
     
     if (!(logfile = fopen(_PWDB_LOGFILE,"a"))) {
         logfile = stderr;
         must_close = 0;
     }
-    fprintf(logfile,"[%s:%s(%d)] ",file, fn, line);
+    gettimeofday(&tv, NULL);
+    fprintf(logfile,"[%s:%s(%d), %ld:%03ld] ", file, fn, line,
+            tv.tv_sec, (tv.tv_usec+499)/1000);
     if (must_close) {
         fflush(logfile);
         fclose(logfile);
diff -ruN libpwdb-0.54preD/libpwdb/_pwdb_macros.h libpwdb-0.54preD.my/libpwdb/_pwdb_macros.h
--- libpwdb-0.54preD/libpwdb/_pwdb_macros.h	Tue Dec  3 18:14:31 1996
+++ libpwdb-0.54preD.my/libpwdb/_pwdb_macros.h	Sat Mar  7 15:36:33 1998
@@ -46,6 +46,7 @@
 #include <stdarg.h>
 #include <stdlib.h>
 #include <errno.h>
+#include <sys/time.h>
 
 /*
  * This is for debugging purposes ONLY. DO NOT use on live systems !!!
@@ -64,12 +65,15 @@
 {
     FILE *logfile;
     int must_close = 1;
+    struct timeval tv;
     
     if (!(logfile = fopen(_PWDB_LOGFILE,"a"))) {
         logfile = stderr;
         must_close = 0;
     }
-    fprintf(logfile,"[%s:%s(%d)] ",file, fn, line);
+    gettimeofday(&tv, NULL);
+    fprintf(logfile,"[%s:%s(%d), %ld:%03ld] ", file, fn, line,
+            tv.tv_sec, (tv.tv_usec+499)/1000);
     if (must_close) {
         fflush(logfile);
         fclose(logfile);
diff -ruN libpwdb-0.54preD/libpwdb/unix/passwd.c libpwdb-0.54preD.my/libpwdb/unix/passwd.c
--- libpwdb-0.54preD/libpwdb/unix/passwd.c	Wed Nov  6 06:22:20 1996
+++ libpwdb-0.54preD.my/libpwdb/unix/passwd.c	Sat Mar  7 16:58:27 1998
@@ -6,6 +6,7 @@
  */
 
 #include "../_pwdb_internal.h"
+#include "../_pwdb_macros.h"
 
 #define	NFIELDS	7
 
@@ -189,6 +190,7 @@
 {
     struct  __pwdb_passwd *pwd;
 
+    D(("called for %d", (int)uid));
     __pwdb_setpwent();
     if (! pwdfp)
         return 0;
@@ -203,6 +205,7 @@
     } while ( pwd || !passwd_file_end);
     
     __pwdb_endpwent();
+    D(("finished"));
     return pwd;
 }
 
@@ -218,6 +221,7 @@
 {
     struct __pwdb_passwd *pwd;
 
+    D(("called for %s", name));
     __pwdb_setpwent();
     if (! pwdfp)
         return NULL;
@@ -233,6 +237,7 @@
     } while ( pwd || !passwd_file_end );
 
     __pwdb_endpwent(); 
+    D(("finished"));
     return pwd;
 }
 

[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index] []