SageTV Community  

Go Back   SageTV Community > SageTV Products > SageTV Placeshifter
Forum Rules FAQs Community Downloads Today's Posts Search

Notices

SageTV Placeshifter Discussion related to the SageTV Placeshifter application produced by SageTV. Questions, issues, problems, suggestions, etc. relating to the SageTV Placeshifter software application should be posted here.

Reply
 
Thread Tools Search this Thread Display Modes
  #1  
Old 05-10-2010, 01:13 PM
bastafidli bastafidli is offline
Sage Expert
 
Join Date: Dec 2007
Location: Charlottesville, VA
Posts: 728
Placeshifter doesn't play music

Hello,

Since I setup my new computer with Placeshifter and my new server with SagTV server I am having issues with it. The HD100 is playing everything just fine. Last week the placeshifter on my laptop when playing music played one song, then when switching to the next one, it just went directly to the end of it and hang. I had to push Next Song button to make it play next song. Today it doesn't play music at all. When I start playing song, the mini player appears at the bottom and it displays timeline as if it was at the end of the song (e.g. 3:41 of 3:41) and hangs. When I hit Next Song button, it does the same thing for the next song. It goes straight to the end.

I had reinstalled JRE (since I found old thread that this might have been JRE bug) and I have reinstalled placeshifter, but nothing seems to work. I am starting to wonder if the problem is with the server, but as I mentioned, HD100 has no issue playing music.

Here is output from the server log when trying to play music

Code:
Mon 5/10 13:44:17.026 [EventRouter-f4ce46e4f122@f8e2bc]  ++++++++ Music folder browser:  Reloaded folder info
Mon 5/10 13:44:22.115 [EventRouter-f4ce46e4f122@f8e2bc] SongList size=11
Mon 5/10 13:44:22.116 [EventRouter-f4ce46e4f122@f8e2bc] SongList size=11
Mon 5/10 13:44:22.116 [EventRouter-f4ce46e4f122@f8e2bc] processOptionsMenu optionsMenu=default:BASE-63782|OptionsMenu:Show options for song or group of songs
Mon 5/10 13:44:23.987 [EventRouter-f4ce46e4f122@f8e2bc] VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=false
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VF processing job null nPlayin=false
Mon 5/10 13:44:23.988 [EventRouter-f4ce46e4f122@f8e2bc] Seeker.finishWatch(UIManager:localhost@@f4ce46e4f122-1944792)
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VF thread is now waiting for 0:00:00.000
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VF processing job null nPlayin=false
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VF thread is now waiting for 0:00:00.000
Mon 5/10 13:44:23.988 [EventRouter-f4ce46e4f122@f8e2bc] VF.startPlaylist Playlist[Now Playing Uhol pohladu by Desmod, ] startIdx=-1
Mon 5/10 13:44:23.988 [EventRouter-f4ce46e4f122@f8e2bc] VF.submitJob(VFJob[StartPlaylist r=0.0 t=0 file=null ifn=null])
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VF processing job VFJob[StartPlaylist r=0.0 t=0 file=null ifn=null] nPlayin=false
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VF processing on UI Thread VFJob[StartPlaylist r=0.0 t=0 file=null ifn=null]
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VF.playbackNextRandomPlaylist playlistChain=[Playlist[Now Playing Uhol pohladu by Desmod, ]] playindices=[-1] currFile=null
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] VideoFrame.watch(A[55743,55742,"Uhol pohladu",0@0430.23:08,3])
Mon 5/10 13:44:23.988 [VideoFrame-f4ce46e4f122@14b362c] watchThisFile=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]]
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] Watch airing is a file & over, do that instead dvd=false
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] Seeker.finishWatch(UIManager:localhost@@f4ce46e4f122-1944792)
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]] ifn=null])
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]] ifn=null] nPlayin=false
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]] ifn=null]
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] VideoFrame creating new media player for file:MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]]
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]] ifn=null] nPlayin=false
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]] ifn=null]
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] VF file=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]] targetTime = Mon 4/30 23:08:49.000
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] VideoFrame.timeSelected(Mon 4/30 23:08:49.000, true) currFile=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]]
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] initDriver0()
Mon 5/10 13:44:23.989 [VideoFrame-f4ce46e4f122@14b362c] MiniPlayer established for f4ce46e4f122
Mon 5/10 13:44:24.005 [VideoFrame-f4ce46e4f122@14b362c] getEstimatedBW=0 estimatedBWBytes=0 estimatedBWTime=0
Mon 5/10 13:44:24.005 [VideoFrame-f4ce46e4f122@14b362c] MiniPlayer was not able to get a bandwidth estimate from the UI system, sending data to get its own estimate...
Mon 5/10 13:44:24.032 [VideoFrame-f4ce46e4f122@14b362c] Not using optimized bandwidth detection because the numbers didn't align
Mon 5/10 13:44:24.032 [VideoFrame-f4ce46e4f122@14b362c] Bandwidth test base=0 base*2=1 BW=131168000
Mon 5/10 13:44:24.032 [VideoFrame-f4ce46e4f122@14b362c] MiniPlayer got an estimate from the UI on bandwidth of 131168Kbps
Mon 5/10 13:44:24.032 [VideoFrame-f4ce46e4f122@14b362c] MiniPlayer is using Pull mode playback
Mon 5/10 13:44:24.032 [VideoFrame-f4ce46e4f122@14b362c] openURL0(stv://10.44.21.39//archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3)
Mon 5/10 13:44:26.013 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 752
Mon 5/10 13:44:26.765 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 1504
Mon 5/10 13:44:26.866 [Ministry@9ba045] Ministry is waiting for 180 sec
Mon 5/10 13:44:27.517 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 2256
Mon 5/10 13:44:28.269 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 3008
Mon 5/10 13:44:29.021 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 3760
Mon 5/10 13:44:29.773 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 4512
Mon 5/10 13:44:30.525 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 5264
Mon 5/10 13:44:31.277 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 6016
Mon 5/10 13:44:32.029 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 6768
Mon 5/10 13:44:32.281 [Seeker@178a7d9] Seeker awoken
Mon 5/10 13:44:32.281 [Seeker@178a7d9] MemStats: Used=258MB Total=542MB Max=954MB
Mon 5/10 13:44:32.281 [Seeker@178a7d9] MARK 1 currRecord=null enc=HDHomeRun 101a71a8 Tuner 0 clients=[] ir=false
Mon 5/10 13:44:32.281 [Seeker@178a7d9] Seeker in AUTOMATIC mode nextRecord=A[125830,125771,"Two and a Half Men",26636@0510.18:30,30] nextTTA=17127719
Mon 5/10 13:44:32.281 [Seeker@178a7d9] newRecord=null
Mon 5/10 13:44:32.281 [Seeker@178a7d9] NOTHING TO RECORD FOR NOW...
Mon 5/10 13:44:32.281 [Seeker@178a7d9] Checking video directories for new files
Mon 5/10 13:44:32.281 [VideoFrame-00085c53a30c@174a4fb] VF processing job null nPlayin=true
Mon 5/10 13:44:32.283 [VideoFrame-00085c53a30c@174a4fb] isRec=false rd=2318460 base=2318610
Mon 5/10 13:44:32.283 [VideoFrame-00085c53a30c@174a4fb] VF thread is now waiting for 0:00:00.000
Mon 5/10 13:44:32.286 [Seeker@178a7d9] Diskspace checking is running
Mon 5/10 13:44:32.286 [Seeker@178a7d9] Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Mon 5/10 13:44:32.287 [Seeker@178a7d9] Enforcing keep at most limits for the files...
Mon 5/10 13:44:32.287 [Seeker@178a7d9] Seeker clearing unwanted and partial files...
Mon 5/10 13:44:32.289 [Seeker@178a7d9] Seeker waiting for 280 mins.
Mon 5/10 13:44:32.781 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 7520
Mon 5/10 13:44:33.533 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 8272
Mon 5/10 13:44:34.285 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 9024
Mon 5/10 13:44:35.037 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 9776
Mon 5/10 13:44:35.789 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 10528
Mon 5/10 13:44:36.541 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 11280
Mon 5/10 13:44:37.293 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 12032
Mon 5/10 13:44:38.045 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 12784
Mon 5/10 13:44:38.797 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 13536
Mon 5/10 13:44:39.549 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 14288
Mon 5/10 13:44:40.301 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 15040
Mon 5/10 13:44:41.053 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 15792
Mon 5/10 13:44:41.805 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 16544
Mon 5/10 13:44:42.557 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 17296
Mon 5/10 13:44:43.309 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 18048
Mon 5/10 13:44:44.061 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 18800
Mon 5/10 13:44:44.813 [AWTThreadWatcher-f4ce46e4f122@12b4ddf] EventThread-f4ce46e4f122 Hang Detected - hang time = 19552
Mon 5/10 13:44:45.527 [VideoFrame-f4ce46e4f122@14b362c] Sigma video dim=null
Mon 5/10 13:44:45.557 [VideoFrame-f4ce46e4f122@14b362c] getDuration : 0
Mon 5/10 13:44:45.557 [VideoFrame-f4ce46e4f122@14b362c] setMute0()
Mon 5/10 13:44:45.558 [VideoFrame-f4ce46e4f122@14b362c] VideoFrame.timeSelected2(Mon 4/30 23:08:49.000, true) currFile=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]] realDur=0
Mon 5/10 13:44:45.558 [VideoFrame-f4ce46e4f122@14b362c] playPush0()
Mon 5/10 13:44:45.558 [VideoFrame-f4ce46e4f122@14b362c] VF processing job null nPlayin=true
Mon 5/10 13:44:45.558 [VideoFrame-f4ce46e4f122@14b362c] isRec=false rd=231000 base=0
Mon 5/10 13:44:45.558 [VideoFrame-f4ce46e4f122@14b362c] VF thread is now waiting for 0:03:50.750
I should probably mention that this is on Ubuntu 10.04 32bit

uname -a
Linux bac 2.6.32-22-generic #33-Ubuntu SMP Wed Apr 28 13:27:30 UTC 2010 i686 GNU/Linux

java -version
java version "1.6.0_20"
Java(TM) SE Runtime Environment (build 1.6.0_20-b02)
Java HotSpot(TM) Server VM (build 16.3-b01, mixed mode)

Server is running on CenOS 5.4 64 bit
__________________

TV: Samsung UN46D8000
Server: Intel Core i3 540, 4G RAM, Matrox G450, 70GB EXT3 encrypted software RAID1 system drive, 1TB XFS tv recording drive, 2TB EXT3 encrypted data drive mirror across 2 machines, 2TB EXT3 encrypted media drive mirror across 2 machines, CentOS 6 64 bit, Experimenting with DNLA servers
1Gb wired network
Disconnected after G day[HD 100 Media Extender, Placeshifter 7.x, SageTV 7.x, HDHomeRun]

Last edited by bastafidli; 05-10-2010 at 01:18 PM.
Reply With Quote
  #2  
Old 05-10-2010, 01:27 PM
bastafidli bastafidli is offline
Sage Expert
 
Join Date: Dec 2007
Location: Charlottesville, VA
Posts: 728
I just noticed in the log following

Mon 5/10 13:44:24.005 [VideoFrame-f4ce46e4f122@14b362c] MiniPlayer was not able to get a bandwidth estimate from the UI system, sending data to get its own estimate...
Mon 5/10 13:44:24.032 [VideoFrame-f4ce46e4f122@14b362c] Not using optimized bandwidth detection because the numbers didn't align
Mon 5/10 13:44:24.032 [VideoFrame-f4ce46e4f122@14b362c] Bandwidth test base=0 base*2=1 BW=131168000
Mon 5/10 13:44:24.032 [VideoFrame-f4ce46e4f122@14b362c] MiniPlayer got an estimate from the UI on bandwidth of 131168Kbps


I changed Placeshifter settings to
Playback media without transcoding (only recommended for Lan usage)
from User SageTV's dynamic streaming system and that played the first song, but the Next Song jumps directly to the end and hangs and when I git Next Song button I get this in the log

Code:
Mon 5/10 14:26:43.603 [MiniUIServer@3e34a7] MiniUI got connection from java.nio.channels.SocketChannel[connected local=/10.44.21.39:31099 remote=/10.44.21.37:42540]
Mon 5/10 14:26:43.604 [MiniUIServer@3e34a7] MiniPlayer is adding to its map:f4ce46e4f122
Mon 5/10 14:26:43.604 [VideoFrame-f4ce46e4f122@14b362c] MiniPlayer established for f4ce46e4f122
Mon 5/10 14:26:43.604 [VideoFrame-f4ce46e4f122@14b362c] getEstimatedBW=131168000 estimatedBWBytes=16396000 estimatedBWTime=1000
Mon 5/10 14:26:43.604 [VideoFrame-f4ce46e4f122@14b362c] MiniPlayer got an estimate from the UI on bandwidth of 131168Kbps
Mon 5/10 14:26:43.604 [VideoFrame-f4ce46e4f122@14b362c] MiniPlayer is using Pull mode playback
Mon 5/10 14:26:43.604 [VideoFrame-f4ce46e4f122@14b362c] openURL0(stv://10.44.21.39//archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3)
Mon 5/10 14:26:46.034 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 752
Mon 5/10 14:26:46.786 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 1504
Mon 5/10 14:26:47.538 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 2256
Mon 5/10 14:26:48.290 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 3008
Mon 5/10 14:26:49.042 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 3760
Mon 5/10 14:26:49.794 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 4512
Mon 5/10 14:26:50.546 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 5264
Mon 5/10 14:26:51.298 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 6016
Mon 5/10 14:26:52.050 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 6768
Mon 5/10 14:26:52.802 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 7520
Mon 5/10 14:26:53.554 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 8272
Mon 5/10 14:26:54.306 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 9024
Mon 5/10 14:26:55.058 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 9776
Mon 5/10 14:26:55.810 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 10528
Mon 5/10 14:26:56.562 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 11280
Mon 5/10 14:26:57.314 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 12032
Mon 5/10 14:26:58.066 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 12784
Mon 5/10 14:26:58.818 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 13536
Mon 5/10 14:26:59.570 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 14288
Mon 5/10 14:27:00.322 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 15040
Mon 5/10 14:27:01.074 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 15792
Mon 5/10 14:27:01.826 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 16544
Mon 5/10 14:27:02.578 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 17296
Mon 5/10 14:27:03.330 [AWTThreadWatcher-f4ce46e4f122@129296e] EventThread-f4ce46e4f122 Hang Detected - hang time = 18048
Mon 5/10 14:27:03.626 [VideoFrame-f4ce46e4f122@14b362c] Sigma video dim=null
Mon 5/10 14:27:03.627 [VideoFrame-f4ce46e4f122@14b362c] getDuration : 0
Mon 5/10 14:27:03.627 [VideoFrame-f4ce46e4f122@14b362c] setMute0()
Mon 5/10 14:27:03.627 [VideoFrame-f4ce46e4f122@14b362c] VideoFrame.timeSelected2(Mon 4/30 23:08:49.000, true) currFile=MediaFile[id=55741 A[55743,55742,"Uhol pohladu",0@0430.23:08,3] host=storage.bastafidli.com encodedBy= format=MP3 0:03:50 128 kbps [#0 Audio[MP3 44100 Hz 2 channels 128 kbps]] /archive/Music/Slovak/Desmod/Uhol pohladu/01_Desmod_100 rokov samoty.mp3, Seg0[Mon 4/30 23:08:49.000-Mon 4/30 23:12:40.000]] realDur=0
Mon 5/10 14:27:03.628 [VideoFrame-f4ce46e4f122@14b362c] playPush0()
Mon 5/10 14:27:03.628 [VideoFrame-f4ce46e4f122@14b362c] VF processing job null nPlayin=true
Mon 5/10 14:27:03.628 [VideoFrame-f4ce46e4f122@14b362c] isRec=false rd=231000 base=0
Mon 5/10 14:27:03.628 [VideoFrame-f4ce46e4f122@14b362c] VF thread is now waiting for 0:03:50.750
__________________

TV: Samsung UN46D8000
Server: Intel Core i3 540, 4G RAM, Matrox G450, 70GB EXT3 encrypted software RAID1 system drive, 1TB XFS tv recording drive, 2TB EXT3 encrypted data drive mirror across 2 machines, 2TB EXT3 encrypted media drive mirror across 2 machines, CentOS 6 64 bit, Experimenting with DNLA servers
1Gb wired network
Disconnected after G day[HD 100 Media Extender, Placeshifter 7.x, SageTV 7.x, HDHomeRun]
Reply With Quote
  #3  
Old 05-12-2010, 01:44 PM
bastafidli bastafidli is offline
Sage Expert
 
Join Date: Dec 2007
Location: Charlottesville, VA
Posts: 728
I have made progress to make one placeshifter working. I enabled the log on the placeshifter and found out, that placeshifter cannot open the audio device and it completely silently fails

Code:
Wed 5/12 14:34:03.172 stdout:==========================================================================
Wed 5/12 14:34:03.172 stdout:Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
Wed 5/12 14:34:03.172 stdout:AUDIO: 44100 Hz, 2 ch, s16le, 128.0 kbit/9.07% (ratio: 16000->176400)
Wed 5/12 14:34:03.173 stdout:ID_AUDIO_BITRATE=128000
Wed 5/12 14:34:03.173 stdout:ID_AUDIO_RATE=44100
Wed 5/12 14:34:03.173 stdout:ID_AUDIO_NCH=2
Wed 5/12 14:34:03.173 stdout:Selected audio codec: [mp3] afm: mp3lib (mp3lib MPEG layer-2, layer-3)
Wed 5/12 14:34:03.173 stdout:==========================================================================
Wed 5/12 14:34:04.506 stderr:[AO_ALSA] alsa-lib: pcm_hw.c:1293:(snd_pcm_hw_open) open /dev/snd/pcmC0D0p failed: Device or resource busy
Wed 5/12 14:34:04.507 stdout:Audio: no sound
Wed 5/12 14:34:04.507 stderr:[AO_ALSA] Playback open error: Device or resource busy
Wed 5/12 14:34:04.507 stdout:Video: no video
Wed 5/12 14:34:04.508 stderr:Failed to initialize audio driver 'alsa:device=hw'
Wed 5/12 14:34:04.508 stderr:Could not open/initialize audio device -> no sound.
Wed 5/12 14:34:04.509 stdout:
Wed 5/12 14:34:04.532 stderr:CACHE THREAD ENDING
Wed 5/12 14:34:04.534 stdout:
Wed 5/12 14:34:04.534 stdout:Exiting... (End of file)
Wed 5/12 14:34:04.535 stdout:ID_EXIT=EOF
Wed 5/12 14:34:04.535 stdout consumer has closed
Wed 5/12 14:34:04.536 stderr consumer has closed
Wed 5/12 14:34:12.730 Done waiting for MPlayer to finish loading
Wed 5/12 14:34:12.731 Waiting for MPlayer to pass time:0
Wed 5/12 14:34:22.732 Done waiting for MPlayer to pass time:0
Wed 5/12 14:34:22.733 Execute media command 24
Wed 5/12 14:34:22.735 Execute media command 27
Wed 5/12 14:34:22.736 Sending mplayer command:volume 100 1
Wed 5/12 14:34:22.737 Execute media command 18
Wed 5/12 14:34:22.738 Execute media command 21
Wed 5/12 14:34:23.791 Execute media command 17
Wed 5/12 14:34:24.789 Execute media command 17
Wed 5/12 14:34:25.784 Execute media command 17
The reason is that I was running VMWare Player that also uses Alsa to send sound from the guest VM to host. It doesnt seems to conflict with any other application using the default PulseAudio in Ubuntu, just with SageTV Placeshifter.

When I disconnected the sound card from VMWare Player, the placeshifter is now able to play the music

Code:
Wed 5/12 14:35:16.355 stdout:==========================================================================
Wed 5/12 14:35:16.356 stdout:Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
Wed 5/12 14:35:16.356 stdout:AUDIO: 44100 Hz, 2 ch, s16le, 128.0 kbit/9.07% (ratio: 16000->176400)
Wed 5/12 14:35:16.356 stdout:ID_AUDIO_BITRATE=128000
Wed 5/12 14:35:16.356 stdout:ID_AUDIO_RATE=44100
Wed 5/12 14:35:16.356 stdout:ID_AUDIO_NCH=2
Wed 5/12 14:35:16.357 stdout:Selected audio codec: [mp3] afm: mp3lib (mp3lib MPEG layer-2, layer-3)
Wed 5/12 14:35:16.357 stdout:==========================================================================
Wed 5/12 14:35:16.529 stdout:AO: [alsa] 44100Hz 2ch s16le (2 bytes per sample)
Wed 5/12 14:35:16.530 stdout:ID_AUDIO_CODEC=mp3
Wed 5/12 14:35:16.530 stdout:Video: no video
Wed 5/12 14:35:16.530 Done waiting for MPlayer to finish loading
Wed 5/12 14:35:16.531 Waiting for MPlayer to pass time:0
Wed 5/12 14:35:16.589 Done waiting for MPlayer to pass time:0
Wed 5/12 14:35:16.590 Execute media command 24
Wed 5/12 14:35:16.590 Execute media command 27
Wed 5/12 14:35:16.591 Sending mplayer command:volume 100 1
Wed 5/12 14:35:16.592 Execute media command 18
Wed 5/12 14:35:16.593 Execute media command 21
Wed 5/12 14:35:16.688 stderr:[AO_ALSA] Unable to find simple control 'PCM',0.
Wed 5/12 14:35:16.691 stdout:[Mixer] No hardware mixing, inserting volume filter.
Wed 5/12 14:35:16.722 stderr:[AO_ALSA] Unable to find simple control 'PCM',0.
Wed 5/12 14:35:17.794 Execute media command 17
But it seems that Placeshifter is not compatible with Ubuntu 10.04 PulseAudio, because when I go to Ubuntu Volume Control and i look at the Applications tab, it doesn't show Placeshifter playing sound, even though it is playing.

Now lets see if I can get it playing more than one song in a row :-)
__________________

TV: Samsung UN46D8000
Server: Intel Core i3 540, 4G RAM, Matrox G450, 70GB EXT3 encrypted software RAID1 system drive, 1TB XFS tv recording drive, 2TB EXT3 encrypted data drive mirror across 2 machines, 2TB EXT3 encrypted media drive mirror across 2 machines, CentOS 6 64 bit, Experimenting with DNLA servers
1Gb wired network
Disconnected after G day[HD 100 Media Extender, Placeshifter 7.x, SageTV 7.x, HDHomeRun]
Reply With Quote
Reply


Currently Active Users Viewing This Thread: 1 (0 members and 1 guests)
 

Posting Rules
You may not post new threads
You may not post replies
You may not post attachments
You may not edit your posts

BB code is On
Smilies are On
[IMG] code is On
HTML code is Off

Forum Jump

Similar Threads
Thread Thread Starter Forum Replies Last Post
music files don't play wammer23 SageTV Beta Test Software 4 11-30-2008 11:01 AM
Play a music CD ? rv73 SageMC Custom Interface 3 07-23-2008 03:52 AM
Can't get Music to Play on Placeshifter wheelrandolph SageTV Beta Test Software 4 07-16-2007 11:26 AM
What does it take for Sage to play all music!! nyplayer SageTV Software 4 05-24-2007 08:55 AM
Can't Play Music mkelly4ca SageTV Software 1 10-21-2005 09:48 AM


All times are GMT -6. The time now is 04:16 PM.


Powered by vBulletin® Version 3.8.11
Copyright ©2000 - 2023, vBulletin Solutions Inc.
Copyright 2003-2005 SageTV, LLC. All rights reserved.