Bug 10250 - SBC does not reconnect to SN when coming out of sleep (power up)
: SBC does not reconnect to SN when coming out of sleep (power up)
Status: CLOSED FIXED
Product: SB Controller
Classification: Unclassified
Component: SqueezeNetwork
: unspecified
: PC All
: -- major with 1 vote (vote)
: 7.3.3
Assigned To: Ross Levine
http://forums.slimdevices.com/showthr...
:
Depends on:
Blocks: 10454
  Show dependency treegraph
 
Reported: 2008-12-08 06:59 UTC by James Richardson
Modified: 2009-09-08 09:20 UTC (History)
7 users (show)

See Also:
Category: ---


Attachments
1st log set (386.56 KB, application/octet-stream)
2008-12-08 10:34 UTC, James Richardson
Details
2nd log set (1000.13 KB, application/octet-stream)
2008-12-08 10:34 UTC, James Richardson
Details
SBC 1 (708.61 KB, application/octet-stream)
2008-12-08 20:04 UTC, James Richardson
Details
SBC 2 (120.72 KB, application/octet-stream)
2008-12-08 20:04 UTC, James Richardson
Details
Failed to connect from Power UP (38.00 KB, text/plain)
2009-02-04 07:47 UTC, James Richardson
Details
Failed to connect from Power UP (95.37 KB, text/plain)
2009-02-04 07:56 UTC, James Richardson
Details
another serial capture (205.09 KB, text/plain)
2009-02-04 10:03 UTC, James Richardson
Details

Note You need to log in before you can comment on or make changes to this bug.
Description James Richardson 2008-12-08 06:59:53 UTC
When the SBC is attached to SN, it fails to reconnect to the last player it was attached to when recovering from sleep.

This will happen if the player is any IP3K or SBR device.

Steps to reproduce:
Attach Duet to SN
Leave SBC in our out of dock
stop any music playback
Allow the SBC to go to sleep
Bring the SBC out of sleep and notice that it has dropped the player and is at the 'choose player' menu.  SBC is at white network icon.

This has been reproduced with 7.2 3191 as well as 7.3 nightly firmware.

Which SBC Logs would you like me to attempt to capture?
Comment 1 James Richardson 2008-12-08 09:12:14 UTC
James will get net.comet logs from the controllers and attach to this.
Comment 2 James Richardson 2008-12-08 10:34:25 UTC
Created attachment 4398 [details]
1st log set
Comment 3 James Richardson 2008-12-08 10:34:42 UTC
Created attachment 4399 [details]
2nd log set
Comment 4 James Richardson 2008-12-08 10:35:26 UTC
Ben: See the 2 attached logs, tell me if that helps or not?
Comment 5 Ben Klaas 2008-12-08 20:00:53 UTC
afaict, playerConnected message is not being generated by Player.lua

That's the same conclusion I came to when investigating one of the other bugs that have been open in the past few weeks related to SN/SC switching.

No cause as of yet, but my hunch is a race condition, esp. since it seems to show up with SN. Will investigate further tomorrow.
Comment 6 James Richardson 2008-12-08 20:03:14 UTC
Ben: here are 2 more logs, from the SBC's I have at home
Comment 7 James Richardson 2008-12-08 20:04:09 UTC
Created attachment 4401 [details]
SBC 1
Comment 8 James Richardson 2008-12-08 20:04:28 UTC
Created attachment 4402 [details]
SBC 2
Comment 9 Ben Klaas 2008-12-09 09:23:20 UTC
From the attachment marked "SBC 1", I'm seeing that the controller does not think that SN has any attached players. James, any chance your player is attaching itself to a different SN account than your controller?

Dec  8 19:43:33 SqueezeboxController user.debug jive: (Comet.lua:795) - Comet {SqueezeNetwork}: _response, /116538X01ddddbfe4d0beae215d2384d6000320X1228775412Xc247165f/slim/serverstatus id=1 OK
Dec  8 19:43:33 SqueezeboxController user.debug jive: (Comet.lua:855) - Comet {SqueezeNetwork}: _response, notifiying callbacks for /slim/serverstatus
Dec  8 19:43:33 SqueezeboxController user.debug jive: (Comet.lua:858) -   callback to: function: 0x154c80
Dec  8 19:43:33 SqueezeboxController user.info jive: (SlimServer.lua:201) - SlimServer {SqueezeNetwork}: has no players!
Dec  8 19:43:55 SqueezeboxController user.info jive: (SqueezeboxJiveApplet.lua:584) - setPowerState=sleep acpower=true
Dec  8 19:43:55 SqueezeboxController user.info jive: (SqueezeboxJiveApplet.lua:997) - Set CPU speed 200000
Dec  8 19:43:57 SqueezeboxController user.info jive: (SlimDiscoveryApplet.lua:189) - Removing player Player {Squeezebox 161147}
Dec  8 19:43:57 SqueezeboxController user.info jive: (Player.lua:430) - Player {Squeezebox 161147} delete for false
Dec  8 19:43:57 SqueezeboxController user.info jive: (NetworkThread.lua:249) - NOTIFY: playerDelete(Player {Squeezebox 161147})
Comment 10 Andy Grundman 2008-12-09 09:30:34 UTC
SN builds the list of connected players by using the serviceip database field.  There is another bug where somehow players are connected to SN but this field is null.  This would cause the player list to be empty.  Wonder if they are related.
Comment 11 James Richardson 2008-12-09 10:00:50 UTC
(In reply to comment #9)
> From the attachment marked "SBC 1", I'm seeing that the controller does not
> think that SN has any attached players. James, any chance your player is
> attaching itself to a different SN account than your controller?
> 
Nope, that is my unit from home, only ever been attached to a single SN account, with a Boom and SB3 as the players.  This controller was attached to the Boom before going to sleep

Comment 12 Ben Klaas 2008-12-09 12:14:06 UTC
Comment #10 from Andy sounds promising, given what I saw in the log and reported in Comment #9.

A bunch more test cycles here at my house waking up to an SN-connected player. Just can't get it to fail here...
Comment 13 James Richardson 2008-12-10 13:37:58 UTC
Moving to 7.3.1 for further investigation
Comment 14 James Richardson 2008-12-19 08:02:40 UTC
Changing target to next release
Comment 15 James Richardson 2009-01-02 22:24:14 UTC
*** Bug 10460 has been marked as a duplicate of this bug. ***
Comment 16 Ben Klaas 2009-01-05 10:13:51 UTC
with only these exceptions, my bug list is being retargetted for 8.0

for 7.3.2 (very soon):
https://bugs-archive.lyrion.org/show_bug.cgi?id=7186 Browse albums/artists/genres/  years should remember previous state 

for 7.3.3 (later, but before 8.0):
https://bugs-archive.lyrion.org/show_bug.cgi?id=7139 Add editable "Network Settings" page

https://bugs-archive.lyrion.org/show_bug.cgi?id=7502 Add setup mode to set Static IPs (even if DHCP is present)

https://bugs-archive.lyrion.org/show_bug.cgi?id=7829 Jive menu broken if BLOCK_SIZE == list count + 1 and "Pla...

https://bugs-archive.lyrion.org/show_bug.cgi?id=8878 Party Mode

https://bugs-archive.lyrion.org/show_bug.cgi?id=10064 SqueezeCenter doesn't always auto-generate playerstatus w... (which will fix 8300)

https://bugs-archive.lyrion.org/show_bug.cgi?id=6334 add applet for network diagnostics (currently assigned to Tom)

Comment 17 James Richardson 2009-01-22 08:07:34 UTC
I'm testing this now with the updated Jive firmware, if it's still valid, I'll assign it back to the appropriate person
Comment 18 James Richardson 2009-01-26 05:50:42 UTC
I have been unable to reproduce this with 7.3.2/3 and r3856
Comment 19 James Richardson 2009-01-26 10:10:22 UTC
James to verify with older firmware as well
Comment 20 James Richardson 2009-02-04 07:47:54 UTC
Created attachment 4761 [details]
Failed to connect from Power UP

I have been able to repo this again, but it's intermittent.  This time was with r3993, from a Power UP

See attached log
Comment 21 James Richardson 2009-02-04 07:50:54 UTC
On the SBC I see the 'home' menu with only 2 options: Now Playing & Settings

if I go to Settings > Music Source > SN (only thing listed) the SBC tries to connect to SN bug fails with 'Problem Connecting' message
Comment 22 James Richardson 2009-02-04 07:56:52 UTC
Created attachment 4762 [details]
Failed to connect from Power UP
Comment 23 James Richardson 2009-02-04 07:57:47 UTC
I updated the log file, powered off SBC, then powered it back on, this time it connected to SN fine
Comment 24 James Richardson 2009-02-04 10:01:14 UTC
I am only able to get this to fail on TEST.SN (Genisis).  Prod.SN has not had an error for me yet.
Comment 25 James Richardson 2009-02-04 10:03:09 UTC
Created attachment 4763 [details]
another serial capture

Another serial capture of r3993.  I was plugging / unplugging AC, browsing music sources, playing content, controller was sleeping/suspending/waking.  Near the end of the log the SBC went red, then would not connect back to test.sn
Comment 26 James Richardson 2009-02-04 11:47:21 UTC
(In reply to comment #24)
> I am only able to get this to fail on TEST.SN (Genisis).  Prod.SN has not had
> an error for me yet.
> 

I have reproduced the Red Wifi icon on Prod.sn now as well
Comment 27 Chris Owens 2009-03-16 09:43:08 UTC
We are now planning to make a 7.3.3 release.  Please review your bugs (all marked open against 7.3.3) to see if they can be fixed in the next few weeks, or if they should be retargeted for 7.4 or future.

Thanks!
Comment 28 Mickey Gee 2009-04-06 15:45:35 UTC
QA to retest with latest firmware.
Comment 29 James Richardson 2009-04-06 21:59:07 UTC
So far So good...been testing r5149 for 3 days, no red icon when waking from sleep while attached to SN
Comment 30 Ross Levine 2009-04-07 11:21:42 UTC
I'm also not seeing this any more with 5151, Actiontec MI 424 WR.
Comment 31 Ross Levine 2009-04-08 13:49:51 UTC
Fixed in 7.3.3 - r5225. If you've experienced this bug please update to latest nightly 7.3.3 build. Install the new version of SqueezeCenter, update your Duet firmware, factory reset both Controller and Receiver and setup one more time. Please post here in the bug with your findings. 

7.3.3 nightly download here:

http://downloads.slimdevices.com/nightly/?ver=7.3
Comment 32 James Richardson 2009-06-17 09:35:50 UTC
This bug has been fixed in the 7.3.3 release version of SqueezeCenter!

If you haven't already. please download the new version from http://www.logitechsqueezebox.com/support/download-squeezecenter.html 

If you are still experiencing this problem, feel free to reopen the bug with your new comments and we'll have another look.