[mythtv-users] Is mythfrontend's AirPlay support supposed to be audio-only or audio-and-video?

Scott Alfter scott-sender-2f809c at alfter.us
Wed May 9 01:08:43 UTC 2012


On 05/07/2012 05:54 PM, Jean-Yves Avenard wrote:
> On 8 May 2012 10:39, Anthony Giggins<seven at seven.dorksville.net>  wrote:
>> The other issue I've noticed isno matter where you start airplay from mythtv
>> will always start from the beginning, not sure if this is correct
>> behavour.....
>
> sigh...
>
> And once again... Update your version of mythtv, all of those issues
> have been fixed !

Upgraded my machines to 0.25-fixes revision 
7fbcfb4b862069d9caa2c61c811b8602327f6552 today...down to just one output per 
host showing when I play video, but one of my hosts (the main backend/frontend 
machine) isn't playing audio now.  On revision 
2a2af9f7f7b66c13b7cb4e65149acbf6088f4cbf, audio worked.  Audio still works on 
another host in another room.

Here's the mythfrontend log from trying to play a podcast.  It's complaining 
that the audio output (HDMI on a GeForce 210) is busy.  The frontend is just 
sitting at the main menu when I try to start playing.  Tried it with both an 
iPhone 4 and an iPad...no difference:

------------------------------ start ------------------------------

xauth:  file /home/mythtv/.serverauth.1035 does not exist


X.Org X Server 1.11.2
Release Date: 2011-11-04
X Protocol Version 11, Revision 0
Build Operating System: Linux 3.3.0-gentoo x86_64 Gentoo
Current Operating System: Linux mythserver 3.3.4-gentoo #1 SMP Mon May 7 
12:07:21 PDT 2012 x86_64
Kernel command line: root=/dev/sda1 vga=791
Build Date: 10 April 2012  02:48:37PM

Current version of pixman: 0.24.4
	Before reporting problems, check http://wiki.x.org
	to make sure that you have the latest version.
Markers: (--) probed, (**) from config file, (==) default setting,
	(++) from command line, (!!) notice, (II) informational,
	(WW) warning, (EE) error, (NI) not implemented, (??) unknown.
(==) Log file: "/var/log/Xorg.0.log", Time: Tue May  8 17:42:06 2012
(==) Using config file: "/etc/X11/xorg.conf"
(==) Using system config directory "/usr/share/X11/xorg.conf.d"
(EE) Failed to load module "xtrap" (module does not exist, 0)
(EE) Failed to load module "dri" (module does not exist, 0)
(EE) Failed to load module "dri2" (module does not exist, 0)
(EE) NVIDIA: Failed to load module "dri2" (module does not exist, 0)

Tue May  8 17:42:07 2012
  vncext:      VNC extension running!
  vncext:      Listening for VNC connections on all interface(s), port 5900
  vncext:      created VNC server for screen 0

   Attribute 'SyncToVBlank' (mythserver:0.0) assigned value 1.

2012-05-08 17:42:08.109101 C  mythfrontend version: fixes/0.25 
[v0.25-82-g7fbcfb4] www.mythtv.org
2012-05-08 17:42:08.109142 C  Qt version: compile: 4.7.4, runtime: 4.7.4
2012-05-08 17:42:08.109146 N  Enabled verbose msgs:  general
2012-05-08 17:42:08.109186 N  Setting Log Level to LOG_INFO
2012-05-08 17:42:08.109244 I  Added logging to the console
2012-05-08 17:42:08.109254 I  Added database logging to table logging
2012-05-08 17:42:08.109365 N  Setting up SIGHUP handler
2012-05-08 17:42:08.109534 N  Using runtime prefix = /usr
2012-05-08 17:42:08.109550 N  Using configuration directory = /home/mythtv/.mythtv
2012-05-08 17:42:08.109771 I  Assumed character encoding: en_US.UTF-8
2012-05-08 17:42:08.110319 E  Unable to read configuration file mysql.txt
2012-05-08 17:42:08.110511 N  Empty LocalHostName.
2012-05-08 17:42:08.110521 I  Using localhost value of mythserver
2012-05-08 17:42:08.126551 N  Setting QT default locale to EN_US
2012-05-08 17:42:08.126563 I  Current locale EN_US
2012-05-08 17:42:08.126596 N  Reading locale defaults from 
/usr/share/mythtv//locales/en_us.xml
2012-05-08 17:42:08.130956 I  Starting process signal handler
2012-05-08 17:42:08.131033 I  Starting process manager
2012-05-08 17:42:08.131049 I  Starting IO manager (write)
2012-05-08 17:42:08.131057 I  Starting IO manager (read)
2012-05-08 17:42:08.250113 I  ScreenSaverX11Private: DPMS is active.
2012-05-08 17:42:08.283136 N  Desktop video mode: 1920x1080 60.000 Hz
2012-05-08 17:42:08.292054 I  Listening on TCP 127.0.0.1:6547
2012-05-08 17:42:08.292114 I  Listening on TCP 192.168.100.15:6547
2012-05-08 17:42:08.292178 I  Listening on TCP [0:0:0:0:0:0:0:1]:6547
2012-05-08 17:42:09.303971 I  AirPay: Created airplay objects.
2012-05-08 17:42:09.304149 I  Listening on TCP 127.0.0.1:5100
2012-05-08 17:42:09.304209 I  Listening on TCP 192.168.100.15:5100
2012-05-08 17:42:09.304295 I  Listening on TCP [0:0:0:0:0:0:0:1]:5100
2012-05-08 17:42:09.304652 I  RAOP Device: Created RAOP device objects.
2012-05-08 17:42:09.308071 I  Listening on TCP 127.0.0.1:5000
2012-05-08 17:42:09.308132 I  Listening on TCP 192.168.100.15:5000
2012-05-08 17:42:09.308210 I  Listening on TCP [0:0:0:0:0:0:0:1]:5000
2012-05-08 17:42:09.308231 I  RAOP Device: Listening for connections on port 5000
2012-05-08 17:42:09.308289 I  Registering service 22544b463663 at MythTV on 
mythserver._raop._tcp port 5000 TXT 
tp=UDPsm=falsesv=falseek=1et=0,1cn=0,1ch=2ss=16sr=44100pw=falsevn=3	txtvers=1md=0,1,2 
vs=130.14da=true
2012-05-08 17:42:09.419537 I  Connecting to lcd server: 127.0.0.1:6545 (try 1 
of 10)
2012-05-08 17:42:09.430166 I  Loading en_us translation for module mythfrontend
2012-05-08 17:42:09.435573 I  Binding to UDP 127.0.0.1:6948
2012-05-08 17:42:09.435629 I  Binding to UDP 192.168.100.15:6948
2012-05-08 17:42:09.435729 I  Binding to UDP [0:0:0:0:0:0:0:1]:6948
2012-05-08 17:42:09.435781 I  Binding to UDP 192.168.100.255:6948
2012-05-08 17:42:09.479919 I  Using Frameless Window
2012-05-08 17:42:09.479964 I  Using Full Screen Window
2012-05-08 17:42:09.607269 I  Trying the OpenGL painter
2012-05-08 17:42:09.607774 I  OpenGL: Sync to VBlank is enabled (good!)
2012-05-08 17:42:09.647718 I  OpenGL1: Fragment program support available
2012-05-08 17:42:09.647776 I  OpenGL: OpenGL vendor  : NVIDIA Corporation
2012-05-08 17:42:09.647782 I  OpenGL: OpenGL renderer: GeForce 210/PCIe/SSE2
2012-05-08 17:42:09.647785 I  OpenGL: OpenGL version : 3.3.0 NVIDIA 295.40
2012-05-08 17:42:09.647792 I  OpenGL: Max texture size: 8192 x 8192
2012-05-08 17:42:09.647795 I  OpenGL: Max texture units: 4
2012-05-08 17:42:09.647804 I  OpenGL: Direct rendering: Yes
2012-05-08 17:42:09.647810 I  OpenGL: PixelBufferObject support available
2012-05-08 17:42:09.647814 I  OpenGL: Initialised MythRenderOpenGL
2012-05-08 17:42:09.648880 E  MythUIHelper: Removing stale cache dir: 
/home/mythtv/.mythtv/themecache/Terra.1920.1080
2012-05-08 17:42:09.862495 I  Current MythTV Schema Version (DBSchemaVer): 1299
2012-05-08 17:42:10.082354 N  Registering Internal as a media playback plugin.
2012-05-08 17:42:10.116634 N  Registering WebBrowser as a media playback plugin.
2012-05-08 17:42:10.116675 I  Loading en_us translation for module mythbrowser
2012-05-08 17:42:10.123077 I  Current MythMusic Schema Version 
(MusicDBSchemaVer): 1019
2012-05-08 17:42:10.128861 I  Loading en_us translation for module mythmusic
2012-05-08 17:42:10.131013 I  Loading en_us translation for module mythnetvision
2012-05-08 17:42:10.131682 I  Listening on TCP 127.0.0.1:6546
2012-05-08 17:42:10.131723 I  Listening on TCP 192.168.100.15:6546
2012-05-08 17:42:10.131778 I  Listening on TCP [0:0:0:0:0:0:0:1]:6546
2012-05-08 17:42:10.170586 I  Bonjour: Service registration complete: name 
'22544b463663 at MythTV on mythserver' type '_raop._tcp.' domain: 'local.'
2012-05-08 17:42:10.170633 I  Bonjour: Service registration complete: name 
'MythTV on mythserver' type '_airplay._tcp.' domain: 'local.'
2012-05-08 17:42:10.205617 N  Found mainmenu.xml for theme 'MythCenter-wide'
2012-05-08 17:42:10.466051 I  MythCoreContext: Connecting to backend server: 
192.168.100.15:6543 (try 1 of 1)
2012-05-08 17:42:10.466622 I  Using protocol version 72
2012-05-08 17:42:10.473313 I  Bonjour: Service registration complete: name 
'Mythfrontend on mythserver' type '_mythfrontend._tcp.' domain: 'local.'
2012-05-08 17:42:19.836677 I  RAOP Device: New connection from 192.168.100.17:50533
2012-05-08 17:42:19.836825 I  Binding to UDP 127.0.0.1:6000
2012-05-08 17:42:19.836883 I  Binding to UDP 192.168.100.15:6000
2012-05-08 17:42:19.836973 I  Binding to UDP [0:0:0:0:0:0:0:1]:6000
2012-05-08 17:42:19.836985 I  RAOP Conn: Bound to port 6000 for incoming data
2012-05-08 17:42:19.868316 I  RAOP Conn: Negotiated setup with client 
192.168.100.17 on port 50533
2012-05-08 17:42:19.868387 I  Binding to UDP 127.0.0.1:64458
2012-05-08 17:42:19.868444 I  Binding to UDP 192.168.100.15:64458
2012-05-08 17:42:19.868521 I  Binding to UDP [0:0:0:0:0:0:0:1]:64458
2012-05-08 17:42:19.868535 I  RAOP Conn: Bound to client control port 64458 on 
port 64458
2012-05-08 17:42:19.868595 I  Binding to UDP 127.0.0.1:51160
2012-05-08 17:42:19.868649 I  Binding to UDP 192.168.100.15:51160
2012-05-08 17:42:19.868721 I  Binding to UDP [0:0:0:0:0:0:0:1]:51160
2012-05-08 17:42:19.868733 I  RAOP Conn: Bound to client timing port 51160 on 
port 51160
2012-05-08 17:42:20.013593 I  AO: Opening audio device 'hdmi:CARD=NVidia,DEV=1' 
ch 2(2) sr 44100 sf signed 16 bit reenc 0
2012-05-08 17:42:20.703812 I  AirPay: New connection from 192.168.100.17:50535
2012-05-08 17:42:20.706261 I  Method: GET URI: /server-info
2012-05-08 17:42:20.729936 I  <?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE plist PUBLIC "-//Apple//DTD PLIST 1.0//EN" 
"http://www.apple.com/DTDs/PropertyList-1.0.dtd">
<plist version="1.0">
<dict>
<key>deviceid</key>
<string>22:54:4b:46:36:63</string>
<key>features</key>
<integer>119</integer>
<key>model</key>
<string>AppleTV2,1</string>
<key>protovers</key>
<string>1.0</string>
<key>srcvers</key>
<string>101.28</string>
</dict>
</plist>

2012-05-08 17:42:20.759013 I  AirPay: New connection from 192.168.100.17:50537
2012-05-08 17:42:20.761624 I  Method: POST URI: /reverse
2012-05-08 17:42:20.768154 I  Method: POST URI: /play
2012-05-08 17:42:20.768308 I  AirPay: File: 
'http://192.168.100.17:7001/1/0e9d1e41-7ded-5c2f-a9a9-0f4691a32216.m4v' 
start_pos '0.170616'
2012-05-08 17:42:20.770499 I  TV: Creating TV object
2012-05-08 17:42:20.775558 N  Resuming idle timer
2012-05-08 17:42:20.775625 N  Suspending idle timer
2012-05-08 17:42:20.776724 I  TV: Created TvPlayWindow.
2012-05-08 17:42:20.781379 I  TV: Attempting to change from None to WatchingVideo
2012-05-08 17:42:20.785284 I  Method: POST URI: /rate
2012-05-08 17:42:20.839520 I  Method: POST URI: /rate
2012-05-08 17:42:20.853756 I  Method: HTTP/1.1 URI: 200
2012-05-08 17:42:20.865296 I  Method: PUT URI: /setProperty
2012-05-08 17:42:20.871134 I  Method: PUT URI: /setProperty
2012-05-08 17:42:20.977159 I 
StreamRingBuf(http://192.168.100.17:7001/1/0e9d1e41-7ded-5c2f-a9a9-0f4691a32216.m4v): 
Trying http://192.168.100.17:7001/1/0e9d1e41-7ded-5c2f-a9a9-0f4691a32216.m4v 
(allow seeks: 1
2012-05-08 17:42:20.986522 I  Method: POST URI: /rate
2012-05-08 17:42:21.009472 I  Method: HTTP/1.1 URI: 200
2012-05-08 17:42:21.121721 E  ALSA: snd_pcm_open("hdmi:CARD=NVidia,DEV=1"): 
Device or resource busy
2012-05-08 17:42:21.121759 N  AudioPlayer: Enabling Audio
2012-05-08 17:42:21.155672 I  Method: HTTP/1.1 URI: 200
2012-05-08 17:42:21.332763 I  AFD: Opened codec 0x29e80c0, id(H264) type(Video)
2012-05-08 17:42:21.332780 I  AFD: codec AAC has 2 channels
2012-05-08 17:42:21.334167 I  AFD: Opened codec 0x29e8780, id(AAC) type(Audio)
2012-05-08 17:42:21.334250 I  AO: Resampling from 44 kHz to 48 kHz with quality 
medium
2012-05-08 17:42:21.334371 I  AO: Opening audio device 'hdmi:CARD=NVidia,DEV=1' 
ch 2(2) sr 48000 sf signed 16 bit reenc 0
2012-05-08 17:42:21.334854 E  ALSA: snd_pcm_open("hdmi:CARD=NVidia,DEV=1"): 
Device or resource busy
2012-05-08 17:42:21.334864 E  AudioOutput Error: Aborting reconfigure
2012-05-08 17:42:21.334875 N  AudioPlayer: Disabling Audio, reason is: Aborting 
reconfigure
2012-05-08 17:42:21.348473 I  Clearing OpenGL painter cache.
2012-05-08 17:42:21.368978 I  Method: GET URI: /scrub
2012-05-08 17:42:21.762637 I  VDPAU: Created 2 output surfaces.
2012-05-08 17:42:21.762672 I  VDPAU: Version 1
2012-05-08 17:42:21.762679 I  VDPAU: Information NVIDIA VDPAU Driver Shared 
Library  295.40  Thu Apr  5 22:02:06 PDT 2012
2012-05-08 17:42:21.762691 I  VDPAU: Created VDPAU render device 1920x1080
2012-05-08 17:42:21.767402 N  Player(0): Forcing decode extra audio option on 
(Video method requires it).
2012-05-08 17:42:21.851933 I  Player(0): Video timing method: RTC
2012-05-08 17:42:21.859976 I  TV: Created player.
2012-05-08 17:42:21.860006 I  TV: Changing from None to WatchingVideo
2012-05-08 17:42:21.919737 I  TV: Main UI disabled.
2012-05-08 17:42:21.920152 I  TV: Entering main playback loop.
2012-05-08 17:42:21.922408 I  ScreenSaverX11Private: DPMS Deactivated 1
2012-05-08 17:42:21.924871 I  VDPAU: Added 2 output surfaces (total 4, max 4)
2012-05-08 17:42:21.929562 I  AirPay: Scrub: (get) returned 45.8957 of 269
2012-05-08 17:42:21.948274 I  Method: HTTP/1.1 URI: 200
2012-05-08 17:42:21.960805 I  ScreenSaverX11Private: DPMS Deactivated 1
2012-05-08 17:42:22.019524 I  AFD: No DTS Seeking Hack!
2012-05-08 17:42:22.139535 N  Player(0): Waited 120ms for video buffers 
AAAAAAAAAAuuuD
2012-05-08 17:42:22.411143 E  RAOP Conn: Audio discontinuity seen. Played 57236 
(21865644) expected 0
2012-05-08 17:42:23.990139 I  RAOP Conn: Missed 1 packet(s): expected 57652 got 
57653 ts:21868973
2012-05-08 17:42:23.990172 I  RAOP Conn: Sent resend for 57652
2012-05-08 17:42:25.680831 I  RAOP Device: Removing client connection.
2012-05-08 17:42:26.116279 I  Method: POST URI: /getProperty
2012-05-08 17:42:26.238195 I  Method: POST URI: /getProperty
2012-05-08 17:42:26.247068 I  Method: POST URI: /stop
2012-05-08 17:42:26.290597 I  TV: Attempting to change from WatchingVideo to None
2012-05-08 17:42:26.311419 I  VDPAU Painter: Clearing VDPAU painter cache.
2012-05-08 17:42:26.312403 W  MythPainter: 16 images not yet de-allocated.
2012-05-08 17:42:26.347668 I  TV: Changing from WatchingVideo to None
2012-05-08 17:42:26.347690 I  TV: Exiting main playback loop.
2012-05-08 17:42:26.348818 I  ScreenSaverX11Private: DPMS Reactivated 1
2012-05-08 17:42:26.364834 I  AirPay: Removing connection 192.168.100.17:50535
2012-05-08 17:42:26.369224 I  AirPay: Removing connection 192.168.100.17:50537
2012-05-08 17:42:26.369239 I  AirPay: Removing session 
'9a019057-28ca-4630-a585-fd6a69b04352'
2012-05-08 17:42:26.371465 N  Resuming idle timer
2012-05-08 17:42:33.045727 N  Resuming idle timer
2012-05-08 17:42:33.047049 N  Resuming idle timer
2012-05-08 17:42:35.189983 I  Bonjour: De-registering service 
'_mythfrontend._tcp.' on 'Mythfrontend on mythserver'
2012-05-08 17:42:35.190226 I  RAOP Device: Cleaning up.
2012-05-08 17:42:35.190245 I  Bonjour: De-registering service '_raop._tcp.' on 
'22544b463663 at MythTV on mythserver'
2012-05-08 17:42:35.191484 I  AirPay: Cleaning up.
2012-05-08 17:42:35.191500 I  Bonjour: De-registering service '_airplay._tcp.' 
on 'MythTV on mythserver'
2012-05-08 17:42:35.192194 I  Deleting UPnP client...
2012-05-08 17:42:35.872061 I  OpenGL1: Deleting OpenGL Resources
2012-05-08 17:42:35.872083 I  OpenGL: Deleting OpenGL Resources
2012-05-08 17:42:35.873804 I  Waiting for threads to exit.

------------------------------- end -------------------------------

Scott Alfter
scott at alfter.us


More information about the mythtv-users mailing list