[pulseaudio-tickets] [PulseAudio] #571: failed assertion when trying to access appleTV airtunes

PulseAudio trac-noreply at tango.0pointer.de
Tue Nov 17 02:05:08 PST 2009 

#571: failed assertion when trying to access appleTV airtunes
----------------------------+-----------------------------------------------
  Reporter:  globalmatador  |       Owner:  coling       
      Type:  defect         |      Status:  assigned     
 Milestone:                 |   Component:  module-raop-*
Resolution:                 |    Keywords:               
----------------------------+-----------------------------------------------

Comment(by yoann):

 Hi,

 I'm hitting the same issue on my machine. The initial connection to
 Airport Express work, then further connection will fail. The only way to
 make it work again is to reconfigure the Airport and change the Airtunes
 HP name.

 The following trace show something interesting:

 [Activating the "Make Apple Airtunes discoverable" button in paprefs,
 which initially work]:

 {{{
 D: module-gconf.c: Loading module 'module-raop-discover' with args '' due
 to GConf configuration.
 I: module.c: Loaded "module-raop-discover" (index: #32; argument: "").
 D: module-raop-discover.c: Found RAOP: MusicTest1
 D: module-raop-discover.c: Found key: 'txtvers' with value: '1'
 D: module-raop-discover.c: Found key: 'ch' with value: '2'
 D: module-raop-discover.c: Found key: 'cn' with value: '0,1'
 D: module-raop-discover.c: Found key: 'ek' with value: '1'
 D: module-raop-discover.c: Found key: 'et' with value: '0,1'
 D: module-raop-discover.c: Found key: 'sv' with value: 'false'
 D: module-raop-discover.c: Found key: 'da' with value: 'true'
 D: module-raop-discover.c: Found key: 'sr' with value: '44100'
 D: module-raop-discover.c: Found key: 'ss' with value: '16'
 D: module-raop-discover.c: Found key: 'pw' with value: 'false'
 D: module-raop-discover.c: Found key: 'vn' with value: '65537'
 D: module-raop-discover.c: Found key: 'tp' with value: 'TCP,UDP'
 D: module-raop-discover.c: Found key: 'vs' with value: '101.9'
 D: module-raop-discover.c: Found key: 'am' with value: 'AirPort4,107'
 D: module-raop-discover.c: Found key: 'fv' with value: '74200.9'
 D: module-raop-discover.c: Found key: 'sf' with value: '0x0'
 D: module-raop-discover.c: Loading module-raop-sink with arguments
 'server=192.168.0.253 sink_name=raop.muse.local description="MusicTest1"'
 I: sink.c: Created sink 9 "raop.muse.local" with sample spec s16le 2ch
 44100Hz and channel map front-left,front-right
 I: sink.c:     device.string = "192.168.0.253"
 I: sink.c:     device.intended_roles = "music"
 I: sink.c:     device.description = "MusicTest1"
 I: sink.c:     device.icon_name = "audio-card"
 I: source.c: Created source 10 "raop.muse.local.monitor" with sample spec
 s16le 2ch 44100Hz and channel map front-left,front-right
 I: source.c:     device.description = "Monitor of MusicTest1"
 I: source.c:     device.class = "monitor"
 I: source.c:     device.icon_name = "audio-input-microphone"
 D: module-raop-sink.c: Thread starting up
 D: module-suspend-on-idle.c: Sink raop.muse.local becomes idle, timeout in
 5 seconds.
 I: module.c: Loaded "module-raop-sink" (index: #33; argument:
 "server=192.168.0.253 sink_name=raop.muse.local
 description="MusicTest1"").
 D: rtsp_client.c: Established RTSP connection from local ip 192.168.0.1
 D: raop_client.c: RAOP: CONNECTED
 D: rtsp_client.c: Sending command: ANNOUNCE
 D: rtsp_client.c: Full response received. Dispatching
 D: raop_client.c: RAOP: ANNOUNCED
 D: rtsp_client.c: Sending command: SETUP
 D: rtsp_client.c: Full response received. Dispatching
 D: raop_client.c: RAOP: SETUP
 D: rtsp_client.c: Sending command: RECORD
 D: rtsp_client.c: Full response received. Dispatching
 D: raop_client.c: RAOP: RECORDED
 D: raop_client.c: Connection established
 D: module-raop-sink.c: SO_SNDBUF is 2048.
 D: module-raop-sink.c: Requested volume: 0: 100% 1: 100%
 D: module-raop-sink.c: Got hardware volume: 0: 100% 1: 100%
 D: module-raop-sink.c: Calculated software volume: 0: 100% 1: 100%
 D: rtsp_client.c: Sending command: SET_PARAMETER
 D: module-raop-sink.c: Connection authenticated, handing fd to IO
 thread...
 D: rtsp_client.c: Full response received. Dispatching
 D: raop_client.c: RAOP: SET_PARAMETER

 I: module-suspend-on-idle.c: Sink raop.muse.local idle for too long,
 suspending ...
 D: sink.c: Suspend cause of sink raop.muse.local is 0x0004, suspending
 D: rtsp_client.c: Sending command: FLUSH
 D: rtsp_client.c: Full response received. Dispatching
 D: raop_client.c: RAOP: FLUSHED
 }}}


 [Desactivating the "Make Apple Airtunes discoverable" button in paprefs]:

 {{{
 D: module-gconf.c: Unloading module #32
 I: module.c: Unloading "module-raop-discover" (index: #32).
 I: module.c: Unloaded "module-raop-discover" (index: #32).
 I: module.c: Unloading "module-raop-sink" (index: #33).
 D: module-rescue-streams.c: No sink inputs to move away.
 D: module-rescue-streams.c: No source outputs to move away.
 D: module-raop-sink.c: Thread shutting down
 I: sink.c: Freeing sink 9 "raop.muse.local"
 I: source.c: Freeing source 10 "raop.muse.local.monitor"
 I: module.c: Unloaded "module-raop-sink" (index: #33).
 }}}

 [Activating again through the "Make Apple Airtunes discoverable" button in
 paprefs]:

 {{{
 D: module-gconf.c: Loading module 'module-raop-discover' with args '' due
 to GConf configuration.
 I: module.c: Loaded "module-raop-discover" (index: #34; argument: "").
 D: module-raop-discover.c: Found RAOP: MusicTest1
 D: module-raop-discover.c: Found key: 'txtvers' with value: '1'
 D: module-raop-discover.c: Found key: 'ch' with value: '2'
 D: module-raop-discover.c: Found key: 'cn' with value: '0,1'
 D: module-raop-discover.c: Found key: 'ek' with value: '1'
 D: module-raop-discover.c: Found key: 'et' with value: '0,1'
 D: module-raop-discover.c: Found key: 'sv' with value: 'false'
 D: module-raop-discover.c: Found key: 'da' with value: 'true'
 D: module-raop-discover.c: Found key: 'sr' with value: '44100'
 D: module-raop-discover.c: Found key: 'ss' with value: '16'
 D: module-raop-discover.c: Found key: 'pw' with value: 'false'
 D: module-raop-discover.c: Found key: 'vn' with value: '65537'
 D: module-raop-discover.c: Found key: 'tp' with value: 'TCP,UDP'
 D: module-raop-discover.c: Found key: 'vs' with value: '101.9'
 D: module-raop-discover.c: Found key: 'am' with value: 'AirPort4,107'
 D: module-raop-discover.c: Found key: 'fv' with value: '74200.9'
 D: module-raop-discover.c: Found key: 'sf' with value: '0x0'
 D: module-raop-discover.c: Loading module-raop-sink with arguments
 'server=169.254.10.243 sink_name=raop.muse.local description="MusicTest1"'
 I: sink.c: Created sink 10 "raop.muse.local" with sample spec s16le 2ch
 44100Hz and channel map front-left,front-right
 I: sink.c:     device.string = "169.254.10.243"
 I: sink.c:     device.intended_roles = "music"
 I: sink.c:     device.description = "MusicTest1"
 I: sink.c:     device.icon_name = "audio-card"
 I: source.c: Created source 11 "raop.muse.local.monitor" with sample spec
 s16le 2ch 44100Hz and channel map front-left,front-right
 I: source.c:     device.description = "Monitor of MusicTest1"
 I: source.c:     device.class = "monitor"
 I: source.c:     device.icon_name = "audio-input-microphone"
 D: module-raop-sink.c: Thread starting up
 D: module-suspend-on-idle.c: Sink raop.muse.local becomes idle, timeout in
 5 seconds.
 I: module.c: Loaded "module-raop-sink" (index: #35; argument:
 "server=169.254.10.243 sink_name=raop.muse.local
 description="MusicTest1"").
 E: rtsp_client.c: Connection failed: Connexion terminée par expiration du
 délai d'attente
 I: module-suspend-on-idle.c: Sink raop.muse.local idle for too long,
 suspending ...
 D: sink.c: Suspend cause of sink raop.muse.local is 0x0004, suspending
 }}}

 Now, in the above log, notice how the "server" IP address changed, which
 result in the connection failing.

 The only way to workaround this is to change the Airtunes HP name again:

 {{{
 D: module-gconf.c: Loading module 'module-raop-discover' with args '' due
 to GConf configuration.
 I: module.c: Loaded "module-raop-discover" (index: #36; argument: "").
 D: module-raop-discover.c: Found RAOP: MusicTest2
 D: module-raop-discover.c: Found key: 'txtvers' with value: '1'
 D: module-raop-discover.c: Found key: 'ch' with value: '2'
 D: module-raop-discover.c: Found key: 'cn' with value: '0,1'
 D: module-raop-discover.c: Found key: 'ek' with value: '1'
 D: module-raop-discover.c: Found key: 'et' with value: '0,1'
 D: module-raop-discover.c: Found key: 'sv' with value: 'false'
 D: module-raop-discover.c: Found key: 'da' with value: 'true'
 D: module-raop-discover.c: Found key: 'sr' with value: '44100'
 D: module-raop-discover.c: Found key: 'ss' with value: '16'
 D: module-raop-discover.c: Found key: 'pw' with value: 'false'
 D: module-raop-discover.c: Found key: 'vn' with value: '65537'
 D: module-raop-discover.c: Found key: 'tp' with value: 'TCP,UDP'
 D: module-raop-discover.c: Found key: 'vs' with value: '101.9'
 D: module-raop-discover.c: Found key: 'am' with value: 'AirPort4,107'
 D: module-raop-discover.c: Found key: 'fv' with value: '74200.9'
 D: module-raop-discover.c: Found key: 'sf' with value: '0x0'
 D: module-raop-discover.c: Loading module-raop-sink with arguments
 'server=192.168.0.253 sink_name=raop.muse.local description="MusicTest2"'
 I: sink.c: Created sink 11 "raop.muse.local" with sample spec s16le 2ch
 44100Hz and channel map front-left,front-right
 I: sink.c:     device.string = "192.168.0.253"
 I: sink.c:     device.intended_roles = "music"
 I: sink.c:     device.description = "MusicTest2"
 I: sink.c:     device.icon_name = "audio-card"
 I: source.c: Created source 12 "raop.muse.local.monitor" with sample spec
 s16le 2ch 44100Hz and channel map front-left,front-right
 I: source.c:     device.description = "Monitor of MusicTest2"
 I: source.c:     device.class = "monitor"
 I: source.c:     device.icon_name = "audio-input-microphone"
 D: module-raop-sink.c: Thread starting up
 D: module-suspend-on-idle.c: Sink raop.muse.local becomes idle, timeout in
 5 seconds.
 I: module.c: Loaded "module-raop-sink" (index: #37; argument:
 "server=192.168.0.253 sink_name=raop.muse.local
 description="MusicTest2"").
 D: rtsp_client.c: Established RTSP connection from local ip 192.168.0.1
 D: raop_client.c: RAOP: CONNECTED
 D: rtsp_client.c: Sending command: ANNOUNCE
 D: rtsp_client.c: Full response received. Dispatching
 D: raop_client.c: RAOP: ANNOUNCED
 D: rtsp_client.c: Sending command: SETUP
 D: rtsp_client.c: Full response received. Dispatching
 D: raop_client.c: RAOP: SETUP
 D: rtsp_client.c: Sending command: RECORD
 D: rtsp_client.c: Full response received. Dispatching
 D: raop_client.c: RAOP: RECORDED
 D: raop_client.c: Connection established
 D: module-raop-sink.c: SO_SNDBUF is 2048.
 D: module-raop-sink.c: Requested volume: 0: 100% 1: 100%
 D: module-raop-sink.c: Got hardware volume: 0: 100% 1: 100%
 D: module-raop-sink.c: Calculated software volume: 0: 100% 1: 100%
 D: rtsp_client.c: Sending command: SET_PARAMETER
 D: module-raop-sink.c: Connection authenticated, handing fd to IO
 thread...
 D: rtsp_client.c: Full response received. Dispatching
 D: raop_client.c: RAOP: SET_PARAMETER
 }}}

 Hope this help,

-- 
Ticket URL: <http://pulseaudio.org/ticket/571#comment:12>
PulseAudio <http://pulseaudio.org/>
The PulseAudio Sound Server

More information about the pulseaudio-bugs mailing list