At first thanks for this plugin! I'm having the problem of a ~45 seconds delay between the playing of two songs. For server and client (browser panel) I'm using foobar 0.9.6.9 with the latest foo_upnp 0.99.16.1. I tried different sizes of the media library, tried to connect from work and everything works fine except the waiting time between the songs. Well, I assume thats not supposed to be, right? I'm running out of ideas and I didn't find anything helpful on the boards...
Was this ever resolved?
I have the exact same problem, except w/ foobar v1.0.2.1 and foo_upnp 0.99.23.1. Foobar is both server and client, streaming over the net, everything works just fine except for the unreasonably long delay between playlist tracks. I've attached logs below:
Client Log:0.16: foo_upnp::on_init(120)/3796: INFO: foo_upnp: version 0.99.23.1
0.16: path_registry::populate(57)/3796: INFO: created 58 path registry entries in 0.000s
0.16: media_tree_root_node_t::load_ml_filters_from_file(167)/3796: INFO: file C:\Documents and Settings\Craig\Application Data\foobar2000\foo_upnp_ml_tree.xml do not exists
0.16: standard_media_tree_root_node_t::load_ml_filters(487)/3796: INFO: loaded default Media Library filters
0.16: PLT_UPnP::Start(211)/3796: INFO: Starting UPnP...
0.32: PLT_HttpServer::Start(109)/3796: INFO: HttpServer listening on 0.0.0.0:57407
0.32: PLT_HttpServer::Start(109)/3796: INFO: HttpServer listening on 0.0.0.0:56923
0.47: PLT_HttpServer::Start(109)/3796: INFO: HttpServer listening on 0.0.0.0:60646
2.32: LoadBrowseTreeTask::DoRun(84)/3408: INFO: loaded 1 nodes in 0.000s
2.32: LoadBrowseTreeTask::DoRun(84)/3240: INFO: loaded 2 nodes in 0.000s
159.235: PLT_UPnP::Stop(312)/3796: INFO: Stopping UPnP...
159.235: NPT_HttpResponse::Parse(765)/2088: WARNING: NPT_CHECK failed, result=-1 (FAILURE) [(res)]
159.235: PLT_SsdpSearchTask::DoRun(493)/2088: WARNING: PLT_SsdpSearchTask got an error (-1) waiting for response
159.235: NPT_HttpResponse::Parse(765)/1060: WARNING: NPT_CHECK failed, result=-1 (FAILURE) [(res)]
159.235: PLT_SsdpSearchTask::DoRun(493)/1060: WARNING: PLT_SsdpSearchTask got an error (-1) waiting for response
159.235: NPT_HttpResponse::Parse(765)/3868: WARNING: NPT_CHECK failed, result=-1 (FAILURE) [(res)]
159.235: PLT_SsdpSearchTask::DoRun(493)/3868: WARNING: PLT_SsdpSearchTask got an error (-1) waiting for response
159.235: NPT_HttpResponse::Parse(765)/2372: WARNING: NPT_CHECK failed, result=-1 (FAILURE) [(res)]
159.235: PLT_SsdpSearchTask::DoRun(493)/2372: WARNING: PLT_SsdpSearchTask got an error (-1) waiting for response
160.188: PLT_HttpServerSocketTask::Read(196)/808: WARNING: NPT_CHECK failed, result=-1 (FAILURE) [(res)]
Server Log:
0.0: foo_upnp::on_init(120)/3788: INFO: foo_upnp: version 0.99.23.1
0.62: path_registry::populate(57)/3788: INFO: created 1185 path registry entries in 0.046s
0.109: media_tree_root_node_t::load_ml_filters_from_file(167)/3788: INFO: file C:\Documents and Settings\gary\Application Data\foobar2000\foo_upnp_ml_tree.xml do not exists
0.109: standard_media_tree_root_node_t::load_ml_filters(487)/3788: INFO: loaded default Media Library filters
0.141: PLT_UPnP::Start(211)/3788: INFO: Starting UPnP...
0.203: PLT_HttpServer::Start(109)/3788: INFO: HttpServer listening on 0.0.0.0:56923
0.297: PLT_HttpServer::Start(109)/3788: INFO: HttpServer listening on 0.0.0.0:56107
2.641: LoadBrowseTreeTask::DoRun(84)/3544: INFO: loaded 3 nodes in 0.422s
24.812: FbMediaServer::ProcessHttpRequest(255)/1228: INFO: received WAN request: [url=http://216.221.89.25:56923/DeviceDescription.xml]http://216.221.89.25:56923/DeviceDescription.xml[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
24.812: FbMediaServer::ProcessGetDescription(320)/1228: INFO: ProcessGetDescription: user-agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000
26.500: FbMediaServer::ProcessHttpRequest(255)/528: INFO: received WAN request: [url=http://216.221.89.25:56923/ContentDirectory/0263e755-5a82-125f-780b-79aa5b112d5b/control.xml]http://216.221.89.25:56923/ContentDirector...d5b/control.xml[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
26.500: FbMediaServer::OnAction(197)/528: INFO: received action 'Browse', args = { ObjectID=0, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=0, RequestedCount=50, SortCriteria= }
26.500: PLT_MediaServer::OnBrowse(380)/528: INFO: Received BrowseDirectChildren from 70.29.106.167 for id = 0 with filter = *, start = 0, count = 50
26.500: FbMediaServer::OnAction(214)/528: INFO: action 'Browse' response: args = { ObjectID=0, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=0, RequestedCount=50, SortCriteria=, NumberReturned=3, TotalMatches=3, UpdateID=0 }
28.141: FbMediaServer::ProcessHttpRequest(255)/208: INFO: received WAN request: [url=http://216.221.89.25:56923/ContentDirectory/0263e755-5a82-125f-780b-79aa5b112d5b/control.xml]http://216.221.89.25:56923/ContentDirector...d5b/control.xml[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
28.141: FbMediaServer::OnAction(197)/208: INFO: received action 'Browse', args = { ObjectID=0/1, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=0, RequestedCount=50, SortCriteria= }
28.141: PLT_MediaServer::OnBrowse(380)/208: INFO: Received BrowseDirectChildren from 70.29.106.167 for id = 0/1 with filter = *, start = 0, count = 50
28.141: FbMediaServer::OnAction(214)/208: INFO: action 'Browse' response: args = { ObjectID=0/1, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=0, RequestedCount=50, SortCriteria=, NumberReturned=8, TotalMatches=8, UpdateID=0 }
30.328: FbMediaServer::ProcessHttpRequest(255)/2184: INFO: received WAN request: [url=http://216.221.89.25:56923/ContentDirectory/0263e755-5a82-125f-780b-79aa5b112d5b/control.xml]http://216.221.89.25:56923/ContentDirector...d5b/control.xml[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
30.328: FbMediaServer::OnAction(197)/2184: INFO: received action 'Browse', args = { ObjectID=0/1/1, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=0, RequestedCount=50, SortCriteria= }
30.328: PLT_MediaServer::OnBrowse(380)/2184: INFO: Received BrowseDirectChildren from 70.29.106.167 for id = 0/1/1 with filter = *, start = 0, count = 50
30.328: FbMediaServer::OnAction(214)/2184: INFO: action 'Browse' response: args = { ObjectID=0/1/1, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=0, RequestedCount=50, SortCriteria=, NumberReturned=50, TotalMatches=62, UpdateID=0 }
30.766: FbMediaServer::ProcessHttpRequest(255)/1836: INFO: received WAN request: [url=http://216.221.89.25:56923/ContentDirectory/0263e755-5a82-125f-780b-79aa5b112d5b/control.xml]http://216.221.89.25:56923/ContentDirector...d5b/control.xml[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
30.766: FbMediaServer::OnAction(197)/1836: INFO: received action 'Browse', args = { ObjectID=0/1/1, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=50, RequestedCount=50, SortCriteria= }
30.766: PLT_MediaServer::OnBrowse(380)/1836: INFO: Received BrowseDirectChildren from 70.29.106.167 for id = 0/1/1 with filter = *, start = 50, count = 50
30.766: FbMediaServer::OnAction(214)/1836: INFO: action 'Browse' response: args = { ObjectID=0/1/1, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=50, RequestedCount=50, SortCriteria=, NumberReturned=12, TotalMatches=62, UpdateID=0 }
34.812: FbMediaServer::ProcessHttpRequest(255)/2668: INFO: received WAN request: [url=http://216.221.89.25:56923/ContentDirectory/0263e755-5a82-125f-780b-79aa5b112d5b/control.xml]http://216.221.89.25:56923/ContentDirector...d5b/control.xml[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
34.812: FbMediaServer::OnAction(197)/2668: INFO: received action 'Browse', args = { ObjectID=0/1/1/1, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=0, RequestedCount=50, SortCriteria= }
34.812: PLT_MediaServer::OnBrowse(380)/2668: INFO: Received BrowseDirectChildren from 70.29.106.167 for id = 0/1/1/1 with filter = *, start = 0, count = 50
34.812: upnp_server_conf::get_profile(651)/2668: INFO: using default profile (User-Agent:Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
34.812: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.812: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.812: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.812: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.812: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.812: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.812: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.828: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.828: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.828: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.828: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.828: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.828: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.828: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.828: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.844: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.859: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.859: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.859: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.859: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.859: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.859: FbMediaServer::BuildAudioItem(1464)/2668: INFO: remote address = 70.29.106.167
34.859: FbMediaServer::OnAction(214)/2668: INFO: action 'Browse' response: args = { ObjectID=0/1/1/1, BrowseFlag=BrowseDirectChildren, Filter=*, StartingIndex=0, RequestedCount=50, SortCriteria=, NumberReturned=33, TotalMatches=33, UpdateID=0 }
43.562: FbMediaServer::ProcessHttpRequest(255)/3468: INFO: received WAN request: [url=http://216.221.89.25:56923/albumart/18758/e23d03b4169635204e38382f3a1b9956]http://216.221.89.25:56923/albumart/18758/...e38382f3a1b9956[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
43.562: PLT_HttpHelper::ToLog(404)/3468: INFO:
GET /albumart/18758/e23d03b4169635204e38382f3a1b9956 HTTP/1.1
User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000
Host: 216.221.89.25:56923
46.625: FbMediaServer::ProcessHttpRequest(255)/180: INFO: received WAN request: [url=http://216.221.89.25:56923/content/18758/e23d03b4169635204e38382f3a1b9956.mp3?profile_id=0&convert=mp3]http://216.221.89.25:56923/content/18758/e...amp;convert=mp3[/url] (User-Agent: foobar2000/1.0.2.1)
46.625: PLT_HttpHelper::ToLog(404)/180: INFO:
GET /content/18758/e23d03b4169635204e38382f3a1b9956.mp3?profile_id=0&convert=mp3 HTTP/1.1
Host: 216.221.89.25:56923
User-Agent: foobar2000/1.0.2.1
Accept: */*
Icy-MetaData: 1
opened 'file://E:\Music\Bach, JS\Glenn Gould Goldberg Variations\Glenn Gould - 01 Aria.mp3' for streaming, profile: Default, MP3 / VBR -V4, replaygain: on, DSP chain: off
204.234: FbMediaServer::ProcessHttpRequest(255)/3756: INFO: received WAN request: [url=http://216.221.89.25:56923/content/18758/bb7739d5af9535258cb1a28b33da0387.mp3?profile_id=0&convert=mp3]http://216.221.89.25:56923/content/18758/b...amp;convert=mp3[/url] (User-Agent: foobar2000/1.0.2.1)
204.234: PLT_HttpHelper::ToLog(404)/3756: INFO:
GET /content/18758/bb7739d5af9535258cb1a28b33da0387.mp3?profile_id=0&convert=mp3 HTTP/1.1
Host: 216.221.89.25:56923
User-Agent: foobar2000/1.0.2.1
Accept: */*
Icy-MetaData: 1
opened 'file://E:\Music\Bach, JS\Glenn Gould Goldberg Variations\Glenn Gould - 02 Variation 1.mp3' for streaming, profile: Default, MP3 / VBR -V4, replaygain: on, DSP chain: off
204.750: FbMediaServer::ProcessHttpRequest(255)/3564: INFO: received WAN request: [url=http://216.221.89.25:56923/albumart/18758/bb7739d5af9535258cb1a28b33da0387]http://216.221.89.25:56923/albumart/18758/...cb1a28b33da0387[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
204.750: PLT_HttpHelper::ToLog(404)/3564: INFO:
GET /albumart/18758/bb7739d5af9535258cb1a28b33da0387 HTTP/1.1
User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000
Host: 216.221.89.25:56923
292.47: FbMediaServer::ProcessHttpRequest(255)/3188: INFO: received WAN request: [url=http://216.221.89.25:56923/content/18758/32c31f525a7e60b75118d19b99243008.mp3?profile_id=0&convert=mp3]http://216.221.89.25:56923/content/18758/3...amp;convert=mp3[/url] (User-Agent: foobar2000/1.0.2.1)
292.47: PLT_HttpHelper::ToLog(404)/3188: INFO:
GET /content/18758/32c31f525a7e60b75118d19b99243008.mp3?profile_id=0&convert=mp3 HTTP/1.1
Host: 216.221.89.25:56923
User-Agent: foobar2000/1.0.2.1
Accept: */*
Icy-MetaData: 1
opened 'file://E:\Music\Bach, JS\Glenn Gould Goldberg Variations\Glenn Gould - 03 Variation 2.mp3' for streaming, profile: Default, MP3 / VBR -V4, replaygain: on, DSP chain: off
292.578: FbMediaServer::ProcessHttpRequest(255)/3408: INFO: received WAN request: [url=http://216.221.89.25:56923/albumart/18758/32c31f525a7e60b75118d19b99243008]http://216.221.89.25:56923/albumart/18758/...118d19b99243008[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
292.578: PLT_HttpHelper::ToLog(404)/3408: INFO:
GET /albumart/18758/32c31f525a7e60b75118d19b99243008 HTTP/1.1
User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000
Host: 216.221.89.25:56923
295.62: FbMediaServer::ProcessHttpRequest(255)/3228: INFO: received WAN request: [url=http://216.221.89.25:56923/albumart/18758/e23d03b4169635204e38382f3a1b9956]http://216.221.89.25:56923/albumart/18758/...e38382f3a1b9956[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
295.62: PLT_HttpHelper::ToLog(404)/3228: INFO:
GET /albumart/18758/e23d03b4169635204e38382f3a1b9956 HTTP/1.1
User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000
Host: 216.221.89.25:56923
298.750: PLT_HttpServerSocketTask::Write(327)/3188: WARNING: NPT_CHECK failed, result=-20400 (NPT_ERROR_CONNECTION_RESET) [(NPT_StreamToStreamCopy( *body_stream.AsPointer(), *output_stream.AsPointer(), 0, entity->GetContentLength(), 0, abort))]
376.141: FbMediaServer::ProcessHttpRequest(255)/3936: INFO: received WAN request: [url=http://216.221.89.25:56923/albumart/18758/e23d03b4169635204e38382f3a1b9956]http://216.221.89.25:56923/albumart/18758/...e38382f3a1b9956[/url] (User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000)
376.141: PLT_HttpHelper::ToLog(404)/3936: INFO:
GET /albumart/18758/e23d03b4169635204e38382f3a1b9956 HTTP/1.1
User-Agent: Platinum/0.5.4.0, DLNADOC/1.50 / foobar2000
Host: 216.221.89.25:56923
418.578: PLT_UPnP::Stop(312)/3788: INFO: Stopping UPnP...
420.828: PLT_HttpServerSocketTask::Read(196)/2396: WARNING: NPT_CHECK failed, result=-1 (FAILURE) [(res)]