LG BD-390

I will try provide you the packet sniff from the player.

Would be great, as I tried to look at it using Intel UPnP tools and cannot see anything interesting there. It might require the actual device.

Actually it looks like the player supports subtitles over DLNA, Nero 4 can apparently play it. Will have a look and try to implement it. Testers welcome

I'd be happy to help test it Zip. I don't watch a lot of films with subtitles, but a few here and there. So, it would be a "nice to have" feature, and would save a lot of time in having to hard code the subtitles.

Will have a look and try to implement it. Testers welcome

Count on me!

Also Zip, in the latest ver.0.4, I am noticing that High Def content in files greater than 1GB on average sometimes freeze mid-way and then start up again with the audio lagging behind the video. I figured out that if I rewind a bit and hit play again, the audio and video get back in sync. Any ideas?

This is the log created when i try to play a video with subs:

  Code:

2010-06-02 22:17:30,125 INFO  [MediaServer] ------------------------------------------------------------------------
2010-06-02 22:17:30,125 INFO  [MediaServer] Serviio DLNA media streaming server v 0.4
2010-06-02 22:17:30,125 INFO  [MediaServer] Petr Nejedly 2009-2010
2010-06-02 22:17:30,125 INFO  [MediaServer] http://www.serviio.org
2010-06-02 22:17:30,125 INFO  [MediaServer]
2010-06-02 22:17:30,125 INFO  [MediaServer] Java 1.6.0_20-Sun Microsystems Inc.
2010-06-02 22:17:30,125 INFO  [MediaServer] OS Windows XP x86 5.1
2010-06-02 22:17:30,125 INFO  [MediaServer] File encoding: windows-1252
2010-06-02 22:17:30,125 INFO  [MediaServer] ------------------------------------------------------------------------
2010-06-02 22:17:30,140 INFO  [ORBServer] Starting Corba server exposed on localhost:23423
2010-06-02 22:17:30,140 INFO  [NamingService] Starting Corba Naming service on port 23423
2010-06-02 22:17:30,140 DEBUG [NamingService] Executing: c:\archivos de programa\java\jre6\bin\tnameserv -ORBInitialPort 23423
2010-06-02 22:17:30,812 DEBUG [ORBServer] Registering objects with the ORB
2010-06-02 22:17:30,890 DEBUG [ORBServer] Starting ORB
2010-06-02 22:17:30,890 INFO  [DBSchemaUpdateExecutor] Checking if DB schema needs to be updated
2010-06-02 22:17:30,890 DEBUG [DBLogDAOImpl] Checking if script 'script-0.1.sql' has been run
2010-06-02 22:17:31,546 DEBUG [DBLogDAOImpl] Checking if script 'script-0.1.1.sql' has been run
2010-06-02 22:17:31,546 DEBUG [DBLogDAOImpl] Checking if script 'script-0.2.sql' has been run
2010-06-02 22:17:31,546 DEBUG [DBLogDAOImpl] Checking if script 'script-0.3.1.sql' has been run
2010-06-02 22:17:31,546 DEBUG [DBLogDAOImpl] Checking if script 'script-0.4.sql' has been run
2010-06-02 22:17:31,625 INFO  [ProfilesDefinitionParser] Parsing Profiles definition
2010-06-02 22:17:31,640 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 1
2010-06-02 22:17:31,718 INFO  [ProfilesDefinitionParser] Added profile 'Generic DLNA profile' (id=1)
2010-06-02 22:17:31,718 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 2
2010-06-02 22:17:31,750 INFO  [ProfilesDefinitionParser] Added profile 'Samsung WiselinkPro' (id=2)
2010-06-02 22:17:31,750 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 3
2010-06-02 22:17:31,781 INFO  [ProfilesDefinitionParser] Added profile 'XBox 360' (id=3)
2010-06-02 22:17:31,781 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 4
2010-06-02 22:17:31,796 INFO  [ProfilesDefinitionParser] Added profile 'Playstation 3' (id=4)
2010-06-02 22:17:31,796 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 5
2010-06-02 22:17:31,812 INFO  [ProfilesDefinitionParser] Added profile 'Samsung WiselinkPro (TV A-series)' (id=5)
2010-06-02 22:17:31,812 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 6
2010-06-02 22:17:31,828 INFO  [ProfilesDefinitionParser] Added profile 'DirecTV HD-DVR' (id=6)
2010-06-02 22:17:31,828 DEBUG [ConfigEntryDAOImpl] Reading all ConfigEntries
2010-06-02 22:17:31,843 DEBUG [RepositoryDAOImpl] Reading all Repositories
2010-06-02 22:17:31,859 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type AUDIO
2010-06-02 22:17:31,875 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type VIDEO
2010-06-02 22:17:31,875 DEBUG [FFMPEGWrapper] Invoking FFMPEG to check if it exists of path C:\Archivos de programa\Serviio\bin\\..\lib/ffmpeg.exe
2010-06-02 22:17:31,875 DEBUG [ProcessExecutor] Starting C:\Archivos de programa\Serviio\bin\\..\lib/ffmpeg.exe
2010-06-02 22:17:31,906 INFO  [VideoDeliveryEngine] Cleaning transcode engine and its data
2010-06-02 22:17:31,921 INFO  [WebServer] WebServer starting on port 8895
2010-06-02 22:17:32,078 INFO  [Device] Created UPnP Device with UUID: 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8, bound address: 10.0.1.4
2010-06-02 22:17:32,093 DEBUG [DiscoveryManager] UPNP device 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8 is available
2010-06-02 22:17:32,093 INFO  [DiscoveryAdvertisementNotifier] Starting DiscoveryAdvertisementNotifier
2010-06-02 22:17:32,093 INFO  [DiscoverySearchListener] Starting DiscoverySearchListener using interface 10.0.1.4
2010-06-02 22:17:32,093 INFO  [EventSubscriptionExpirationChecker] Starting EventSubscriptionExpirationChecker
2010-06-02 22:17:32,093 INFO  [EventDispatcher] Starting EventDispatcher
2010-06-02 22:17:32,125 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface 10.0.1.4
2010-06-02 22:17:32,125 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8
2010-06-02 22:17:32,125 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 1428189 ms
2010-06-02 22:17:32,156 DEBUG [WebServer] Incoming connection from /10.0.1.4:1166
2010-06-02 22:17:32,156 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8 from null
2010-06-02 22:17:32,296 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Generic DLNA profile'
2010-06-02 22:17:32,359 DEBUG [WebServer] Incoming connection from /10.0.1.4:1170
2010-06-02 22:17:32,359 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ConnectionManager
2010-06-02 22:17:32,359 DEBUG [WebServer] Incoming connection from /10.0.1.4:1171
2010-06-02 22:17:32,359 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ContentDirectory
2010-06-02 22:17:32,359 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-06-02 22:17:32,359 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-06-02 22:17:52,093 INFO  [LibraryAdditionsCheckerThread] Started looking for newly added files
2010-06-02 22:17:52,093 DEBUG [RepositoryDAOImpl] Reading all Repositories
2010-06-02 22:17:52,093 INFO  [LibraryUpdatesCheckerThread] Started looking for updates to currently shared files
2010-06-02 22:17:52,093 DEBUG [RepositoryDAOImpl] Reading all Repositories
2010-06-02 22:17:52,093 DEBUG [LibraryAdditionsCheckerThread] Looking for files to share in folder: C:\Documents and Settings\Palma\Escritorio\prueba
2010-06-02 22:17:52,093 DEBUG [LibraryUpdatesCheckerThread] Looking for removed files in repository: C:\Documents and Settings\Palma\Escritorio\prueba
2010-06-02 22:17:52,093 DEBUG [MediaItemDAOImpl] Reading MediaItems for Repository (id = 1)
2010-06-02 22:17:52,125 DEBUG [LibraryAdditionsCheckerThread] Found file 'HIMYM_S05E24.avi', checking if it's already in the Library
2010-06-02 22:17:52,125 DEBUG [MediaItemDAOImpl] Checking if DB already contains media item HIMYM_S05E24.avi
2010-06-02 22:17:52,171 DEBUG [MediaItemDAOImpl] Media item HIMYM_S05E24.avi already exists in DB
2010-06-02 22:17:52,250 DEBUG [MediaItemDAOImpl] Getting file of media item 1
2010-06-02 22:17:52,265 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type AUDIO
2010-06-02 22:17:52,265 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type VIDEO
2010-06-02 22:17:52,265 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type IMAGE
2010-06-02 22:17:52,265 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 1) and extractor EMBEDDED
2010-06-02 22:17:52,281 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 1) and extractor COVER_IMAGE_IN_FOLDER
2010-06-02 22:17:52,281 DEBUG [LibraryUpdatesCheckerThread] Updating dirty metadata
2010-06-02 22:17:52,281 DEBUG [MediaItemDAOImpl] Reading dirty MediaItems for Repository (id = 1)
2010-06-02 22:17:58,640 DEBUG [WebServer] Socket closed
2010-06-02 22:17:58,640 INFO  [WebServer] WebServer shutting down
2010-06-02 22:17:58,640 DEBUG [DiscoveryManager] UPNP device 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8 is unavailable
2010-06-02 22:17:58,640 INFO  [DiscoveryAdvertisementNotifier] Leaving DiscoveryAdvertisementNotifier
2010-06-02 22:17:58,640 INFO  [EventSubscriptionExpirationChecker] Leaving EventSubscriptionExpirationChecker, removing all event subscriptions
2010-06-02 22:17:58,640 INFO  [EventDispatcher] Leaving EventDispatcher
2010-06-02 22:17:58,640 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP byebye using interface 10.0.1.4
2010-06-02 22:17:58,656 INFO  [DiscoverySearchListener] Leaving DiscoverySearchListener
2010-06-02 22:17:58,656 INFO  [DatabaseManager] Shutting down database
2010-06-02 22:17:58,656 DEBUG [DBConnectionPool] Closed connection for pool Serviio DB Pool
2010-06-02 22:17:58,656 DEBUG [DBConnectionPool] Closed connection for pool Serviio DB Pool
2010-06-02 22:17:58,750 DEBUG [DatabaseManager] DB shutdown returned: Derby system shutdown.
2010-06-02 22:17:58,750 INFO  [ORBServer] Stopped Corba server
2010-06-02 22:17:58,750 INFO  [VideoDeliveryEngine] Cleaning transcode engine and its data
2010-06-02 22:18:06,765 DEBUG [ApplicationInstanceManager] Listening for application instances on socket 44331
2010-06-02 22:18:06,781 INFO  [MediaServer] ------------------------------------------------------------------------
2010-06-02 22:18:06,781 INFO  [MediaServer] Serviio DLNA media streaming server v 0.4
2010-06-02 22:18:06,781 INFO  [MediaServer] Petr Nejedly 2009-2010
2010-06-02 22:18:06,781 INFO  [MediaServer] http://www.serviio.org
2010-06-02 22:18:06,781 INFO  [MediaServer]
2010-06-02 22:18:06,781 INFO  [MediaServer] Java 1.6.0_20-Sun Microsystems Inc.
2010-06-02 22:18:06,781 INFO  [MediaServer] OS Windows XP x86 5.1
2010-06-02 22:18:06,781 INFO  [MediaServer] File encoding: windows-1252
2010-06-02 22:18:06,781 INFO  [MediaServer] ------------------------------------------------------------------------
2010-06-02 22:18:06,796 INFO  [ORBServer] Starting Corba server exposed on localhost:23423
2010-06-02 22:18:06,796 INFO  [NamingService] Starting Corba Naming service on port 23423
2010-06-02 22:18:06,796 DEBUG [NamingService] Executing: c:\archivos de programa\java\jre6\bin\tnameserv -ORBInitialPort 23423
2010-06-02 22:18:07,453 DEBUG [ORBServer] Registering objects with the ORB
2010-06-02 22:18:07,531 DEBUG [ORBServer] Starting ORB
2010-06-02 22:18:07,531 INFO  [DBSchemaUpdateExecutor] Checking if DB schema needs to be updated
2010-06-02 22:18:07,531 DEBUG [DBLogDAOImpl] Checking if script 'script-0.1.sql' has been run
2010-06-02 22:18:08,234 DEBUG [DBLogDAOImpl] Checking if script 'script-0.1.1.sql' has been run
2010-06-02 22:18:08,234 DEBUG [DBLogDAOImpl] Checking if script 'script-0.2.sql' has been run
2010-06-02 22:18:08,234 DEBUG [DBLogDAOImpl] Checking if script 'script-0.3.1.sql' has been run
2010-06-02 22:18:08,234 DEBUG [DBLogDAOImpl] Checking if script 'script-0.4.sql' has been run
2010-06-02 22:18:08,312 INFO  [ProfilesDefinitionParser] Parsing Profiles definition
2010-06-02 22:18:08,312 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 1
2010-06-02 22:18:08,406 INFO  [ProfilesDefinitionParser] Added profile 'Generic DLNA profile' (id=1)
2010-06-02 22:18:08,406 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 2
2010-06-02 22:18:08,437 INFO  [ProfilesDefinitionParser] Added profile 'Samsung WiselinkPro' (id=2)
2010-06-02 22:18:08,437 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 3
2010-06-02 22:18:08,453 INFO  [ProfilesDefinitionParser] Added profile 'XBox 360' (id=3)
2010-06-02 22:18:08,453 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 4
2010-06-02 22:18:08,468 INFO  [ProfilesDefinitionParser] Added profile 'Playstation 3' (id=4)
2010-06-02 22:18:08,468 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 5
2010-06-02 22:18:08,500 INFO  [ProfilesDefinitionParser] Added profile 'Samsung WiselinkPro (TV A-series)' (id=5)
2010-06-02 22:18:08,500 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 6
2010-06-02 22:18:08,515 INFO  [ProfilesDefinitionParser] Added profile 'DirecTV HD-DVR' (id=6)
2010-06-02 22:18:08,515 DEBUG [ConfigEntryDAOImpl] Reading all ConfigEntries
2010-06-02 22:18:08,515 DEBUG [RepositoryDAOImpl] Reading all Repositories
2010-06-02 22:18:08,546 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type AUDIO
2010-06-02 22:18:08,562 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type VIDEO
2010-06-02 22:18:08,562 DEBUG [FFMPEGWrapper] Invoking FFMPEG to check if it exists of path C:\Archivos de programa\Serviio\bin\\..\lib/ffmpeg.exe
2010-06-02 22:18:08,562 DEBUG [ProcessExecutor] Starting C:\Archivos de programa\Serviio\bin\\..\lib/ffmpeg.exe
2010-06-02 22:18:08,593 INFO  [VideoDeliveryEngine] Cleaning transcode engine and its data
2010-06-02 22:18:08,609 INFO  [WebServer] WebServer starting on port 8895
2010-06-02 22:18:08,765 INFO  [Device] Created UPnP Device with UUID: 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8, bound address: 10.0.1.4
2010-06-02 22:18:08,781 DEBUG [DiscoveryManager] UPNP device 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8 is available
2010-06-02 22:18:08,781 INFO  [DiscoveryAdvertisementNotifier] Starting DiscoveryAdvertisementNotifier
2010-06-02 22:18:08,781 INFO  [DiscoverySearchListener] Starting DiscoverySearchListener using interface 10.0.1.4
2010-06-02 22:18:08,781 INFO  [EventSubscriptionExpirationChecker] Starting EventSubscriptionExpirationChecker
2010-06-02 22:18:08,781 INFO  [EventDispatcher] Starting EventDispatcher
2010-06-02 22:18:08,843 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface 10.0.1.4
2010-06-02 22:18:08,843 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8
2010-06-02 22:18:08,843 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 1221379 ms
2010-06-02 22:18:08,890 DEBUG [WebServer] Incoming connection from /10.0.1.4:1182
2010-06-02 22:18:08,890 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8 from null
2010-06-02 22:18:09,031 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Generic DLNA profile'
2010-06-02 22:18:09,093 DEBUG [WebServer] Incoming connection from /10.0.1.4:1186
2010-06-02 22:18:09,093 DEBUG [WebServer] Incoming connection from /10.0.1.4:1187
2010-06-02 22:18:09,093 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ConnectionManager
2010-06-02 22:18:09,093 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ContentDirectory
2010-06-02 22:18:09,093 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-06-02 22:18:09,156 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-06-02 22:18:28,781 INFO  [LibraryUpdatesCheckerThread] Started looking for updates to currently shared files
2010-06-02 22:18:28,781 DEBUG [RepositoryDAOImpl] Reading all Repositories
2010-06-02 22:18:28,781 DEBUG [LibraryUpdatesCheckerThread] Looking for removed files in repository: C:\Documents and Settings\Palma\Escritorio\prueba
2010-06-02 22:18:28,781 DEBUG [MediaItemDAOImpl] Reading MediaItems for Repository (id = 1)
2010-06-02 22:18:28,796 INFO  [LibraryAdditionsCheckerThread] Started looking for newly added files
2010-06-02 22:18:28,796 DEBUG [RepositoryDAOImpl] Reading all Repositories
2010-06-02 22:18:28,796 DEBUG [LibraryAdditionsCheckerThread] Looking for files to share in folder: C:\Documents and Settings\Palma\Escritorio\prueba
2010-06-02 22:18:28,812 DEBUG [LibraryAdditionsCheckerThread] Found file 'HIMYM_S05E24.avi', checking if it's already in the Library
2010-06-02 22:18:28,812 DEBUG [MediaItemDAOImpl] Checking if DB already contains media item HIMYM_S05E24.avi
2010-06-02 22:18:28,875 DEBUG [MediaItemDAOImpl] Media item HIMYM_S05E24.avi already exists in DB
2010-06-02 22:18:28,953 DEBUG [MediaItemDAOImpl] Getting file of media item 1
2010-06-02 22:18:28,968 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type AUDIO
2010-06-02 22:18:28,968 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type VIDEO
2010-06-02 22:18:28,968 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type IMAGE
2010-06-02 22:18:28,984 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 1) and extractor EMBEDDED
2010-06-02 22:18:28,984 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 1) and extractor COVER_IMAGE_IN_FOLDER
2010-06-02 22:18:28,984 DEBUG [LibraryUpdatesCheckerThread] Updating dirty metadata
2010-06-02 22:18:28,984 DEBUG [MediaItemDAOImpl] Reading dirty MediaItems for Repository (id = 1)
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /127.0.0.1:1195
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /127.0.0.1:1195
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:23,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:23,109 DEBUG [WebServer] Incoming connection from /10.0.1.4:1196
2010-06-02 22:20:23,109 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8 from null
2010-06-02 22:20:23,109 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Generic DLNA profile'
2010-06-02 22:20:23,187 DEBUG [WebServer] Incoming connection from /10.0.1.4:1203
2010-06-02 22:20:23,187 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ConnectionManager
2010-06-02 22:20:23,187 DEBUG [WebServer] Incoming connection from /10.0.1.4:1204
2010-06-02 22:20:23,187 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ContentDirectory
2010-06-02 22:20:23,187 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-06-02 22:20:23,250 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-06-02 22:20:56,203 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /10.0.1.2:50906
2010-06-02 22:20:56,203 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:56,296 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /10.0.1.2:50906
2010-06-02 22:20:56,312 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:56,406 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /10.0.1.2:50906
2010-06-02 22:20:56,406 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:56,484 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /10.0.1.2:50906
2010-06-02 22:20:56,484 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /10.0.1.2:50906
2010-06-02 22:20:56,484 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /10.0.1.2:50906
2010-06-02 22:20:56,484 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:56,484 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:56,484 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:20:59,000 DEBUG [WebServer] Incoming connection from /10.0.1.2:59863
2010-06-02 22:20:59,000 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 589e9dd0-b928-3c1d-8dbf-f6f400f8f8d8 from Linux/2.6.24.7.0909171-REL UPnP/1.0 DLNADOC/1.50 INTEL_NMPR/2.0 LG_DLNA_SDK/1.5.0
2010-06-02 22:20:59,000 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Generic DLNA profile'
2010-06-02 22:20:59,062 DEBUG [WebServer] Incoming connection from /10.0.1.2:59864
2010-06-02 22:20:59,062 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ConnectionManager
2010-06-02 22:20:59,062 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-06-02 22:20:59,125 DEBUG [WebServer] Incoming connection from /10.0.1.2:59865
2010-06-02 22:20:59,125 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ContentDirectory
2010-06-02 22:20:59,125 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-06-02 22:21:02,937 DEBUG [WebServer] Incoming connection from /10.0.1.2:59866
2010-06-02 22:21:02,937 DEBUG [ServiceEventSubscriptionRequestHandler] ServiceEvent subscription request received for service ConnectionManager
2010-06-02 22:21:02,937 DEBUG [ServiceEventSubscriptionRequestHandler] Event subscription registered (uuid=172f815c-e75b-4f33-9e9b-1c08fe6b02e7) for service urn:upnp-org:serviceId:ConnectionManager reporting to http://10.0.1.2:43777/
2010-06-02 22:21:02,953 DEBUG [WebServer] Incoming connection from /10.0.1.2:59867
2010-06-02 22:21:02,953 DEBUG [ServiceEventSubscriptionRequestHandler] ServiceEvent subscription request received for service ContentDirectory
2010-06-02 22:21:02,953 DEBUG [ServiceEventSubscriptionRequestHandler] Event subscription registered (uuid=55721c52-533a-422d-a14a-84252f1b59d2) for service urn:upnp-org:serviceId:ContentDirectory reporting to http://10.0.1.2:43777/
2010-06-02 22:21:03,312 DEBUG [EventDispatcher] Sending event notification #0 for subscription 55721c52-533a-422d-a14a-84252f1b59d2 to endpoint http://10.0.1.2:43777/
2010-06-02 22:21:03,328 DEBUG [RequestExecutor] Sending HTTP request to 10.0.1.2:43777
2010-06-02 22:21:03,343 DEBUG [EventDispatcher] Event notification sent and received successfully
2010-06-02 22:21:03,343 DEBUG [EventDispatcher] Sending event notification #0 for subscription 172f815c-e75b-4f33-9e9b-1c08fe6b02e7 to endpoint http://10.0.1.2:43777/
2010-06-02 22:21:03,343 DEBUG [RequestExecutor] Sending HTTP request to 10.0.1.2:43777
2010-06-02 22:21:03,375 DEBUG [EventDispatcher] Event notification sent and received successfully
2010-06-02 22:21:03,859 DEBUG [WebServer] Incoming connection from /10.0.1.2:59868
2010-06-02 22:21:03,859 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from Linux/2.6.24.7.0909171-REL UPnP/1.0 DLNADOC/1.50 INTEL_NMPR/2.0 LG_DLNA_SDK/1.5.0:
2010-06-02 22:21:03,906 DEBUG [ContentDirectory] Browse() called for profile Generic DLNA profile with parameters: objectID = V_F#FOL_R1, browseFlag = BrowseMetadata, filter = *, startIndex = 0, count = 0, sortCriteria =
2010-06-02 22:21:03,906 INFO  [ContentDirectoryDefinitionParser] Parsing ContentDirectory definition
2010-06-02 22:21:03,906 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=0, title=Serviio Media Library, class=CONTAINER
2010-06-02 22:21:03,921 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=A, title=Audio, class=CONTAINER
2010-06-02 22:21:03,921 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=A_A, title=Artists, class=CONTAINER
2010-06-02 22:21:03,937 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.person.ListArtistsByNameCommand, containerClass=MUSIC_ARTIST, itemClass=null, idPrefix=ART, recursive=false
2010-06-02 22:21:03,937 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListAlbumsForArtistCommand, containerClass=MUSIC_ALBUM, itemClass=null, idPrefix=A, recursive=false
2010-06-02 22:21:03,937 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListSongsForArtistAndAlbumCommand, containerClass=null, itemClass=MUSIC_TRACK, idPrefix=S, recursive=false
2010-06-02 22:21:03,937 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=A_F, title=Folders, class=CONTAINER
2010-06-02 22:21:03,937 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListAudioFoldersByNameCommand, containerClass=STORAGE_FOLDER, itemClass=MUSIC_TRACK, idPrefix=FOL, recursive=true
2010-06-02 22:21:03,953 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=A_G, title=Genres, class=CONTAINER
2010-06-02 22:21:03,953 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListAudioGenresByNameCommand, containerClass=MUSIC_GENRE, itemClass=null, idPrefix=GEN, recursive=false
2010-06-02 22:21:03,953 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListSongsForGenreCommand, containerClass=null, itemClass=MUSIC_TRACK, idPrefix=S, recursive=false
2010-06-02 22:21:03,953 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=A_T, title=Titles, class=CONTAINER
2010-06-02 22:21:03,953 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListSongInitialsCommand, containerClass=CONTAINER, itemClass=null, idPrefix=INI, recursive=false
2010-06-02 22:21:03,953 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListSongsForInitialCommand, containerClass=null, itemClass=MUSIC_TRACK, idPrefix=S, recursive=false
2010-06-02 22:21:03,968 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=A_S, title=All songs, class=CONTAINER
2010-06-02 22:21:03,968 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListAllSongsCommand, containerClass=null, itemClass=MUSIC_TRACK, idPrefix=S, recursive=false
2010-06-02 22:21:03,968 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=A_AS, title=Artist Songs, class=CONTAINER
2010-06-02 22:21:03,968 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.person.ListArtistsByNameCommand, containerClass=MUSIC_ARTIST, itemClass=null, idPrefix=ART_S, recursive=false
2010-06-02 22:21:03,968 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListSongsForArtistCommand, containerClass=null, itemClass=MUSIC_TRACK, idPrefix=S, recursive=false
2010-06-02 22:21:03,968 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=A_ALB, title=All albums, class=CONTAINER
2010-06-02 22:21:03,984 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListAllAlbumsCommand, containerClass=MUSIC_ALBUM, itemClass=null, idPrefix=ALB, recursive=false
2010-06-02 22:21:03,984 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.audio.ListSongsForAlbumCommand, containerClass=null, itemClass=MUSIC_TRACK, idPrefix=S, recursive=false
2010-06-02 22:21:03,984 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=I, title=Image, class=CONTAINER
2010-06-02 22:21:03,984 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=I_A, title=Albums, class=CONTAINER
2010-06-02 22:21:03,984 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.image.ListFlatImageFoldersByNameCommand, containerClass=CONTAINER, itemClass=null, idPrefix=ALB, recursive=false
2010-06-02 22:21:04,000 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.image.ListImagesForFolderCommand, containerClass=null, itemClass=PHOTO, idPrefix=I, recursive=false
2010-06-02 22:21:04,000 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=I_F, title=Folders, class=CONTAINER
2010-06-02 22:21:04,000 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.image.ListImageFoldersByNameCommand, containerClass=STORAGE_FOLDER, itemClass=PHOTO, idPrefix=FOL, recursive=true
2010-06-02 22:21:04,000 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=I_Y, title=Year, class=CONTAINER
2010-06-02 22:21:04,000 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.image.ListImagesCreationYearsCommand, containerClass=CONTAINER, itemClass=null, idPrefix=YEAR, recursive=false
2010-06-02 22:21:04,000 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.image.ListImagesForCreationYearCommand, containerClass=null, itemClass=PHOTO, idPrefix=I, recursive=false
2010-06-02 22:21:04,015 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=I_T, title=Timeline, class=CONTAINER
2010-06-02 22:21:04,015 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.image.ListImagesCreationYearsCommand, containerClass=CONTAINER, itemClass=null, idPrefix=YEAR, recursive=false
2010-06-02 22:21:04,015 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.image.ListImagesCreationMonthsCommand, containerClass=CONTAINER, itemClass=null, idPrefix=MON, recursive=false
2010-06-02 22:21:04,015 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.image.ListImagesForCreationMonthAndYearCommand, containerClass=null, itemClass=PHOTO, idPrefix=I, recursive=false
2010-06-02 22:21:04,015 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=I_AI, title=All images, class=CONTAINER
2010-06-02 22:21:04,015 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.image.ListAllImagesCommand, containerClass=null, itemClass=PHOTO, idPrefix=I, recursive=false
2010-06-02 22:21:04,031 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V, title=Video, class=CONTAINER
2010-06-02 22:21:04,031 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_T, title=All titles, class=CONTAINER
2010-06-02 22:21:04,031 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListVideoInitialsCommand, containerClass=CONTAINER, itemClass=null, idPrefix=INI, recursive=false
2010-06-02 22:21:04,031 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListVideosForInitialCommand, containerClass=null, itemClass=VIDEO_ITEM, idPrefix=V, recursive=false
2010-06-02 22:21:04,031 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_M, title=Movies, class=CONTAINER
2010-06-02 22:21:04,031 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListMovieVideosByNameCommand, containerClass=null, itemClass=VIDEO_ITEM, idPrefix=V, recursive=false
2010-06-02 22:21:04,031 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_S, title=Series, class=CONTAINER
2010-06-02 22:21:04,046 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListSeriesByNameCommand, containerClass=CONTAINER, itemClass=null, idPrefix=SER, recursive=false
2010-06-02 22:21:04,046 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListSeasonsForSeriesCommand, containerClass=CONTAINER, itemClass=null, idPrefix=SSN, recursive=false
2010-06-02 22:21:04,046 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListEpisodesForSeriesSeasonCommand, containerClass=null, itemClass=VIDEO_ITEM, idPrefix=V, recursive=false
2010-06-02 22:21:04,046 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_F, title=Folders, class=CONTAINER
2010-06-02 22:21:04,046 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListVideoFoldersByNameCommand, containerClass=STORAGE_FOLDER, itemClass=VIDEO_ITEM, idPrefix=FOL, recursive=true
2010-06-02 22:21:04,062 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_LV, title=Last viewed, class=CONTAINER
2010-06-02 22:21:04,062 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListLastViewedVideosCommand, containerClass=null, itemClass=VIDEO_ITEM, idPrefix=V, recursive=false
2010-06-02 22:21:04,062 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_LA, title=Last added, class=CONTAINER
2010-06-02 22:21:04,062 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListLastAddedVideosCommand, containerClass=null, itemClass=VIDEO_ITEM, idPrefix=V, recursive=false
2010-06-02 22:21:04,062 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_G, title=Genres, class=CONTAINER
2010-06-02 22:21:04,062 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListVideoGenresByNameCommand, containerClass=CONTAINER, itemClass=null, idPrefix=GEN, recursive=false
2010-06-02 22:21:04,078 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListVideosForGenreCommand, containerClass=null, itemClass=VIDEO_ITEM, idPrefix=V, recursive=false
2010-06-02 22:21:04,078 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_A, title=Actors, class=CONTAINER
2010-06-02 22:21:04,078 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.person.ListActorInitialsCommand, containerClass=CONTAINER, itemClass=null, idPrefix=INI, recursive=false
2010-06-02 22:21:04,078 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.person.ListActorsForInitialCommand, containerClass=PERSON, itemClass=null, idPrefix=P, recursive=false
2010-06-02 22:21:04,078 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListVideosForActorCommand, containerClass=null, itemClass=VIDEO_ITEM, idPrefix=V, recursive=false
2010-06-02 22:21:04,078 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_D, title=Directors, class=CONTAINER
2010-06-02 22:21:04,093 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.person.ListDirectorInitialsCommand, containerClass=CONTAINER, itemClass=null, idPrefix=INI, recursive=false
2010-06-02 22:21:04,093 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.person.ListDirectorsForInitialCommand, containerClass=PERSON, itemClass=null, idPrefix=P, recursive=false
2010-06-02 22:21:04,093 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListVideosForDirectorCommand, containerClass=null, itemClass=VIDEO_ITEM, idPrefix=V, recursive=false
2010-06-02 22:21:04,093 DEBUG [ContentDirectoryDefinitionParser] Found Container node with attributes: id=V_P, title=Producers, class=CONTAINER
2010-06-02 22:21:04,093 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.person.ListProducerInitialsCommand, containerClass=CONTAINER, itemClass=null, idPrefix=INI, recursive=false
2010-06-02 22:21:04,109 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.person.ListProducersForInitialCommand, containerClass=PERSON, itemClass=null, idPrefix=P, recursive=false
2010-06-02 22:21:04,109 DEBUG [ContentDirectoryDefinitionParser] Found Action node with attributes: command=org.serviio.upnp.service.contentdirectory.command.video.ListVideosForProducerCommand, containerClass=null, itemClass=VIDEO_ITEM, idPrefix=V, recursive=false
2010-06-02 22:21:04,109 DEBUG [RepositoryDAOImpl] Reading a Repository (id = 1)
2010-06-02 22:21:04,125 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder null
2010-06-02 22:21:04,156 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-06-02 22:21:04,218 DEBUG [WebServer] Incoming connection from /10.0.1.2:59869
2010-06-02 22:21:04,218 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from Linux/2.6.24.7.0909171-REL UPnP/1.0 DLNADOC/1.50 INTEL_NMPR/2.0 LG_DLNA_SDK/1.5.0:
2010-06-02 22:21:04,218 DEBUG [ContentDirectory] Browse() called for profile Generic DLNA profile with parameters: objectID = V_F#FOL_R1, browseFlag = BrowseDirectChildren, filter = *, startIndex = 0, count = 10, sortCriteria =
2010-06-02 22:21:04,218 DEBUG [FolderDAOImpl] Getting number of sub-Folders in folder null
2010-06-02 22:21:04,234 DEBUG [VideoDAOImpl] Retrieving list of videos for folder 1 (from=0, count=10)
2010-06-02 22:21:04,250 DEBUG [GenreDAOImpl] Reading a Genre (id = 1)
2010-06-02 22:21:04,250 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 1)
2010-06-02 22:21:04,265 DEBUG [MediaItemDAOImpl] Getting file of media item 1
2010-06-02 22:21:04,265 DEBUG [VideoDAOImpl] Reading a Video (id = 1)
2010-06-02 22:21:04,265 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1 and profile Generic DLNA profile
2010-06-02 22:21:04,265 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 1)
2010-06-02 22:21:04,281 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder null
2010-06-02 22:21:04,281 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-06-02 22:21:05,390 DEBUG [WebServer] Incoming connection from /10.0.1.2:59870
2010-06-02 22:21:05,390 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from Linux/2.6.24.7.0909171-REL UPnP/1.0 DLNADOC/1.50 INTEL_NMPR/2.0 LG_DLNA_SDK/1.5.0:
2010-06-02 22:21:05,406 DEBUG [ContentDirectory] Browse() called for profile Generic DLNA profile with parameters: objectID = V_F, browseFlag = BrowseMetadata, filter = *, startIndex = 0, count = 0, sortCriteria =
2010-06-02 22:21:05,406 DEBUG [RepositoryDAOImpl] Retrieving number of repositories for VIDEO
2010-06-02 22:21:05,406 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-06-02 22:21:05,484 DEBUG [WebServer] Incoming connection from /10.0.1.2:59871
2010-06-02 22:21:05,484 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from Linux/2.6.24.7.0909171-REL UPnP/1.0 DLNADOC/1.50 INTEL_NMPR/2.0 LG_DLNA_SDK/1.5.0:
2010-06-02 22:21:05,484 DEBUG [ContentDirectory] Browse() called for profile Generic DLNA profile with parameters: objectID = V_F, browseFlag = BrowseDirectChildren, filter = *, startIndex = 0, count = 10, sortCriteria =
2010-06-02 22:21:05,484 DEBUG [RepositoryDAOImpl] Retrieving list of Repositories for VIDEO (from=0, count=10)
2010-06-02 22:21:05,484 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder null
2010-06-02 22:21:05,484 DEBUG [RepositoryDAOImpl] Retrieving number of repositories for VIDEO
2010-06-02 22:21:05,484 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-06-02 22:21:06,312 DEBUG [WebServer] Incoming connection from /10.0.1.2:59872
2010-06-02 22:21:06,312 DEBUG [ResourceTransportRequestHandler] GET /resource/1/COVER_IMAGE HTTP/1.1, headers = [Host: 10.0.1.4:8895, Accept: */*, ]
2010-06-02 22:21:06,312 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:21:06,312 DEBUG [ResourceTransportRequestHandler] Request for resource 1 and type 'COVER_IMAGE' received
2010-06-02 22:21:06,328 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 1)
2010-06-02 22:21:06,328 DEBUG [CoverImageRetrievalStrategy] Retrieving Cover image with id 1
2010-06-02 22:21:06,328 DEBUG [ResourceTransportRequestHandler] Stream length required: false
2010-06-02 22:21:06,328 DEBUG [ResourceTransportRequestHandler] Creating stream entity with chunked transfer
2010-06-02 22:21:06,328 DEBUG [ResourceTransportRequestHandler] Sending file back
2010-06-02 22:21:06,328 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [Content-Type: image/jpeg, Cache-control: no-cache, Pragma: no-cache, Server: Windows XP UPnP/1.0 Serviio 0.4, transferMode.dlna.org: Interactive, ]
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /127.0.0.1:1195
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /127.0.0.1:1195
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:21,937 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:21,984 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:21:21,984 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:21:21,984 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:21,984 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /127.0.0.1:1195
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /127.0.0.1:1195
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.4:1193
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,046 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,203 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:21:27,203 DEBUG [DiscoverySearchListener] Received a valid M-SEARCH message for search target upnp:rootdevice from address /10.0.1.5:1194
2010-06-02 22:21:27,203 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:21:27,203 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s)
2010-06-02 22:22:06,828 DEBUG [WebServer] Incoming connection from /10.0.1.2:59876
2010-06-02 22:22:06,843 DEBUG [ResourceTransportRequestHandler] GET /resource/1/MEDIA_ITEM HTTP/1.1, headers = [Range: bytes=0-15, Host: 10.0.1.4:8895, Accept: */*, ]
2010-06-02 22:22:06,843 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:06,843 DEBUG [ResourceTransportRequestHandler] Request for resource 1 and type 'MEDIA_ITEM' received
2010-06-02 22:22:06,843 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 1)
2010-06-02 22:22:06,843 DEBUG [VideoDAOImpl] Reading a Video (id = 1)
2010-06-02 22:22:06,843 DEBUG [VideoDeliveryEngine] Delivering item '1' for client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:06,843 DEBUG [VideoDeliveryEngine] Delivering file 'HIMYM_S05E24.avi' in native format
2010-06-02 22:22:06,843 DEBUG [MediaItemDAOImpl] Getting file of media item 1
2010-06-02 22:22:06,843 DEBUG [MediaItemDAOImpl] Marking MediaItem (id = 1) as read
2010-06-02 22:22:06,875 DEBUG [ResourceTransportRequestHandler] Stream length required: true
2010-06-02 22:22:06,875 DEBUG [ResourceTransportRequestHandler] Creating stream entity with length: 16
2010-06-02 22:22:06,875 DEBUG [ResourceTransportRequestHandler] Sending file back
2010-06-02 22:22:06,875 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [Content-Type: video/x-msvideo, Content-Range: bytes 0-15/183268710, Content-Length: 16, Cache-control: no-cache, Pragma: no-cache, Server: Windows XP UPnP/1.0 Serviio 0.4, transferMode.dlna.org: Streaming, ]
2010-06-02 22:22:07,234 DEBUG [WebServer] Incoming connection from /10.0.1.2:59877
2010-06-02 22:22:07,250 DEBUG [ResourceTransportRequestHandler] GET /resource/1/MEDIA_ITEM HTTP/1.1, headers = [Range: bytes=0-51199, Host: 10.0.1.4:8895, Accept: */*, ]
2010-06-02 22:22:07,250 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:07,250 DEBUG [ResourceTransportRequestHandler] Request for resource 1 and type 'MEDIA_ITEM' received
2010-06-02 22:22:07,250 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 1)
2010-06-02 22:22:07,250 DEBUG [VideoDAOImpl] Reading a Video (id = 1)
2010-06-02 22:22:07,250 DEBUG [VideoDeliveryEngine] Delivering item '1' for client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:07,250 DEBUG [VideoDeliveryEngine] Delivering file 'HIMYM_S05E24.avi' in native format
2010-06-02 22:22:07,250 DEBUG [MediaItemDAOImpl] Getting file of media item 1
2010-06-02 22:22:07,250 DEBUG [MediaItemDAOImpl] Marking MediaItem (id = 1) as read
2010-06-02 22:22:07,250 DEBUG [ResourceTransportRequestHandler] Stream length required: true
2010-06-02 22:22:07,250 DEBUG [ResourceTransportRequestHandler] Creating stream entity with length: 51200
2010-06-02 22:22:07,250 DEBUG [ResourceTransportRequestHandler] Sending file back
2010-06-02 22:22:07,250 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [Content-Type: video/x-msvideo, Content-Range: bytes 0-51199/183268710, Content-Length: 51200, Cache-control: no-cache, Pragma: no-cache, Server: Windows XP UPnP/1.0 Serviio 0.4, transferMode.dlna.org: Streaming, ]
2010-06-02 22:22:07,359 DEBUG [ResourceTransportRequestHandler] GET /resource/1/MEDIA_ITEM HTTP/1.1, headers = [Range: bytes=326-409, Host: 10.0.1.4:8895, Accept: */*, ]
2010-06-02 22:22:07,359 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:07,359 DEBUG [ResourceTransportRequestHandler] Request for resource 1 and type 'MEDIA_ITEM' received
2010-06-02 22:22:07,359 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 1)
2010-06-02 22:22:07,359 DEBUG [VideoDAOImpl] Reading a Video (id = 1)
2010-06-02 22:22:07,359 DEBUG [VideoDeliveryEngine] Delivering item '1' for client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:07,359 DEBUG [VideoDeliveryEngine] Delivering file 'HIMYM_S05E24.avi' in native format
2010-06-02 22:22:07,359 DEBUG [MediaItemDAOImpl] Getting file of media item 1
2010-06-02 22:22:07,359 DEBUG [ResourceTransportRequestHandler] Stream length required: true
2010-06-02 22:22:07,359 DEBUG [ResourceTransportRequestHandler] Creating stream entity with length: 84
2010-06-02 22:22:07,359 DEBUG [ResourceTransportRequestHandler] Sending file back
2010-06-02 22:22:07,359 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [Content-Type: video/x-msvideo, Content-Range: bytes 326-409/183268710, Content-Length: 84, Cache-control: no-cache, Pragma: no-cache, Server: Windows XP UPnP/1.0 Serviio 0.4, transferMode.dlna.org: Streaming, ]
2010-06-02 22:22:07,421 DEBUG [ResourceTransportRequestHandler] GET /resource/1/MEDIA_ITEM HTTP/1.1, headers = [Range: bytes=362-445, Host: 10.0.1.4:8895, Accept: */*, ]
2010-06-02 22:22:07,421 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:07,421 DEBUG [ResourceTransportRequestHandler] Request for resource 1 and type 'MEDIA_ITEM' received
2010-06-02 22:22:07,421 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 1)
2010-06-02 22:22:07,421 DEBUG [VideoDAOImpl] Reading a Video (id = 1)
2010-06-02 22:22:07,421 DEBUG [VideoDeliveryEngine] Delivering item '1' for client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:07,421 DEBUG [VideoDeliveryEngine] Delivering file 'HIMYM_S05E24.avi' in native format
2010-06-02 22:22:07,421 DEBUG [MediaItemDAOImpl] Getting file of media item 1
2010-06-02 22:22:07,421 DEBUG [ResourceTransportRequestHandler] Stream length required: true
2010-06-02 22:22:07,421 DEBUG [ResourceTransportRequestHandler] Creating stream entity with length: 84
2010-06-02 22:22:07,421 DEBUG [ResourceTransportRequestHandler] Sending file back
2010-06-02 22:22:07,421 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [Content-Type: video/x-msvideo, Content-Range: bytes 362-445/183268710, Content-Length: 84, Cache-control: no-cache, Pragma: no-cache, Server: Windows XP UPnP/1.0 Serviio 0.4, transferMode.dlna.org: Streaming, ]
2010-06-02 22:22:07,484 DEBUG [ResourceTransportRequestHandler] GET /resource/1/MEDIA_ITEM HTTP/1.1, headers = [Range: bytes=24-35, Host: 10.0.1.4:8895, Accept: */*, ]
2010-06-02 22:22:07,484 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:07,484 DEBUG [ResourceTransportRequestHandler] Request for resource 1 and type 'MEDIA_ITEM' received
2010-06-02 22:22:07,484 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 1)
2010-06-02 22:22:07,484 DEBUG [VideoDAOImpl] Reading a Video (id = 1)
2010-06-02 22:22:07,484 DEBUG [VideoDeliveryEngine] Delivering item '1' for client 'IPAddress=/10.0.1.2, Profile=Generic DLNA profile'
2010-06-02 22:22:07,484 DEBUG [VideoDeliveryEngine] Delivering file 'HIMYM_S05E24.avi' in native format
2010-06-02 22:22:07,484 DEBUG [MediaItemDAOImpl] Getting file of media item 1
2010-06-02 22:22:07,484 DEBUG [ResourceTransportRequestHandler] Stream length required: true
2010-06-02 22:22:07,484 DEBUG [ResourceTransportRequestHandler] Creating stream entity with length: 12
2010-06-02 22:22:07,484 DEBUG [ResourceTransportRequestHandler] Sending file back
2010-06-02 22:22:07,484 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [Content-Type: video/x-msvideo, Content-Range: bytes 24-35/183268710, Content-Length: 12, Cache-control: no-cache, Pragma: no-cache, Server: Windows XP UPnP/1.0 Serviio 0.4, transferMode.dlna.org: Streaming, ]

I try to run the Device Spy but the application is not able to detect the player. ?_?

[zip]

I need packet sniffing (eg Wireshark) of playing a video via Nero MediaHome 4.

The file with the packet sniffing of Nero MediaHome 4 playing a video with subtitles to the BD390 is uploaded here:

http://www.megaupload.com/?d=EZAPVROM

I hope I've done well. The Wireshark is strange to me.

Hi Zip,

v 0.4.1 was working well with my LG BD-390 until recently. I'm finding that some .mkv and .avi files are just ending prematurely during playback (i.e., file does not play all the way through). I searched the forum and couldn't find any other posts with this issue. Have you received any reports of this happening? I presume that it's related to transcoding in some way, although I believe with the latest firmware update from LG, the player can now read .mkv files without the need for transcoding (and it always could read .avi files). I did not have this issue with version 0.3.1.

It pains me to say that I had to uninstall Serviio and switch to Rivet for the time being (Rivet isn't nearly as full-featured as Serviio). The most recent version of Rivet plays the same files all the way through, so maybe you can get a copy of Rivet and dissect/compare their code (thelittleappfactory.com)?

[zip]

I presume you have selected LG profile. That doesn't have any transcoding setup, so it's not transcoding issue. Is it just MKV's you have problems with? Also can you run ffmpeg -i <yourfile> and check what is the duration and if it matches the actual file duration?

I presume you have selected LG profile. That doesn't have any transcoding setup, so it's not transcoding issue. Is it just MKV's you have problems with? Also can you run ffmpeg -i <yourfile> and check what is the duration and if it matches the actual file duration?

When I run (in terminal) ffmpeg -i <file path> (with or without the <>), I get "ffmpeg command not found".

[zip]

It's located in Serviio's lib folder

I had already uninstalled Serviio because of this. But, I don't know if this will help, but I was able to obtain server/DLNA specs for the LG BD390 from other software I demo'd that I hadn't seen logged prior:

Linux/2.6.24.7.0909171-REL UPnP/1.0 DLNADOC/1.50 INTEL_NMPR/...

Would having this specific Linux/UPnP/DLNA version/revision information be helpful in fine tuning Serviio for compatibility?

[zip]

No, it's just a device name.

Hi Petr,

So, turns out Rivet (thelittleappfactory.com) is not working right afterall, as almost all apps don't (except yours of course -- for the most part). Rivet just freezes in middle of shows now and quits on the PC side for no reason.. great, eh? Anyway, back to what you were saying about running ffmpeg -i... I realized that I had installed FFmpeg and Lame separately on my system. I wasn't sure if that mattered, but just in case, I uninstalled the stand-alone packages, and then reinstalled Serviio. So far so good, after watching a few of the same shows (newest episodes) yesterday. You had said to run "ffmpeg -i" for some reason, and I couldn't figure out how to do that. You said it was in Serviio's 'lib' folder? I couldn't find a 'lib' folder, unless you mean 'library', in which case I couldn't see anything ffmpeg related in that folder. I did find ffmpeg in the 'MacOS' folder, and if I open it with terminal, I now see the usage options including -i:

  Code:

usage: ffmpeg [options] [[infile options] -i infile]... {[outfile options] outfile}...

But, I'm still not sure exactly what that means...[which options?] [[what infile options?]...{[what outfile options?] what outfile?}...can you help me with what exactly to enter using this syntax, so I can log this for you if it happens again? Also, do I need to turn on debug again in the log4j.xml? Cheers.

[zip]

Yeah, sorry, didn't realize you're on OSX. It's the right ffmpeg you found there. You just need to open Terminal in that directory and run

  Code:

ffmpeg -i "<path_to_your_movie_file>"

Thanks Petr. I'll run it next time there's a video problem (if a next time?). Also, no worries on the confusion of OSX and Linux...I run triple-boot on my Mac, so sometimes I quote issues in OSX, and other times Linux or Windblows. My primary OS is OSX though So, no need to run debug then? What about the ongoing issue with the LG BD390 not always returning to the folder tree at the end of a show? Sometimes it does as it should, and other times it returns a "network error" message and I have to refresh the server list and enter again. That issue has been across the board regardless of what DLNA media server software I've tried, but yours is more reliable (happens less often).

Also Petr, I found a specific profile for the LG BD-390 in a forum thread for TVersity (which is a DLNA Windows-only media server app), dated April 29, 2010. Someone had modified the PS3 profile in TVersity to work specifically with the LG BD-390. I'm not quite tech enough to compare with the Serviio coding, but maybe you could decipher any differences between this profile information and what Serviio is using?:

  Code:

   <profile id="2f626312-b3cf-4a69-b22f-694f4b8ddd01">
      <friendlyName>LG BD390</friendlyName>
      <manufacturerName>LG</manufacturerName>
      <modelName>LG BD Player</modelName>

      <HTTPHeader inUASubstr="Linux/2.6.24.7.0909171-REL UPnP/1.0 DLNADOC/1.50 INTEL_NMPR/2.0 LG_DLNA_SDK/1.5.0"/>

      <!-- The Name of the media serverdevice description file that should be used in conjunction with a player that
      corresponds to this profile -->
      <deviceDescription name="UPNP_AV_MediaServer_1.0.default.xml"/>

      <!-- The container identifier media players of this profile expect
      -->
      <contentDirectory shortUrl="true" friendlyFilename="false"/>

      <!-- When transcoding is needed to which format should we transcode -->
      <transcodeTarget audio="audio/mpeg" video="video/vob" photo="image/jpeg"
      onlineAudio="audio/mpeg" onlineVideo="video/vob" onlinePhoto="image/jpeg" />

      <maxVideoInfo width="1920" height="1080" bitrate="20000000" fps="60000/1001"></maxVideoInfo>
      <minVideoInfo width="0" height="0" bitrate="0" fps="24"></minVideoInfo>

      <maxImageInfo width="1920" height="1080"></maxImageInfo>
      <minImageInfo width="0" height="0"></minImageInfo>

      <maxAudioInfo sampleRate="48000" bitsperSample="16" nchannels="6" bitrate="1536000"></maxAudioInfo>
      <minAudioInfo sampleRate="44100" bitsperSample="8" nchannels="1" bitrate="20000"></minAudioInfo>

      <fileInfo maxSize="9223372036854775807"/>

      <mimetypeList>
         <mimetype value="audio/L16"/><!--PCM audio format-->
         <mimetype value="audio/wav"/><!-- WAV audio format-->
         <mimetype value="audio/x-wav" rename="audio/wav"/><!-- Another mume type used for WAV audio format-->
         <mimetype value="audio/wave" rename="audio/wav"/><!-- Another mume type used for WAV audio format-->
         <mimetype value="audio/x-pn-wav" rename="audio/wav"/><!-- Another mume type used for WAV audio format-->

         <mimetype value="audio/mpeg"/><!-- MP3 audio format-->
         <mimetype value="audio/x-mpeg" rename="audio/mpeg"/><!-- MP3 audio format-->
         <mimetype value="audio/mp3" rename="audio/mpeg"/><!-- MP3 audio format-->
         <mimetype value="audio/x-mp3" rename="audio/mpeg"/><!-- MP3 audio format-->
         <mimetype value="audio/mpeg3" rename="audio/mpeg"/><!-- MP3 audio format-->
         <mimetype value="audio/x-mpeg3" rename="audio/mpeg"/><!-- MP3 audio format-->
         <mimetype value="audio/mpg" rename="audio/mpeg"/><!-- MP3 audio format-->
         <mimetype value="audio/x-mpg" rename="audio/mpeg"/><!-- MP3 audio format-->
         <mimetype value="audio/x-mpegaudio" rename="audio/mpeg"/><!-- MP3 audio format-->

         <mimetype value="image/jpeg"/><!-- jpeg image format-->
         <mimetype value="image/jp2"/><!--JPEG2000 image format-->

         <mimetype value="video/mpeg"><!-- MPEG (1 or 2 program or transport stream) video format -->
            <codec name="MPEG2VIDEO" />
            <codec name="MP2" />
            <codec name="MP3" />
         </mimetype>
         <mimetype value="video/mpeg2" rename="video/mpeg"/><!-- MPEG2 (program or transport stream) video format-->
         <mimetype value="video/mp2p" rename="video/mpeg"/><!-- MPEG2 program stream (VOB) video format-->
         <mimetype value="video/dvd" rename="video/mpeg"/><!-- MPEG2 program stream (VOB) video format-->
         <mimetype value="video/mp2t" rename="video/mpeg"/><!-- MPEG2 transport stream video format-->
         <mimetype value="video/MP4V-ES"><!-- MPEG4 video format-->
            <codec name="H264"/><!-- H264, AKA MPEG4 AVC or MPEG4 layer 10 or MPEG4.10 -->
            <codec name="AC3"/><!-- Dolby Digital AC3 Audio-->
         </mimetype>
         <mimetype value="video/mp4" rename="video/MP4V-ES"/><!-- MPEG4 video format-->
         <mimetype value="video/x-matroska" rename="video/MP4V-ES"/>
      </mimetypeList>

   </profile>

[zip]

Cool.

Regarding the tree - if it happens with all servers then it seems to be a problem with the player.

The profile - it might be useful, but can you tell me what files you cannot play (without transcoding)? If you can get a mpeg2ts file, mkv, etc and if some of those don't play then we can add that into the current LG profile. Also automatic detection might work - for that I'd need a detailed log from the start of the server to a point when it's trying to play a movie.

Glad this profile info might be helpful. Since the latest firmware available from LG, I believe I am able to play MKV, MP4, and of course AVI files without transcoding, but x264 (H.264/MPEG-4 AVC) files seem to still be a problem. I'm not sure about mpeg2ts either.

Auto-detection - how do I get a detailed (debug) log from the start of the server...what do you mean by that? ...stop the server, add debug to the log, then restart the server? What would the data look like, so I know what to send back to you? Those logs get really verbose.

[zip]

Regarding the log: yes, that's what I need. All the way up to a file being played. You can zip it up and/or upload to 4shared.com or attach here.

Regarding the log: yes, that's what I need. All the way up to a file being played. You can zip it up and/or upload to 4shared.com or attach here.

Okay, see log attached. I was able to capture the information up to when I played a file AND was able to capture the Corba error that has been occurring, which causes a show to end prematurely at random. Hoping you can a) create a specific profile for LG BD-390 based on the prior code provided courtesy of the TVersity forum AND b) fix this Corba error so shows don't just end mid-stream. Also, when I tried playing the same file back again, the same error occurred at almost the exact same point. When I then played that same file back on my Mac, the file played all the way through -- so I don't think it's a corrupt file. Also, this has been happening in the past, and I had tested those files too -- which were not corrupt (and hashes matched after download).

It does seem that all file types are playing without the need for transcoding, including the x264 as I had mentioned in a previous post (I thought x264 was a problem, but I tested a recent file and it does play). So, if I do find a file type that won't play at all, I will submit that log too.
Update: seems AC3 audio codec does not play on LG BD390. Found .mkv files with this audio codec only play video and not the audio. Here is a file's audio package info:

  Code:

General
Count :
267
Count of stream of this kind :
1
Kind of stream :
General
Kind of stream :
General
Stream identifier :
0
Inform :
Matroska: 1.09 GiB, 43mn 13s
Count of video streams :
1
Count of audio streams :
1
Video_Format_List :
AVC
Video_Format_WithHint_List :
AVC
Codecs Video :
AVC
Audio_Format_List :
AC-3
Audio_Format_WithHint_List :
AC-3
Audio codecs :
AC3
Audio_Language_List :
English
Complete name :
Eureka.S04E05.720p.HDTV.x264-IMMERSE/eureka.s04e05.720p.hdtv.x264-immerse.mkv
Folder name :
Eureka.S04E05.720p.HDTV.x264-IMMERSE
File name :
eureka.s04e05.720p.hdtv.x264-immerse
File extension :
mkv
Format :
Matroska
Format :
Matroska
Format/Url :
http://packs.matroska.org/
Format/Extensions usually used :
mkv mka mks
Format_Commercial :
Matroska
Codec :
Matroska
Codec :
Matroska
Codec/Url :
http://packs.matroska.org/
Codec/Extensions usually used :
mkv mka mks
File size :
1174142956
File size :
1.09 GiB
File size :
1 GiB
File size :
1.1 GiB
File size :
1.09 GiB
File size :
1.094 GiB
Duration :
2593000
Duration :
43mn 13s
Duration :
43mn 13s 0ms
Duration :
43mn 13s
Duration :
00:43:13.000
Overall bit rate :
3622500
Overall bit rate :
3 622 Kbps
Stream size :
23361627
Stream size :
22.3 MiB (2%)
Stream size :
22 MiB
Stream size :
22 MiB
Stream size :
22.3 MiB
Stream size :
22.28 MiB
Stream size :
22.3 MiB (2%)
Proportion of this stream :
0.01990
File last modification date :
UTC 2010-08-07 10:11:18
File last modification date (local) :
2010-08-07 03:11:18
Writing application :
x264.exe
Writing library :
mkv2rls x264-tv version built on 2010 jul 11
Writing library :
mkv2rls x264-tv version built on 2010 jul 11

One other note: I think I found the solution to the issue with Serviio not returning to the folder tree after a file ends, as I had identified in an earlier post. You had said it might be a problem with the player. In fact, it seems it was a problem with my router. Despite my Belkin router supporting UPnP, and having enabled UPnP, it seems that more often than not TCP 8895 and UDP 1900 were not available to the player, and therefore returned the network error on the player. I have since manually added port forwarding for these ports in the router configuration, and the problems seems to have disappeared.
Update: this did not solve this problem.


Cheers.

serviio.log.zip

(5.92 KiB) Downloaded 2454 times

serviio.log.zip

(22.66 KiB) Downloaded 2401 times