Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

[INSTEON] Scan link table of PLM is stuck #184

Closed
peloy opened this issue May 13, 2013 · 2 comments
Closed

[INSTEON] Scan link table of PLM is stuck #184

peloy opened this issue May 13, 2013 · 2 comments

Comments

@peloy
Copy link
Collaborator

peloy commented May 13, 2013

After scanning the link table of the PLM, things seems to be stuck:

05/13/13 08:16:41 AM Running: PLM scan link table
05/13/13 08:16:41 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:42 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e20115a491021639
05/13/13 08:16:42 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:42 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e210174ec3021639
05/13/13 08:16:42 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:43 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e21015a478021639
05/13/13 08:16:43 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:43 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e2012291ed022c41
05/13/13 08:16:43 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:44 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e2011fcea2021f41
05/13/13 08:16:44 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:44 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20411aa4e000000
05/13/13 08:16:44 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:45 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a204229245000000
05/13/13 08:16:45 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:45 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20111aa4e000000
05/13/13 08:16:45 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:46 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20115b365000000
05/13/13 08:16:46 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:46 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a201141abc000000
05/13/13 08:16:46 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:47 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20114172e000000
05/13/13 08:16:47 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:47 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a201141a9a000000
05/13/13 08:16:47 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:48 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20115a5f2000000
05/13/13 08:16:48 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:48 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20511aa4e000000
05/13/13 08:16:48 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:49 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20115a598000000
05/13/13 08:16:49 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:49 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e210174ec3021639
05/13/13 08:16:49 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:50 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e21015a478021639
05/13/13 08:16:50 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:50 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20115a5ac000000
05/13/13 08:16:50 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:51 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a2011419e9000000
05/13/13 08:16:51 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:51 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a2011b42da000000
05/13/13 08:16:51 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:52 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a2012291ed000000
05/13/13 08:16:52 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:52 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e2012291ed022c41
05/13/13 08:16:52 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:53 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a2011fcea2000000
05/13/13 08:16:53 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:53 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20611aa4e000000
05/13/13 08:16:53 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:54 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20311aa4e000000
05/13/13 08:16:54 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:54 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20211aa4e000000
05/13/13 08:16:54 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:55 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20105dab7000000
05/13/13 08:16:55 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:55 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a201174ec3000000
05/13/13 08:16:55 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:56 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e201229245022c41
05/13/13 08:16:56 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:56 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a201229245000000
05/13/13 08:16:56 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:57 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a2022291ed000000
05/13/13 08:16:57 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:57 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a2032291ed000000
05/13/13 08:16:57 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:58 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e2112291ed010003
05/13/13 08:16:58 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:58 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a2042291ed000000
05/13/13 08:16:58 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:59 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a2062291ed000000
05/13/13 08:16:59 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:16:59 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a2052291ed000000
05/13/13 08:16:59 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:00 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20115a491000000
05/13/13 08:17:00 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:00 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20115a6ae000000
05/13/13 08:17:00 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:01 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20115a7bc000000
05/13/13 08:17:01 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:01 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20115a478000000
05/13/13 08:17:01 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:02 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a203229245000000
05/13/13 08:17:02 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:02 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e20122ae4d022a42
05/13/13 08:17:02 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:03 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a20122ae4d000000
05/13/13 08:17:03 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:03 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e21022ae4d010000
05/13/13 08:17:03 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:04 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a205229245000000
05/13/13 08:17:04 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:04 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a206229245000000
05/13/13 08:17:04 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:05 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e212229245010004
05/13/13 08:17:05 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:05 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e21215a491010000
05/13/13 08:17:05 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:06 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e2122291ed010004
05/13/13 08:17:06 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:07 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e2131b42da010000
05/13/13 08:17:07 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:07 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e213229245010005
05/13/13 08:17:07 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:08 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e214229245010003
05/13/13 08:17:08 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:08 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:e2141fcea2010000
05/13/13 08:17:08 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:09 AM [Insteon_PLM] DEBUG2: ALL-Link Record Response:a201141b33021639
05/13/13 08:17:09 AM [Insteon_PLM] DEBUG2: Sending obj=$PLM; interface_data= incurred delay of 0.00 seconds; starting hop-count: ?
05/13/13 08:17:09 AM [Insteon_PLM] $PLM completed link memory scan: status: good

05/13/13 08:17:19 AM Running: PLM log links
05/13/13 08:17:20 AM [Insteon::ALDB_PLM] Link table health: out-of-sync
05/13/13 08:17:31 AM Running: PLM log links
05/13/13 08:17:31 AM [Insteon::ALDB_PLM] Link table health: out-of-sync
05/13/13 08:17:36 AM Running: PLM scan link table
05/13/13 08:17:36 AM [Insteon::BaseInterface] Attempt to queue command already in queue; skipping ...

This was after manually unlinking and then re-linking a motion sensor.

I am sorry I don't have more information but I thought I'd at least report this just in case someone has an idea of what could have gone wrong. Feel free to close this issue if there isn't enough information to figure anything out.

The problem went away after I restart MH.

@krkeegan
Copy link
Collaborator

Hmm, with what you provided I am not sure we can get to the bottom of it.

I presume scan-PLM-link-table works now?  

Do you recall what steps you did prior to this other than just unlink and link the motion sensor?

Did you do any reload or forced reload of the code?  I have noticed a bizarre bug that I haven't been able to figure out related to force reload code.

@peloy
Copy link
Collaborator Author

peloy commented May 20, 2013

Hi Kevin,

Thanks for looking at this.

Unfortunately, I do not recall the steps that led to the reported failure. I think (though I am not 100% sure) that I did normal code reloads (as opposed to doing cold MisterHouse starts) at the time.

Things are working fine now -- I have scanned the PLM link table, done an all devices link table scan, log links, etc. and have not had any failures.

I am closing this issue since there is no real information to act on. I'll keep my eyes open and create new issues if I see anything.

Cheers!

Eloy Paris.-

@peloy peloy closed this as completed May 20, 2013
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants