issues with sipper media and "broken pipe"
denodaeus
get the below. The behavior is that this process stays up and gets
"hung", and when the next sipper test script starts, it just sit there
and spins until the previous sippermedia process is manually killed.
I'm trying execute an answer script that isn't really using the media
portion, just answering and hanging up (the first script is dialing
into an ACD type device and dialing some DTMF digits to "opt out"):
Also, below is my sipper.cfg file. Note, I've tried toggling the
sipper media process reuse option, and having it "on" seems to make it
behave better but it's not consistent. I've also tried building this
from source (I'm on 64 bit Ubuntu, built with gxx 4.3), and still have
pretty much the same issues. Is there any non-console advanced sipper
media logging I can turn on, or just something I can do to figure out
why this process is hanging? I know that I'm terminating the call
script on success simply because it sometimes works, and it sometimes
doesn't (and the times it does, the call flow is a complete success).
Thanks for your help.
[junit] ALW 0 -2088548080 15:6:9-367 SipperMediaController
SipperMediaController.cpp-364 Processing Msg Len[49] Command
[COMMAND=SET STATUS;MEDIAID=1;MEDIASTATUS=SENDRECV]
[junit]
[junit] ALW 0 -2088548080 15:6:9-367 SipperMediaController
SipperMediaController.cpp-372 Result Len[55] Command
[TYPE=Result;MEDIAID=1;COMMAND=SET STATUS;RESULT=Success]
[junit]
[junit] TRC 0 -2088548080 15:6:9-367 SipperMediaCodec
SipperMediaCodec.cpp-387 End of duration[1263845169-367586] [0-0].
[junit]
[junit] TRC 0 -2088548080 15:6:9-367 SipperMediaCodec
SipperMediaCodec.cpp-233 Processing command [PLAY_REPEAT 0 0].
[junit]
[junit] ALW 0 -2088548080 15:6:9-469 SipperMediaController
SipperMediaController.cpp-617 Event Len[47] Event
[TYPE=EVENT;MEDIAID=1;CODEC=0;EVENT=AUDIOSTARTED]
[junit]
[junit] ALW 0 -2088548080 15:6:9-824 SipperMediaController
SipperMediaController.cpp-617 Event Len[58] Event
[TYPE=EVENT;MEDIAID=1;CODEC=0;EVENT=VOICE_ACTIVITY_DETECTED]
[junit] /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/bin/../
sipper_test/../sipper/media/sipper_media_manager.rb:119:in `write':
Broken pipe (Errno::EPIPE)
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/media/sipper_media_manager.rb:119:in `<<'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/media/sipper_media_manager.rb:119:in
`send_command'
[junit] from /usr/local/lib/ruby/1.8/monitor.rb:242:in
`synchronize'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/media/sipper_media_manager.rb:117:in
`send_command'
[junit] from /usr/local/lib/ruby/1.8/monitor.rb:242:in
`synchronize'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/media/sipper_media_manager.rb:116:in
`send_command'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/media/sipper_media_client.rb:147:in
`_send_command'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/media/sipper_media_client.rb:100:in
`destroy_media'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/media/sipper_offer_answer.rb:29:in
`close'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/media/sipper_offer_answer.rb:27:in `each'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/media/sipper_offer_answer.rb:27:in
`close'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/session.rb:1624:in `invalidate'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/session.rb:1465:in `_on_timer'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/session.rb:986:in `on_message'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/session.rb:970:in `loop'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/session.rb:970:in `on_message'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/session.rb:1334:in `on_timer_expiration'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/util/timer/timer_task.rb:42:in `invoke'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sip_message_router.rb:212:in `start'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sip_message_router.rb:45:in `times'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sip_message_router.rb:45:in `start'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sip_message_router.rb:38:in `initialize'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sip_message_router.rb:38:in `new'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sip_message_router.rb:38:in `start'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sip_message_router.rb:36:in `upto'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sip_message_router.rb:36:in `start'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sipper.rb:268:in `start'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sipper.rb:262:in `initialize'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sipper.rb:262:in `new'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/../sipper/sipper.rb:262:in `start'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/sip_test_case.rb:34:in `setup_once'
[junit] from /usr/local/lib/ruby/gems/1.8/gems/Sipper-2.0.0/
bin/../sipper_test/sip_test_case.rb:20:in `setup'
[junit] from ./../act_test_case.rb:6:in `setup'
And here's my sipper.cfg file:
# :LocalSipperIP: the ip address of the server the tests are running
on
#:LocalSipperIP: 10.0.3.28
#:LocalSipperIP: 10.0.4.91
#:LocalSipperIP: 192.168.0.4
:LocalSipperIP: 10.0.3.78
# :DefaultRIP: the ip address of the sip registrar
#:DefaultRIP: sip-act-mhdap10.vocalocity.com
:DefaultRIP: sip-act-mhdap8.vocalocity.com
:ConfigPath: ../../config/
#:SipperMedia: false
:SipperMedia: true
:PrintHeapOnExit: false
:GobletRelease: false
:TcpRequestTimeout: 32000
:CommandlineBitmask: 0
:T2xxUsage: false
:ProtocolCompliance: strict
:CallRate: 5
:SipperMediaDefaultControlPort: 54680
:TransactionTimers: {}
:SipperRealm: sipper.com
:TimerGranularity: 70
:WaitSecondsForTestCompletion: 180
:ControllerPath: ../../controllers/
:SipperMediaProcessReuse: false
:SessionTxnUsage:
:use_transactions: false
:SipperHttpServer: false
:TargetRefreshMethods:
- INVITE
- SUBSCRIBE
- UPDATE
- NOTIFY
- REFER
:TestManagerName:
:NumCalls: 1
:DialogCreatingMethods:
- INVITE
- SUBSCRIBE
- NOTIFY
- REFER
:TestManagerPort:
:HttpClientThreads: 5
:SessionTimer: 60000
:LogPath: ../../logs/
:SupportedOptionTags:
- 100rel
- path
:EnableRecordingLock: false
:RunLoad: false
:ShowSessionIdInMessages: true
:SessionLimit: 60000