So, with bit rate limiting removed the problem remains.  This morning
alarms came on in two rooms at 07:00 as planned; in one room ("Front
Bedroom Player") the Squeezebox Radio began playing a random song, then
went silent after ~10 seconds, then some seconds later it switched to
the default alarm sound.  In the other room ("Hazel's Bedroom Player")
the Squeezebox Radio actually worked correctly, paying random songs as
it should.

An LMS log is attached.  Again, I'm not sure what error messages are
significant or whether I've logged the right things at debug level, but
at ~15 seconds in there is an occurrence of:


Code:
--------------------
    [17-07-14 07:00:15.7632] Slim::Player::Protocols::File::sysread (286) 
Trying to read past the end of file: 
file:///C:/Users/Loft/Music/iTunes/iTunes%20Music/Iron%20Maiden/The%20Number%20Of%20The%20Beast/07%20Gangland.m4a
  [17-07-14 07:00:15.7635] Slim::Player::Source::_readNextChunk (350) Read to 
end of file or pipe
  [17-07-14 07:00:15.7638] Slim::Player::Source::_readNextChunk (373) end of 
file or error on socket, song pos: 3692923, tell says: 3692923, totalbytes: 
3692923
  [17-07-14 07:00:15.7640] Slim::Player::Source::_readNextChunk (378) 
00:04:20:26:f1:e2 mark end of stream
  [17-07-14 07:00:15.7644] Slim::Player::StreamingController::_eventAction 
(271) 00:04:20:26:f1:e2: LocalEndOfStream in PLAYING-STREAMING -> 
Slim::Player::StreamingController::_Streamout
--------------------


...and at 22 seconds in:


Code:
--------------------
    [17-07-14 07:00:22.3901] Slim::Player::StreamingController::stop (2097) 
00:04:20:26:f1:be
  [17-07-14 07:00:22.3907] Slim::Player::StreamingController::_eventAction 
(271) 00:04:20:26:f1:be: Stop in PLAYING-STREAMING -> 
Slim::Player::StreamingController::_Stop
  [17-07-14 07:00:22.3918] Slim::Player::StreamingController::_Stop (603) Song 
queue is now 0
  [17-07-14 07:00:22.3926] Slim::Player::SongStreamController::DESTROY (44) 
DESTROY(Slim::Player::SongStreamController=HASH(0xae16cac)) live=1
  [17-07-14 07:00:22.3930] Slim::Player::StreamingController::_setPlayingState 
(2357) new playing state STOPPED
  [17-07-14 07:00:22.3934] 
Slim::Player::StreamingController::_setStreamingState (2366) new streaming 
state IDLE
  [17-07-14 07:00:22.3939] Slim::Player::StreamingController::_eventAction 
(303) 00:04:20:26:f1:be: Stop - new state STOPPED-IDLE
  [17-07-14 07:00:22.3948] Slim::Player::Source::playmode (96) 
00:04:20:26:f1:be: Current playmode: stop
--------------------


...followed shortly by something that definitely looks like an error:


Code:
--------------------
    
  [17-07-14 07:00:22.9229] 
Slim::Player::StreamingController::playerTrackStarted (2180) 00:04:20:26:f1:be
  [17-07-14 07:00:22.9234] Slim::Player::StreamingController::_eventAction 
(271) 00:04:20:26:f1:be: Started in STOPPED-IDLE -> 
Slim::Player::StreamingController::_Invalid
  [17-07-14 07:00:22.9238] Slim::Player::StreamingController::_Invalid (326) 
00:04:20:26:f1:be: event Started received while in invalid state STOPPED-IDLE
  [17-07-14 07:00:22.9242] Slim::Player::StreamingController::_Invalid (328) 
Error: 
  [17-07-14 07:00:22.9248] Slim::Player::StreamingController::_Invalid (328) 
Backtrace:
  
  frame 0: Slim::Utils::Log::logBacktrace 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Player/StreamingController.pm
 line 328)
  frame 1: Slim::Player::StreamingController::_Invalid 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Player/StreamingController.pm
 line 288)
  frame 2: Slim::Player::StreamingController::_eventAction 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Player/StreamingController.pm
 line 2189)
  frame 3: Slim::Player::StreamingController::playerTrackStarted 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Player/Squeezebox2.pm line 
145)
  frame 4: Slim::Player::Squeezebox2::statHandler 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Networking/Slimproto.pm line 
853)
  frame 5: Slim::Networking::Slimproto::_stat_handler 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Networking/Slimproto.pm line 
402)
  frame 6: Slim::Networking::Slimproto::client_readable 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Networking/IO/Select.pm line 
123)
  frame 7: (eval) 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Networking/IO/Select.pm line 
119)
  frame 8: Slim::Networking::IO::Select::__ANON__ 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Networking/IO/Select.pm line 
168)
  frame 9: (eval) 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Networking/IO/Select.pm line 
168)
  frame 10: Slim::Networking::IO::Select::loop (slimserver.pl line 728)
  frame 11: main::idle (slimserver.pl line 89)
  frame 12: PerlSvc::Startup 
(/<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>PerlSvc.pm line 95)
  frame 13: PerlSvc::_startup (slimserver.pl line 0)
  frame 14: (eval) (slimserver.pl line 0)
--------------------


Any suggestions as to what I might try next?


+-------------------------------------------------------------------+
|Filename: alarm_failure.zip                                        |
|Download: http://forums.slimdevices.com/attachment.php?attachmentid=23113|
+-------------------------------------------------------------------+

------------------------------------------------------------------------
Rob Meades's Profile: http://forums.slimdevices.com/member.php?userid=533
View this thread: http://forums.slimdevices.com/showthread.php?t=107622

_______________________________________________
Squeezecenter mailing list
[email protected]
http://lists.slimdevices.com/mailman/listinfo/squeezecenter

Reply via email to