asterisk users - Jul 2008 - Problems w/Asterisk Realtime + MySQL + SIP

Hi all, Asterisk is great but I'm having issues with setting up
realtime for our call center, which is needed for login integration
with the rest of our applications (telephonists' web interface, etc.).

I have reviewed a large number of previous posts to the mailing list
and the voip-info wiki to no avail.

Setup is as follows:
 Linux 2.6.23 (gentoo) / AMD Athlon(tm) 64 Processor 3000+ / 2GB RAM
 Sangoma  A102 card + E1 (30 channels)
 Asterisk 1.4.17 (custom compile from source, not using gentoo package
or any patches)
 Wanpipe drivers 3.2.3.0
 Iaxmodem + libiax 2-0.2.3-SVN-20071223+

I have tried both kphone and zoiper (linux) clients.  On kphone the
interface's register result is 'bad password', on zoiper
registration
continues indefinitely but after the first request it is ignored by
asterisk due to being duplicate, after a time it fails silently.

The debug log:
[Jul 21 15:28:21] DEBUG[2028] chan_sip.c: = No match Their Call ID:
NDcxYjAyNTc4ZDQwZjZhMzM5OGE0MWYxYjg0YzZhZDk. Their Tag a9a71835 Our
tag: as0a26e7a5
[Jul 21 15:28:21] DEBUG[2028] chan_sip.c: Allocating new SIP dialog
for ZjFhZjZlNmZmZjM3OWFlYzE0MGYzZDYwYzJmODAwNDg. - REGISTER (No RTP)
[Jul 21 15:28:21] DEBUG[2028] chan_sip.c: **** Received REGISTER (2) -
Command in SIP REGISTER
[Jul 21 15:28:21] DEBUG[2028] chan_sip.c: = Found Their Call ID:
ZjFhZjZlNmZmZjM3OWFlYzE0MGYzZDYwYzJmODAwNDg. Their Tag f1b0df07 Our
tag: as25a61774
[Jul 21 15:28:21] DEBUG[2028] chan_sip.c: **** Received REGISTER (2) -
Command in SIP REGISTER
[Jul 21 15:28:21] DEBUG[2028] chan_sip.c: SIP message could not be
handled, bad request: ZjFhZjZlNmZmZjM3OWFlYzE0MGYzZDYwYzJmODAwNDg.

Console output:
*CLI> [Jul 21 15:40:47] DEBUG[2105]: chan_sip.c:4562 find_call: Found Their
Call ID: 1832465624 at 192.168.0.25 Their Tag  Our tag:
as60d9fbbb
[Jul 21 15:40:47] DEBUG[2105]: chan_sip.c:15154 handle_request: ****
Received REGISTER (2) - Command in SIP REGISTER
[Jul 21 15:40:47] NOTICE[2105]: chan_sip.c:15049
handle_request_register: Registration from '"walter"
<sip:walter at 192.168.0.2>' failed for '192.168.0.25' - Wrong
password
[Jul 21 15:40:47] DEBUG[2105]: chan_sip.c:15372 sipsock_read: SIP
message could not be handled, bad request: 1832465624 at 192.168.0.25

This error is different to the error that is received if a username
that is not in the MySQL sip_peers / sip_users table is specified.
Therefore at least the MySQL connection appears to be working.

extconfig.conf:
sipusers => mysql,asterisk_config
sippeers => mysql,asterisk_config

I have also tried explicitly adding ',sip_users' and
',sip_peers' to
these lines, but asterisk behaved similarly.

res_mysql.conf
dbhost = 127.0.0.1
dbname = asterisk_config
dbuser = asterisk
dbpass =<snip>
;dbport = 3306
dbsock = /tmp/mysql.sock

MySQL tables follow.  They are static right now for debugging
purposes, actually we will use views.  We will use md5 passwords, but
I have both in there right now for testing.

mysql> select * from sip_peers;
+--------+--------+--------+---------+----------+-------------+----------------------------------+----------+--------+
| user   | type   | secret | host    | context  | pickupgroup |
md5secret                        | username | name   |
+--------+--------+--------+---------+----------+-------------+----------------------------------+----------+--------+
| walter | friend | aaa    | dynamic | outgoing |           1 |
47bce5c74f589f4867dbd57e9ca9f808 | walter   | walter |
+--------+--------+--------+---------+----------+-------------+----------------------------------+----------+--------+
1 row in set (0.00 sec)

mysql> select * from sip_users;
+--------+--------+--------+---------+----------+-------------+----------------------------------+--------+----------+
| user   | type   | secret | host    | context  | pickupgroup |
md5secret                        | name   | username |
+--------+--------+--------+---------+----------+-------------+----------------------------------+--------+----------+
| walter | friend | aaa    | dynamic | outgoing |           1 |
47bce5c74f589f4867dbd57e9ca9f808 | walter | walter   |
+--------+--------+--------+---------+----------+-------------+----------------------------------+--------+----------+
1 row in set (0.00 sec)

Thanks for any help you can offer.

Regards,
Walter Stanish
Owner / Director
Occident Systems
(+86 15808 700 801)

On Mon, Jul 21, 2008 at 9:11 AM, Walter Stanish
<walter at occidentsystems.com> wrote:
> [Jul 21 15:28:21] DEBUG[2028] chan_sip.c: **** Received REGISTER (2) -
> Command in SIP REGISTER
> [Jul 21 15:28:21] DEBUG[2028] chan_sip.c: SIP message could not be
> handled, bad request: ZjFhZjZlNmZmZjM3OWFlYzE0MGYzZDYwYzJmODAwNDg.
>
Hi Walter.

It looks like Asterisk is unhappy with the SIP REGISTER request coming
from your softphone for some reason. It's very strange that it's
occurring for two different softphones though.

Trun on SIP debugging by typing "sip debug" on your Asterisk console
and then post up the 4 SIP messages invloved in the register
transaction so we can take a look and spot why it could be getting
rejected.

Regards,

Greyman.