#320: preiodical faad failure when polling aac stream with input.http
----------------------------+-----------------------------------------------
  Reporter:  romeodeepmind  |       Owner:  admin      
      Type:  Bugs           |      Status:  new        
  Priority:  1              |   Milestone:  NEAR FUTURE
 Component:  Liquidsoap     |     Version:  0.9.1+svn  
Resolution:                 |    Keywords:             
       Mac:  1              |       Linux:  1          
    Netbsd:  1              |       Other:  1          
   Freebsd:  1              |  
----------------------------+-----------------------------------------------

Comment(by romeodeepmind):

 i make this test. all scripts was started at the same time. script with
 harbor input showed stable behavour while runtime, but segfault when
 shutting down.

 script with http input failed several times while runtime (this leads to
 sound glitches)

 both scripts showed bad sound quality. i guess this is faad related
 problem.

 harbor input script log
 {{{
 2009/10/23 17:29:37 >>> LOG START
 2009/10/23 17:29:36 [protocols.external:3] Didn't find "ufetch"
 2009/10/23 17:29:36 [protocols.external:3] Found "/usr/bin/wget"
 2009/10/23 17:29:37 [main:3] Liquidsoap 0.9.1+svn
 (trunk/liquids...@rev6849)
 2009/10/23 17:29:37 [lang:3] flac binary not found: flac decoder disabled.
 2009/10/23 17:29:37 [lang:3] metaflac binary not found: flac metadata
 resolver disabled.
 2009/10/23 17:29:37 [harbor:3] Adding mountpoint '/rvk' to list...
 2009/10/23 17:29:37 [video.converter:4] Couldn't find prefered video
 converter: gavl
 2009/10/23 17:29:37 [threads:3] Created thread "non-blocking queue #1".
 2009/10/23 17:29:37 [audio.converter:4] Using prefered samplerate
 converter: libsamplerate
 2009/10/23 17:29:37 [threads:3] Created thread "generic queue #1".
 2009/10/23 17:29:37 [threads:3] Created thread "root" (1 total).
 2009/10/23 17:29:37 [root:3] Waking up active nodes...
 2009/10/23 17:29:37 [source:4] rvk64a gets up
 2009/10/23 17:29:37 [source:4] mksafe gets up
 2009/10/23 17:29:37 [source:4] live gets up
 2009/10/23 17:29:37 [live:4] Activations changed: static=[],
 dynamic=[mksafe:rvk64a:rvk64a].
 2009/10/23 17:29:37 [source:4] safe_blank gets up
 2009/10/23 17:29:37 [safe_blank:4] Activations changed: static=[],
 dynamic=[mksafe:rvk64a:rvk64a].
 2009/10/23 17:29:37 [mksafe:4] Activations changed:
 static=[rvk64a:rvk64a], dynamic=[].
 2009/10/23 17:29:37 [rvk64a:4] Activations changed: static=[rvk64a],
 dynamic=[].
 2009/10/23 17:29:37 [rvk64a:4] Enabling caching mode (active source)
 2009/10/23 17:29:37 [source:4] src_5653 gets up
 2009/10/23 17:29:37 [mksafe:4] Activations changed:
 static=[src_5653:src_5653, rvk64a:rvk64a], dynamic=[].
 2009/10/23 17:29:37 [mksafe:4] Enabling caching mode (two static
 activations)
 2009/10/23 17:29:37 [src_5653:4] Activations changed: static=[src_5653],
 dynamic=[].
 2009/10/23 17:29:37 [src_5653:4] Enabling caching mode (active source)
 2009/10/23 17:29:37 [rvk64a:3] Connecting mount rvk64a for sou...@sigma...
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @stop-atom
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @start-triggers
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @stop-triggers
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @stop
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @return
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @called
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @start
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @start-depends
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @stop-depends
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @start-atom
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @stop-atom
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @start-triggers
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @stop-triggers
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @stop
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @return
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @stop-triggers
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @stop
 2009/10/23 17:29:37 [stdout:3] init(0):init-start
 @return
 2009/10/23 17:29:37 [rvk64a:3] Connection setup was successful.
 2009/10/23 17:29:37 [root:3] Broadcast starts up!
 2009/10/23 17:29:37 [mksafe:3] Switch to safe_blank.
 2009/10/23 17:29:37 [safe_blank:4] Activations changed:
 static=[mksafe:rvk64a:rvk64a], dynamic=[mksafe:rvk64a:rvk64a].
 2009/10/23 17:29:37 [harbor:3] New client: 127.0.0.1
 2009/10/23 17:29:37 [harbor:4] Header: ICE-AUDIO-INFO, value:
 bitrate=72;samplerate=44100;channels=2.
 2009/10/23 17:29:37 [harbor:4] Header: ICE-GENRE, value: Electronic.
 2009/10/23 17:29:37 [harbor:4] Header: ICE-NAME, value: RadioVkontakte.ru
 | ICQ:6979990.
 2009/10/23 17:29:37 [harbor:4] Header: ICE-URL, value:  .
 2009/10/23 17:29:37 [harbor:4] Header: ICE-DESCRIPTION, value:
 RadioVkontakte.ru.
 2009/10/23 17:29:37 [harbor:4] Header: ICE-PUBLIC, value: 1.
 2009/10/23 17:29:37 [harbor:4] Header: USER-AGENT, value: liquidsoap
 0.9.1+svn.
 2009/10/23 17:29:37 [harbor:4] Header: CONTENT-TYPE, value: audio/aacp.
 2009/10/23 17:29:37 [harbor:4] Client logged in.
 2009/10/23 17:29:37 [harbor:3] SOURCE request on /rvk.
 2009/10/23 17:29:37 [harbor:3] Adding source on mountpoint '/rvk' with
 type 'audio/aacp'.
 2009/10/23 17:29:37 [threads:3] Created thread "harbor source feeding" (2
 total).
 2009/10/23 17:29:37 [live:3] Decoding...
 2009/10/23 17:29:38 [harbor:3] New client: 127.0.0.1
 2009/10/23 17:29:38 [harbor:4] Header: USER-AGENT, value: liquidsoap
 0.9.1+svn.
 2009/10/23 17:29:38 [harbor:3] GET request on /admin/metadata.
 2009/10/23 17:29:38 [harbor:4] GET Arg: title, value: no signal.
 2009/10/23 17:29:38 [harbor:4] GET Arg: song, value: no signal.
 2009/10/23 17:29:38 [harbor:4] GET Arg: mount, value: /rvk.
 2009/10/23 17:29:38 [harbor:4] GET Arg: mode, value: updinfo.
 2009/10/23 17:29:38 [harbor:3] Request to update metadata for mount /rvk
 2009/10/23 17:29:38 [harbor:4] Client logged in.
 2009/10/23 17:29:38 [live:3] New metadata chunk "? -- no signal"
 2009/10/23 17:29:48 [mksafe:3] Switch to live with transition.
 2009/10/23 17:29:48 [safe_blank:4] Activations changed: static=[],
 dynamic=[mksafe:rvk64a:rvk64a].
 2009/10/23 17:29:48 [live:4] Activations changed:
 static=[mksafe:rvk64a:rvk64a], dynamic=[mksafe:rvk64a:rvk64a].
 <... segfault here! process stopped unexpectedly when i send daemon stop
 signal ...>
 }}}


 http input script log
 {{{
 2009/10/23 17:29:36 >>> LOG START
 2009/10/23 17:29:36 [protocols.external:3] Didn't find "ufetch"
 2009/10/23 17:29:36 [protocols.external:3] Found "/usr/bin/wget"
 2009/10/23 17:29:36 [main:3] Liquidsoap 0.9.1+svn
 (trunk/liquids...@rev6849)
 2009/10/23 17:29:36 [lang:3] flac binary not found: flac decoder disabled.
 2009/10/23 17:29:36 [lang:3] metaflac binary not found: flac metadata
 resolver disabled.
 2009/10/23 17:29:36 [video.converter:4] Couldn't find prefered video
 converter: gavl
 2009/10/23 17:29:36 [audio.converter:4] Using prefered samplerate
 converter: libsamplerate
 2009/10/23 17:29:36 [threads:3] Created thread "non-blocking queue #1".
 2009/10/23 17:29:36 [threads:3] Created thread "generic queue #1".
 2009/10/23 17:29:36 [threads:3] Created thread "root" (1 total).
 2009/10/23 17:29:36 [root:3] Waking up active nodes...
 2009/10/23 17:29:36 [source:4] rvk32a gets up
 2009/10/23 17:29:36 [source:4] mksafe gets up
 2009/10/23 17:29:36 [source:4] src_5648 gets up
 2009/10/23 17:29:36 [threads:3] Created thread "http polling" (2 total).
 2009/10/23 17:29:36 [src_5648:4] Activations changed: static=[],
 dynamic=[mksafe:rvk32a:rvk32a].
 2009/10/23 17:29:36 [source:4] safe_blank gets up
 2009/10/23 17:29:36 [safe_blank:4] Activations changed: static=[],
 dynamic=[mksafe:rvk32a:rvk32a].
 2009/10/23 17:29:36 [mksafe:4] Activations changed:
 static=[rvk32a:rvk32a], dynamic=[].
 2009/10/23 17:29:36 [rvk32a:4] Activations changed: static=[rvk32a],
 dynamic=[].
 2009/10/23 17:29:36 [rvk32a:4] Enabling caching mode (active source)
 2009/10/23 17:29:36 [rvk32a:3] Connecting mount rvk32a for sou...@sigma...
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @stop-atom
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @start-triggers
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @stop-triggers
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @stop
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @return
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @called
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @start
 2009/10/23 17:29:36 [src_5648:4] Connecting to <http://sigma:9000/rvk>...
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @start-depends
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @stop-depends
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @start-atom
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @stop-atom
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @start-triggers
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @stop-triggers
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @stop
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @return
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @stop-triggers
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @stop
 2009/10/23 17:29:36 [stdout:3] init(0):init-start
 @return
 2009/10/23 17:29:37 [src_5648:4] Could not get file: File Not Found
 2009/10/23 17:29:37 [src_5648:4] Connection failed: Http_source.Internal
 2009/10/23 17:29:37 [rvk32a:3] Connection setup was successful.
 2009/10/23 17:29:37 [root:3] Broadcast starts up!
 2009/10/23 17:29:37 [mksafe:3] Switch to safe_blank.
 2009/10/23 17:29:37 [safe_blank:4] Activations changed:
 static=[mksafe:rvk32a:rvk32a], dynamic=[mksafe:rvk32a:rvk32a].
 2009/10/23 17:29:39 [src_5648:4] Connecting to <http://sigma:9000/rvk>...
 2009/10/23 17:29:39 [src_5648:4] Trying playlist parser for mime
 audio/aacp
 2009/10/23 17:29:39 [src_5648:4] Content-type "audio/aacp".
 2009/10/23 17:29:39 [src_5648:3] Decoding...
 2009/10/23 17:29:40 [mksafe:3] Switch to src_5648 with transition.
 2009/10/23 17:29:40 [safe_blank:4] Activations changed: static=[],
 dynamic=[mksafe:rvk32a:rvk32a].
 2009/10/23 17:29:40 [src_5648:4] Activations changed:
 static=[mksafe:rvk32a:rvk32a], dynamic=[mksafe:rvk32a:rvk32a].
 2009/10/23 17:29:40 [src_5648:4] End of track.
 2009/10/23 17:37:13 [src_5648:2] Feeding stopped: Faad.Failed
 2009/10/23 17:37:15 [src_5648:4] Connecting to <http://sigma:9000/rvk>...
 2009/10/23 17:37:15 [src_5648:4] End of track.
 2009/10/23 17:37:15 [src_5648:4] Buffer emptied, starting buffering.
 2009/10/23 17:37:15 [mksafe:3] Switch to safe_blank with forgetful
 transition.
 2009/10/23 17:37:15 [src_5648:4] Activations changed: static=[],
 dynamic=[mksafe:rvk32a:rvk32a].
 2009/10/23 17:37:15 [safe_blank:4] Activations changed:
 static=[mksafe:rvk32a:rvk32a], dynamic=[mksafe:rvk32a:rvk32a].
 2009/10/23 17:37:15 [src_5648:4] Trying playlist parser for mime
 audio/aacp
 2009/10/23 17:37:15 [src_5648:4] Content-type "audio/aacp".
 2009/10/23 17:37:15 [src_5648:3] Decoding...
 2009/10/23 17:37:16 [mksafe:3] Switch to src_5648 with transition.
 2009/10/23 17:37:16 [safe_blank:4] Activations changed: static=[],
 dynamic=[mksafe:rvk32a:rvk32a].
 2009/10/23 17:37:16 [src_5648:4] Activations changed:
 static=[mksafe:rvk32a:rvk32a], dynamic=[mksafe:rvk32a:rvk32a].
 2009/10/23 17:37:16 [src_5648:4] End of track.
 2009/10/23 17:42:33 [src_5648:2] Feeding stopped: Faad.Failed
 2009/10/23 17:42:35 [src_5648:4] Connecting to <http://sigma:9000/rvk>...
 2009/10/23 17:42:36 [src_5648:4] Trying playlist parser for mime
 audio/aacp
 2009/10/23 17:42:36 [src_5648:4] Content-type "audio/aacp".
 2009/10/23 17:42:36 [src_5648:3] Decoding...
 2009/10/23 17:43:49 [src_5648:2] Feeding stopped: Faad.Failed
 2009/10/23 17:43:51 [src_5648:4] Connecting to <http://sigma:9000/rvk>...
 2009/10/23 17:43:51 [src_5648:4] Trying playlist parser for mime
 audio/aacp
 2009/10/23 17:43:51 [src_5648:4] Content-type "audio/aacp".
 2009/10/23 17:43:51 [src_5648:3] Decoding...
 2009/10/23 17:44:54 [src_5648:2] Feeding stopped: Faad.Failed
 2009/10/23 17:44:56 [src_5648:4] Connecting to <http://sigma:9000/rvk>...
 2009/10/23 17:44:56 [src_5648:4] Trying playlist parser for mime
 audio/aacp
 2009/10/23 17:44:56 [src_5648:4] Content-type "audio/aacp".
 2009/10/23 17:44:56 [src_5648:3] Decoding...
 2009/10/23 17:50:05 [src_5648:2] Feeding stopped: Faad.Failed
 2009/10/23 17:50:07 [src_5648:4] Connecting to <http://sigma:9000/rvk>...
 2009/10/23 17:50:07 [src_5648:4] Trying playlist parser for mime
 audio/aacp
 2009/10/23 17:50:07 [src_5648:4] Content-type "audio/aacp".
 2009/10/23 17:50:07 [src_5648:3] Decoding...
 2009/10/23 17:52:16 [src_5648:2] Feeding stopped: Faad.Failed
 2009/10/23 17:52:18 [src_5648:4] Connecting to <http://sigma:9000/rvk>...
 2009/10/23 17:52:18 [src_5648:4] Trying playlist parser for mime
 audio/aacp
 2009/10/23 17:52:18 [src_5648:4] Content-type "audio/aacp".
 2009/10/23 17:52:18 [src_5648:3] Decoding...
 2009/10/23 17:52:53 [main:3] Shutdown started!
 2009/10/23 17:52:53 [main:3] Waiting for threads to terminate...
 2009/10/23 17:52:53 [stdout:3] init(0):init-stop
 @called
 2009/10/23 17:52:53 [stdout:3] init(0):init-stop
 @start
 2009/10/23 17:52:53 [stdout:3] init(0):init-stop
 @start-depends
 2009/10/23 17:52:53 [stdout:3] init(0):init-stop
 @called
 2009/10/23 17:52:53 [stdout:3] init(0):init-stop
 @start
 2009/10/23 17:52:53 [stdout:3] init(0):init-stop
 @start-depends
 2009/10/23 17:52:53 [root:3] Shutting down sources...
 2009/10/23 17:52:53 [source:4] rvk32a gets down
 2009/10/23 17:52:53 [rvk32a:3] Closing connection...
 2009/10/23 17:52:53 [source:4] mksafe gets down
 2009/10/23 17:52:53 [src_5648:4] Activations changed:
 static=[mksafe:rvk32a:rvk32a], dynamic=[].
 2009/10/23 17:52:53 [source:4] safe_blank gets down
 2009/10/23 17:52:53 [safe_blank:4] Activations changed: static=[],
 dynamic=[].
 2009/10/23 17:52:53 [source:4] src_5648 gets down
 2009/10/23 17:52:53 [src_5648:4] Activations changed: static=[],
 dynamic=[].
 2009/10/23 17:52:53 [mksafe:4] Activations changed: static=[], dynamic=[].
 2009/10/23 17:52:53 [rvk32a:4] Activations changed: static=[], dynamic=[].
 2009/10/23 17:52:53 [threads:3] Thread "root" exited (1 remaining).
 2009/10/23 17:52:53 [stdout:3] init(0):init-stop
 @stop-depends
 2009/10/23 17:52:53 [stdout:3] init(0):init-stop
 @start-atom
 2009/10/23 17:52:53 [src_5648:2] Feeding stopped: source stopped.
 2009/10/23 17:52:53 [threads:3] Thread "http polling" exited (0
 remaining).
 2009/10/23 17:52:53 [main:3] Cleaning downloaded files...
 2009/10/23 17:52:53 >>> LOG END
 }}}

-- 
Ticket URL: <http://savonet.rastageeks.org/ticket/320#comment:18>
Savonet <http://savonet.rastageeks.org/>
Let's program our stream !
------------------------------------------------------------------------------
Come build with us! The BlackBerry(R) Developer Conference in SF, CA
is the only developer event you need to attend this year. Jumpstart your
developing skills, take BlackBerry mobile applications to market and stay 
ahead of the curve. Join us from November 9 - 12, 2009. Register now!
http://p.sf.net/sfu/devconference
_______________________________________________
Savonet-trac mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/savonet-trac

Reply via email to