Ok, there were several problems with the previous setup -
first of of all, I needed to setup MOH_601 with service-type = treatment.
I did not do it, so it would not even try to use SM.
Of course, now, I am stuck with 404 Error in SM: There is an INVITE when I issue RequestHOLD, but SM logs show that SM returns 404 - not found.
I think the reasons are:
1. unspecified codec
2. cannot find file
[hr]
Application name: StreamManager
Application type: VoIPStreamManager (78)
Command line: sm.exe -service VoIPSM -app StreamManager -host alegria_test -port 2020 -sstart
Host name: alegria_test
DST: TZ = 0, timeb = 0
Time zone: -32400, (W), (W)
UTC time: 2006-12-12T12:04:04.218
Local time: 2006-12-12T21:04:04.218
Start time (UTC): 2006-12-12T12:04:04
Running time: 0:00:00:00
Host info: Windows 5.2.3790, 2, Service Pack 1, 1.0, 0110, 3
File: (1) logs/sm.20061212_210404_204.log
21:04:04.218 Trc 04112 The Log Output of type 'logs/sm' has been created and opened
21:04:04.218 Std 04503 Connected to ConfigServer at alegria_test:2020 (appName=StreamManager)
@21:04:04.2180 [TCONF] Debug: Main Tenant received: DBID [101], name [HappyTenant]
21:04:04.218 Std 05060 StreamManager started
@21:04:04.2180 [TCONF] Debug: Registering CfgSwitch tenant=101
@21:04:04.2180 [TCONF] Debug: Registering CfgDN tenant=101
@21:04:04.2180 [TCONF] Debug: Registering CfgApplication tenant=101
@21:04:04.2180 [TCONF] Debug: Registering CfgHost tenant=0
@21:04:04.2180 [TCONF] Debug: Registering CfgTenant tenant=0
Stream Manager 7.2.002.02 Compiled: May 31 2006 01:17:27
Genesys Telecommunications Laboratories, Inc., Copyright 1991 - 2006
----------------------------
Build with: TCONF 7.2.005.03
Genesys CommonLib 7.2.000.03
confserv library 7.2.000.03
gservice library 7.2.000.03
Genesys SIP lib = 7.2.000.12
x-config list
options list <+>
@location = NULL <D>
rtp-port = 8000
max-ports = 2000
call list
call-address = '$HOST'
call-protocol = sm
rtcp-inactivity-timeout = '30 sec'
max-record-time = '5 min' <+>
max-record-silence = '0'
max-record-file-size = 0
rtp-ip-precedence = 0
rtp-stream-delay = 60
log-trace-flags = 0x1000022 = -ping -rtp/16th -rtp/nte -rtp/dump +rtcp +xconf +cfgserv <+>
x-type = sm
audio-file-format = wav
file-cache-size = 10240
max-mixer-delay = '0.060 sec' <+>
sip-port = 5061 <+>
sip-annc-codecs = 'g723,g729,gsm,pcmu,pcma'
sip-conf-codecs = 'gsm,pcmu,pcma'
sip-http-codecs = 'pcmu'
sip-http-delay = '0.120 sec' <+>
sip-h261-fmtp = NULL
sip-h263-fmtp = NULL
sip-record-all-conf = false
sip-record-base-name = 'recording/call'
sip-record-codec = 'pcmu'
sip-send-info = auto
packet-size = 'g723=1,g729=2,gsm=2'
remote-server-%d array
DN array
StreamManager work mode: regular
RTP-stream-delay set to 60 msec
RTP-regular-timeout set to 30000 (30 sec)
RTP-record-timeout set to 30000 (30 sec)
RTP port range 8000..9999
Connecting to LCA at port 4999...
Open LCALayer on port=4999
LCA Library version 7.1.100.00
gsip:STACKSIMPLE:INIT:SIP Listener TCP on port 5061 ...
(conn_adjust_rlimit) set_sbh_threshold(1016):1
CGCL2Listener[232]: Port 5061 opened for listening, protocol TCP
gsip:STACKSIMPLE:INIT:SIP Listener UDP on port 5061 ...
CGCL2Listener[244]: Port 5061 opened for listening, protocol UDP
gsip:STACKSIMPLE:INIT:BASE ...
gsip:STACKBASE:INIT:Transaction Manager ...
gsip:STACKBASE:INIT:Message Factory ...
gsip:STACKBASE:INIT:OK
SIP Stack initialized (port=5061)
sip-annc-codecs = ("g723","g729","gsm","pcmu","pcma")
sip-conf-codecs = ("gsm","pcmu","pcma")
sip-http-codecs = ("pcmu")
RTPLeg[3141593] created RTP:8000(fd=252), RTCP:8001(fd=260)
21:04:04.234 Trc 04541 Registered received from 176 (CfgServer)
21:04:04.234 Trc 04541 Registered received from 176 (CfgServer)
21:04:04.234 Trc 04541 Registered received from 176 (CfgServer)
21:04:04.234 Trc 04541 Registered received from 176 (CfgServer)
21:04:04.234 Trc 04541 Registered received from 176 (CfgServer)
************************************
LCALayer: REventRegistered on LCA...
************************************
Testing scheduler granularity:
pgtime=404864264(+0) delta=2
pgtime=404864266(+0) delta=2
pgtime=404864268(+0) delta=2
pgtime=404864270(+0) delta=2
pgtime=404864272(+0) delta=2
pgtime=404864274(+0) delta=2
pgtime=404864276(+0) delta=2
RTPtimeWheel tick = 2 msec (60 slots) clock = 404864276
RTPleg[3141593]:8000/8001 completed (remote 0.0.0.0:0)
RX=0/0+0(err=0) rtcp=0(err=0) ssrc[0] jitter=0(max=0)
TX=0/0+0(err=0) rtcp=0(err=0)
21:04:04.281 Std 05061 Initialization completed
GKconnDMX(DMX_Dualmode)::configure(alegria_test:0)
@21:04:04.2810 [TCONF] Debug: Remote Server found: remote-server-%d array <+>
DMX_Dualmode [115] list {aux} <+>
app-type = DMX <+>
hostname = 'alegria_test' <+>
TServer list <D>
x-config list <D>
@21:04:04.2810 [TCONF] Debug: Configuration is fully initialized
21:05:09.156 Trc 04541 Message ObjectInfoChanged received from 176 (CfgServer '')
Object dump => CfgDeltaApplication={deltaApplication={DBID=117,name=NIL,password=NIL,type=0,version=NIL,appServerDBIDs=NIL,tenantDBIDs=NIL,isServer=0,serverInfo={hostDBID=0,port=NIL,backupServerDBID=0,timeout=0,attempts=0},options=NIL,state=0,userProperties=NIL,appPrototypeDBID=0,flexibleProperties=NIL,workDirectory=NIL,commandLine=NIL,autoRestart=0,startupTimeout=0,shutdownTimeout=0,redundancyType=0,isPrimary=0,startupType=0,commandLineArguments=NIL},deletedAppServerDBIDs=NIL,deletedTenantDBIDs=NIL,deletedOptions=NIL,changedOptions=(x-config=(audio-file-format='.wav')),deletedUserProperties=NIL,changedUserProperties=NIL,deletedFlexibleProperties=NIL,changedFlexibleProperties=NIL,changedAppServerDBIDs=NIL}
@21:05:09.1710 [TCONF] Debug: Main application changed: DBID [117], name [StreamManager]
21:05:09.187 Std 04106 Log Messages file 'C:\Program Files\GCTI\SM\sm.lms' successfully loaded
Network output disabled, cluster undefined
@21:05:09.1870 [TCONF] Error: Configuration option x-config/options/audio-file-format has wrong value '.wav'
gsip:CL2LIST[244,UDP]:21:06:11.609 <<<< 484 bytes from 172.30.0.222:5060 <<<<
INVITE sip:MOH_600@172.30.0.222:5061 SIP/2.0
From: "ALEGRIA-6002"<sip:6002@172.30.0.222>;tag=3b64843d
To: <sip:MOH_600@172.30.0.222:5060>
Call-ID: 29AF4546-C3FC-4C30-9A91-AF82B0F1CDED-508@172.30.0.222
CSeq: 1 INVITE
Content-Length: 0
Via: SIP/2.0/UDP 172.30.0.222:5060;branch=z9hG4bKF7ED18EE-BA12-4D78-8D50-DAF6B93AF672-559
Contact: <sip:172.30.0.222:5060>
Alert-Info: Ring Answer
Max-Forwards: 70
Session-Expires: 1800;refresher=uac
Min-SE: 90
Supported: 100rel,timer
gsip:DLG[1]: INVITE TD = TRN[1]
gsip:STACKBASE:Transport allocated for 172.30.0.222:5060
CGCL2Connector[260]: Connection with 172.30.0.222(172.30.0.222) established
SM_PhoneDialog[1] event 12 INVITE
21:06:11.6090 ---- GKconnSIP[1x]::IncomingDLG(MOH_600) rejected 404
gsip:CL2CONN[260,UDP]:21:06:11.609 >>>> 375 bytes to 172.30.0.222:5060 >>>>
[b][color=red]SIP/2.0 404 Not Found
[/color][/b]
From: "ALEGRIA-6002"<sip:6002@172.30.0.222>;tag=3b64843d
To: <sip:MOH_600@172.30.0.222:5060>;tag=8AE7C353-A5FF-4D19-A20D-67049EE8064C-1
Call-ID: 29AF4546-C3FC-4C30-9A91-AF82B0F1CDED-508@172.30.0.222
CSeq: 1 INVITE
Via: SIP/2.0/UDP 172.30.0.222:5060;branch=z9hG4bKF7ED18EE-BA12-4D78-8D50-DAF6B93AF672-559;received=172.30.0.222
Content-Length: 0
SM_PhoneDialog[1] event 15 CALLED/ResREJECT
SM_PhoneDialog[1] event 58 DESTROY