Bugzilla – Bug 17317
SBT will not remain powered off when synced to other SB devices in 7.6 (SBS)
Last modified: 2011-08-15 12:57:21 UTC
Even with "Synchronize Power" set to "Power off/on Separately" in SBS - the SBT will randomly power back on after power is turned off. Running squeezeboxserver-7.6.0-0.1.32722.noarch.rpm with the latest firmware update on the SBT.
Alan, this is the bug that I mistakenly tried to combine with bug 17307. It is also discussed in http://forums.slimdevices.com/showthread.php?t=88616. I spent some time this morning with various debugging enabled, but was unable to find anything in the logs when the problem occurs. I can add the following details about my experiences: - The problem started about a month ago with 7.6 nightlys. - I have a sync group with 2 booms, 2 radios and 2 touches (power and volume not synced). The problem does not affect the booms. - The problem does not affect other players connected to the same server but not part of the sync group. - As the bug report states, the problem is that a member of the sync group that is off, turns itself on. This does not seemed to be related to any other user event happening at the same time. While listening to one (or more) players, another player will simply turn on. - On the touch, it doesn't always turn on. Sometimes it switches to the NP display, but remains off. - I've noticed this mostly when listening to internet radio, but I think it affects other sources as well. Let me know what testing I can do to help. This occurs at least once per day for me.
PS - my SBT is in a sync-group with a SBR and a SBB
Power indicator still shows dim in SBS web interface after the SBT randomly powers back up.
Michael, I noticed coming back from a weekend camping that all of my squeezeboxes were confused whether they were off or on. I don't think all of the confused ones were in sync groups, but at least one of them was. Any chance there's been a recent change, 9252-9255, that may have affected power on/power off screensaver logic?
> Any chance there's been a recent change, 9252-9255, that may have affected > power on/power off screensaver logic? 9452+ you mean? No: string & icon changes, plus a change in SetupDateTimeApplet re. initial setup. But do you remember the bug I once opened which you were unable to reproduce? Where a player would be playing, while it was still showing the idle screensaver etc.? Your case remembers me very much of the issue I had back then.
>9452+ you mean? No: string & icon changes, plus a change in SetupDateTimeApplet >re. initial setup. that's what I meant, but sounds like there are no candidates. >But do you remember the bug I once opened which you were unable to reproduce? >Where a player would be playing, while it was still showing the idle >screensaver etc.? Your case remembers me very much of the issue I had back >then. I do, because I spent quite some time trying to reproduce it and failed. I'll keep my eye on this and see if it happens again here, and provide more info if/when it does. Because of the logic required, there is some reasonably tricky code to handle power on/power off state in Squeezeplay. One suggestion is to either throw in some debug code or even create something in diagnostics that can report what the powerState (as squeezeplay believes it to be). It's possible you could isolate a particular set of steps where the server believes the player is off and the player does not.
This is easily reproducible for me. Any suggestions as to what logging to turn on?
set applets.AlarmSnooze to DEBUG, as there will be a debug message that will print there on a notify_playerPower() event also can't hurt to set applets.ScreenSavers to DEBUG as well
Here's some logs from when the event happened. In this case, the "Living Room" player, a Touch, changed to the NP screen by itself, but did not start playing. I'll try to get another one where it actually does start playing. When this occurred there were 2 or 3 other members of the sync group on and playing. This event *may* have happened at the same time as I turned off one of the other sync members via the webUI. Server is 7.6.0 - r32713 on arm linux. Jul 19 10:33:00 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:538 screensaver opened 1 Jul 19 10:33:00 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:556 screensaver closed 1 Jul 19 10:33:00 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:538 screensaver opened 1 Jul 19 10:33:00 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:556 screensaver closed 1 Jul 19 10:33:30 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 10:33:30 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 10:33:30 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 10:33:30 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 10:33:33 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 10:33:33 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 10:33:33 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 10:33:33 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 10:33:34 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 10:33:34 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 10:33:34 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 10:33:34 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 10:34:31 squeezeplay: WARN net.thread - NetworkThread.lua:146 network thread timeout for Task(SocketHttp {Server_Request}(R)) Jul 19 10:36:23 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 10:36:23 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 10:36:23 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 10:36:23 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil
Here's one where the player turns on and starts playing what the sync group is playing. Now that I've had a chance to experiment, I can definitely trigger this by turning other members of the sync group on and off. It seems as if turning a member off is usually what turns another one on incorrectly. I'm pretty sure, though, that I've seen this happen with no user interaction with any UI. Jul 19 16:09:00 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:538 screensaver opened 1 Jul 19 16:09:00 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:556 screensaver closed 1 Jul 19 16:09:00 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:538 screensaver opened 1 Jul 19 16:09:00 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:556 screensaver closed 1 Jul 19 16:09:49 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:09:49 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:09:49 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:09:49 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:09:54 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:09:54 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:09:54 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:09:54 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:09:55 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:09:55 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:09:55 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:09:55 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:09:58 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:09:58 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:09:58 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:09:58 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:05 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:05 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:05 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:05 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:11 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:11 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:11 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:11 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:15 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:15 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:15 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:15 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:22 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:22 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:22 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:22 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:27 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:27 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:27 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:27 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:32 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:32 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:32 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:32 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:35 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:35 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:35 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:35 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:37 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:386 Screensaver deactivate Jul 19 16:10:37 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:359 whenOff: Clock:openDetailedClockBlack Jul 19 16:10:37 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:552 screensaver inactive Jul 19 16:10:37 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:556 screensaver closed 0 Jul 19 16:10:37 squeezeplay: INFO squeezeplay - JiveMain.lua:207 Turn soft power on Jul 19 16:10:37 squeezeplay: INFO squeezebox.server - SlimServer.lua:628 wakeOnLan(): Sending WOL to f0:ad:4e:00:50:60 Jul 19 16:10:38 squeezeplay: INFO audio.decode - decode_start_handler:280 init decoder mp3 Jul 19 16:10:38 squeezeplay: INFO audio.decode - Playback.lua:445 connect 192.168.1.153:9000 GET /stream.mp3?player=00:04:20:22:01:e1 HTTP/1.0^M Jul 19 16:10:39 squeezeplay: INFO audio.decode - decode_start_handler:280 init decoder mp3 Jul 19 16:10:39 squeezeplay: INFO audio.decode - Playback.lua:445 connect 192.168.1.153:9000 GET /stream.mp3?player=00:04:20:22:01:e1 HTTP/1.0^M Jul 19 16:10:40 squeezeplay: INFO audio.decode - decode_start_handler:280 init decoder mp3 Jul 19 16:10:40 squeezeplay: INFO audio.decode - Playback.lua:445 connect 192.168.1.153:9000 GET /stream.mp3?player=00:04:20:22:01:e1 HTTP/1.0^M Jul 19 16:10:41 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:293 notify_playerPower(): true Jul 19 16:10:41 squeezeplay: INFO applet.SlimDiscovery - SlimDiscoveryApplet.lua:517 notify_playerPower: true Jul 19 16:10:41 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:317 notify_playerModeChange: player (LocalPlayer {Living Room}) mode has been changed to play Jul 19 16:10:41 squeezeplay: WARN applet.AlarmSnooze - AlarmSnoozeApplet.lua:323 notify_playerModeChange: - audioState is 0 Jul 19 16:10:42 squeezeplay: INFO squeezeplay.applets - AppletManager.lua:708 store settings: Playback Jul 19 16:10:44 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:44 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:44 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:44 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:45 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:45 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:45 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:45 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:46 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:46 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:46 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:46 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:10:59 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:502 _menuSink(1) nil menuDirective: add isCurrentServer:true Jul 19 16:10:59 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:802 hiding any 'connecting to server' popup after menu response from current server, SlimServer {Server} Jul 19 16:10:59 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:275 notify_playerLoaded(LocalPlayer {Living Room}) Jul 19 16:10:59 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jul 19 16:11:07 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:227 Screensaver activate Jul 19 16:11:07 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:362 whenPlaying: NowPlaying:openScreensaver Jul 19 16:11:07 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:244 DEBUG: self:isScreensaverActive()false self.current: nil Jul 19 16:11:37 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:227 Screensaver activate Jul 19 16:11:37 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:362 whenPlaying: NowPlaying:openScreensaver Jul 19 16:11:37 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:244 DEBUG: self:isScreensaverActive()false self.current: nil Jul 19 16:11:39 squeezeplay: WARN net.thread - NetworkThread.lua:146 network thread timeout for Task(SocketHttp {Server_Request}(R)) Jul 19 16:12:07 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:227 Screensaver activate Jul 19 16:12:07 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:362 whenPlaying: NowPlaying:openScreensaver Jul 19 16:12:07 squeezeplay: DEBUG applet.ScreenSavers - ScreenSaversApplet.lua:244 DEBUG: self:isScreensaverActive()false self.current: nil
I just had this happen. A Touch turned on and started playing (as part of a sync-group that was already playing). Here is the log around the event, which occurred at 12:27:52: Jul 23 08:27:46 udhcpc[1117]: Sending renew... Jul 23 08:27:48 udhcpc[1117]: Lease of 192.168.11.102 obtained, lease time 86400 Jul 23 08:27:48 root: udhcpc_action wlan0 renew ip=192.168.11.102 Jul 23 12:17:51 squeezeplay: INFO applet.NowPlaying - NowPlayingApplet.lua:422 enable volume UI in NP Jul 23 12:18:52 squeezeplay: WARN net.thread - NetworkThread.lua:146 network thread timeout for Task(SocketHttp {oz_Request}(R)) Jul 23 12:27:52 squeezeplay: INFO applet.NowPlaying - NowPlayingApplet.lua:422 enable volume UI in NP Jul 23 12:27:52 squeezeplay: INFO squeezeplay - JiveMain.lua:207 Turn soft power on Jul 23 12:27:52 squeezeplay: INFO squeezebox.server - SlimServer.lua:628 wakeOnLan(): Sending WOL to 00:1d:60:6a:d5:4c Jul 23 12:27:52 squeezeplay: DEBUG audio.decode - Playback.lua:597 strm q I'll try adjusting the log levels and see if it happens again.
I have seen many instance of the following symptom. Synced Touch is powered off and has 'blank' as is off screensaver. The display spontaneously lights ou with the "When off" NP screen. The only log entry is: Jul 27 13:04:38 squeezeplay: INFO applet.NowPlaying - NowPlayingApplet.lua:422 enable volume UI in NP I have the debug logging enabled as requested by Ben. This occurs frequently, maybe after 10 minutes. Using the Back button returns to the blank screen. I believe that I have also seen the full spontaneous power-on case but this is no so reproducible.
I wonder if this is related to r9418.
... probably not
I don't know if the problems are connected but I experienced a simililiar behavior on my Radio with 7.6 r9449 that I traced to r9443 changes. I After reverting to using the SlimBrowserApplet.lua from a saved r9443 Radio firmware the problem disappeared completely. More details may be found in the following forum thread (starting at posting #15): http://forums.slimdevices.com/showthread.php?t=87386&page=2
Here is a better debug trace. Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:508 notify_playerTrackChange(): BBC Radio 2 Jul 28 08:06:12 squeezeplay: BBC Radio 2 Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1318 REPLACING NP WINDOW Jul 28 08:06:12 squeezeplay: INFO applet.NowPlaying - NowPlayingApplet.lua:422 enable volume UI in NP Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:737 _updateButtons Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:807 reset buttons to defaults Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1082 _updateRepeat(): 0 Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1099 repeat button style changed to: repeatOff Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1058 _updateShuffle(): 0 Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1075 shuffle button style changed to: shuffleOff Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:827 changing rbutton to + button Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:551 notify_playerPlaylistChange() Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:737 _updateButtons Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:807 reset buttons to defaults Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1049 new volume from player: 71 Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:164 style nowplaying okay for this player Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:164 style nowplaying_art_only okay for this player Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:164 style nowplaying_text_only okay for this player Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:164 style nowplaying_spectrum_text okay for this player Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:164 style nowplaying_vuanalog_text okay for this player Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1819 player=LocalPlayer {Fab4} status=table: 0x824bf0 Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1082 _updateRepeat(): 0 Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1099 repeat button style changed to: repeatOff Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1058 _updateShuffle(): 0 Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1075 shuffle button style changed to: shuffleOff Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:737 _updateButtons Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:807 reset buttons to defaults Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:737 _updateButtons Jul 28 08:06:12 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:807 reset buttons to defaults Jul 28 08:06:13 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1404 trackTitle animation done, animate artistalbum/artistTitle Jul 28 08:06:13 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1429 artist animation done, animate album text Jul 28 08:06:13 squeezeplay: DEBUG applet.NowPlaying - NowPlayingApplet.lua:1438 in albumTitle textStop callback Jul 28 08:07:13 squeezeplay: WARN net.thread - NetworkThread.lua:146 network thread timeout for Task(SocketHttp {oz_Request}(R))
== Auto-comment from SVN commit #9461 to the jive repo by ayoung == == http://svn.slimdevices.com/jive?view=revision&revision=9461 == bug 17317: SBT will not remain powered off when synced to other SB devices in 7.6 Fix typo that could be related (but probably not).
== Auto-comment from SVN commit #9462 to the jive repo by ayoung == == http://svn.slimdevices.com/jive?view=revision&revision=9462 == bug 17317: SBT will not remain powered off when synced to other SB devices in 7.6 Only go to NP on playlist change if ON.
I am pretty sure that the change above solves the problem with the screen coming on (in NP) but the player remaining in soft power-off state. It turns out that r9418 is at least partly relevant. That change introduced a 10-minute player-status poll, in addition to the on-demand notifications that occur. But the difference is that an on-demand notification will not be sent to an OFF player for playlist and metadata notifications, whereas the 10-minute status will always be sent. SP then notices the change in the playlist and triggers the update.
I'm not certain, because it seems to be much more difficult to reproduce, but the 'starting playing' case is probably also triggered by the issue that the fix above addresses. In this case there has to be a screen-saver active, in which case the showNowPlaying() causes the old SS to be deactivated which in turn causes a power-on action. It could be a that a better fix would be simply to return at the start of SlimBrowserApplet:notify_playerPlaylistChange() if the player is not on. If Ben is reading this then maybe he might comment.
Not sure if this helps, but the following just occurred to me regarding the 2 cases of "change to NP but remain soft-off" vs. "start playing". I don't think I've ever seen the former on a radio - it always starts playing when this happens. On the touch I've seen both, probably the former more often than the latter.
The new SlimBrowserApplet.lua from r9462 seems to work fine (with Radio firmware r9449 at least).
I don't know whether this is the same bug or another: My SBT-display turns on by itself, but the SBT is not part of a sync group. Most of the times the state of the SBT seems still to be "off", but the display is on (I can swipe through the menus but have to click twice to turn it off again). This happens about every 24 hours and since approx. 1 month now.
I'm also not sure this is the same bug, but here is what I posted in the Slimdevices forum linked to above: Problem started after my SBT was upgraded to 7.6 by mysb.com. I was going to skip the upgrade for a while but accidentally went thru with it. For me, it looks like it goes from screensaver when off to the now playing screen. It does say 'when off' at the top. It is connected to mysb.com most of the time (that's also when the screen changes have happened). Also, it is not synced to any other players.
I think this bug is more general then the title implies. I have a brand new Squeezebox Touch that often turns on by itself, and there is no other SB device it syncs with. I bought by Touch brand new a couple days ago. All I've done is allow the firmware to automatically update, and then add/configure the official Spotify App. Oh, and I favorited one internet radio station. That's it. I haven't installed anything on my computer or sync'ed anything, and don't own any other SB devices. Every five minutes or so it stops displaying the clock and shows the play screen for my last played track (via spotify). It also says "when off" in the button at the top. The music isn't playing because I left it in a paused state.
I have the same problem since last firmware update on my Radio and my Touch : I find them power on, displaying last radio listened, but no sound is playing. But, note that (it's important): -I am connected to mysqueezebox.com (no use of squeezeboxserver) for both of them -No Squeezebox are synchronized I have not open a new bug because I think it's perhaps the same ?? Thank you.
I just had this start happening after upgrading to 7.6. But, I have never used synchronization and run my own Squeezebox Server. I don't remember it ever happening with 7.5.x.
This keeps happening. I'll switch a radio off as I leave the room, and it's powered itself back on again a few minutes later. It seems easily reproducible: just restart SBS. It's definitely a firmware issue, since it was happening a few weeks ago with the radio running the latest firmware but with an SBS from way back in February. IMO this needs to be high priority, because even if the household has a resident geek who can work around most issues, this affects other people who just want to listen to music and not be chastised for leaving the radio switched on when they've done nothing wrong. <hangs head in shame>
Yesterday (8/5/2011) my SBT updated to 7.6.0-r9463 and has been acting as it should. It has NOT randomly powered on since this update. It has been over 24 hours, it would never stay powered off that long before under 7.6 Perhaps the issue has been resolved with this update? NOW- I just updated to today's firmware push: 7.6.0-r9464, so far, things still look good. STB is not powering on randomly.
(In reply to comment #29) > Yesterday (8/5/2011) my SBT updated to 7.6.0-r9463 and has been acting as it > should. It has NOT randomly powered on since this update. It has been over 24 > hours, it would never stay powered off that long before under 7.6 Perhaps the > issue has been resolved with this update? NOW- I just updated to today's > firmware push: 7.6.0-r9464, so far, things still look good. STB is not powering > on randomly. Correction: "Yesterday" was 8/4/2011 - not 8/5/2011 :)
(In reply to comment #29) > I just updated to today's > firmware push: 7.6.0-r9464, so far, things still look good. STB is not powering > on randomly. Good to hear, Tim. I have been following this bug and waiting to update until it was resolved. I am curious to hear others' experiences with 7.6.0-r9464 firmware.
My Radio is not synced to my Touch. I have noticed that since 7.6 FW upgrade it comes out of standby to the last played station in stop mode--no sound. I wonder if it is related to Bug 17398? I am not sure, but it seems like it tends to happen after the alarm has triggered and instead of choosing "alarm off", I just put the Radio in standby using the power button.
As the bug title says - this bug is for when players are synced. If you encounter the issue that a not synced player randomly turns itself on, i.e. does not stay in the off screen, please report to bug 17391. Thanks.
(In reply to comment #22) > The new SlimBrowserApplet.lua from r9462 seems to work fine (with Radio > firmware r9449 at least). Updating the latest 7.6 Radio firmware (r9458) with the files from r9461 and r9462 works fine, too. :)
Things still working great, SBT does NOT randomly power on while in a sync-group with a SBR and a SBB after the lastest two firmware pushes - 7.6.0-r9463 and 7.6.0-r9464. Running squeezeboxserver-7.6.1-0.1.32942.noarch.rpm
I'm still seeing this on 7.6.0
Still seeing random Squeezebox Radio / Touch turned on, Running R33004 with Touch firmware 9464 and Radio 6458. The setup have 2 Radios, 1 Touch and 1 Boom synchronized ( but not sync volume or power). I turned off Touch on the touchscreen, it will turn back on when I switch off the Radio (or press "Pause" to play the music after previously Pausing the music). One or both Radios will also turn on and play randomly (when they are off) when only Touch was playing after say 15 minutes. When I power-down the Radios (by pressing Power button for couple seconds), the Touch that was on and playing will also pause and stop playing. All in all 7.6 sync is a mess.
Fixed in 7.6.1. Need updated Radio firmware with fix for 7.6.1. Already believed to be fixed in Touch only so far.
Seems to be fixed. Awaiting Radio firmware push to test that.
That www.sn.com is hard-coded: Index: SlimProto.lua =================================================================== --- SlimProto.lua (revision 9458) +++ SlimProto.lua (working copy) @@ -424,7 +424,7 @@ end serverip = self.lastServerip elseif serverip == 1 then - serverip = "www.squeezenetwork.com" + serverip = self.jnt.getSNHostname() elseif serverip == 2 then serverip = "www.test.squeezenetwork.com" else
Huh? Sorry but I do not quite get that post... (In reply to comment #40) > That www.sn.com is hard-coded: > > Index: SlimProto.lua > =================================================================== > --- SlimProto.lua (revision 9458) > +++ SlimProto.lua (working copy) > @@ -424,7 +424,7 @@ > end > serverip = self.lastServerip > elseif serverip == 1 then > - serverip = "www.squeezenetwork.com" > + serverip = self.jnt.getSNHostname() > elseif serverip == 2 then > serverip = "www.test.squeezenetwork.com" > else
> Huh? Sorry but I do not quite get that post... I'm sorry, wrong bug (though probably related...)
baby_7.6.1_r9468 has been pushed out. fab4 and jive will be updated to the same version shortly.
Cool. Will they be in todays Nightly Build? (In reply to comment #43) > baby_7.6.1_r9468 has been pushed out. fab4 and jive will be updated to the same > version shortly.
Please, will it fix 17391 ? Is it the same origin r totally different ? Thank tou
They aren't part of the nightly, all 3 are already updated to 7.6.1 if you are using any nightly.
Hmm... But how will I be able to update then...? (In reply to comment #46) > They aren't part of the nightly, all 3 are already updated to 7.6.1 if you are > using any nightly.
So far so good with r9468 on both Radio and Touch. Thanks! This has been a real annoyance since I seem to have very few clocks that are not Squeezeboxes...
Same fix as the other bug.
Will it be long to have the new fw in Europe ? Is it rolled out ? Thank you.
My new SBT is not synced, but it has turned on by itself at least once in the first three days I have had it running.