FAQ  •  Register  •  Login

"Temporarily cannot acces server." When playing .mkv files?

<<

HacKage

Serviio newbie

Posts: 9

Joined: Thu Nov 18, 2010 5:39 pm

Post Fri Nov 19, 2010 5:05 pm

"Temporarily cannot acces server." When playing .mkv files?

Hi there, I managed to get Serviio set up last night after a lot of playing around and it seems to be working fine all except for one problem. I have a large collection of 1080p mkv files which when I try to play through Serviio, I get a message on the screen saying "Temporarily cannot access server. Please retry". I am using an iMac and a Bravia KDL-40NX503 using the Sony Bravia profile included in 0.4.2. Do I need to somehow modify the standard Bravia profile in order to play .mkv files, or do I have a problem elsewhere?

Thanks
<<

Illico

User avatar

DLNA master

Posts: 4646

Joined: Fri Jul 23, 2010 8:08 am

Location: France

Post Fri Nov 19, 2010 6:42 pm

Re: "Temporarily cannot acces server." When playing .mkv files?

Could you provide details of an unrecognized video file viewtopic.php?f=5&t=38
Illico
Sony 2010 KDL-46EX501 | BDP-S373 | SMP-N100 | Windows 8-i7 | Network DD HD-CE1.5TLU2 | Livebox2-UHD86 | ServiiDroid | ServiiGo | BubbleUPnP
Serviio beta tester - Moderator
<<

HacKage

Serviio newbie

Posts: 9

Joined: Thu Nov 18, 2010 5:39 pm

Post Fri Nov 19, 2010 7:04 pm

Re: "Temporarily cannot acces server." When playing .mkv files?

I don't think I can run UPnP tools on a Mac. The files are 1080p mkv with AC3 audio, they show up in Serviio fine, showing the title and how long the video is, but just when I go to start playing the video I get that message showing. It has happened on full length mkv films and 1min long samples, also in mkv
<<

Illico

User avatar

DLNA master

Posts: 4646

Joined: Fri Jul 23, 2010 8:08 am

Location: France

Post Fri Nov 19, 2010 7:21 pm

Re: "Temporarily cannot acces server." When playing .mkv files?

So turn on detailed logging viewtopic.php?f=5&t=7
And post the log during mkv file transcoding section...
Illico
Sony 2010 KDL-46EX501 | BDP-S373 | SMP-N100 | Windows 8-i7 | Network DD HD-CE1.5TLU2 | Livebox2-UHD86 | ServiiDroid | ServiiGo | BubbleUPnP
Serviio beta tester - Moderator
<<

HacKage

Serviio newbie

Posts: 9

Joined: Thu Nov 18, 2010 5:39 pm

Post Fri Nov 19, 2010 10:01 pm

Re: "Temporarily cannot acces server." When playing .mkv files?

Here is the log:

  Code:
2010-11-19 21:49:35,081 DEBUG [ApplicationInstanceManager] Listening for application instances on socket 44331
2010-11-19 21:49:35,092 INFO  [MediaServer] ------------------------------------------------------------------------
2010-11-19 21:49:35,092 INFO  [MediaServer] Serviio DLNA media streaming server v 0.4.2 (rev. 683706a96104)
2010-11-19 21:49:35,092 INFO  [MediaServer] Petr Nejedly 2009-2010
2010-11-19 21:49:35,092 INFO  [MediaServer] http://www.serviio.org
2010-11-19 21:49:35,092 INFO  [MediaServer]
2010-11-19 21:49:35,092 INFO  [MediaServer] Java 1.6.0_22-Apple Inc.
2010-11-19 21:49:35,092 INFO  [MediaServer] OS Mac OS X x86_64 10.6.5
2010-11-19 21:49:35,092 INFO  [MediaServer] File encoding: UTF-8
2010-11-19 21:49:35,092 INFO  [MediaServer] ------------------------------------------------------------------------
2010-11-19 21:49:35,214 INFO  [RestletServer] Starting Restlet server exposed on localhost:23423
2010-11-19 21:49:35,251 INFO  [DBSchemaUpdateExecutor] Checking if DB schema needs to be updated
2010-11-19 21:49:35,260 DEBUG [DBLogDAOImpl] Checking if script 'script-0.1.sql' has been run
2010-11-19 21:49:36,163 DEBUG [DBLogDAOImpl] Checking if script 'script-0.1.1.sql' has been run
2010-11-19 21:49:36,164 DEBUG [DBLogDAOImpl] Checking if script 'script-0.2.sql' has been run
2010-11-19 21:49:36,164 DEBUG [DBLogDAOImpl] Checking if script 'script-0.3.1.sql' has been run
2010-11-19 21:49:36,164 DEBUG [DBLogDAOImpl] Checking if script 'script-0.4.sql' has been run
2010-11-19 21:49:36,165 DEBUG [DBLogDAOImpl] Checking if script 'script-0.4.1.sql' has been run
2010-11-19 21:49:36,165 DEBUG [DBLogDAOImpl] Checking if script 'script-0.4.2.sql' has been run
2010-11-19 21:49:36,501 INFO  [ProfilesDefinitionParser] Parsing Profiles definition
2010-11-19 21:49:36,510 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 1
2010-11-19 21:49:36,679 INFO  [ProfilesDefinitionParser] Added profile 'Generic DLNA profile' (id=1)
2010-11-19 21:49:36,680 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 2
2010-11-19 21:49:36,711 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV (B-series)' (id=2)
2010-11-19 21:49:36,711 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 3
2010-11-19 21:49:36,736 INFO  [ProfilesDefinitionParser] Added profile 'XBox 360' (id=3)
2010-11-19 21:49:36,737 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 4
2010-11-19 21:49:36,750 INFO  [ProfilesDefinitionParser] Added profile 'Playstation 3' (id=4)
2010-11-19 21:49:36,750 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 5
2010-11-19 21:49:36,767 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV (A-series)' (id=5)
2010-11-19 21:49:36,767 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 6
2010-11-19 21:49:36,782 INFO  [ProfilesDefinitionParser] Added profile 'DirecTV HD-DVR' (id=6)
2010-11-19 21:49:36,783 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 7
2010-11-19 21:49:36,799 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV / player (C-series)' (id=7)
2010-11-19 21:49:36,800 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 8
2010-11-19 21:49:36,812 INFO  [ProfilesDefinitionParser] Added profile 'LG BD player' (id=8)
2010-11-19 21:49:36,813 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 9
2010-11-19 21:49:36,851 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV' (id=9)
2010-11-19 21:49:36,851 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 10
2010-11-19 21:49:36,901 INFO  [ProfilesDefinitionParser] Added profile 'Sony BD Player' (id=10)
2010-11-19 21:49:36,902 DEBUG [FFMPEGWrapper] Invoking FFMPEG to check if it exists of path /Applications/Serviio.app/Contents/Resources/Java/../../MacOS/ffmpeg
2010-11-19 21:49:36,905 DEBUG [ProcessExecutor] Starting /Applications/Serviio.app/Contents/Resources/Java/../../MacOS/ffmpeg
2010-11-19 21:49:37,051 INFO  [VideoDeliveryEngine] Cleaning transcode engine and its data
2010-11-19 21:49:37,054 DEBUG [ConfigEntryDAOImpl] Reading all ConfigEntries
2010-11-19 21:49:37,413 INFO  [WebServer] WebServer starting on port 8895
2010-11-19 21:49:37,559 INFO  [Device] Created UPnP Device with UUID: b8788ec1-4308-32fc-a48f-2532c9b147a9, bound address: 192.168.2.4
2010-11-19 21:49:37,877 INFO  [CompositeCacheManager] Creating cache manager from config file: /cache.ccf
2010-11-19 21:49:37,910 INFO  [ThreadPoolManager] thread_pool.default PoolConfiguration = useBoundary = [true] boundarySize = [2000] maximumPoolSize = [150] minimumPoolSize = [4] keepAliveTime = [300000] whenBlockedPolicy = [RUN] startUpSize = [4]
2010-11-19 21:49:37,912 INFO  [CompositeCacheConfigurator] Setting default auxiliaries to null
2010-11-19 21:49:37,912 INFO  [CompositeCacheConfigurator] No special CompositeCacheAttributes class defined for key [jcs.default.cacheattributes], using default class.
2010-11-19 21:49:37,913 INFO  [CompositeCacheConfigurator] setting defaultCompositeCacheAttributes to [ useLateral = true, useRemote = true, useDisk = true, maxObjs = 100, maxSpoolPerRun = -1, diskUsagePattern = 0 ]
2010-11-19 21:49:37,913 INFO  [CompositeCacheConfigurator] No special ElementAttribute class defined for key [jcs.default.elementattributes], using default class.
2010-11-19 21:49:37,914 INFO  [CompositeCacheConfigurator] setting defaultElementAttributes to [ IS_LATERAL = true, IS_SPOOL = true, IS_REMOTE = true, IS_ETERNAL = true, MaxLifeSeconds = -1, IdleTime = -1, CreateTime = 1290203377913, LastAccessTime = 1290203377913, getTimeToLiveSeconds() = -1, createTime = 1290203377913 ]
2010-11-19 21:49:37,915 INFO  [CompositeCacheConfigurator] No special ElementAttribute class defined for key [jcs.region.local_resetafterplay.elementattributes], using default class.
2010-11-19 21:49:37,926 INFO  [LRUMemoryCache] initialized LRUMemoryCache for local_resetafterplay
2010-11-19 21:49:37,926 INFO  [CompositeCache] Constructed cache with name [local_resetafterplay] and cache attributes [ useLateral = true, useRemote = true, useDisk = true, maxObjs = 1000, maxSpoolPerRun = -1, diskUsagePattern = 0 ]
2010-11-19 21:49:37,926 INFO  [CompositeCacheConfigurator] No special ElementAttribute class defined for key [jcs.region.local_default.elementattributes], using default class.
2010-11-19 21:49:37,926 INFO  [LRUMemoryCache] initialized LRUMemoryCache for local_default
2010-11-19 21:49:37,926 INFO  [CompositeCache] Constructed cache with name [local_default] and cache attributes [ useLateral = true, useRemote = true, useDisk = true, maxObjs = 1000, maxSpoolPerRun = -1, diskUsagePattern = 0 ]
2010-11-19 21:49:37,926 INFO  [CompositeCacheConfigurator] Parsed regions [local_resetafterplay, local_default]
2010-11-19 21:49:37,926 INFO  [CompositeCacheConfigurator] Finished configuration in 15 ms.
2010-11-19 21:49:37,927 DEBUG [DiscoveryManager] UPNP device b8788ec1-4308-32fc-a48f-2532c9b147a9 is available
2010-11-19 21:49:37,927 INFO  [DiscoveryAdvertisementNotifier] Starting DiscoveryAdvertisementNotifier
2010-11-19 21:49:37,928 INFO  [DiscoverySSDPMessageListener] Starting DiscoverySSDPMessageListener using interface 192.168.2.4
2010-11-19 21:49:37,928 INFO  [EventSubscriptionExpirationChecker] Starting EventSubscriptionExpirationChecker
2010-11-19 21:49:37,928 INFO  [EventDispatcher] Starting EventDispatcher
2010-11-19 21:49:37,950 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface 192.168.2.4
2010-11-19 21:49:37,968 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device b8788ec1-4308-32fc-a48f-2532c9b147a9
2010-11-19 21:49:37,970 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:14:17
2010-11-19 21:49:38,305 DEBUG [WebServer] Incoming connection from /192.168.2.5:49945
2010-11-19 21:49:38,308 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device b8788ec1-4308-32fc-a48f-2532c9b147a9 from UPnP/1.0
2010-11-19 21:49:38,525 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Sony Bravia TV'
2010-11-19 21:49:38,604 DEBUG [WebServer] Incoming connection from /192.168.2.5:49946
2010-11-19 21:49:38,605 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ConnectionManager
2010-11-19 21:49:38,612 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-11-19 21:49:38,657 DEBUG [WebServer] Incoming connection from /192.168.2.5:49947
2010-11-19 21:49:38,660 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ContentDirectory
2010-11-19 21:49:38,673 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2010-11-19 21:49:38,757 DEBUG [WebServer] Incoming connection from /192.168.2.5:49948
2010-11-19 21:49:38,758 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#GetSortCapabilities"' from UPnP/1.0 DLNADOC/1.50:
2010-11-19 21:49:39,005 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-11-19 21:49:39,024 DEBUG [WebServer] Incoming connection from /192.168.2.5:49949
2010-11-19 21:49:39,025 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ConnectionManager:1#GetProtocolInfo"' from UPnP/1.0 DLNADOC/1.50:
2010-11-19 21:49:39,030 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-11-19 21:49:39,436 DEBUG [WebServer] Incoming connection from /192.168.2.5:49950
2010-11-19 21:49:39,437 DEBUG [UPnPIconRequestHandler] UPnP icon request received for icon largeJPG
2010-11-19 21:49:39,526 DEBUG [WebServer] Incoming connection from /192.168.2.5:49951
2010-11-19 21:49:39,527 DEBUG [UPnPIconRequestHandler] UPnP icon request received for icon largeJPG
2010-11-19 21:49:39,649 DEBUG [WebServer] Incoming connection from /192.168.2.5:49952
2010-11-19 21:49:39,650 DEBUG [UPnPIconRequestHandler] UPnP icon request received for icon largeJPG
2010-11-19 21:49:41,323 INFO  [UpdateChecker] Checking if a new version is available
2010-11-19 21:49:42,078 DEBUG [RepositoryDAOImpl] Reading all Repositories
2010-11-19 21:49:43,632 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type AUDIO
2010-11-19 21:49:43,653 DEBUG [MetadataExtractorConfigDAOImpl] Reading a list of Extractor configuration for type VIDEO
2010-11-19 21:49:45,327 DEBUG [RepositoryDAOImpl] Reading all Repositories
2010-11-19 21:49:57,944 INFO  [LibraryAdditionsCheckerThread] Started looking for newly added files------------------------------------------------------------------
2010-11-19 21:50:22,896 DEBUG [WebServer] Incoming connection from /192.168.2.5:38159
2010-11-19 21:50:22,899 DEBUG [ResourceTransportRequestHandler] HEAD /resource/1287/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO HTTP/1.1, headers = [getcontentFeatures.dlna.org: 1, Pragma: getIfoFileURI.dlna.org, transferMode.dlna.org: Streaming, X-AV-Physical-Unit-Info: pa="BRAVIA KDL-40NX503";, X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-40NX503"; mv="1.7";, Host: 192.168.2.4:8895, ]
2010-11-19 21:50:22,899 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/192.168.2.5, Profile=Sony Bravia TV'
2010-11-19 21:50:22,899 DEBUG [ResourceTransportRequestHandler] Request for resource 1287 and type 'MEDIA_ITEM' received
2010-11-19 21:50:22,899 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 1287)
2010-11-19 21:50:22,900 DEBUG [VideoDAOImpl] Reading a Video (id = 1287)
2010-11-19 21:50:22,900 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1287, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV
2010-11-19 21:50:22,900 DEBUG [VideoDeliveryEngine] Getting media info for transcoded version of file Inception (2010) 1080P MKV AC3+DTS Eng-NLSubs-DMT.mkv
2010-11-19 21:50:22,900 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file Inception (2010) 1080P MKV AC3+DTS Eng-NLSubs-DMT.mkv: AVC_TS_MP_HD_AC3_ISO
2010-11-19 21:50:22,901 DEBUG [ResourceTransportRequestHandler] Sending HEAD response back
2010-11-19 21:50:22,901 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [Content-Type: video/mpeg, Date: Fri, 19 Nov 2010 21:50:22 GMT, Server: Mac OS X, UPnP/1.0 DLNADOC/1.50, Serviio/0.4.2, Cache-control: no-cache, contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_50_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000, transferMode.dlna.org: Streaming, ]
2010-11-19 21:50:22,904 DEBUG [MediaItemDAOImpl] Getting file of media item 403
2010-11-19 21:50:22,904 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 403) and extractor EMBEDDED
2010-11-19 21:50:22,929 DEBUG [WebServer] Incoming connection from /192.168.2.5:38160
2010-11-19 21:50:22,934 DEBUG [ResourceTransportRequestHandler] GET /resource/1287/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=0.000-, getcontentFeatures.dlna.org: 1, Pragma: getIfoFileURI.dlna.org, transferMode.dlna.org: Streaming, X-AV-Physical-Unit-Info: pa="BRAVIA KDL-40NX503";, X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-40NX503"; mv="1.7";, Host: 192.168.2.4:8895, ]
2010-11-19 21:50:22,934 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/192.168.2.5, Profile=Sony Bravia TV'
2010-11-19 21:50:22,934 DEBUG [ResourceTransportRequestHandler] Request for resource 1287 and type 'MEDIA_ITEM' received
2010-11-19 21:50:22,934 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 1287)
2010-11-19 21:50:22,934 DEBUG [VideoDAOImpl] Reading a Video (id = 1287)
2010-11-19 21:50:22,935 DEBUG [VideoDeliveryEngine] Delivering item '1287' for client 'IPAddress=/192.168.2.5, Profile=Sony Bravia TV'
2010-11-19 21:50:22,935 DEBUG [VideoDeliveryEngine] Delivering file 'Inception (2010) 1080P MKV AC3+DTS Eng-NLSubs-DMT.mkv' using transcoding
2010-11-19 21:50:22,935 DEBUG [VideoDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/192.168.2.5, Profile=Sony Bravia TV'
2010-11-19 21:50:22,935 DEBUG [MediaItemDAOImpl] Getting file of media item 1287
2010-11-19 21:50:22,936 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode file: /Users/kage_1/Downloads/Transmission Downloads/Inception (2010) 1080P MKV AC3+DTS Eng-NLSubs-DMT/Inception (2010) 1080P MKV AC3+DTS Eng-NLSubs-DMT.mkv
2010-11-19 21:50:22,936 DEBUG [ProcessExecutor] Starting /Applications/Serviio.app/Contents/Resources/Java/../../MacOS/ffmpeg -i /Users/kage_1/Downloads/Transmission Downloads/Inception (2010) 1080P MKV AC3+DTS Eng-NLSubs-DMT/Inception (2010) 1080P MKV AC3+DTS Eng-NLSubs-DMT.mkv -y -vcodec copy -copyts -acodec ac3 -ab 192k -ac 2 -vbsf h264_mp4toannexb -sn -f mpegts /var/folders/tG/tGYomiu9GnGaCid5sJSkxk+++TI/-Tmp-/Serviio/transcoding-temp-1287-MPEG2TS.stf
2010-11-19 21:50:30,439 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: FFmpeg execution failed
2010-11-19 21:50:30,485 DEBUG [MediaItemDAOImpl] Getting file of media item 478
2010-11-19 21:50:30,485 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 478) and extractor EMBEDDED
2010-11-19 21:50:30,586 DEBUG [MediaItemDAOImpl] Getting file of media item 479
2010-11-19 21:50:36,043 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 533) and extractor EMBEDDED
2010-11-19 21:50:36,085 DEBUG [WebServer] Incoming connection from /192.168.2.5:38161
2010-11-19 21:50:36,085 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from UPnP/1.0 DLNADOC/1.50:
2010-11-19 21:50:36,090 DEBUG [ContentDirectory] Browse() called for profile Sony Bravia TV with parameters: objectID = V_T, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:class,res@resolution,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria =
2010-11-19 21:50:36,090 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it
2010-11-19 21:50:36,094 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-11-19 21:50:38,359 DEBUG [WebServer] Incoming connection from /192.168.2.5:38162
2010-11-19 21:50:38,360 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from UPnP/1.0 DLNADOC/1.50:
2010-11-19 21:50:38,364 DEBUG [ContentDirectory] Browse() called for profile Sony Bravia TV with parameters: objectID = V_T#INI_D, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:class,res@resolution,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria =
2010-11-19 21:50:38,364 DEBUG [VideoDAOImpl] Retrieving list of videos with initial D (from=0, count=10)
2010-11-19 21:50:38,366 DEBUG [MediaItemDAOImpl] Getting file of media item 556
2010-11-19 21:50:38,366 DEBUG [GenreDAOImpl] Reading a Genre (id = 3)
2010-11-19 21:50:38,366 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 556) and extractor EMBEDDED
2010-11-19 21:50:38,367 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 290)
2010-11-19 21:50:38,367 DEBUG [MediaItemDAOImpl] Getting file of media item 290
2010-11-19 21:50:38,368 DEBUG [VideoDAOImpl] Reading a Video (id = 290)
2010-11-19 21:50:38,368 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 290 and profile Sony Bravia TV
2010-11-19 21:50:38,369 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file The.Dark.Knight.2008.BluRay.1080p.DTS.x264.dxva-EuReKA.mkv: AVC_TS_MP_HD_AC3_ISO
2010-11-19 21:50:38,369 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 289)
2010-11-19 21:50:38,422 DEBUG [VideoDAOImpl] Retrieving number of videos with initial D
2010-11-19 21:50:38,424 DEBUG [LocalContentCacheDecorator] Stored entry in the cache (local_default), returning it
2010-11-19 21:50:38,427 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-11-19 21:50:38,467 DEBUG [MediaItemDAOImpl] Getting file of media item 557
2010-11-19 21:50:38,468 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 557) and extractor EMBEDDED
2010-11-19 21:50:38,567 DEBUG [WebServer] Incoming connection from /192.168.2.5:38163
2010-11-19 21:50:38,568 DEBUG [MediaItemDAOImpl] Getting file of media item 558
2010-11-19 21:50:38,569 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 558) and extractor EMBEDDED
2010-11-19 21:50:38,571 DEBUG [ResourceTransportRequestHandler] GET /resource/289/COVER_IMAGE HTTP/1.1, headers = [transferMode.dlna.org: Interactive, X-AV-Physical-Unit-Info: pa="BRAVIA KDL-40NX503";, X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-40NX503"; mv="1.7";, Host: 192.168.2.4:8895, ]
2010-11-19 21:50:38,571 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/192.168.2.5, Profile=Sony Bravia TV'
2010-11-19 21:50:38,571 DEBUG [ResourceTransportRequestHandler] Request for resource 289 and type 'COVER_IMAGE' received
2010-11-19 21:50:38,572 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 289)
2010-11-19 21:50:38,573 DEBUG [CoverImageRetrievalStrategy] Retrieving Cover image with id 289
2010-11-19 21:50:38,573 DEBUG [ResourceTransportRequestHandler] Entity will be consumed till the end
2010-11-19 21:50:38,573 DEBUG [ResourceTransportRequestHandler] Creating stream entity with length: -1
2010-11-19 21:50:38,573 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2010-11-19 21:50:38,573 DEBUG [ResourceTransportRequestHandler] Sending file back
2010-11-19 21:50:38,573 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [Content-Type: image/jpeg, Date: Fri, 19 Nov 2010 21:50:38 GMT, Server: Mac OS X, UPnP/1.0 DLNADOC/1.50, Serviio/0.4.2, Cache-control: no-cache, transferMode.dlna.org: Interactive, ]
2010-11-19 21:50:42,334 DEBUG [WebServer] Incoming connection from /192.168.2.5:38164
2010-11-19 21:50:42,334 DEBUG [ResourceTransportRequestHandler] HEAD /resource/290/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO HTTP/1.1, headers = [getcontentFeatures.dlna.org: 1, Pragma: getIfoFileURI.dlna.org, transferMode.dlna.org: Streaming, X-AV-Physical-Unit-Info: pa="BRAVIA KDL-40NX503";, X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-40NX503"; mv="1.7";, Host: 192.168.2.4:8895, ]
2010-11-19 21:50:42,335 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/192.168.2.5, Profile=Sony Bravia TV'
2010-11-19 21:50:42,335 DEBUG [ResourceTransportRequestHandler] Request for resource 290 and type 'MEDIA_ITEM' received
2010-11-19 21:50:42,335 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 290)
2010-11-19 21:50:42,335 DEBUG [VideoDAOImpl] Reading a Video (id = 290)
2010-11-19 21:50:42,335 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 290, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV
2010-11-19 21:50:42,335 DEBUG [VideoDeliveryEngine] Getting media info for transcoded version of file The.Dark.Knight.2008.BluRay.1080p.DTS.x264.dxva-EuReKA.mkv
2010-11-19 21:50:42,336 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file The.Dark.Knight.2008.BluRay.1080p.DTS.x264.dxva-EuReKA.mkv: AVC_TS_MP_HD_AC3_ISO
2010-11-19 21:50:42,336 DEBUG [ResourceTransportRequestHandler] Sending HEAD response back
2010-11-19 21:50:42,336 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [Content-Type: video/mpeg, Date: Fri, 19 Nov 2010 21:50:42 GMT, Server: Mac OS X, UPnP/1.0 DLNADOC/1.50, Serviio/0.4.2, Cache-control: no-cache, contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_50_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000, transferMode.dlna.org: Streaming, ]
2010-11-19 21:50:42,354 DEBUG [WebServer] Incoming connection from /192.168.2.5:38165
2010-11-19 21:50:42,367 DEBUG [ResourceTransportRequestHandler] GET /resource/290/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=0.000-, getcontentFeatures.dlna.org: 1, Pragma: getIfoFileURI.dlna.org, transferMode.dlna.org: Streaming, X-AV-Physical-Unit-Info: pa="BRAVIA KDL-40NX503";, X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-40NX503"; mv="1.7";, Host: 192.168.2.4:8895, ]
2010-11-19 21:50:42,367 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/192.168.2.5, Profile=Sony Bravia TV'
2010-11-19 21:50:42,368 DEBUG [ResourceTransportRequestHandler] Request for resource 290 and type 'MEDIA_ITEM' received
2010-11-19 21:50:42,368 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 290)
2010-11-19 21:50:42,368 DEBUG [VideoDAOImpl] Reading a Video (id = 290)
2010-11-19 21:50:42,368 DEBUG [VideoDeliveryEngine] Delivering item '290' for client 'IPAddress=/192.168.2.5, Profile=Sony Bravia TV'
2010-11-19 21:50:42,368 DEBUG [VideoDeliveryEngine] Delivering file 'The.Dark.Knight.2008.BluRay.1080p.DTS.x264.dxva-EuReKA.mkv' using transcoding
2010-11-19 21:50:42,368 DEBUG [VideoDeliveryEngine] Stopping previous transcoding job of file '/var/folders/tG/tGYomiu9GnGaCid5sJSkxk+++TI/-Tmp-/Serviio/transcoding-temp-1287-MPEG2TS.stf'
2010-11-19 21:50:42,368 DEBUG [VideoDeliveryEngine] Deleted temp file '/var/folders/tG/tGYomiu9GnGaCid5sJSkxk+++TI/-Tmp-/Serviio/transcoding-temp-1287-MPEG2TS.stf': true
2010-11-19 21:50:42,369 DEBUG [VideoDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/192.168.2.5, Profile=Sony Bravia TV'
2010-11-19 21:50:42,369 DEBUG [MediaItemDAOImpl] Getting file of media item 290
2010-11-19 21:50:42,369 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode file: /Users/kage_1/Downloads/Transmission Downloads/The.Dark.Knight.BluRay.1080p.DTS.x264.dxva-EuReKA/1. Sample/The.Dark.Knight.2008.BluRay.1080p.DTS.x264.dxva-EuReKA.mkv
2010-11-19 21:50:42,369 DEBUG [ProcessExecutor] Starting /Applications/Serviio.app/Contents/Resources/Java/../../MacOS/ffmpeg -i /Users/kage_1/Downloads/Transmission Downloads/The.Dark.Knight.BluRay.1080p.DTS.x264.dxva-EuReKA/1. Sample/The.Dark.Knight.2008.BluRay.1080p.DTS.x264.dxva-EuReKA.mkv -y -vcodec copy -copyts -acodec ac3 -ab 192k -ac 2 -vbsf h264_mp4toannexb -sn -f mpegts /var/folders/tG/tGYomiu9GnGaCid5sJSkxk+++TI/-Tmp-/Serviio/transcoding-temp-290-MPEG2TS.stf
2010-11-19 21:50:42,408 DEBUG [MediaItemDAOImpl] Getting file of media item 596
2010-11-19 21:50:42,409 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 596) and extractor EMBEDDED
2010-11-19 21:50:42,460 WARN  [ProcessExecutor] Process /Applications/Serviio.app/Contents/Resources/Java/../../MacOS/ffmpeg has a return code of 1! This is a possible error.
2010-11-19 21:50:42,460 DEBUG [TranscodingJobListener] Transcoding finished; successful: false
2010-11-19 21:50:49,872 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: FFmpeg execution failed
2010-11-19 21:50:49,885 DEBUG [MediaItemDAOImpl] Getting file of media item 670
2010-11-19 21:50:49,885 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 670) and extractor EMBEDDED
2010-11-19 21:50:49,986 DEBUG [MediaItemDAOImpl] Getting file of media item 671
2010-11-19 21:50:49,987 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 671) and extractor EMBEDDED
2010-11-19 21:50:50,087 DEBUG [MediaItemDAOImpl] Getting file of media item 672
2010-11-19 21:50:50,088 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 672) and extractor EMBEDDED
2010-11-19 21:50:50,188 DEBUG [MediaItemDAOImpl] Getting file of media item 673
2010-11-19 21:50:50,189 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 673) and extractor EMBEDDED
2010-11-19 21:50:50,289 DEBUG [MediaItemDAOImpl] Getting file of media item 674
2010-11-19 21:50:50,290 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 674) and extractor EMBEDDED
2010-11-19 21:50:50,390 DEBUG [MediaItemDAOImpl] Getting file of media item 675
2010-11-19 21:50:50,391 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 675) and extractor EMBEDDED
2010-11-19 21:50:50,491 DEBUG [MediaItemDAOImpl] Getting file of media item 676
2010-11-19 21:50:50,492 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 676) and extractor EMBEDDED
2010-11-19 21:50:50,592 DEBUG [MediaItemDAOImpl] Getting file of media item 677
2010-11-19 21:50:50,593 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 677) and extractor EMBEDDED
2010-11-19 21:50:50,693 DEBUG [MediaItemDAOImpl] Getting file of media item 678
2010-11-19 21:50:50,694 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 678) and extractor EMBEDDED
2010-11-19 21:50:50,794 DEBUG [MediaItemDAOImpl] Getting file of media item 679
2010-11-19 21:50:50,795 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 679) and extractor EMBEDDED
2010-11-19 21:50:50,895 DEBUG [MediaItemDAOImpl] Getting file of media item 680
2010-11-19 21:50:50,896 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 680) and extractor EMBEDDED
2010-11-19 21:50:50,996 DEBUG [MediaItemDAOImpl] Getting file of media item 681
2010-11-19 21:50:50,997 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 681) and extractor EMBEDDED
2010-11-19 21:50:51,097 DEBUG [MediaItemDAOImpl] Getting file of media item 682
2010-11-19 21:50:51,098 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 682) and extractor EMBEDDED
2010-11-19 21:50:51,198 DEBUG [MediaItemDAOImpl] Getting file of media item 683
2010-11-19 21:50:51,199 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 683) and extractor EMBEDDED
2010-11-19 21:50:51,299 DEBUG [MediaItemDAOImpl] Getting file of media item 684
2010-11-19 21:50:51,300 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 684) and extractor EMBEDDED
2010-11-19 21:50:51,400 DEBUG [MediaItemDAOImpl] Getting file of media item 685
2010-11-19 21:50:51,401 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 685) and extractor EMBEDDED
2010-11-19 21:50:51,501 DEBUG [MediaItemDAOImpl] Getting file of media item 686
2010-11-19 21:50:51,502 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 686) and extractor EMBEDDED
2010-11-19 21:50:51,602 DEBUG [MediaItemDAOImpl] Getting file of media item 687
2010-11-19 21:50:51,603 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 687) and extractor EMBEDDED
2010-11-19 21:50:51,703 DEBUG [MediaItemDAOImpl] Getting file of media item 688
2010-11-19 21:50:51,703 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 688) and extractor EMBEDDED
2010-11-19 21:50:51,804 DEBUG [MediaItemDAOImpl] Getting file of media item 689
2010-11-19 21:50:51,805 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 689) and extractor EMBEDDED
2010-11-19 21:50:51,905 DEBUG [MediaItemDAOImpl] Getting file of media item 690
2010-11-19 21:50:51,905 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 690) and extractor EMBEDDED
2010-11-19 21:50:52,006 DEBUG [MediaItemDAOImpl] Getting file of media item 691
2010-11-19 21:50:52,007 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 691) and extractor EMBEDDED
2010-11-19 21:50:52,107 DEBUG [MediaItemDAOImpl] Getting file of media item 692
2010-11-19 21:50:52,108 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 692) and extractor EMBEDDED
2010-11-19 21:50:52,208 DEBUG [MediaItemDAOImpl] Getting file of media item 693
2010-11-19 21:50:52,209 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 693) and extractor EMBEDDED
2010-11-19 21:50:52,309 DEBUG [MediaItemDAOImpl] Getting file of media item 694
2010-11-19 21:50:52,310 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 694) and extractor EMBEDDED
2010-11-19 21:50:52,410 DEBUG [MediaItemDAOImpl] Getting file of media item 695
2010-11-19 21:50:52,410 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 695) and extractor EMBEDDED
2010-11-19 21:50:52,511 DEBUG [MediaItemDAOImpl] Getting file of media item 696
2010-11-19 21:50:52,511 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 696) and extractor EMBEDDED
2010-11-19 21:50:52,612 DEBUG [MediaItemDAOImpl] Getting file of media item 697
2010-11-19 21:50:52,612 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 697) and extractor EMBEDDED
2010-11-19 21:50:52,713 DEBUG [MediaItemDAOImpl] Getting file of media item 698
2010-11-19 21:50:52,713 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 698) and extractor EMBEDDED
2010-11-19 21:50:52,814 DEBUG [MediaItemDAOImpl] Getting file of media item 699
2010-11-19 21:50:52,814 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 699) and extractor EMBEDDED
2010-11-19 21:50:52,915 DEBUG [MediaItemDAOImpl] Getting file of media item 700
2010-11-19 21:50:52,915 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 700) and extractor EMBEDDED
2010-11-19 21:50:53,016 DEBUG [MediaItemDAOImpl] Getting file of media item 701
2010-11-19 21:50:53,016 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 701) and extractor EMBEDDED
2010-11-19 21:50:53,117 DEBUG [MediaItemDAOImpl] Getting file of media item 702
2010-11-19 21:50:53,117 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 702) and extractor EMBEDDED
2010-11-19 21:50:53,218 DEBUG [MediaItemDAOImpl] Getting file of media item 703
2010-11-19 21:50:53,218 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 703) and extractor EMBEDDED
2010-11-19 21:50:53,319 DEBUG [MediaItemDAOImpl] Getting file of media item 704
2010-11-19 21:50:53,319 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 704) and extractor EMBEDDED
2010-11-19 21:50:53,420 DEBUG [MediaItemDAOImpl] Getting file of media item 705
2010-11-19 21:50:53,420 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 705) and extractor EMBEDDED
2010-11-19 21:50:53,521 DEBUG [MediaItemDAOImpl] Getting file of media item 706
2010-11-19 21:50:53,521 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 706) and extractor EMBEDDED
2010-11-19 21:50:53,622 DEBUG [MediaItemDAOImpl] Getting file of media item 707
2010-11-19 21:50:53,622 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 707) and extractor EMBEDDED
2010-11-19 21:50:53,723 DEBUG [MediaItemDAOImpl] Getting file of media item 708
2010-11-19 21:50:53,723 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 708) and extractor EMBEDDED
2010-11-19 21:50:53,824 DEBUG [MediaItemDAOImpl] Getting file of media item 709
2010-11-19 21:50:53,824 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 709) and extractor EMBEDDED
2010-11-19 21:50:53,925 DEBUG [MediaItemDAOImpl] Getting file of media item 710
2010-11-19 21:50:53,925 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 710) and extractor EMBEDDED
2010-11-19 21:50:54,026 DEBUG [MediaItemDAOImpl] Getting file of media item 711
2010-11-19 21:50:54,026 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 711) and extractor EMBEDDED
2010-11-19 21:50:54,127 DEBUG [MediaItemDAOImpl] Getting file of media item 712
2010-11-19 21:50:54,127 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 712) and extractor EMBEDDED
2010-11-19 21:50:54,228 DEBUG [MediaItemDAOImpl] Getting file of media item 713
2010-11-19 21:50:54,228 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 713) and extractor EMBEDDED
2010-11-19 21:50:54,260 DEBUG [WebServer] Incoming connection from /192.168.2.5:38166
2010-11-19 21:50:54,275 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from UPnP/1.0 DLNADOC/1.50:
2010-11-19 21:50:54,280 DEBUG [ContentDirectory] Browse() called for profile Sony Bravia TV with parameters: objectID = V_T, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:class,res@resolution,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria =
2010-11-19 21:50:54,280 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it
2010-11-19 21:50:54,284 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-11-19 21:50:54,329 DEBUG [MediaItemDAOImpl] Getting file of media item 714
2010-11-19 21:50:54,329 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 714) and extractor EMBEDDED
2010-11-19 21:50:54,429 DEBUG [MediaItemDAOImpl] Getting file of media item 715
2010-11-19 21:50:54,430 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 715) and extractor EMBEDDED
2010-11-19 21:50:54,530 DEBUG [MediaItemDAOImpl] Getting file of media item 716
2010-11-19 21:50:54,531 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 716) and extractor EMBEDDED
2010-11-19 21:50:54,631 DEBUG [MediaItemDAOImpl] Getting file of media item 717
2010-11-19 21:50:54,632 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 717) and extractor EMBEDDED
2010-11-19 21:50:54,695 DEBUG [WebServer] Incoming connection from /192.168.2.5:38167
2010-11-19 21:50:54,696 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from UPnP/1.0 DLNADOC/1.50:
2010-11-19 21:50:54,699 DEBUG [ContentDirectory] Browse() called for profile Sony Bravia TV with parameters: objectID = V, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:class,res@resolution,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria =
2010-11-19 21:50:54,699 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it
2010-11-19 21:50:54,704 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-11-19 21:50:54,732 DEBUG [MediaItemDAOImpl] Getting file of media item 718
2010-11-19 21:50:54,733 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 718) and extractor EMBEDDED
2010-11-19 21:50:54,833 DEBUG [MediaItemDAOImpl] Getting file of media item 719
2010-11-19 21:50:54,834 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 719) and extractor EMBEDDED
2010-11-19 21:50:54,934 DEBUG [MediaItemDAOImpl] Getting file of media item 720
2010-11-19 21:50:54,935 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 720) and extractor EMBEDDED
2010-11-19 21:50:55,035 DEBUG [MediaItemDAOImpl] Getting file of media item 721
2010-11-19 21:50:55,036 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 721) and extractor EMBEDDED
2010-11-19 21:50:55,062 DEBUG [WebServer] Incoming connection from /192.168.2.5:38168
2010-11-19 21:50:55,062 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from UPnP/1.0 DLNADOC/1.50:
2010-11-19 21:50:55,066 DEBUG [ContentDirectory] Browse() called for profile Sony Bravia TV with parameters: objectID = 0, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:class,res@resolution,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria =
2010-11-19 21:50:55,066 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it
2010-11-19 21:50:55,068 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2010-11-19 21:50:55,136 DEBUG [MediaItemDAOImpl] Getting file of media item 722
2010-11-19 21:50:55,137 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 722) and extractor EMBEDDED
2010-11-19 21:50:55,237 DEBUG [MediaItemDAOImpl] Getting file of media item 723
2010-11-19 21:50:55,238 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 723) and extractor EMBEDDED
2010-11-19 21:50:55,338 DEBUG [MediaItemDAOImpl] Getting file of media item 724
2010-11-19 21:50:55,339 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 724) and extractor EMBEDDED
2010-11-19 21:50:55,439 DEBUG [MediaItemDAOImpl] Getting file of media item 725
2010-11-19 21:50:55,440 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 725) and extractor EMBEDDED
2010-11-19 21:50:55,540 DEBUG [MediaItemDAOImpl] Getting file of media item 726
2010-11-19 21:50:55,541 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 726) and extractor EMBEDDED
2010-11-19 21:50:55,641 DEBUG [MediaItemDAOImpl] Getting file of media item 727
2010-11-19 21:50:55,642 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 727) and extractor EMBEDDED
2010-11-19 21:50:55,742 DEBUG [MediaItemDAOImpl] Getting file of media item 728
2010-11-19 21:50:55,743 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 728) and extractor EMBEDDED
2010-11-19 21:50:55,843 DEBUG [MediaItemDAOImpl] Getting file of media item 729
2010-11-19 21:50:55,844 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 729) and extractor EMBEDDED
2010-11-19 21:50:55,944 DEBUG [MediaItemDAOImpl] Getting file of media item 730
2010-11-19 21:50:55,945 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 730) and extractor EMBEDDED
2010-11-19 21:50:56,045 DEBUG [MediaItemDAOImpl] Getting file of media item 731
2010-11-19 21:50:56,046 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 731) and extractor EMBEDDED
2010-11-19 21:50:56,146 DEBUG [MediaItemDAOImpl] Getting file of media item 732
2010-11-19 21:50:56,147 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 732) and extractor EMBEDDED
2010-11-19 21:50:56,247 DEBUG [MediaItemDAOImpl] Getting file of media item 733
2010-11-19 21:50:56,248 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 733) and extractor EMBEDDED
2010-11-19 21:50:56,348 DEBUG [MediaItemDAOImpl] Getting file of media item 734
2010-11-19 21:50:56,349 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 734) and extractor EMBEDDED
2010-11-19 21:50:56,449 DEBUG [MediaItemDAOImpl] Getting file of media item 735
2010-11-19 21:50:56,450 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 735) and extractor EMBEDDED
2010-11-19 21:50:56,550 DEBUG [MediaItemDAOImpl] Getting file of media item 736
2010-11-19 21:50:56,551 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 736) and extractor EMBEDDED
2010-11-19 21:50:56,651 DEBUG [MediaItemDAOImpl] Getting file of media item 737
2010-11-19 21:50:56,652 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 737) and extractor EMBEDDED
2010-11-19 21:50:56,752 DEBUG [MediaItemDAOImpl] Getting file of media item 738
2010-11-19 21:50:56,753 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 738) and extractor EMBEDDED
2010-11-19 21:50:56,853 DEBUG [MediaItemDAOImpl] Getting file of media item 739
2010-11-19 21:50:56,854 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 739) and extractor EMBEDDED
2010-11-19 21:50:56,954 DEBUG [MediaItemDAOImpl] Getting file of media item 740
2010-11-19 21:50:56,955 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 740) and extractor EMBEDDED
2010-11-19 21:50:57,055 DEBUG [MediaItemDAOImpl] Getting file of media item 741
2010-11-19 21:50:57,056 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 741) and extractor EMBEDDED
2010-11-19 21:50:57,156 DEBUG [MediaItemDAOImpl] Getting file of media item 742
2010-11-19 21:50:57,157 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 742) and extractor EMBEDDED
2010-11-19 21:50:57,257 DEBUG [MediaItemDAOImpl] Getting file of media item 743
2010-11-19 21:50:57,258 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 743) and extractor EMBEDDED
2010-11-19 21:50:57,358 DEBUG [MediaItemDAOImpl] Getting file of media item 744
2010-11-19 21:50:57,358 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 744) and extractor EMBEDDED
2010-11-19 21:50:57,459 DEBUG [MediaItemDAOImpl] Getting file of media item 745
2010-11-19 21:50:57,459 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 745) and extractor EMBEDDED
2010-11-19 21:50:57,560 DEBUG [MediaItemDAOImpl] Getting file of media item 746
2010-11-19 21:50:57,560 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 746) and extractor EMBEDDED
2010-11-19 21:50:57,661 DEBUG [MediaItemDAOImpl] Getting file of media item 747
2010-11-19 21:50:57,661 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 747) and extractor EMBEDDED
2010-11-19 21:50:57,762 DEBUG [MediaItemDAOImpl] Getting file of media item 748
2010-11-19 21:50:57,762 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 748) and extractor EMBEDDED
2010-11-19 21:50:57,863 DEBUG [MediaItemDAOImpl] Getting file of media item 749
2010-11-19 21:50:57,863 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 749) and extractor EMBEDDED
2010-11-19 21:50:57,964 DEBUG [MediaItemDAOImpl] Getting file of media item 750
2010-11-19 21:50:57,964 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 750) and extractor EMBEDDED
2010-11-19 21:50:58,065 DEBUG [MediaItemDAOImpl] Getting file of media item 751
2010-11-19 21:50:58,065 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 751) and extractor EMBEDDED
2010-11-19 21:50:58,166 DEBUG [MediaItemDAOImpl] Getting file of media item 752
2010-11-19 21:50:58,166 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 752) and extractor EMBEDDED
2010-11-19 21:50:58,267 DEBUG [MediaItemDAOImpl] Getting file of media item 753
2010-11-19 21:50:58,267 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 753) and extractor EMBEDDED
2010-11-19 21:50:58,368 DEBUG [MediaItemDAOImpl] Getting file of media item 754
2010-11-19 21:50:58,368 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 754) and extractor EMBEDDED
2010-11-19 21:50:58,469 DEBUG [MediaItemDAOImpl] Getting file of media item 755
2010-11-19 21:50:58,469 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 755) and extractor EMBEDDED
2010-11-19 21:50:58,569 DEBUG [MediaItemDAOImpl] Getting file of media item 756
2010-11-19 21:50:58,570 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 756) and extractor EMBEDDED
2010-11-19 21:50:58,671 DEBUG [MediaItemDAOImpl] Getting file of media item 757
2010-11-19 21:50:58,671 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 757) and extractor EMBEDDED
2010-11-19 21:50:58,772 DEBUG [MediaItemDAOImpl] Getting file of media item 758
2010-11-19 21:50:58,772 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 758) and extractor EMBEDDED
2010-11-19 21:50:58,873 DEBUG [MediaItemDAOImpl] Getting file of media item 759
2010-11-19 21:50:58,873 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 759) and extractor EMBEDDED
2010-11-19 21:50:58,974 DEBUG [MediaItemDAOImpl] Getting file of media item 760
2010-11-19 21:50:58,974 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 760) and extractor EMBEDDED
2010-11-19 21:50:59,075 DEBUG [MediaItemDAOImpl] Getting file of media item 761
2010-11-19 21:50:59,075 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 761) and extractor EMBEDDED
2010-11-19 21:50:59,176 DEBUG [MediaItemDAOImpl] Getting file of media item 762
2010-11-19 21:50:59,176 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 762) and extractor EMBEDDED
2010-11-19 21:50:59,277 DEBUG [MediaItemDAOImpl] Getting file of media item 763
2010-11-19 21:50:59,277 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 763) and extractor EMBEDDED
2010-11-19 21:50:59,378 DEBUG [MediaItemDAOImpl] Getting file of media item 764
2010-11-19 21:50:59,378 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 764) and extractor EMBEDDED
2010-11-19 21:50:59,478 DEBUG [MediaItemDAOImpl] Getting file of media item 765
2010-11-19 21:50:59,479 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 765) and extractor EMBEDDED
2010-11-19 21:50:59,579 DEBUG [MediaItemDAOImpl] Getting file of media item 766
2010-11-19 21:50:59,580 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 766) and extractor EMBEDDED
2010-11-19 21:50:59,680 DEBUG [MediaItemDAOImpl] Getting file of media item 767
2010-11-19 21:50:59,681 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 767) and extractor EMBEDDED
2010-11-19 21:50:59,781 DEBUG [MediaItemDAOImpl] Getting file of media item 768
2010-11-19 21:50:59,782 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 768) and extractor EMBEDDED
2010-11-19 21:50:59,883 DEBUG [MediaItemDAOImpl] Getting file of media item 769
2010-11-19 21:50:59,883 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 769) and extractor EMBEDDED
2010-11-19 21:50:59,984 DEBUG [MediaItemDAOImpl] Getting file of media item 770
2010-11-19 21:50:59,984 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 770) and extractor EMBEDDED
2010-11-19 21:51:00,085 DEBUG [MediaItemDAOImpl] Getting file of media item 771
2010-11-19 21:51:00,085 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 771) and extractor EMBEDDED
2010-11-19 21:51:00,186 DEBUG [MediaItemDAOImpl] Getting file of media item 772
2010-11-19 21:51:00,186 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 772) and extractor EMBEDDED
2010-11-19 21:51:00,286 DEBUG [MediaItemDAOImpl] Getting file of media item 773
2010-11-19 21:51:00,287 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 773) and extractor EMBEDDED
2010-11-19 21:51:00,387 DEBUG [MediaItemDAOImpl] Getting file of media item 774
2010-11-19 21:51:00,388 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 774) and extractor EMBEDDED
2010-11-19 21:51:00,488 DEBUG [MediaItemDAOImpl] Getting file of media item 775
2010-11-19 21:51:00,489 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 775) and extractor EMBEDDED
2010-11-19 21:51:00,589 DEBUG [MediaItemDAOImpl] Getting file of media item 776
2010-11-19 21:51:00,590 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 776) and extractor EMBEDDED
2010-11-19 21:51:00,690 DEBUG [MediaItemDAOImpl] Getting file of media item 777
2010-11-19 21:51:00,691 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 777) and extractor EMBEDDED
2010-11-19 21:51:00,791 DEBUG [MediaItemDAOImpl] Getting file of media item 778
2010-11-19 21:51:00,792 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 778) and extractor EMBEDDED
2010-11-19 21:51:00,892 DEBUG [MediaItemDAOImpl] Getting file of media item 779
2010-11-19 21:51:00,893 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 779) and extractor EMBEDDED
2010-11-19 21:51:00,994 DEBUG [MediaItemDAOImpl] Getting file of media item 780
2010-11-19 21:51:00,994 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 780) and extractor EMBEDDED
2010-11-19 21:51:01,095 DEBUG [MediaItemDAOImpl] Getting file of media item 781
2010-11-19 21:51:01,095 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 781) and extractor EMBEDDED
2010-11-19 21:51:01,196 DEBUG [MediaItemDAOImpl] Getting file of media item 782
2010-11-19 21:51:01,196 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 782) and extractor EMBEDDED
2010-11-19 21:51:01,297 DEBUG [MediaItemDAOImpl] Getting file of media item 783
2010-11-19 21:51:01,297 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 783) and extractor EMBEDDED
2010-11-19 21:51:01,398 DEBUG [MediaItemDAOImpl] Getting file of media item 784
2010-11-19 21:51:01,398 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 784) and extractor EMBEDDED
2010-11-19 21:51:01,499 DEBUG [MediaItemDAOImpl] Getting file of media item 785
2010-11-19 21:51:01,499 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 785) and extractor EMBEDDED
2010-11-19 21:51:01,600 DEBUG [MediaItemDAOImpl] Getting file of media item 786
2010-11-19 21:51:01,600 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 786) and extractor EMBEDDED
2010-11-19 21:51:01,701 DEBUG [MediaItemDAOImpl] Getting file of media item 787
2010-11-19 21:51:01,701 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 787) and extractor EMBEDDED
2010-11-19 21:51:01,802 DEBUG [MediaItemDAOImpl] Getting file of media item 788
2010-11-19 21:51:01,802 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 788) and extractor EMBEDDED
2010-11-19 21:51:01,903 DEBUG [MediaItemDAOImpl] Getting file of media item 789
2010-11-19 21:51:01,903 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 789) and extractor EMBEDDED
2010-11-19 21:51:01,904 DEBUG [ActionsServerResource] Action with name 'exitServiio' was requested
2010-11-19 21:51:01,913 INFO  [LibraryAdditionsCheckerThread] Finished looking for newly added files
2010-11-19 21:51:02,004 DEBUG [MediaItemDAOImpl] Getting file of media item 790
2010-11-19 21:51:02,005 DEBUG [MetadataDescriptorDAOImpl] Reading MetadataDescriptor for MediaItem (id = 790) and extractor EMBEDDED
2010-11-19 21:51:02,105 DEBUG [WebServer] Socket closed
2010-11-19 21:51:02,105 DEBUG [DiscoveryManager] UPNP device b8788ec1-4308-32fc-a48f-2532c9b147a9 is unavailable
2010-11-19 21:51:02,105 INFO  [WebServer] WebServer shutting down
2010-11-19 21:51:02,105 INFO  [EventDispatcher] Leaving EventDispatcher
2010-11-19 21:51:02,105 INFO  [EventSubscriptionExpirationChecker] Leaving EventSubscriptionExpirationChecker, removing all event subscriptions
2010-11-19 21:51:02,105 INFO  [DiscoveryAdvertisementNotifier] Leaving DiscoveryAdvertisementNotifier
2010-11-19 21:51:02,105 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP byebye using interface 192.168.2.4
2010-11-19 21:51:02,106 INFO  [DatabaseManager] Shutting down database
2010-11-19 21:51:02,106 INFO  [DiscoverySSDPMessageListener] Leaving DiscoverySSDPMessageListener
2010-11-19 21:51:02,107 DEBUG [DBConnectionPool] Closed connection for pool Serviio DB Pool
2010-11-19 21:51:02,107 DEBUG [DBConnectionPool] Closed connection for pool Serviio DB Pool
2010-11-19 21:51:02,107 DEBUG [DBConnectionPool] Closed connection for pool Serviio DB Pool
2010-11-19 21:51:02,107 DEBUG [DBConnectionPool] Closed connection for pool Serviio DB Pool
2010-11-19 21:51:02,143 DEBUG [DatabaseManager] DB shutdown returned: Derby system shutdown.
2010-11-19 21:51:02,143 INFO  [VideoDeliveryEngine] Cleaning transcode engine and its data
2010-11-19 21:51:02,143 DEBUG [VideoDeliveryEngine] Deleting temporary transcoded files from: /var/folders/tG/tGYomiu9GnGaCid5sJSkxk+++TI/-Tmp-/Serviio
2010-11-19 21:51:02,144 DEBUG [VideoDeliveryEngine] Deleted file /var/folders/tG/tGYomiu9GnGaCid5sJSkxk+++TI/-Tmp-/Serviio/transcoding-temp-290-MPEG2TS.stf: true


I have deleted some unrelevant lines from the log.By the looks of it, I seem to be having a problem with ffmpeg, but as far as I know, it is installed fine. I can play DivX avi files which would surely need to be transcoded using ffmpeg?
<<

Illico

User avatar

DLNA master

Posts: 4646

Joined: Fri Jul 23, 2010 8:08 am

Location: France

Post Sat Nov 20, 2010 9:07 am

Re: "Temporarily cannot acces server." When playing .mkv files?

Yes this is a ffmpeg error...

Could you provide the result of ffmpeg -i <mkv_file>

You could also try localy the following ffmpeg command and look at the error
ffmpeg -i /Users/kage_1/Downloads/Transmission Downloads/Inception (2010) 1080P MKV AC3+DTS Eng-NLSubs-DMT/Inception (2010) 1080P MKV AC3+DTS Eng-NLSubs-DMT.mkv -y -vcodec copy -copyts -acodec ac3 -ab 192k -ac 2 -vbsf h264_mp4toannexb -sn -f mpegts /var/folders/tG/tGYomiu9GnGaCid5sJSkxk+++TI/-Tmp-/Serviio/transcoding-temp-1287-MPEG2TS.stf
Illico
Sony 2010 KDL-46EX501 | BDP-S373 | SMP-N100 | Windows 8-i7 | Network DD HD-CE1.5TLU2 | Livebox2-UHD86 | ServiiDroid | ServiiGo | BubbleUPnP
Serviio beta tester - Moderator
<<

HacKage

Serviio newbie

Posts: 9

Joined: Thu Nov 18, 2010 5:39 pm

Post Sat Nov 20, 2010 10:34 am

Re: "Temporarily cannot acces server." When playing .mkv files?

I found that the problem was with the ffmepg that was in the Servio package contents. I used XCode and Macports and downloaded and recompiled a new version of ffmpeg and then replaced the ffmpeg file in Serviio with the newly compiled one and that seemed to get it working.


Thanks
<<

jamiej73

Serviio newbie

Posts: 3

Joined: Sat Dec 11, 2010 4:50 pm

Post Sat Dec 11, 2010 4:52 pm

Re: "Temporarily cannot acces server." When playing .mkv files?

Any chance Hackage you can share how you fixed the ffmpeg ? I have the same issue with some .mkv files.... I'm very new to all this, so it may need to be an idiot guide, apologies...
<<

Zek

User avatar

Serviio lover

Posts: 72

Joined: Wed Nov 24, 2010 11:03 am

Location: Boulder, Colorado, USA

Post Sun Dec 12, 2010 9:06 am

Re: "Temporarily cannot acces server." When playing .mkv files?

I think I'm running into this error too. You log shows ffmpeg returning 1 as well and then Serviio bails out. Maybe a threading issue? I'm running an i7-860 here.
Sony Bravia KDL-55NX810 | Serviio 0.5 (rev. 975aa458693c) | Synology DS-1010+
<<

bobtorr

Serviio newbie

Posts: 1

Joined: Mon Dec 13, 2010 5:23 pm

Post Mon Dec 13, 2010 5:27 pm

Re: "Temporarily cannot acces server." When playing .mkv files?

I had this problem when using a Sony Bravia. I found that the problem was
resolved by chosing Sony Bravia in the rendering profile (instead of automatic).
<<

jamiej73

Serviio newbie

Posts: 3

Joined: Sat Dec 11, 2010 4:50 pm

Post Thu Dec 16, 2010 10:00 am

Re: "Temporarily cannot acces server." When playing .mkv files?

I have the Sony Bravia profile selected.

Some .mkv files play fine, but others (mainly bigger files HD quality) have this Temp cannot access server issue...

Anyone got a fix, I would be most grateful.
<<

richierm257

User avatar

Streaming enthusiast

Posts: 33

Joined: Fri Dec 31, 2010 2:04 am

Location: Bah..........

Post Fri Dec 31, 2010 2:12 am

Re: "Temporarily cannot acces server." When playing .mkv files?

Hi is there any chance of posting this fix for those of us who have the same problem please ? ;) by the way thanks for a really great server i have tried every single other one with my Bravia EX403 but this is the only one thant works !!! :D

Thanks

Rich
<<

hhan

Serviio newbie

Posts: 8

Joined: Tue Jan 24, 2012 12:55 am

Post Tue Jan 24, 2012 1:21 am

Re: "Temporarily cannot acces server." When playing .mkv fil

Firstly, I am newbie and thank you whole heartedly everyone for making this wonderful project !

I was able to setup my Bravia 3(KDL40EX703) renderer to access the serviio server on my PC for both static and youtube online content via the plugin. It works like a treat !

It all worked fine but I had a minor issue after I updated Java JRE in my windows 7 PC to the latest. TV displayed the above error, "Temporarily cannot access server, please try again" while trying to access pluggin content using transcoding. Enabling debug as suggested returned the following line

2012-01-23 23:16:29,598 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: Cannot create transcoding folder: C:\Windows\TEMP\Serviio

In my case, the error disappeared and it was all back to normal after I changed the transcoding location using the console GUI tool to : C:\Temp\Serviio . Obviously, there is some access restrictions to write temp files in Windows folder hence.

So hopefully this will help someone !
<<

serviiooser

Serviio newbie

Posts: 1

Joined: Sat Sep 22, 2012 4:28 pm

Post Sat Sep 22, 2012 4:46 pm

Re: "Temporarily cannot acces server." When playing .mkv fil

Yeay! I got it working:)
Maybe it is a little to late since the last post was 9 months ago but this forum helped me at this moment so just thought I try to help out a bit:)

I am currently using it with my Bravia KDL-37W5500. But this also works with the ps3 and transformer prime.

To make this newbie friendly I'll describe it as good as I can.

First off, this obiously was an ffmpeg error. I found this out by running the following command:
  Code:
ffmpeg -i /path/to/some/file.mkv


That command gave me a bunch of stuff that I did not now what meant, all I could understand was that it had to to with ffmpeg.
So I reckoned I'd uninstalled (for fun if nothing else):
[code}
apt-get remove --purge ffmpeg
apt-get autoremove
[/code]

When this was done I somehow found the latest stable ffmpeg releases in a ppa repo:
https://launchpad.net/~jon-severinsson/+archive/ffmpeg?field.series_filter=precise

The website provedes a rather good explanation for how to add it to you repository, but here is what I did:
  Code:
add-apt-repository ppa:jon-severinsson/ffmpeg
apt-get update
apt-get install ffmpeg


Then I just rebooted my machine and it worked nicely. I guess a restart of serviio also would do.

As an alternative to adding the repository using
  Code:
add-apt-repository
you could manully place the url in the list of sources: (NB! I did not test this)
Select your version of ubuntu in the dropdown list and there will show two lines like this:
  Code:
deb http://ppa.launchpad.net/jon-severinsson/ffmpeg/ubuntu precise main
deb-src http://ppa.launchpad.net/jon-severinsson/ffmpeg/ubuntu precise main


Open /etc/apt/sources.list with your favourive editor and just add those lines at the bottom of the file, update aptitude and install:
  Code:
vi /etc/apt/sources.list
apt-get update
apt-get install ffmpeg


Hope this helps:)

Return to Serviio Support & Help

Who is online

Users browsing this forum: No registered users and 84 guests

Powered by phpBB © 2000, 2002, 2005, 2007 phpBB Group.
Designed by ST Software for PTF.