FAQ  •  Register  •  Login

nPlayer on iPad not showing as connected device

<<

mjb

User avatar

Streaming enthusiast

Posts: 45

Joined: Fri Jan 06, 2012 10:42 pm

Post Tue May 29, 2018 10:48 am

nPlayer on iPad not showing as connected device

I am using an iPad (1st gen) with the nPlayer app to access Serviio on my home network. The good news is that nPlayer works great, playing just about any video natively. Sometimes it is a little fussy about the aspect ratio, but other than that, no issues, and it can output to my TV via an HDMI adapter.

Serviio just uses the generic transcoding profile for this device, which is fine. However, there are a few things which will not play, so I made a custom profile. The bad news is Serviio is not giving me a way to select the profile!

The device does not show up in Serviio Console as a connected device, even when it is actively playing a video, so I cannot manually select the profile. I also tried to make the profile automatically match based on the HTTP headers ("User-Agent: nPlayer/3.0"), but the generic profile is still being chosen.

The profile I would like to use:

  Code:
<Profile id="nPlayer-iPad1" name="nPlayer on iPad (1st Gen)" extendsProfileId="1">
   <Detection>
      <HttpHeaders>
         <User-Agent>.*nPlayer/.*</User-Agent>
      </HttpHeaders>
   </Detection>
   <Transcoding>
      <Video targetContainer="mpegts" targetVCodec="h264" forceVTranscoding="true" targetACodec="ac3" maxVBitrate="6000">
         <Matches container="*" vCodec="h263"/>
         <Matches container="*" vCodec="h264" levelGreaterThan="5.0"/>
         <Matches container="*" vCodec="h264" profile="high_422"/>
         <Matches container="*" vCodec="h264" profile="high_444"/>
         <Matches container="*" vCodec="h264" profile="high_10"/>
         <Matches container="*" vCodec="h265"/>
         <Matches container="*" vCodec="vc1"/>
      </Video>
      <Audio targetContainer="lpcm">
         <Matches container="ape"/>
      </Audio>
   </Transcoding>
</Profile>


Debug log output (10.0.1.6 is the host running Serviio, 10.0.1.4 is the iPad):

  Code:
2018-05-29 04:37:08,368 DEBUG [RendererSearchSender] Searching for Renderer devices
2018-05-29 04:37:08,369 DEBUG [RendererSearchSender$RendererSearchWorker] Multicasting SSDP M-SEARCH using interface eth3 (Intel(R) 82579LM Gigabit Network Connection) and address 10.0.1.6, timeout = 0
2018-05-29 04:37:08,369 DEBUG [RendererSearchSender$RendererSearchWorker] Sending 1 'm-search' messages
2018-05-29 04:37:08,369 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:51062s
2018-05-29 04:37:08,369 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-05-29 04:37:08,370 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:51062s
2018-05-29 04:37:08,370 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-05-29 04:37:08,370 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:51062s
2018-05-29 04:37:08,370 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-05-29 04:37:09,166 DEBUG [FeedUpdaterWorker] Checking for new and expired online resources
2018-05-29 04:37:09,166 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2018-05-29 04:37:12,995 DEBUG [SearchManager] Committing search index
2018-05-29 04:37:13,170 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 12933)
2018-05-29 04:37:13,171 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-05-29 04:37:14,371 DEBUG [RendererSearchSender] Finished searching for Renderer devices
2018-05-29 04:37:16,052 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.4:64501s
2018-05-29 04:37:16,053 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-29 04:37:16,569 DEBUG [ServiioHttpService] Incoming request from /10.0.1.4:54192: GET /resource/6862/MEDIA_ITEM/AVC_MP4_MP_SD_AAC_MULT5-0/ORIGINAL HTTP/1.1, headers = [Host: 10.0.1.6:8895,Accept: */*,Cookie: Squeezebox-player=00%3A04%3A20%3A1e%3A53%3A3a,User-Agent: nPlayer/3.0]]
2018-05-29 04:37:16,569 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-29 04:37:16,569 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-29 04:37:16,570 DEBUG [ProfileManager] Cannot find stored renderer, using Generic
2018-05-29 04:37:16,570 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-29 04:37:16,570 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-05-29 04:37:16,570 DEBUG [ResourceDeliveryProcessor] Request for resource 6862 and type 'MEDIA_ITEM' received
2018-05-29 04:37:16,570 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6862 (local)
2018-05-29 04:37:16,570 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6862)
2018-05-29 04:37:16,571 DEBUG [VideoDAOImpl] Reading a Video (id = 6862)
2018-05-29 04:37:16,571 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 6862, format AVC_MP4_MP_SD_AAC_MULT5 and profile Generic DLNA profile
2018-05-29 04:37:16,571 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6862 (local)
2018-05-29 04:37:16,571 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6862)
2018-05-29 04:37:16,571 DEBUG [VideoDAOImpl] Reading a Video (id = 6862)
2018-05-29 04:37:16,572 DEBUG [VideoDeliveryEngine] Delivering item '6862' for client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-05-29 04:37:16,572 DEBUG [VideoDeliveryEngine] Delivering file '2. Stridex.mp4' in native format
2018-05-29 04:37:16,572 DEBUG [MediaItemDAOImpl] Getting file of media item 6862
2018-05-29 04:37:18,170 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 12933)
2018-05-29 04:37:18,171 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-05-29 04:37:23,168 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 12933)
2018-05-29 04:37:23,169 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-05-29 04:37:26,552 DEBUG [GETMethodProcessor] Stream entity has length: 54674102
2018-05-29 04:37:26,552 INFO  [PlaybackEventsManager] Playback of media item 6862 (2. Stridex [2. Stridex.mp4]) has started at 0% on Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown
2018-05-29 04:37:26,552 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Length: 54674102,Content-Type: video/mp4,Cache-control: no-cache,Connection: close,Date: Tue, 29 May 2018 10:37:26 GMT,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*,Server: Windows_7 UPnP/1.0 DLNADOC/1.50 Serviio/1.9.2,transferMode.dlna.org: Streaming]]
2018-05-29 04:37:26,818 DEBUG [ServiioHttpService] Incoming request from /10.0.1.4:54193: GET /resource/6862/MEDIA_ITEM/AVC_MP4_MP_SD_AAC_MULT5-0/ORIGINAL HTTP/1.1, headers = [Host: 10.0.1.6:8895,Range: bytes=54525952-,Accept: */*,Cookie: Squeezebox-player=00%3A04%3A20%3A1e%3A53%3A3a,User-Agent: nPlayer/3.0]]
2018-05-29 04:37:26,818 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-29 04:37:26,819 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-29 04:37:26,819 DEBUG [ProfileManager] Cannot find stored renderer, using Generic
2018-05-29 04:37:26,819 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-29 04:37:26,819 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-05-29 04:37:26,819 DEBUG [ResourceDeliveryProcessor] Request for resource 6862 and type 'MEDIA_ITEM' received
2018-05-29 04:37:26,819 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6862 (local)
2018-05-29 04:37:26,819 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6862)
2018-05-29 04:37:26,820 DEBUG [VideoDAOImpl] Reading a Video (id = 6862)
2018-05-29 04:37:26,820 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 6862, format AVC_MP4_MP_SD_AAC_MULT5 and profile Generic DLNA profile
2018-05-29 04:37:26,820 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6862 (local)
2018-05-29 04:37:26,820 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6862)
2018-05-29 04:37:26,821 DEBUG [VideoDAOImpl] Reading a Video (id = 6862)
2018-05-29 04:37:26,821 DEBUG [VideoDeliveryEngine] Delivering item '6862' for client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-05-29 04:37:26,821 DEBUG [VideoDeliveryEngine] Delivering file '2. Stridex.mp4' in native format
2018-05-29 04:37:26,821 DEBUG [MediaItemDAOImpl] Getting file of media item 6862
2018-05-29 04:37:26,821 DEBUG [GETMethodProcessor] Stream entity has length: 148150
2018-05-29 04:37:26,822 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Length: 148150,Content-Type: video/mp4,Cache-control: no-cache,Connection: close,Content-Range: bytes 54525952-54674101/54674102,Date: Tue, 29 May 2018 10:37:26 GMT,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*,Server: Windows_7 UPnP/1.0 DLNADOC/1.50 Serviio/1.9.2,transferMode.dlna.org: Streaming]]


Serviio Console not showing any device at 10.0.1.4 at all:

serviioconsole.PNG
serviioconsole.PNG (126.64 KiB) Viewed 9630 times


Am I doing something wrong?

Shouldn't Serviio use the custom profile based on the User-Agent header?

And shouldn't Serviio Console show the iPad as a connected device, at least when streaming to it, even if it can't "see" it in advance?
Last edited by mjb on Tue Jun 05, 2018 5:11 pm, edited 4 times in total.
<<

atc98092

User avatar

DLNA master

Posts: 5205

Joined: Fri Aug 17, 2012 10:22 pm

Location: Washington (the state)

Post Wed May 30, 2018 12:29 am

Re: nPlayer on iPad not showing as connected device

What is the IP address of the iPad? Find that and you should find a match in the Serviio console. My iOS devices only appear as an unrecognized device. You have two in your console. It's probably one of those.
Dan

LG NANO85 4K TV, Samsung JU7100 4K TV, Sony BDP-S3500, Sharp 4K Roku TV, Insignia Roku TV, Roku Ultra, Premiere and Stick, Nvidia Shield, Yamaha RX-V583 AVR.
Primary server: Intel i5-6400, 16 gig ram, Windows 10 Pro, 22 TB hard drive space | Test server Windows 10 Pro, AMD Phenom II X4 965, 8 gig ram

HOWTO: Enable debug logging HOWTO: Identify media file contents
<<

mjb

User avatar

Streaming enthusiast

Posts: 45

Joined: Fri Jan 06, 2012 10:42 pm

Post Wed May 30, 2018 7:23 am

Re: nPlayer on iPad not showing as connected device

As I said in my post

"Debug log output (10.0.1.6 is the host running Serviio, 10.0.1.4 is the iPad)" and I verified this in the iPad (Settings > Wi-Fi > i).

"Serviio Console not showing any device at 10.0.1.4 at all" and this was a screenshot taken while in the middle of streaming a video to the iPad at 10.0.1.4 as shown in the log above.

The unrecognized devices at other IPs are not the iPad.
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 17212

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Wed May 30, 2018 1:00 pm

Re: nPlayer on iPad not showing as connected device

Try to use just

  Code:
.*nPlayer.*


as the UserAgent reg-ex in the profile
<<

mjb

User avatar

Streaming enthusiast

Posts: 45

Joined: Fri Jan 06, 2012 10:42 pm

Post Thu May 31, 2018 1:06 am

Re: nPlayer on iPad not showing as connected device

zip wrote:Try to use just

  Code:
.*nPlayer.*


as the UserAgent reg-ex in the profile


No luck.

  Code:
2018-05-30 19:03:38,282 DEBUG [ServiioHttpService] Incoming request from /10.0.1.4:54310: GET /resource/6865/MEDIA_ITEM/AVC_MP4_MP_SD_AAC_MULT5-0/ORIGINAL HTTP/1.1, headers = [Host: 10.0.1.6:8895,Accept: */*,Cookie: Squeezebox-player=00%3A04%3A20%3A1e%3A53%3A3a,User-Agent: nPlayer/3.0]]
2018-05-30 19:03:38,282 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-30 19:03:38,283 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-30 19:03:38,284 DEBUG [ProfileManager] Cannot find stored renderer, using Generic
2018-05-30 19:03:38,284 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-05-30 19:03:38,287 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-05-30 19:03:38,288 DEBUG [ResourceDeliveryProcessor] Request for resource 6865 and type 'MEDIA_ITEM' received
2018-05-30 19:03:38,288 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6865 (local)
2018-05-30 19:03:38,288 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6865)
2018-05-30 19:03:38,293 DEBUG [VideoDAOImpl] Reading a Video (id = 6865)
2018-05-30 19:03:38,294 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 6865, format AVC_MP4_MP_SD_AAC_MULT5 and profile Generic DLNA profile
2018-05-30 19:03:38,295 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6865 (local)
2018-05-30 19:03:38,295 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6865)
2018-05-30 19:03:38,296 DEBUG [VideoDAOImpl] Reading a Video (id = 6865)
2018-05-30 19:03:38,296 DEBUG [VideoDeliveryEngine] Delivering item '6865' for client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-05-30 19:03:38,296 DEBUG [VideoDeliveryEngine] Delivering file '5. Rockin' Down the Block.mp4' in native format
<<

atc98092

User avatar

DLNA master

Posts: 5205

Joined: Fri Aug 17, 2012 10:22 pm

Location: Washington (the state)

Post Thu May 31, 2018 2:40 am

Re: nPlayer on iPad not showing as connected device

My apologies. I read your post too quickly and missed your detailed info.
Dan

LG NANO85 4K TV, Samsung JU7100 4K TV, Sony BDP-S3500, Sharp 4K Roku TV, Insignia Roku TV, Roku Ultra, Premiere and Stick, Nvidia Shield, Yamaha RX-V583 AVR.
Primary server: Intel i5-6400, 16 gig ram, Windows 10 Pro, 22 TB hard drive space | Test server Windows 10 Pro, AMD Phenom II X4 965, 8 gig ram

HOWTO: Enable debug logging HOWTO: Identify media file contents
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 17212

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Thu May 31, 2018 7:24 pm

Re: nPlayer on iPad not showing as connected device

Can you post the whole log, from start to the point you try to play something?
<<

mjb

User avatar

Streaming enthusiast

Posts: 45

Joined: Fri Jan 06, 2012 10:42 pm

Post Fri Jun 01, 2018 8:31 am

Re: nPlayer on iPad not showing as connected device

zip wrote:Can you post the whole log, from start to the point you try to play something?


  Code:
2018-06-01 02:27:37,615 DEBUG [ActionsServerResource] Action with name 'startServer' was requested
2018-06-01 02:27:37,616 INFO  [ProfileManager] Loading profiles from file /profiles.xml
2018-06-01 02:27:37,741 INFO  [ProfilesDefinitionParser] Parsing Profiles definition
2018-06-01 02:27:37,741 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 1
2018-06-01 02:27:37,745 INFO  [ProfilesDefinitionParser] Added profile 'Generic DLNA profile' (id=1)
2018-06-01 02:27:37,745 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 2
2018-06-01 02:27:37,746 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV (B-series)' (id=2)
2018-06-01 02:27:37,746 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 3
2018-06-01 02:27:37,746 INFO  [ProfilesDefinitionParser] Added profile 'Xbox 360' (id=3)
2018-06-01 02:27:37,746 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 4
2018-06-01 02:27:37,747 INFO  [ProfilesDefinitionParser] Added profile 'Playstation 3' (id=4)
2018-06-01 02:27:37,747 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile ps4
2018-06-01 02:27:37,747 INFO  [ProfilesDefinitionParser] Added profile 'Playstation 4' (id=ps4)
2018-06-01 02:27:37,747 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 5
2018-06-01 02:27:37,748 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV (A-series)' (id=5)
2018-06-01 02:27:37,748 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 6
2018-06-01 02:27:37,748 INFO  [ProfilesDefinitionParser] Added profile 'DirecTV HD-DVR' (id=6)
2018-06-01 02:27:37,748 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sam_h
2018-06-01 02:27:37,751 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV / player (H-series)' (id=sam_h)
2018-06-01 02:27:37,751 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sam_j
2018-06-01 02:27:37,752 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV / player (J-series)' (id=sam_j)
2018-06-01 02:27:37,752 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sam_m
2018-06-01 02:27:37,752 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV / player (M-series)' (id=sam_m)
2018-06-01 02:27:37,752 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sam_ef
2018-06-01 02:27:37,752 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV / player (E/F-series)' (id=sam_ef)
2018-06-01 02:27:37,752 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 7
2018-06-01 02:27:37,753 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV / player (C/D-series)' (id=7)
2018-06-01 02:27:37,753 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 8
2018-06-01 02:27:37,753 INFO  [ProfilesDefinitionParser] Added profile 'LG TV / player' (id=8)
2018-06-01 02:27:37,754 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sony2012
2018-06-01 02:27:37,754 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV (2012)' (id=sony2012)
2018-06-01 02:27:37,754 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sony2013
2018-06-01 02:27:37,755 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV (2013/14)' (id=sony2013)
2018-06-01 02:27:37,755 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile bdp2013
2018-06-01 02:27:37,755 INFO  [ProfilesDefinitionParser] Added profile 'Sony BDP-Sx100 (2013)' (id=bdp2013)
2018-06-01 02:27:37,755 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile bdp2012
2018-06-01 02:27:37,755 INFO  [ProfilesDefinitionParser] Added profile 'Sony BDP-Sx90 (2012)' (id=bdp2012)
2018-06-01 02:27:37,755 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile bdp2010
2018-06-01 02:27:37,756 INFO  [ProfilesDefinitionParser] Added profile 'Sony BDP-Sx70/SMP-N100 (2010)' (id=bdp2010)
2018-06-01 02:27:37,756 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile bdp2010us
2018-06-01 02:27:37,756 INFO  [ProfilesDefinitionParser] Added profile 'Sony BDP-Sx70/SMP-N100 (2010) - US' (id=bdp2010us)
2018-06-01 02:27:37,756 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile bdp2011
2018-06-01 02:27:37,756 INFO  [ProfilesDefinitionParser] Added profile 'Sony BDP-Sx80/SMP-N200 (2011)' (id=bdp2011)
2018-06-01 02:27:37,756 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 13
2018-06-01 02:27:37,757 INFO  [ProfilesDefinitionParser] Added profile 'Toshiba REGZA' (id=13)
2018-06-01 02:27:37,757 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile tosh2012
2018-06-01 02:27:37,757 INFO  [ProfilesDefinitionParser] Added profile 'Toshiba REGZA 2012-' (id=tosh2012)
2018-06-01 02:27:37,757 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 14
2018-06-01 02:27:37,757 INFO  [ProfilesDefinitionParser] Added profile 'WDTV Live' (id=14)
2018-06-01 02:27:37,757 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 15
2018-06-01 02:27:37,757 INFO  [ProfilesDefinitionParser] Added profile 'LaCie LaCinema Media Player' (id=15)
2018-06-01 02:27:37,757 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 16
2018-06-01 02:27:37,757 INFO  [ProfilesDefinitionParser] Added profile 'Manta WIFI Centre' (id=16)
2018-06-01 02:27:37,757 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 17
2018-06-01 02:27:37,757 INFO  [ProfilesDefinitionParser] Added profile 'Pure Flow' (id=17)
2018-06-01 02:27:37,757 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 18
2018-06-01 02:27:37,758 INFO  [ProfilesDefinitionParser] Added profile 'Sharp Aquos' (id=18)
2018-06-01 02:27:37,758 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sony2011
2018-06-01 02:27:37,758 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV (2011)' (id=sony2011)
2018-06-01 02:27:37,758 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sony2010
2018-06-01 02:27:37,758 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV (2010)' (id=sony2010)
2018-06-01 02:27:37,758 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile plps2010
2018-06-01 02:27:37,758 INFO  [ProfilesDefinitionParser] Added profile 'Philips (2010-)' (id=plps2010)
2018-06-01 02:27:37,758 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 20
2018-06-01 02:27:37,758 INFO  [ProfilesDefinitionParser] Added profile 'Philips (2009)' (id=20)
2018-06-01 02:27:37,758 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sony2009
2018-06-01 02:27:37,759 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV (2009)' (id=sony2009)
2018-06-01 02:27:37,759 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile 22
2018-06-01 02:27:37,759 INFO  [ProfilesDefinitionParser] Added profile 'Denon AVR' (id=22)
2018-06-01 02:27:37,759 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile viera2013
2018-06-01 02:27:37,759 INFO  [ProfilesDefinitionParser] Added profile 'Panasonic Viera (2013)' (id=viera2013)
2018-06-01 02:27:37,759 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile viera2011a
2018-06-01 02:27:37,759 INFO  [ProfilesDefinitionParser] Added profile 'Panasonic Viera G/GT/DT/UT/VT (2011/2012)' (id=viera2011a)
2018-06-01 02:27:37,759 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile viera2011
2018-06-01 02:27:37,759 INFO  [ProfilesDefinitionParser] Added profile 'Panasonic Viera E/S/ST/VT (2011)' (id=viera2011)
2018-06-01 02:27:37,759 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile viera2010
2018-06-01 02:27:37,759 INFO  [ProfilesDefinitionParser] Added profile 'Panasonic Viera (2010)' (id=viera2010)
2018-06-01 02:27:37,759 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile viera2009
2018-06-01 02:27:37,760 INFO  [ProfilesDefinitionParser] Added profile 'Panasonic Viera (2009)' (id=viera2009)
2018-06-01 02:27:37,760 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sony2012us
2018-06-01 02:27:37,760 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV (2012) - US' (id=sony2012us)
2018-06-01 02:27:37,760 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile sony2011us
2018-06-01 02:27:37,760 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV (2011) - US' (id=sony2011us)
2018-06-01 02:27:37,760 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile SonySTR
2018-06-01 02:27:37,760 INFO  [ProfilesDefinitionParser] Added profile 'Sony AVReceiver STR' (id=SonySTR)
2018-06-01 02:27:37,760 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile SonyCMT
2018-06-01 02:27:37,760 INFO  [ProfilesDefinitionParser] Added profile 'Sony Audio CMT' (id=SonyCMT)
2018-06-01 02:27:37,760 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile viziotv
2018-06-01 02:27:37,760 INFO  [ProfilesDefinitionParser] Added profile 'Vizio TV' (id=viziotv)
2018-06-01 02:27:37,760 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile panasonicBDT220
2018-06-01 02:27:37,761 INFO  [ProfilesDefinitionParser] Added profile 'Panasonic BD player' (id=panasonicBDT220)
2018-06-01 02:27:37,761 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile philips_streamium
2018-06-01 02:27:37,761 INFO  [ProfilesDefinitionParser] Added profile 'Philips NP Streamium' (id=philips_streamium)
2018-06-01 02:27:37,761 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile roku
2018-06-01 02:27:37,761 INFO  [ProfilesDefinitionParser] Added profile 'Chaneru' (id=roku)
2018-06-01 02:27:37,761 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile RokuMPApp
2018-06-01 02:27:37,762 INFO  [ProfilesDefinitionParser] Added profile 'Roku Media Player' (id=RokuMPApp)
2018-06-01 02:27:37,762 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile Roku4kMPApp
2018-06-01 02:27:37,762 INFO  [ProfilesDefinitionParser] Added profile 'Roku 4K Media Player (2016+)' (id=Roku4kMPApp)
2018-06-01 02:27:37,762 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile RokuNo4kApp
2018-06-01 02:27:37,762 INFO  [ProfilesDefinitionParser] Added profile 'Roku 1080 Media Player (2016+)' (id=RokuNo4kApp)
2018-06-01 02:27:37,762 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile RokuTV
2018-06-01 02:27:37,762 INFO  [ProfilesDefinitionParser] Added profile 'Roku TV (non 4K)' (id=RokuTV)
2018-06-01 02:27:37,763 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile Roku4kTV
2018-06-01 02:27:37,763 INFO  [ProfilesDefinitionParser] Added profile 'Roku 4K TV' (id=Roku4kTV)
2018-06-01 02:27:37,763 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile YamBD
2018-06-01 02:27:37,763 INFO  [ProfilesDefinitionParser] Added profile 'Yamaha BD-A1020/BD-A1010' (id=YamBD)
2018-06-01 02:27:37,763 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile TNDC
2018-06-01 02:27:37,763 INFO  [ProfilesDefinitionParser] Added profile 'Telenet Yelo TV' (id=TNDC)
2018-06-01 02:27:37,763 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile xbox_one
2018-06-01 02:27:37,764 INFO  [ProfilesDefinitionParser] Added profile 'Xbox One' (id=xbox_one)
2018-06-01 02:27:37,764 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile raumfeld
2018-06-01 02:27:37,764 INFO  [ProfilesDefinitionParser] Added profile 'Raumfeld' (id=raumfeld)
2018-06-01 02:27:37,765 INFO  [ProfileManager] Loading profiles from file /application-profiles.xml
2018-06-01 02:27:37,783 INFO  [ProfilesDefinitionParser] Parsing Profiles definition
2018-06-01 02:27:37,783 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile flv_player
2018-06-01 02:27:37,784 INFO  [ProfilesDefinitionParser] Added profile 'Flash player' (id=flv_player)
2018-06-01 02:27:37,784 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile html5
2018-06-01 02:27:37,784 INFO  [ProfilesDefinitionParser] Added profile 'HTML5' (id=html5)
2018-06-01 02:27:37,784 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile html5_mobile
2018-06-01 02:27:37,784 INFO  [ProfilesDefinitionParser] Added profile 'HTML5 Mobile' (id=html5_mobile)
2018-06-01 02:27:37,784 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile serviigo_standard
2018-06-01 02:27:37,784 INFO  [ProfilesDefinitionParser] Added profile 'ServiiGo (Standard)' (id=serviigo_standard)
2018-06-01 02:27:37,784 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile serviigo
2018-06-01 02:27:37,785 INFO  [ProfilesDefinitionParser] Added profile 'ServiiGo (Legacy Devices)' (id=serviigo)
2018-06-01 02:27:37,785 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile serviigo_hls
2018-06-01 02:27:37,785 INFO  [ProfilesDefinitionParser] Added profile 'ServiiGo (HLS)' (id=serviigo_hls)
2018-06-01 02:27:37,785 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile serviigo_gtv
2018-06-01 02:27:37,785 INFO  [ProfilesDefinitionParser] Added profile 'ServiiGo (Google TV)' (id=serviigo_gtv)
2018-06-01 02:27:37,785 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile googlecast
2018-06-01 02:27:37,785 INFO  [ProfilesDefinitionParser] Added profile 'Google Cast' (id=googlecast)
2018-06-01 02:27:37,785 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile chromecast
2018-06-01 02:27:37,786 INFO  [ProfilesDefinitionParser] Added profile 'Chromecast' (id=chromecast)
2018-06-01 02:27:37,786 INFO  [ProfileManager] Loading profiles from file /user-profiles.xml
2018-06-01 02:27:37,806 INFO  [ProfilesDefinitionParser] Parsing Profiles definition
2018-06-01 02:27:37,806 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile nPlayer-iPad1
2018-06-01 02:27:37,806 INFO  [ProfilesDefinitionParser] Added profile 'nPlayer on iPad (1st Gen)' (id=nPlayer-iPad1)
2018-06-01 02:27:37,806 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile SamsungBDC6500
2018-06-01 02:27:37,806 INFO  [ProfilesDefinitionParser] Added profile 'Samsung BD-C6500' (id=SamsungBDC6500)
2018-06-01 02:27:37,806 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile Hopper
2018-06-01 02:27:37,806 INFO  [ProfilesDefinitionParser] Added profile 'Dish Hopper' (id=Hopper)
2018-06-01 02:27:37,806 DEBUG [ProfilesDefinitionParser] Parsing profile definition for profile RokuStick
2018-06-01 02:27:37,806 INFO  [ProfilesDefinitionParser] Added profile 'Roku Media Player on Roku Stick' (id=RokuStick)
2018-06-01 02:27:37,807 DEBUG [LocalContentCacheDecorator] Cleared cache (local_resetafterplay)
2018-06-01 02:27:37,807 DEBUG [LocalContentCacheDecorator] Cleared cache (local_default)
2018-06-01 02:27:37,807 DEBUG [LocalAddressResolverStrategy] Resolving host IP address automatically
2018-06-01 02:27:37,808 INFO  [WebServer] WebServer starting on port 8895
2018-06-01 02:27:38,078 INFO  [Device] Updated bound IP address of Device with UUID: bcaab743-c909-3813-b5d9-05754149c970, bound address: 10.0.1.6
2018-06-01 02:27:38,078 DEBUG [DiscoveryManager] UPNP device bcaab743-c909-3813-b5d9-05754149c970 (10.0.1.6) is available
2018-06-01 02:27:38,079 INFO  [EventSubscriptionExpirationChecker] Starting EventSubscriptionExpirationChecker
2018-06-01 02:27:38,079 INFO  [DiscoveryAdvertisementNotifier] Starting DiscoveryAdvertisementNotifier
2018-06-01 02:27:38,079 INFO  [EventDispatcher] Starting EventDispatcher
2018-06-01 02:27:38,079 INFO  [RendererSearchSender] Starting Renderer searcher process
2018-06-01 02:27:38,147 DEBUG [RendererSearchSender] Searching for Renderer devices
2018-06-01 02:27:38,147 INFO  [DiscoverySSDPMessageListener] Starting DiscoverySSDPMessageListener using interface eth3 (Intel(R) 82579LM Gigabit Network Connection) and address 10.0.1.6, timeout = 0
2018-06-01 02:27:38,148 DEBUG [RendererSearchSender$RendererSearchWorker] Multicasting SSDP M-SEARCH using interface eth3 (Intel(R) 82579LM Gigabit Network Connection) and address 10.0.1.6, timeout = 0
2018-06-01 02:27:38,148 DEBUG [RendererSearchSender$RendererSearchWorker] Sending 1 'm-search' messages
2018-06-01 02:27:38,149 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49153s
2018-06-01 02:27:38,149 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49153s
2018-06-01 02:27:38,149 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49153s
2018-06-01 02:27:38,149 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:27:38,149 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:27:38,150 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:27:38,176 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface eth3 (Intel(R) 82579LM Gigabit Network Connection) and address 10.0.1.6, timeout = 0
2018-06-01 02:27:38,176 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device bcaab743-c909-3813-b5d9-05754149c970
2018-06-01 02:27:38,403 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:27:39,976 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:00:08 (advertisement duration is 1800 sec.)
2018-06-01 02:27:43,403 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:27:44,152 DEBUG [RendererSearchSender] Finished searching for Renderer devices
2018-06-01 02:27:48,153 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface eth3 (Intel(R) 82579LM Gigabit Network Connection) and address 10.0.1.6, timeout = 0
2018-06-01 02:27:48,153 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device bcaab743-c909-3813-b5d9-05754149c970
2018-06-01 02:27:48,403 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:27:49,954 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:00:08 (advertisement duration is 1800 sec.)
2018-06-01 02:27:53,404 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:27:58,154 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface eth3 (Intel(R) 82579LM Gigabit Network Connection) and address 10.0.1.6, timeout = 0
2018-06-01 02:27:58,154 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device bcaab743-c909-3813-b5d9-05754149c970
2018-06-01 02:27:58,405 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:27:59,955 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:03:23 (advertisement duration is 1800 sec.)
2018-06-01 02:28:03,404 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:08,405 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:13,404 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:18,403 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:19,448 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:dial-multiscreen-org:service:dial:1 from address /10.0.1.5:50005s
2018-06-01 02:28:19,448 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.5
2018-06-01 02:28:23,405 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:28,244 DEBUG [RendererSearchSender] Searching for Renderer devices
2018-06-01 02:28:28,245 DEBUG [RendererSearchSender$RendererSearchWorker] Multicasting SSDP M-SEARCH using interface eth3 (Intel(R) 82579LM Gigabit Network Connection) and address 10.0.1.6, timeout = 0
2018-06-01 02:28:28,245 DEBUG [RendererSearchSender$RendererSearchWorker] Sending 1 'm-search' messages
2018-06-01 02:28:28,245 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49157s
2018-06-01 02:28:28,245 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:28:28,245 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49157s
2018-06-01 02:28:28,245 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:28:28,245 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49157s
2018-06-01 02:28:28,245 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:28:28,403 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:30,094 DEBUG [FeedUpdaterWorker] Checking for new and expired online resources
2018-06-01 02:28:30,094 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2018-06-01 02:28:33,406 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:34,245 DEBUG [RendererSearchSender] Finished searching for Renderer devices
2018-06-01 02:28:38,406 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:43,108 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.4:52221s
2018-06-01 02:28:43,109 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 02:28:43,406 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:43,469 DEBUG [ServiioHttpService] Incoming request from /10.0.1.4:54394: GET /resource/6862/MEDIA_ITEM/AVC_MP4_MP_SD_AAC_MULT5-0/ORIGINAL HTTP/1.1, headers = [Host: 10.0.1.6:8895,Accept: */*,Cookie: Squeezebox-player=00%3A04%3A20%3A1e%3A53%3A3a,User-Agent: nPlayer/3.0]]
2018-06-01 02:28:43,469 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 02:28:43,471 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 02:28:43,471 DEBUG [ProfileManager] Cannot find stored renderer, using Generic
2018-06-01 02:28:43,471 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 02:28:43,495 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-06-01 02:28:43,526 DEBUG [ResourceDeliveryProcessor] Request for resource 6862 and type 'MEDIA_ITEM' received
2018-06-01 02:28:43,528 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6862 (local)
2018-06-01 02:28:43,528 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6862)
2018-06-01 02:28:43,544 DEBUG [VideoDAOImpl] Reading a Video (id = 6862)
2018-06-01 02:28:43,584 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 6862, format AVC_MP4_MP_SD_AAC_MULT5 and profile Generic DLNA profile
2018-06-01 02:28:43,590 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6862 (local)
2018-06-01 02:28:43,590 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6862)
2018-06-01 02:28:43,590 DEBUG [VideoDAOImpl] Reading a Video (id = 6862)
2018-06-01 02:28:43,591 DEBUG [VideoDeliveryEngine] Delivering item '6862' for client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-06-01 02:28:43,591 DEBUG [VideoDeliveryEngine] Delivering file '2. Stridex.mp4' in native format
2018-06-01 02:28:43,591 DEBUG [MediaItemDAOImpl] Getting file of media item 6862
2018-06-01 02:28:44,033 DEBUG [GETMethodProcessor] Stream entity has length: 54674102
2018-06-01 02:28:44,034 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Length: 54674102,Content-Type: video/mp4,Cache-control: no-cache,Connection: close,Date: Fri, 01 Jun 2018 08:28:44 GMT,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*,Server: Windows_7 UPnP/1.0 DLNADOC/1.50 Serviio/1.9.2,transferMode.dlna.org: Streaming]]
2018-06-01 02:28:44,042 INFO  [PlaybackEventsManager] Playback of media item 6862 (2. Stridex [2. Stridex.mp4]) has started at 0% on Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown
2018-06-01 02:28:44,198 DEBUG [RendererSearchSender] Searching for Renderer devices
2018-06-01 02:28:44,199 DEBUG [RendererSearchSender$RendererSearchWorker] Multicasting SSDP M-SEARCH using interface eth3 (Intel(R) 82579LM Gigabit Network Connection) and address 10.0.1.6, timeout = 0
2018-06-01 02:28:44,199 DEBUG [RendererSearchSender$RendererSearchWorker] Sending 1 'm-search' messages
2018-06-01 02:28:44,199 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49158s
2018-06-01 02:28:44,199 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:28:44,199 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49158s
2018-06-01 02:28:44,199 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:28:44,199 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49158s
2018-06-01 02:28:44,200 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:28:44,242 DEBUG [ServiioHttpService] Incoming request from /10.0.1.4:54395: GET /resource/6862/MEDIA_ITEM/AVC_MP4_MP_SD_AAC_MULT5-0/ORIGINAL HTTP/1.1, headers = [Host: 10.0.1.6:8895,Range: bytes=54525952-,Accept: */*,Cookie: Squeezebox-player=00%3A04%3A20%3A1e%3A53%3A3a,User-Agent: nPlayer/3.0]]
2018-06-01 02:28:44,242 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 02:28:44,243 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 02:28:44,243 DEBUG [ProfileManager] Cannot find stored renderer, using Generic
2018-06-01 02:28:44,243 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 02:28:44,244 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-06-01 02:28:44,244 DEBUG [ResourceDeliveryProcessor] Request for resource 6862 and type 'MEDIA_ITEM' received
2018-06-01 02:28:44,244 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6862 (local)
2018-06-01 02:28:44,244 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6862)
2018-06-01 02:28:44,245 DEBUG [VideoDAOImpl] Reading a Video (id = 6862)
2018-06-01 02:28:44,246 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 6862, format AVC_MP4_MP_SD_AAC_MULT5 and profile Generic DLNA profile
2018-06-01 02:28:44,246 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 6862 (local)
2018-06-01 02:28:44,246 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 6862)
2018-06-01 02:28:44,247 DEBUG [VideoDAOImpl] Reading a Video (id = 6862)
2018-06-01 02:28:44,247 DEBUG [VideoDeliveryEngine] Delivering item '6862' for client 'Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown'
2018-06-01 02:28:44,247 DEBUG [VideoDeliveryEngine] Delivering file '2. Stridex.mp4' in native format
2018-06-01 02:28:44,247 DEBUG [MediaItemDAOImpl] Getting file of media item 6862
2018-06-01 02:28:44,248 DEBUG [GETMethodProcessor] Stream entity has length: 148150
2018-06-01 02:28:44,248 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Length: 148150,Content-Type: video/mp4,Cache-control: no-cache,Connection: close,Content-Range: bytes 54525952-54674101/54674102,Date: Fri, 01 Jun 2018 08:28:44 GMT,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*,Server: Windows_7 UPnP/1.0 DLNADOC/1.50 Serviio/1.9.2,transferMode.dlna.org: Streaming]]
2018-06-01 02:28:48,405 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:48,447 DEBUG [MediaItemDAOImpl] Marking MediaItem (id = 6862) as read
2018-06-01 02:28:48,466 DEBUG [LocalContentCacheDecorator] Cleared cache (local_resetafterplay)
2018-06-01 02:28:48,468 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 7986)
2018-06-01 02:28:50,199 DEBUG [RendererSearchSender] Finished searching for Renderer devices
2018-06-01 02:28:53,404 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:28:58,403 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:29:03,407 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:29:08,404 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:29:12,449 INFO  [PlaybackEventsManager] Playback of media item 6862 (2. Stridex [2. Stridex.mp4]) has stopped at 100% on Identifier=10.0.1.4, Profile=Generic DLNA profile, Name=Unknown
2018-06-01 02:29:13,345 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:dial-multiscreen-org:service:dial:1 from address /10.0.1.6:49159s
2018-06-01 02:29:13,345 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:29:13,407 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:29:14,346 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:dial-multiscreen-org:service:dial:1 from address /10.0.1.6:49159s
2018-06-01 02:29:14,346 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:29:15,346 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:dial-multiscreen-org:service:dial:1 from address /10.0.1.6:49159s
2018-06-01 02:29:15,346 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:29:16,346 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:dial-multiscreen-org:service:dial:1 from address /10.0.1.6:49159s
2018-06-01 02:29:16,346 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:29:18,403 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:29:23,404 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:29:28,410 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:29:29,042 DEBUG [DiscoverySSDPMessageListener] Received a valid NOTIFY (ssdp:alive) message from Renderer 24c772c4-e6f7-c8cc-2b10-befa90fb7e50 from address 10.0.1.6
2018-06-01 02:29:29,043 DEBUG [RendererManager] Retrieve device description from http://10.0.1.6:9000/plugins/UPnP/MediaRenderer.xml?player=00%3A04%3A20%3A1e%3A53%3A3a
2018-06-01 02:29:29,060 DEBUG [RendererManager] Adding renderer Renderer[uuid='24c772c4-e6f7-c8cc-2b10-befa90fb7e50', ipAddress='10.0.1.6', name='Squeezebox Boom', profileId='1', manuallyAdded=false, forcedProfile=false, enabled=true, accessGroupId=1, friendlyName='null'] to list of active renderers
2018-06-01 02:29:29,500 DEBUG [DiscoverySSDPMessageListener] Received a valid NOTIFY (ssdp:alive) message from Renderer 24c772c4-e6f7-c8cc-2b10-befa90fb7e50 from address 10.0.1.6
2018-06-01 02:29:29,501 DEBUG [RendererManager] Retrieve device description from http://10.0.1.6:9000/plugins/UPnP/MediaRenderer.xml?player=00%3A04%3A20%3A1e%3A53%3A3a
2018-06-01 02:29:30,097 DEBUG [FeedUpdaterWorker] Checking for new and expired online resources
2018-06-01 02:29:30,097 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2018-06-01 02:29:33,408 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:29:34,290 DEBUG [RendererSearchSender] Searching for Renderer devices
2018-06-01 02:29:34,291 DEBUG [RendererSearchSender$RendererSearchWorker] Multicasting SSDP M-SEARCH using interface eth3 (Intel(R) 82579LM Gigabit Network Connection) and address 10.0.1.6, timeout = 0
2018-06-01 02:29:34,291 DEBUG [RendererSearchSender$RendererSearchWorker] Sending 1 'm-search' messages
2018-06-01 02:29:34,292 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49463s
2018-06-01 02:29:34,292 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:29:34,292 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49463s
2018-06-01 02:29:34,292 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaRenderer:1 from address /10.0.1.6:49463s
2018-06-01 02:29:34,292 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:29:34,292 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.6
2018-06-01 02:29:38,409 DEBUG [MediaItemDAOImpl] Getting counts of media items by type
2018-06-01 02:29:40,292 DEBUG [RendererSearchSender] Finished searching for Renderer devices
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 17212

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Fri Jun 01, 2018 6:42 pm

Re: nPlayer on iPad not showing as connected device

hmm, weird.
the iPad doesn't make any requests to Serviio prior to playing the file.

Normally it'd search for servers, then get the server description (at which point Serviio detects the proper profile off the http headers and stores the device to the list of connected devices). Then you'd be browsing.

But here it goes directly to the video URL, so it's probably cached in the app.

So currently it won't work, as the app doesn't use the UPnP protocol correctly, in my opinion.
<<

mjb

User avatar

Streaming enthusiast

Posts: 45

Joined: Fri Jan 06, 2012 10:42 pm

Post Fri Jun 01, 2018 7:10 pm

Re: nPlayer on iPad not showing as connected device

zip wrote:hmm, weird.
the iPad doesn't make any requests to Serviio prior to playing the file.

Normally it'd search for servers, then get the server description (at which point Serviio detects the proper profile off the http headers and stores the device to the list of connected devices). Then you'd be browsing.

But here it goes directly to the video URL, so it's probably cached in the app.

So currently it won't work, as the app doesn't use the UPnP protocol correctly, in my opinion.


Yes, this app caches a lot. But hey, that gave me an idea... I went in and cleared its network cache, and also deleted Serviio from its list of known UPnP/DLNA servers. Then I added a new one, letting it scan and offer me Serviio as an option. Voilà:

  Code:
2018-06-01 12:53:24,241 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /10.0.1.4:61921s
2018-06-01 12:53:24,241 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 12:53:24,242 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s) to /10.0.1.4:61921
2018-06-01 12:53:26,377 DEBUG [ServiioHttpService] Incoming request from /10.0.1.4:54448: GET /deviceDescription/bcaab743-c909-3813-b5d9-05754149c970 HTTP/1.1, headers = [Host: 10.0.1.6:8895,Accept: */*,Cookie: Squeezebox-player=00%3A04%3A20%3A1e%3A53%3A3a,User-Agent: UPnP/1.0 DLNADOC/1.50 LGE_DLNA_SDK/1.5.0 nPlayer/3.0]]
2018-06-01 12:53:26,377 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 12:53:26,378 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device bcaab743-c909-3813-b5d9-05754149c970 from 10.0.1.4 (headers = [Host: 10.0.1.6:8895,Accept: */*,Cookie: Squeezebox-player=00%3A04%3A20%3A1e%3A53%3A3a,User-Agent: UPnP/1.0 DLNADOC/1.50 LGE_DLNA_SDK/1.5.0 nPlayer/3.0])
2018-06-01 12:53:26,378 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 12:53:26,378 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [Host: 10.0.1.6:8895,Accept: */*,Cookie: Squeezebox-player=00%3A04%3A20%3A1e%3A53%3A3a,User-Agent: UPnP/1.0 DLNADOC/1.50 LGE_DLNA_SDK/1.5.0 nPlayer/3.0]
2018-06-01 12:53:26,379 DEBUG [RendererDAOImpl] Creating a new Renderer (uuid = 1126f9a2-e73a-40cd-a0a1-04feeef65646)
2018-06-01 12:53:26,403 INFO  [RendererManager] Stored a new renderer: uuid='1126f9a2-e73a-40cd-a0a1-04feeef65646', name = 'nPlayer on iPad (1st Gen)', ipAddress='10.0.1.4', profile = 'nPlayer-iPad1', accessGroupId = '1'
2018-06-01 12:53:26,403 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.4
2018-06-01 12:53:26,410 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'nPlayer on iPad (1st Gen)'


Serviio started using the right profile! Transcoding is happening when it is supposed to now. And I see it in the console as well.

Thank you.

Is the nPlayer app really doing anything unreasonable, though? As far as it is concerned, it discovered Serviio and said hello already. Why shouldn't it remember that Serviio is out there? If Serviio has forgotten about this device, and starts getting requests from it, why not create an entry for it in the connected devices and use the profile that matches the headers?
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 17212

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Mon Jun 04, 2018 9:34 am

Re: nPlayer on iPad not showing as connected device

Serviio might:
- change its IP address
- change its list of supported formats
- each browse request could (potentially) return different URLs for the files (not the case of Serviio, but still)
- file can be removed from the library - so the player should still at east do the browse calls
<<

mjb

User avatar

Streaming enthusiast

Posts: 45

Joined: Fri Jan 06, 2012 10:42 pm

Post Mon Jun 04, 2018 12:17 pm

Re: nPlayer on iPad not showing as connected device

I understand.

It is a difficult situation. The player is not like a regular HTTP client which can be told to go somewhere else if too much time has passed since it was last seen.

I will inquire with the nPlayer developers and see if they can implement a timeout or something.

Return to User experiences

Who is online

Users browsing this forum: No registered users and 13 guests

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