Bugzilla – Bug 1247
Live365 causes SlimServer Service to halt
Last modified: 2008-08-18 10:54:04 UTC
Live365 had been streaming for about 8 hours when the SLimServer service crashed. Here is the text from the event viewer. The description for Event ID ( 0 ) in Source ( Application ) cannot be found. The local computer may not have the necessary registry information or message DLL files to display messages from a remote computer. You may be able to use the /AUXSOURCE= flag to retrieve this description; see Help and Support for details. The following information is part of the event: Not an ARRAY reference at C:/Program Files/SlimServer/server/Plugins/Live365.pm line 619.
Roy - do you have a way of reproducing this crash?
this looks a little like a bad set of metadata from live365 side. maybe the only thing that can be done here is to do a sanity check, make sure that the $nowPlaying->{PlaylistEntry} is an ARRAY
Dan - At the moment I don't think I can, the best I could do is let it play untill it crashes then gather data. What debugging switches should I use and where will the log file be found? I could start it from active perl if it would make any difference.
d_plugins and d_remotestream should be a good start. that should show the response data along the way. --logfile in the command-line sets the log file location: c:\program files\slimserver\server\slim.exe --d_plugins --d_remotestream --logfile c:\live365crash.log
Just crashed again here are the first and last entries in the log 2005-04-01 15:55:26.1827 Live365.ChannelMode URL: live365://www.live365.com/play/stoneclaveradio?sessionid=y_ddraig_goch:18tlGnUKJlvTw 2005-04-01 15:55:26.4429 Live365.protocolHandler requested: live365://www.live365.com/play/stoneclaveradio?sessionid=y_ddraig_goch:18tlGnUKJlvTw (stoneclaveradio) 2005-04-01 15:55:26.9506 Live365 station really at: 'http://216.235.81.8:20068/play?membername=y_ddraig_goch&session=18tlGnUKJlvTw&sessionid=y_ddraig_goch%3A18tlGnUKJlvTw' 2005-04-01 15:55:26.9513 Opening connection to http://216.235.81.8:20068/play?membername=y_ddraig_goch&session=18tlGnUKJlvTw&sessionid=y_ddraig_goch%3A18tlGnUKJlvTw: [216.235.81.8 on port 20068 with path /play?membername=y_ddraig_goch&session=18tlGnUKJlvTw&sessionid=y_ddraig_goch%3A18tlGnUKJlvTw with timeout 5] 2005-04-01 15:55:27.0819 Request: GET /play?membername=y_ddraig_goch&session=18tlGnUKJlvTw&sessionid=y_ddraig_goch%3A18tlGnUKJlvTw HTTP/1.0 Host: 216.235.81.8:20068 User-Agent: iTunes/3.0 (MSWin32; SlimServer 6.0.0) Accept: */* Cache-Control: no-cache Connection: close Icy-MetaData:1 2005-04-01 15:55:27.2093 Response: HTTP/1.0 200 OK 2005-04-01 15:55:27.3612 header: Server: Nanocaster/2.5.16 2005-04-01 15:55:27.3629 header: icy-name:Mystic Soundscapes - Mystic Soundscapes plays a variety of new age, world, celtic and ambient music 2005-04-01 15:55:27.3643 header: icy-genre:new age,ambient,classical 2005-04-01 15:55:27.3654 header: icy-url:http://www.mysticsoundscapes.com 2005-04-01 15:55:27.3660 header: icy-pub:1 2005-04-01 15:55:27.3665 header: icy-br:32 2005-04-01 15:55:27.3784 header: 2005-04-01 15:55:27.3786 Recieved final blank line... 2005-04-01 15:55:27.3787 opened stream! 2005-04-01 16:57:38.3630 Live365 Now Playing: Standing Stones of Callendish - Jon Mark - Standing Stones of Callendish 2005-04-01 16:57:38.3642 Live365 next update: 374 seconds 2005-04-01 17:03:55.7981 Got playlist response: <?xml version="1.0" encoding="UTF-8"?><Playlist><Refresh>112</Refresh><Broadcaster>afl:stoneclaveradio</Broadcaster><PlaylistEntry><Title>Spiral Gate</Title><Artist>Kim Robertson</Artist><Album>Spiral Gate</Album><ECommerceURL></ECommerceURL><FileName>robertson-spiralgate.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>113</Seconds></PlaylistEntry><PlaylistEntry><Title>Standing Stones of Callendish</Title><Artist>Jon Mark</Artist><Album>Standing Stones of Callendish</Album><ECommerceURL></ECommerceURL><FileName>jon_mark-standing_stones_of_c-standing_stones3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>374</Seconds></PlaylistEntry><PlaylistEntry><Title>Sanctuary</Title><Artist>Diane Arkenstone</Artist><Album>The Healing Spirit</Album><ECommerceURL></ECommerceURL><FileName>diane_arkenstone_-_sanctuary_-_healing_spirit_3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>330</Seconds></PlaylistEntry><PlaylistEntry><Title>Tibet Part II</Title><Artist>Mark Isham</Artist><Album>Tibet</Album><ECommerceURL></ECommerceURL><FileName>sr-ishamtibet2.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>282</Seconds></PlaylistEntry><PlaylistEntry><Title>Blwyddyn I Heno</Title><Artist>Ceredwen</Artist><Album>Or Mabinogi</Album><ECommerceURL></ECommerceURL><FileName>ceredwen_Blwyddyn_I_Heno_or_mabinogi_3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>428</Seconds></PlaylistEntry><PlaylistEntry><Title>Secret to Light</Title><Artist>John Eric</Artist><Album>Heaven and Earth</Album><ECommerceURL></ECommerceURL><FileName>john_eric-secret_to_light-heaven_and_earth3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>275</Seconds></PlaylistEntry><PlaylistEntry><Title>The Gift</Title><Artist>David Nevue</Artist><Album>O Come Emmanuel</Album><ECommerceURL></ECommerceURL><FileName>nevue-gift.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>176</Seconds></PlaylistEntry><PlaylistEntry><Title>Time Circles</Title><Artist>H.U.V.A. Network</Artist><Album>Distances</Album><ECommerceURL></ECommerceURL><FileName>H.U.V.A._Network_-_Time_Circles_-_Distances_32_11_jst.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>509</Seconds></PlaylistEntry><PlaylistEntry><Title>Sahara</Title><Artist>Candyfloss</Artist><Album>Candyfloss</Album><ECommerceURL></ECommerceURL><FileName>candyfloss_sahara.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>334</Seconds></PlaylistEntry><PlaylistEntry><Title>Wings of the Morning</Title><Artist>John Doan</Artist><Album>Departures</Album><ECommerceURL></ECommerceURL><FileName>doan-wingsofmorn.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>332</Seconds></PlaylistEntry></Playlist> 2005-04-01 17:03:55.8133 Live365 Now Playing: Spiral Gate - Kim Robertson - Spiral Gate 2005-04-01 17:03:55.8143 Live365 next update: 112 seconds Use of uninitialized value in concatenation (.) or string at C:/PROGRA~1/SLIMSE~1/server/Plugins/Live365.pm line 609. 2005-04-01 17:06:08.8293 Got playlist response: Could not find slim.xml in .\ at C:/PROGRA~1/SLIMSE~1/server/Plugins/Live365.pm line 612 Use of uninitialized value in concatenation (.) or string at /PerlApp/Slim/Buttons/Plugins.pm line 82. Use of uninitialized value in string comparison (cmp) at /PerlApp/Slim/Buttons/Plugins.pm line 90. Use of uninitialized value in string comparison (cmp) at /PerlApp/Slim/Buttons/Plugins.pm line 90. Use of uninitialized value in string comparison (cmp) at /PerlApp/Slim/Buttons/Plugins.pm line 90. Use of uninitialized value in string comparison (cmp) at /PerlApp/Slim/Buttons/Plugins.pm line 90. 2005-04-01 17:06:08.8762 Plugins::Live365::ProtocolHandler shutting down 2005-04-01 17:06:08.8775 Live365 failed to kill playlist job timer. Here is the event log entry: The description for Event ID ( 0 ) in Source ( Application ) cannot be found. The local computer may not have the necessary registry information or message DLL files to display messages from a remote computer. You may be able to use the /AUXSOURCE= flag to retrieve this description; see Help and Support for details. The following information is part of the event: Could not find slim.xml in .\ at C:/PROGRA~1/SLIMSE~1/server/Plugins/Live365.pm line 612.
try changing line 612 to this: my $nowPlaying = XMLin( $playlist, ForceContent => 1 ) if defined $playlist; it wont help the warning at 609, but should avoid the crash at least. we'd need mroe debug info somewhere to track down the lack of $playlist. this is with latest nightly build, correct? dean, maybe this should be assigned to Jim? It looks like some fault in the live365 handler.
Created attachment 398 [details] add artist text simple patch, only supports fishbone skin right now. one way to add artist. it would still probably need an option similar to showYear, or we'd need a whole new titleformat regex (unlikely anyone will be into tackling that) to amke this more flexible.
Jim: Is this bug fixed in the latest live365 plugin you sent in? KDF: Is the attachment on the right bug?
The reference to slim.xml appears to be a result of the call to GetLive365Playlist() returning empty data, presumably as a result of a failed communication with Live365. I suggest falling back to the station title (from line 603) and returning undef if my $playlist = $api->GetLive365Playlist( $isVIP, $handle ); ...isn't true. SVN isn't behaving as I expect, and my attempt to diff a patch against the "update" copy is resulting in more changes than really exist from the checked-in revision. I can get you a patch when I straighten that out.
d'oh. my patch was for 1249 :) jim's plan sounnds right along what I was thinking. I just wasnt sure if it was the right thing to get the right results.
Not sure if this is related or not, but a similar problem started on the night of April 13. Below is the entry from the WinXP event viewer. The description for Event ID ( 0 ) in Source ( Application ) cannot be found. The local computer may not have the necessary registry information or message DLL files to display messages from a remote computer. You may be able to use the /AUXSOURCE= flag to retrieve this description; see Help and Support for details. The following information is part of the event: Could not find slimsvc.xml in .\ at C:/Program Files/SlimServer/server/Plugins/Live365.pm line 612 . It happened 2 nights in a row, so I don't think it's a fluke. I'll turn the logging on Tonight and post the results Tomorrow. Roy
Here is the log output for the most recent crash: 2005-04-17 00:31:16.3403 Live365 Now Playing: Inamorata - Vas - In The Garden Of Souls 2005-04-17 00:31:16.3414 Live365 next update: 289 seconds 2005-04-17 00:31:16.6571 Got playlist response: <?xml version="1.0" encoding="UTF-8"?><Playlist><Refresh>289</Refresh><Broadcaster>afl:stoneclaveradio</Broadcaster><PlaylistEntry><Title>Inamorata</Title><Artist>Vas</Artist><Album>In The Garden Of Souls</Album><ECommerceURL></ECommerceURL><FileName>02-Inamorata.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>289</Seconds></PlaylistEntry><PlaylistEntry><Title>Atrus' Theme</Title><Artist>Robyn Miller</Artist><Album>RIVEN Soundtrack</Album><ECommerceURL></ECommerceURL><FileName>robyn_miller_-_atrus_theme_-_riven_3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>240</Seconds></PlaylistEntry><PlaylistEntry><Title>Storms in Africa [Mystic Mix]</Title><Artist>Enya</Artist><Album>Watermark</Album><ECommerceURL></ECommerceURL><FileName>enya_-_storms_in_africa__ten_year_mix__watermark_3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>276</Seconds></PlaylistEntry><PlaylistEntry><Title>First Touch</Title><Artist>Kostia</Artist><Album>Suite St. Petersburg</Album><ECommerceURL></ECommerceURL><FileName>Kostia___First_Touch-suite_st_petersburg_3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>136</Seconds></PlaylistEntry><PlaylistEntry><Title>Carnation Lily Lily Rose</Title><Artist>Andrew White/David Arkenstone</Artist><Album>Island</Album><ECommerceURL></ECommerceURL><FileName>andrew_white_david_ark-Carnation_Lily_Lily_Rose-island_3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>286</Seconds></PlaylistEntry><PlaylistEntry><Title>Sweet Dreams & Starlight</Title><Artist>David Nevue</Artist><Album>Sweet Dreams & Starlight</Album><ECommerceURL></ECommerceURL><FileName>david_nevue-sweet_dreams___starlight-same3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>247</Seconds></PlaylistEntry><PlaylistEntry><Title>Gentle Speaks the Heart</Title><Artist>Stephanie Sante</Artist><Album>Inner Beauty</Album><ECommerceURL></ECommerceURL><FileName>stephanie_sante_-_Gentle_Speaks_the_Heart3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>482</Seconds></PlaylistEntry><PlaylistEntry><Title>Na Laethe Bhi</Title><Artist>Clannad</Artist><Album>Banba</Album><ECommerceURL></ECommerceURL><FileName>clannad_-_na_laethe_bhi_-_banba_3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>318</Seconds></PlaylistEntry><PlaylistEntry><Title>Fable (Dream Edit)</Title><Artist>Robert Miles</Artist><Album>Dreamland</Album><ECommerceURL></ECommerceURL><FileName>robert_miles-fable_dream_vers_edit-dreamland3211.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>355</Seconds></PlaylistEntry><PlaylistEntry><Title>Carolan's Ramble</Title><Artist>Angelo Eleuteri</Artist><Album>The Music of O'Carolan</Album><ECommerceURL></ECommerceURL><FileName>eleuteri-carolanramble.mp3</FileName><trackType></trackType><desc></desc><clickThruURL></clickThruURL><visualURL></visualURL><Seconds>161</Seconds></PlaylistEntry></Playlist> 2005-04-17 00:31:16.6730 Live365 Now Playing: Inamorata - Vas - In The Garden Of Souls 2005-04-17 00:31:16.6741 Live365 next update: 289 seconds Use of uninitialized value in concatenation (.) or string at C:/Program Files/SlimServer/server/Plugins/Live365.pm line 609. 2005-04-17 00:31:37.6571 Got playlist response: Could not find slim.xml in .\ at C:/Program Files/SlimServer/server/Plugins/Live365.pm line 612 2005-04-17 00:31:37.8446 Plugins::Live365::ProtocolHandler shutting down Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. 2005-04-17 00:31:37.8463 Plugins::Live365::ProtocolHandler shutting down Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. 2005-04-17 00:31:37.8475 Live365 failed to kill playlist job timer. 2005-04-17 00:31:37.8730 Plugins::Live365::ProtocolHandler shutting down Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. 2005-04-17 00:31:37.8745 Live365 failed to kill playlist job timer. 2005-04-17 00:31:37.8781 Plugins::Live365::ProtocolHandler shutting down 2005-04-17 00:31:37.8791 Live365 failed to kill playlist job timer. 2005-04-17 00:31:37.8808 Plugins::Live365::ProtocolHandler shutting down Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. Use of uninitialized value in string eq at /PerlApp/Slim/Utils/Timers.pm line 257 during global destruction. 2005-04-17 00:31:37.8821 Live365 failed to kill playlist job timer.
Jim: Is this fixed in the latest live365 plugin in svn?
An update to make the playlist routine tolerant of bad data is being tested, ETA 4-23.
Fix committed to trunk (change 3062) and 6.0.x branch (change 3063).