help appreciated for radium+sasl configuration

Wed Aug 14 03:23:44 EDT 2013

Hi,

I'm trying to configure radium to deliver realtime data via encrypted
connection (argus > radium > client). Client keeps complaining:
RaSaslNegotiate: error starting SASL negotiation SASL(-4): no mechanism
available: No worthy mechs found. Radium log says "SASL path: 4▒L" and
seems to send an empty list of authentication methods. Any debugging tips
would be welcome.

I have followed the installation howto on wiki. Configuration and debug
logs below.

packages (64bit CentOS 5.9):
argus-clients 3.0.7.12
cyrus-sasl-2.1.22-7.el5_8.1.x86_64
cyrus-sasl-2.1.22-7.el5_8.1.i386
cyrus-sasl-devel-2.1.22-7.el5_8.1.x86_64
cyrus-sasl-devel-2.1.22-7.el5_8.1.i386
cyrus-sasl-md5-2.1.22-7.el5_8.1.x86_64
cyrus-sasl-md5-2.1.22-7.el5_8.1.i386

Radium config:
RADIUM_MONITOR_ID=16001
RADIUM_MAR_STATUS_INTERVAL=300
RADIUM_ARGUS_SERVER="argus-tcp://localhost:561"
RADIUM_ACCESS_PORT=571
RADIUM_MIN_SSF=40
RADIUM_MAX_SSF=128

Ra config:
RA_MIN_SSF=0
RA_MAX_SSF=128
RA_USER_AUTH="local/local"
RA_AUTH_PASS="secret"

User was created with: (I also tried using argus instead of radium)
saslpasswd2 -c -a radium local

There are files /etc/sasl2/radium.conf and /etc/sasl2/argus.conf with
identical contents:
pwcheck_method: auxprop
auxprop_plugin: sasldb
mech_list: DIGEST-MD5

# bin/radium -f /etc/radium-test.conf -D 3
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44 ArgusAddHostList
(0x86bb2010, argus-tcp://localhost:561, 1, 6) returning 1
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44
RadiumParseResourceFile: RadiumMinSsf "40"
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44
RadiumParseResourceFile: RadiumMaxSsf "128"
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44 RadiumParseResourceFile
(/etc/radium-test.conf) returning 0
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44
ArgusEstablishListen(0x86bb2010, 571, null) binding: any:571
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44
ArgusEstablishListen(0x86bb2010, 571, null) returning 3
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44 ArgusNewOutput()
returning retn 0x1e7f1220
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44 SASL path 4▒L
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44 ArgusInitOutput() done
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44 main: reading files
completed
radium[27083.1016bb86dd2a0000]: 2013-08-14T10:05:44
ArgusReadStream(0x2add86bb2010) starting
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44
ArgusConnectRemote(0x2add86eef010) starting
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44 Trying 127.0.0.1 port
561 Expecting Argus records
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44 connected
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44 ArgusGetServerSocket
(0x2add86eef010) returning 4
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44 ArgusReadConnection()
read 16 bytes
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44 ArgusInitAddrtoname
(0x2add86bb2010, 0x1000064, 0xfffffffc)
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44
ArgusParseInit(0x2add86bb2010 0x2add86eef010
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44
ArgusWriteConnection(0x86eef010, 0x88d12f10, 7) returning 7
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44
ArgusReadConnection(0x86eef010, 2) returning 1
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44
ArgusConnectRemote(0x2add86eef010) connected to 127.0.0.1
radium[27083.4039d588dd2a0000]: 2013-08-14T10:05:44 ArgusConnectRemote()
done!
radium[27083.40199587dd2a0000]: 2013-08-14T10:06:27 ArgusOutputProcess()
select returned with tasks

Client connecting:

radium[27083]: 2013-08-14T10:06:27 connect from localhost
radium[27083.40199587dd2a0000]: 2013-08-14T10:06:27 ArgusCheckClientStatus:
SASL enabled
radium[27083.40199587dd2a0000]: 2013-08-14T10:06:27
ArgusSendSaslString(0x1e878990, 0x1e87d890, 2) {}
radium[27083.40199587dd2a0000]: 2013-08-14T10:06:27
ArgusGetSaslString(0x1e87d8b0, 0x8794e250, 512) N:
radium[27083.40199587dd2a0000]: 2013-08-14T10:06:27
ArgusAuthenticateClient: Error ArgusGetSaslString returned -1
radium[27083.40199587dd2a0000]: 2013-08-14T10:06:27 ArgusOutputProcess()
select returned with tasks
radium[27083.40199587dd2a0000]: 2013-08-14T10:06:27 ArgusCheckClientMessage
(0x1e87bba0, 6) recv() returned error Illegal seek
radium[27083.40199587dd2a0000]: 2013-08-14T10:06:27 ArgusDeleteList
(0x1e87bca0, 4) returning
radium[27083.40199587dd2a0000]: 2013-08-14T10:06:32
ArgusCheckClientMessage: client localhost removed

Client log:
# bin/ra -S localhost:571 -F ~/.ra.sasl  -D 9
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 main: reading files
completed
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusCalloc (1, 72)
returning 0xb47bc70
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusNewQueue () returning
0xb47bc70
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 Trying 127.0.0.1 port 571
Expecting Argus records
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 connected
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusGetServerSocket
(0x2b9a8cb4f010) returning 3
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusReadConnection() read
16 bytes
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusCalloc (1, 4194304)
returning 0x8cbb1010
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusCalloc (1, 262144)
returning 0x8cfb2010
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusCalloc (1, 4194304)
returning 0x8cff3010
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusInitAddrtoname
(0x2b9a8c894010, 0x0, 0x0)
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27
ArgusParseInit(0x2b9a8c894010 0x2b9a8cb4f010
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27
ArgusInitializeAuthentication () returning 1
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 RaSaslNegotiate(0x3, 0x3,
0xb501390) receiving capability list...
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 RaGetSaslString(0x3,
0xbe7ee4c0, 8184) {}
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 RaSaslNegotiate(0x3, 0x3,
0xb501390) calling sasl_client_start()
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 RaSendSaslString(3, 0x0, 0)
(null)
ra[27095]: 2013-08-14T10:06:27 RaSaslNegotiate: error starting SASL
negotiation SASL(-4): no mechanism available: No worthy mechs found
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusShutDown (-1)
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusFree (0xb47a190)
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusDeleteQueue
(0xb47a190) returning
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusFree (0xb47a1e0)
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusDeleteQueue
(0xb47a1e0) returning
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 ArgusWindowClose ()
returning
ra[27095.a02a898c9a2b0000]: 2013-08-14T10:06:27 RaParseComplete(caught
signal -1)
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://pairlist1.pair.net/pipermail/argus/attachments/20130814/2a0fe1a3/attachment.html>