Авторегистрация карточных пользователей

[Leonid A. Kazakov]

FreeBSD 5.4
UTM 5.1.010-011

Не происходит авторегистрация карточных пользователей.

Создан пул карточек.
К карточкам привязан тарифный план, содержащий услугу диалап.

radius5.cfg

core_host=127.0.0.1
core_port=11758
radius_acct_host=0.0.0.0
radius_auth_host=0.0.0.0
radius_acct_port=1646
radius_auth_port=1645

radius_card_autoadd=enable

radius_auth_mppe=enable
log_file_main=/netup/utm5/log/radius_main.log
log_file_debug=/netup/utm5/log/radius_main_debug.log
radius_auth_null=enable

в логи пишет следующее:

?Debug : Aug 31 15:59:31 RADIUS Auth: User <1202> connecting
ERROR : Aug 31 15:59:31 RADIUS DBA: NAS found. Data size <0>
ERROR : Aug 31 15:59:31 RADIUS DBA: Can't find login <1202>
ERROR : Aug 31 15:59:31 RADIUS DBA: Can't find card login <000001202>
?Debug : Aug 31 15:59:31 RADIUS Auth: Attempt to add new Card user: <1202>
?Debug : Aug 31 15:59:31 RADIUS DBA: Sending Auto-Add Request for Card-ID: 1202
?Debug : Aug 31 15:59:31 RADIUS Auth: Got AutoAdd -13 UID from core.
ERROR : Aug 31 15:59:31 RADIUS Auth: No data for User <1202> found.

карточка с номером 1202 существует точно. Может кто-нибудь сталкивался с этими проблемами? В какую сторону смотреть?

[aospan]

Судя по приведеннымлогам, а именно по строке "?Debug : Aug 31 15:59:31 RADIUS Auth: Got AutoAdd -13 UID from core. " у вас не прошла регистрация карты в ядре. Необходимо переслать логи ядра в этот момент.
Так же проверьте, может у вас на карту не привязан тарифный план с услугой диал-ап ?

[Leonid A. Kazakov]

Спасибо за оперативный ответ

вот логи радиуса:

?Debug : Sep 01 09:51:58 RADIUS Auth: Packet from <PRINETServer>
?Debug : Sep 01 09:51:58 RADIUS Auth: User <1202> connecting
ERROR : Sep 01 09:51:58 RADIUS DBA: NAS found. Data size <0>
ERROR : Sep 01 09:51:58 RADIUS DBA: NAS found. Data size <0>
ERROR : Sep 01 09:51:58 RADIUS DBA: Can't find login <1202>
ERROR : Sep 01 09:51:58 RADIUS DBA: Can't find login <1202>
ERROR : Sep 01 09:51:58 RADIUS DBA: Can't find card login <000001202>
ERROR : Sep 01 09:51:58 RADIUS DBA: Can't find card login <000001202>
?Debug : Sep 01 09:51:58 RADIUS Auth: Attempt to add new Card user: <1202>
?Debug : Sep 01 09:51:58 RADIUS DBA: Sending Auto-Add Request for Card-ID: 1202
?Debug : Sep 01 09:51:58 RADIUS Auth: Got AutoAdd -13 UID from core.
ERROR : Sep 01 09:51:58 RADIUS Auth: No data for User <1202> found.
ERROR : Sep 01 09:51:58 RADIUS Auth: No data for User <1202> found.

А вот, что говорит в это время ядро:

?Debug : Sep 01 09:51:58 DBA:Ctx: Looking for free context
?Debug : Sep 01 09:51:58 DBCtx: SQL SELECT query: SELECT id,pool_id,secret,balance,currency,expiration,days,is_used,service_id,is_blocked FROM card_info WHERE secret='120208525816'
?Debug : Sep 01 09:51:58 DBCtx: SQL SELECT query: SELECT value FROM utm5_settinings WHERE variable='card_user_prefix'
?Debug : Sep 01 09:51:58 DBCtx: SQL SELECT query: SELECT id,pool_id,secret,balance,currency,expiration,days,is_used,service_id,is_blocked FROM card_info WHERE id='1202'
?Debug : Sep 01 09:51:58 UTM5 DBA: info.secret:<09608605> password:<08525816>
ERROR : Sep 01 09:51:58 DBAGlukError: Bad password for card
?Debug : Sep 01 09:51:58 DBA:Ctx: Pushing back free context

я начинаю понимать, что неверный пароль... но!!!

select * from `UTM5`.`card_info` where pool_id=3;
выдает:
1202\3\09608605\50\810\1133298000\0\1\0\0\
1203\3\08525816\50\810\1133298000\0\1\0\0\
т.е. пароль 08525816 - это пароль для карточки 1203 , а не для 1202.
чудеса? или я чего-то не понимаю???

[Leonid A. Kazakov]

Прошу меня извинить... я полный идиот!!! конечно чудес не бывает... действительно пользователем вводится пароль от другой тестовой карточки!
Еще раз извините за беспокойство