Call for tester for 1.4.0 features and fixes (3 Viewers)

[tourettes]

Only issue I experienced until now is when playing audio file (mp3) and turn off/on receiver, MP crashes.

That could be BASS player related. But logs will tell.

 

[edterbak]

OH, sorry... pressed wrong button. edited your post by accident...

Wanted to say:
Logs and more are in previous post.

 

[Scythe42]

when playing audio file (mp3) and turn off/on receiver, MP crashes.

That's related to http://mantis.team-mediaportal.com/view.php?id=4173. You won't see evidence of the crash in the log itself. But from the log I see that you are using a HDMI audio device that gets removed and added from the system as the receiver disconnects/connects. And that's basically is Mantis #4173.

timebar during playback isnt showing actual position but end only. This is in titan and DW. see screenshot.

Looks like a child of http://mantis.team-mediaportal.com/view.php?id=4129. Maybe another instance where old values are showing through when new ones are not yet set or couldn't be set. Probably need to reset the "current position" as well.

Can you reproduce this on demand?

 

[edterbak]

Can you reproduce this on demand?

Yes, every instance.

Note: I did a clean install of RC version 4 from dev forum. (Damn nearly lost my complete database.... sigh) Then past your files over it.

 

[Scythe42]

Please describe the steps exactly how to reproduce. Because when I start playback of a movie from videos in folder list view on my HDD and hit "y" once playback starts I don't see that.

So please exactly what views, player and what commands (keypress is easiest) are involved until you came to that screenshot.

 

[edterbak]

From the top of my head (Im currently at work and will actually reproduce once again tonight):

It was during the logfile "MediaPortalLogs_17_01_13__23_17". I also created the screenshot during that logfile. Maybe you can retrace that keypress??
I think it was after I switched from Titan to DW skin.
Played a file and press the INFO button on my MCE remote (=harmoney as MCE).

Views: all default after clean installation. Player Default using LAV .. all default.

I will retest tonight.

 

[infinite.loop]

Build_007.7z

1. Start MP
2. While in basic homescreen, switch AV-Receiver to a different input (always triggers the original half size issue here)
3. switch back to the HTPC input
4. takes some time, but MP does then show up again in fullscreen!
5. again switch AV-Receiver to a different input
6. switch back to the HTPC input
7. takes some time, but MP does then show up again in fullscreen!
8. now start playback of an video
9. MP minimizes and starts the playback

Great progress!

 

[infinite.loop]

Build_007.7z

1. Start MP
2. fullscreensplashscreen shows *loading ......*
3. once all is loaded, I get 5 seconds blackscreen until I see the MP gui - this does not happen with plain 1.3.0 beta

1. enter myvideo
2. try to play a ts file recorded by tv-server
3. playback fails

 

[Scythe42]

Big thanks for the logs!

That the file could not be player is caused by this:
2013-01-18 15:37:57.173560 [Info.][MediaPortal(1)]: MediaInfoWrapper.MediaInfoWrapper: VideoDuration : 4924600
...
2013-01-18 15:37:58.401410 [Info.][MediaPortal(1)]: TSReaderPlayer: position:0, duration:-1
...
2013-01-18 15:37:58.802433 [Info.][MediaPortal(1)]: TSReaderPlayer : currentPos > duration

Didn't touch TSReaderPlayer at all. But remember these builds always include current master as well. Is this reproducible for you with the file? It's not related to any change I made.

The minimizing to tray:

The refresh rate changer creates an invisible windows that steals focus shortly. I compensated for that. Probably resetting the tracking variable (that RR is in progress) to false comes a bit too quick on your system. I'll add a Thread.Sleep of 500ms here, so that the RR in progress stays longer "alive" than the actual RR change does. Has no impact on anything beside that deactivation requests are not obeyed during that time. Probably 100ms should be way enough. Let's give it 250ms to be on the safe side.

5 second blackscreen:
2013-01-18 15:37:12.771078 [Info.][MediaPortal(1)]: Load plugins from : D:\HTPC\MediaPortal\Plugins\windows\Micropolis.MPCore.dll
2013-01-18 15:37:12.771078 [Info.][MediaPortal(1)]: File Version : 1.0.0.0
2013-01-18 15:37:12.786678 [Info.][MediaPortal(1)]: Load plugins from : D:\HTPC\MediaPortal\Plugins\windows\MovingPictures.dll
2013-01-18 15:37:12.802278 [Info.][MediaPortal(1)]: File Version : 1.3.1.1350
2013-01-18 15:37:12.880278 [Info.][MediaPortal(1)]: SQLLiteClient: database is remote
2013-01-18 15:37:15.142282 [Info.][MediaPortal(1)]: Load plugins from : D:\HTPC\MediaPortal\Plugins\windows\MP-TVSeries.dll
2013-01-18 15:37:15.157882 [Info.][MediaPortal(1)]: File Version : 3.4.0.1994
2013-01-18 15:37:15.204682 [Info.][MediaPortal(1)]: SQLLiteClient: database is remote
2013-01-18 15:37:19.447890 [Info.][MediaPortal(1)]: Load plugins from : D:\HTPC\MediaPortal\Plugins\windows\MyLyrics.dll
2013-01-18 15:37:19.463490 [Info.][MediaPortal(1)]: File Version : 1.7.0.67
2013-01-18 15:37:19.479090 [Info.][MediaPortal(1)]: Load plugins from : D:\HTPC\MediaPortal\Plugins\windows\OnlineVideos.MediaPortal1.dll
2013-01-18 15:37:19.479090 [Info.][MediaPortal(1)]: File Version : 1.4.0.2523

...later...

2013-01-18 15:37:25.609901 [Info.][MediaPortal(1)]: SQLLiteClient: database is remote
2013-01-18 15:37:28.043505 [Info.][MediaPortal(1)]: LatestMediaHandler Translation: Cannot find translation file C:\ProgramData\Team MediaPortal\MediaPortal\Language\LatestMediaHandler\de.xml. Failing back to English
2013-01-18 15:37:28.059105 [Debug][MediaPortal(1)]: MusicDatabase: GetSongsByFilter - SQL: select distinct strAlbumArtist, strAlbum, dateAdded, strGenre, strPath from tracks order by dateAdded desc limit 50;, Filter: tracks
2013-01-18 15:37:28.683106 [Info.][MediaPortal(1)]: SQLLiteClient: database is remote
2013-01-18 15:37:29.213507 [Info.][MediaPortal(1)]: SQLiteClient: Closing database: PictureDatabase.db3
2013-01-18 15:37:32.146312 [Info.][MediaPortal(1)]: Starting PowerScheduler client plugin...

...more delays follow...

With this patch the splash screen closes as soon as possible and MP tries to render the GUI as soon as possible. Without the patch there was the possibility of an additional delay that was just showing the splash screen longer. I removed this as it speeds up startup time. MP will try to take control as soon as possible to increase start time, if anything else blocks the first rendering it's a bug somewhere else. A plugin might not be ready when started over basic home, but that is not MP's fault. In fact a SpinControl could be shown in the GUI if this is the case.

What I notice are the huge delay for network access. Guess your D is not local. The SQLClientLight Loading is part of MP I guess. It should happen in its own thread. They can run in parallel. Would increase startup time for your by several second.

There are more strange delays in your log without anything logged in between. And that's for stuff that should happen right after each other. Anything else located on the network drive beside the SQL Databases? Maybe the whole Mediaportal Dir from ProgramData?

Also there is roughly another 4 second delay before Basic Home comes up where nothing else is logged in between. Guess this is the delay you were seeing. For me it's about 100-150ms after the SplashScreen closes and Basic Home is visible.

Also why is network access so slow? Are you running over a VPN on limited bandwidth? In the time it take to load the very small SQL DBs I can copy whole TV Show episodes over my LAN.

And I heard of people having sex in that time Not me... I mean not that quick.

There is really something else wrong here in regards to LAN access in your setup. Dead Slow Ahead.

Some more info about your setup would really be appreciated.

The short delays before MP comes back:

What happens here exactly? Do you don't see anything or the wrong size until it comes back? Or doesn't it react right away?

 

[infinite.loop]

Big thanks for the logs!



That the file could not be player is caused by this:

2013-01-18 15:37:57.173560 [Info.][MediaPortal(1)]: MediaInfoWrapper.MediaInfoWrapper: VideoDuration : 4924600
...
2013-01-18 15:37:58.401410 [Info.][MediaPortal(1)]: TSReaderPlayer: position:0, duration:-1
...
2013-01-18 15:37:58.802433 [Info.][MediaPortal(1)]: TSReaderPlayer : currentPos > duration

Didn't touch TSReaderPlayer at all. But remember these builds always include current master as well. Is this reproducible for you with the file? It's not related to any change I made.

Only happens when I apply the binaries from the first post. 100% reproducible.
1.3.0 Beta works just fine.

There are more strange delays in your log without anything logged in between. And that's for stuff that should happen right after each other. Anything else located on the network drive beside the SQL Databases? Maybe the whole Mediaportal Dir from ProgramData?

MP is installed locally. C: and D: is on the HDD of the HTPC.

I use MP Dirs for:

  <Dir id = "Config">
	<Path>\\mainframe\htpc\Configurations\HTPC-bedroom\Config</Path>
  </Dir>
  <Dir id = "Log">
	<Path>\\mainframe\htpc\Configurations\HTPC-bedroom\Log\</Path>
  </Dir>
  <Dir id = "Database">
	<Path>\\mainframe\HTPC\Configurations\General\Database\</Path>
  </Dir>
  <Dir id = "Thumbs">
	<Path>\\mainframe\htpc\Configurations\General\Thumbs\</Path>
  </Dir>

All those folders are located on my Server, on an SSD.
All systems use Windows 7 64bit prof, and I use a 1Gb LAN.

There are no noticeable slowdowns on my LAN when copying files, or starting playbacks.

The short delays before MP comes back:



What happens here exactly? Do you don't see anything or the wrong size until it comes back? Or doesn't it react right away?

TV stays black until MP shows up fullscreen. Works as intended I'd say.