Polyglot LIFX NodeSever

einstein.42 · February 5, 2017

I use the lifxlan module to communicate and do the low level packet abstraction, which is written by another team. I got the same errors randomly during testing but I thought I caught all those so that if it has a communication error on a single packet it wouldn't crash and would resend the packet with rapid=False... let me see if I missed something.

This is inherently a problem with lifxlan, but I"ll see if I can fix it.

einstein.42 · February 5, 2017

git pull

See if that makes any difference.

kzboray · February 6, 2017

Einstein.42

git pull completed.

I moved my router 2 feet from the Lifx strip controller to eliminate wi-fi as a possible issue.

As you can see in the log below it is still throwing errors. Interestingly enough it self recovered this time as shown in the log and started right back up with about a 20sec delay. I have run my little random program several times today, and the first time it ran for about 10 min then failed completely. I had to restart Polyglot. the next time is the log you see, and the third time ran for about 4 minutes then failed completely as well.

INFO     [02-05-2017 15:59:09] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=4525&S.uom56=52185&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 3.22ms
INFO     [02-05-2017 15:59:11] polyglot.element_manager.isy: ISY: [1] ( 0.90) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/15903/56
INFO     [02-05-2017 15:59:11] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/47803/56
INFO     [02-05-2017 15:59:11] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/4525/56
INFO     [02-05-2017 15:59:11] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/52185/56
INFO     [02-05-2017 15:59:13] polyglot.element_manager.isy: ISY: [1] ( 0.91) 200 OK: https://10.0.0.50:443/rest/nodes/n002_lifxcontrol
INFO     [02-05-2017 15:59:13] polyglot.nodeserver_manager: LifX: **INFO: probe: fa=n002_lifxcontrol pfa=n002_lifxcontrol id=lifxcontrol fl=128 en=True nm="LIFX Control"
INFO     [02-05-2017 15:59:17] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=10584&S.uom56=14664&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.86ms
INFO     [02-05-2017 15:59:18] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/6960/56
INFO     [02-05-2017 15:59:18] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/37101/56
INFO     [02-05-2017 15:59:21] polyglot.element_manager.isy: ISY: [1] ( 0.91) 200 OK: https://10.0.0.50:443/rest/nodes/n002_d073d5149bcb
ERROR    [02-05-2017 15:59:21] polyglot.element_manager.isy: ISY: [1] ( 0.03) 404 ERR: https://10.0.0.50:443/rest/nodes/n002_
INFO     [02-05-2017 15:59:21] polyglot.nodeserver_manager: LifX: **INFO: probe: fa=n002_d073d5149bcb pfa=n002_lifxcontrol id=lifxcolor fl=0 en=True nm="LifX BedRm2 Strip Lights"
WARNING  [02-05-2017 15:59:21] polyglot.nodeserver_manager: LifX: **WARNING: probe: status code: 404
INFO     [02-05-2017 15:59:22] polyglot.element_manager.isy: ISY: [1] ( 0.88) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/10584/56
INFO     [02-05-2017 15:59:22] polyglot.element_manager.isy: ISY: [1] ( 0.03) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/14664/56
INFO     [02-05-2017 15:59:24] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=18752&S.uom56=31901&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.74ms
INFO     [02-05-2017 15:59:26] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/13883/56
INFO     [02-05-2017 15:59:26] polyglot.element_manager.isy: ISY: [1] ( 0.06) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/21627/56
INFO     [02-05-2017 15:59:28] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/18752/56
INFO     [02-05-2017 15:59:28] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/31901/56
INFO     [02-05-2017 15:59:32] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=23271&S.uom56=16153&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 3.18ms
INFO     [02-05-2017 15:59:36] polyglot.element_manager.isy: ISY: [1] ( 0.90) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV5/0/25
INFO     [02-05-2017 15:59:36] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV6/0.0/20
INFO     [02-05-2017 15:59:36] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/23205/56
INFO     [02-05-2017 15:59:36] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/16381/56
INFO     [02-05-2017 15:59:36] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV5/1/25
INFO     [02-05-2017 15:59:36] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV6/19.4/20
INFO     [02-05-2017 15:59:41] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=59742&S.uom56=21867&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.74ms
INFO     [02-05-2017 15:59:41] polyglot.element_manager.isy: ISY: [1] ( 0.92) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/23271/56
INFO     [02-05-2017 15:59:41] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/16153/56
INFO     [02-05-2017 15:59:43] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/11645/56
INFO     [02-05-2017 15:59:43] polyglot.element_manager.isy: ISY: [1] ( 0.03) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/18438/56
INFO     [02-05-2017 15:59:47] polyglot.element_manager.isy: ISY: [1] ( 0.90) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/59742/56

Is there a more detailed error level of logging available. THe log shows some interesting differences, but without more detail it hard to say for sure whats going on. A normal run should be...

INFO     [02-05-2017 16:07:49] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=57009&S.uom56=17811&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.84ms
INFO     [02-05-2017 16:07:50] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/31871/56
INFO     [02-05-2017 16:07:50] polyglot.element_manager.isy: ISY: [1] ( 0.07) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/52505/56
INFO     [02-05-2017 16:07:50] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/30438/56
INFO     [02-05-2017 16:07:50] polyglot.element_manager.isy: ISY: [1] ( 0.03) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/48172/56

That's to command to change the values of Hue and Saturation and this is the most common thing I see when I run the random genorator. However when things get weird I see something like this..

INFO     [02-05-2017 16:05:56] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=59833&S.uom56=2543&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.87ms
INFO     [02-05-2017 16:05:59] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/29250/56
INFO     [02-05-2017 16:06:00] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/61155/56
INFO     [02-05-2017 16:06:01] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/23781/56
INFO     [02-05-2017 16:06:01] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/39626/56
INFO     [02-05-2017 16:06:01] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/9782/56
INFO     [02-05-2017 16:06:02] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/16109/56
INFO     [02-05-2017 16:06:04] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=8686&S.uom56=4425&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.99ms
INFO     [02-05-2017 16:06:11] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/81/56
INFO     [02-05-2017 16:06:11] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/3299/56
INFO     [02-05-2017 16:06:13] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=4019&S.uom56=64953&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.80ms
INFO     [02-05-2017 16:06:15] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/6847/56
INFO     [02-05-2017 16:06:15] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/28273/56
INFO     [02-05-2017 16:06:21] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=10191&S.uom56=36567&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.85ms
INFO     [02-05-2017 16:06:26] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/9018/56
INFO     [02-05-2017 16:06:26] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/41960/56
INFO     [02-05-2017 16:06:29] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=40403&S.uom56=18780&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.75ms
INFO     [02-05-2017 16:06:36] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=4984&S.uom56=42258&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.77ms
INFO     [02-05-2017 16:06:44] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=45434&S.uom56=54284&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.73ms
INFO     [02-05-2017 16:06:45] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/40403/56
INFO     [02-05-2017 16:06:45] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/18780/56
INFO     [02-05-2017 16:06:52] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=36349&S.uom56=45235&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.77ms
INFO     [02-05-2017 16:07:00] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=3199&S.uom56=48104&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.75ms
INFO     [02-05-2017 16:07:03] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/4984/56
INFO     [02-05-2017 16:07:08] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=19198&S.uom56=15898&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.74ms
INFO     [02-05-2017 16:07:10] polyglot.element_manager.isy: ISY: [1] ( 0.92) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/42258/56
INFO     [02-05-2017 16:07:16] polyglot.element_manager.isy: ISY: [1] ( 0.92) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/45434/56
INFO     [02-05-2017 16:07:16] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=31871&S.uom56=52505&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 2.57ms
INFO     [02-05-2017 16:07:16] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/54284/56
INFO     [02-05-2017 16:07:24] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=28253&S.uom56=41564&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.78ms
INFO     [02-05-2017 16:07:26] polyglot.element_manager.isy: ISY: [1] ( 0.88) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/41781/56
INFO     [02-05-2017 16:07:30] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/50646/56
INFO     [02-05-2017 16:07:32] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=65462&S.uom56=54755&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.74ms
INFO     [02-05-2017 16:07:36] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/3199/56
INFO     [02-05-2017 16:07:36] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/48104/56
INFO     [02-05-2017 16:07:40] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=54394&S.uom56=1463&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.82ms
INFO     [02-05-2017 16:07:45] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/19198/56
INFO     [02-05-2017 16:07:45] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/15898/56
INFO     [02-05-2017 16:07:49] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=57009&S.uom56=17811&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.84ms
INFO     [02-05-2017 16:07:50] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/31871/56
INFO     [02-05-2017 16:07:50] polyglot.element_manager.isy: ISY: [1] ( 0.07) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/52505/56
INFO     [02-05-2017 16:07:50] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/30438/56
INFO     [02-05-2017 16:07:50] polyglot.element_manager.isy: ISY: [1] ( 0.03) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/48172/56
INFO     [02-05-2017 16:07:57] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=217&S.uom56=32134&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.83ms
INFO     [02-05-2017 16:08:04] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=41995&S.uom56=39596&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.87ms
INFO     [02-05-2017 16:08:12] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=10135&S.uom56=36377&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.82ms
INFO     [02-05-2017 16:08:20] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=46638&S.uom56=18876&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 2.30ms
INFO     [02-05-2017 16:08:21] polyglot.element_manager.isy: ISY: [1] ( 0.92) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/65462/56
INFO     [02-05-2017 16:08:25] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/54755/56
INFO     [02-05-2017 16:08:29] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=8262&S.uom56=57366&B.uom56=65535&K.uom26=2500&D.uom42=1000 (10.0.0.50) 1.74ms
WARNING  [02-05-2017 16:08:34] polyglot.nodeserver_manager: Node Server LifX: time since last pong: 44.79
ERROR    [02-05-2017 16:08:34] polyglot.nodeserver_manager: Node Server LifX has stopped responding.

Now what's weird about all of this is that I would expect to see only a change to GV1 & GV2 per put since I am requesting that only Hue and Saturation be changed, but as I have show above the common log shows GV1 & GV2 changing twice before an actual change is pushed. My program seems right, but most often I see GV1, GV2, GV1, GV2 then a push to change. The above log shows GV1, GV2 then a change which is what I would expect, but when it is just the single instance of GV1 & GV2 changing not the pair it is inevitably followed by the LifX server dying. If there is more information I can supply i'm happy to do so. Thank you for your continued help with this.

I only have the one strip bulb to test with atm, the others (different types) are back ordered. It would be interesting to have you try this on your bulbs and see if you get the same results. It usually takes less than about 10 minutes before the LifX server fails. At least then we could eliminate the new strip bulbs controller as a possible source of the problem.

Here's LifX.log for the similar time period. Just found it.

2017-02-05 15:33:20,040 INFO LifX LIFX Node Server Interface version 0.1.6 created. Initiating setup.
2017-02-05 15:33:20,040 INFO LifX Config File param: config.yaml
2017-02-05 15:33:21,335 INFO LifX 1 bulbs found. Checking status and adding to ISY
2017-02-05 15:33:21,623 INFO LifX Adding new LIFX Color Bulb: LIFX LIFX Bulb 149bcb(d073d5149bcb)
2017-02-05 15:33:22,669 INFO LifX Adding new LIFX Group:
2017-02-05 15:33:22,670 INFO LifX Setup completed. Running Server.
2017-02-05 15:37:26,408 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:37:26,409 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:38:23,969 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:38:23,976 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:40:14,330 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:40:14,332 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:41:49,952 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:41:49,952 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:43:01,432 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:43:01,433 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:43:19,255 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:43:19,256 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:44:05,531 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:44:05,532 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:45:57,586 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:45:57,587 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:48:33,985 INFO LifX LIFX Node Server Interface version 0.1.6 created. Initiating setup.
2017-02-05 15:48:33,986 INFO LifX Config File param: config.yaml
2017-02-05 15:48:35,366 INFO LifX 1 bulbs found. Checking status and adding to ISY
2017-02-05 15:48:35,651 INFO LifX Adding new LIFX Color Bulb: LIFX LIFX Bulb 149bcb(d073d5149bcb)
2017-02-05 15:48:36,724 INFO LifX Adding new LIFX Group:
2017-02-05 15:48:36,727 INFO LifX Setup completed. Running Server.
2017-02-05 15:50:45,326 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:50:45,327 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:53:59,345 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:53:59,345 DEBUG LifX update_info exception: WorkflowException: Did not receive <class 'lifxlan.msgtypes.LightStatePower'> in response to <class 'lifxlan.msgtypes.LightGetPower'>
2017-02-05 15:55:17,093 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:55:17,094 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:57:41,052 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:57:41,052 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 15:59:35,150 ERROR LifX During Query, device LifX BedRm2 Strip Lights wasn't found. Marking as offline
2017-02-05 15:59:35,151 DEBUG LifX update_info exception: [Errno 9] Bad file descriptor
2017-02-05 16:28:56,252 INFO LifX LIFX Node Server Interface version 0.1.6 created. Initiating setup.
2017-02-05 16:28:56,252 INFO LifX Config File param: config.yaml
2017-02-05 16:28:57,350 INFO LifX 1 bulbs found. Checking status and adding to ISY
2017-02-05 16:28:57,635 INFO LifX Adding new LIFX Color Bulb: LIFX LIFX Bulb 149bcb(d073d5149bcb)
2017-02-05 16:28:58,678 INFO LifX Adding new LIFX Group:
2017-02-05 16:28:58,680 INFO LifX Setup completed. Running Server.
2017-02-05 16:29:23,441 INFO LifX Received SetColor command from ISY. Changing color to: COLD_WHTE
2017-02-05 16:29:35,320 INFO LifX Received SetColor command from ISY. Changing color to: WHITE
2017-02-05 16:29:45,350 INFO LifX Received manual change, updating the bulb to: [58275, 0, 65535, 5500] duration: 1000
2017-02-05 16:29:54,361 INFO LifX Received manual change, updating the bulb to: [65535, 0, 65535, 5500] duration: 1000

einstein.42 · February 6, 2017

You can run polyglot with the -vv flags to get extra debugging. I'm looking at this now.

einstein.42 · February 6, 2017

Ok... I ran your exact program for 30 minutes and didn't get an error, so I think this is better. Test it out and see what you get.

git pull

kzboray · February 6, 2017

Einstein.42

git pull

sudo systemctl stop polyglot

sudo nano /lib/systemd/systemctl/polyglot.service ++vv

sudo daemon-reload

sudo systemctl start polyglot

Start the ISY Random routine

It ran for almost 15 minutes. Here's a large part of the log. The error that killed it is near the bottom. Also the light would not always change every 8 sec as ISY was instructing it to do often it would skip a beat and take 2 or 3 iterations of the loop to actually change the bulb color. Also the <Duration> stopped being functional at all. Instead of a nice 1 sec fade from one color to the next the color change is immediate. I tried changing <Duration> to 3000ms, but there was no change in the server's response.


DEBUG    [02-05-2017 23:29:18] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=status seq=1147
DEBUG    [02-05-2017 23:29:18] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/14595/56
INFO     [02-05-2017 23:29:18] requests.packages.urllib3.connectionpool: Resetting dropped connection: 10.0.0.50
DEBUG    [02-05-2017 23:29:19] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:19] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:19] requests.packages.urllib3.connectionpool: "GET /rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/14595/56 HTTP/1.1" 200 0
INFO     [02-05-2017 23:29:19] polyglot.element_manager.isy: ISY: [1] ( 0.89) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/14595/56
DEBUG    [02-05-2017 23:29:19] polyglot.nodeserver_manager:     LifX [1] ( 0.89) _request_handler: completed.
DEBUG    [02-05-2017 23:29:19] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=status seq=1148
DEBUG    [02-05-2017 23:29:19] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/17973/56
DEBUG    [02-05-2017 23:29:19] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": null, "elapsed": 0.8895900249481201, "status_code": 200, "seq": 1147, "retries": 0}}
DEBUG    [02-05-2017 23:29:19] requests.packages.urllib3.connectionpool: "GET /rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/17973/56 HTTP/1.1" 200 0
INFO     [02-05-2017 23:29:19] polyglot.element_manager.isy: ISY: [1] ( 0.07) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/17973/56
DEBUG    [02-05-2017 23:29:19] polyglot.nodeserver_manager:     LifX [0] ( 0.08) _request_handler: completed.
DEBUG    [02-05-2017 23:29:19] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": null, "elapsed": 0.07193708419799805, "status_code": 200, "seq": 1148, "retries": 0}}
DEBUG    [02-05-2017 23:29:20] polyglot.nodeserver_manager: LifX: **DEBUG: node "LifX BedRm2 Strip Lights": driver "GV1": status sent to ISY ok.
DEBUG    [02-05-2017 23:29:20] polyglot.nodeserver_manager: LifX: **DEBUG: node "LifX BedRm2 Strip Lights": driver "GV2": status sent to ISY ok.
INFO     [02-05-2017 23:29:25] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=19282&S.uom56=27401&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.75ms
DEBUG    [02-05-2017 23:29:25] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 27401.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 19282.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:29:28] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:28] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:28] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=status seq=1149
DEBUG    [02-05-2017 23:29:28] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/19282/56
DEBUG    [02-05-2017 23:29:28] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:29:28] requests.packages.urllib3.connectionpool: Resetting dropped connection: 10.0.0.50
DEBUG    [02-05-2017 23:29:28] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:29:33] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=43094&S.uom56=46103&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.77ms
DEBUG    [02-05-2017 23:29:33] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 46103.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 43094.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:29:34] polyglot.nodeserver_manager:     LifX [1] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:34] polyglot.nodeserver_manager:     LifX [2] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:34] polyglot.nodeserver_manager:     LifX [2] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:34] polyglot.nodeserver_manager:     LifX [3] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:38] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
DEBUG    [02-05-2017 23:29:38] polyglot.nodeserver_manager:     LifX [3] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:29:38] polyglot.nodeserver_manager:     LifX [3] ( 0.00)   Done: {"pong": {}}
INFO     [02-05-2017 23:29:41] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=25936&S.uom56=34787&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.88ms
DEBUG    [02-05-2017 23:29:41] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 34787.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 25936.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:29:42] polyglot.nodeserver_manager:     LifX [3] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:42] polyglot.nodeserver_manager:     LifX [4] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:42] polyglot.nodeserver_manager:     LifX [4] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:42] polyglot.nodeserver_manager:     LifX [5] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:29:49] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=60581&S.uom56=18277&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.84ms
DEBUG    [02-05-2017 23:29:49] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 18277.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 60581.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:29:52] polyglot.nodeserver_manager:     LifX [5] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:52] polyglot.nodeserver_manager:     LifX [6] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:52] polyglot.nodeserver_manager:     LifX [6] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:29:52] polyglot.nodeserver_manager:     LifX [7] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:29:57] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=60400&S.uom56=39400&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.83ms
DEBUG    [02-05-2017 23:29:57] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 39400.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 60400.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
INFO     [02-05-2017 23:30:05] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=2954&S.uom56=57131&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:30:05] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 57131.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 2954.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:30:10] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
INFO     [02-05-2017 23:30:13] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=45210&S.uom56=465&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:30:13] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 465.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 45210.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
INFO     [02-05-2017 23:30:21] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=11071&S.uom56=64532&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.83ms
DEBUG    [02-05-2017 23:30:21] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 64532.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 11071.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:30:21] polyglot.nodeserver_manager:     LifX [7] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:21] polyglot.nodeserver_manager:     LifX [8] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:22] polyglot.nodeserver_manager:     LifX [8] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:22] polyglot.nodeserver_manager:     LifX [9] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:22] polyglot.nodeserver_manager:     LifX [9] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:22] polyglot.nodeserver_manager:     LifX [10] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:25] polyglot.nodeserver_manager:     LifX [10] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:25] polyglot.nodeserver_manager:     LifX [11] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:26] polyglot.nodeserver_manager:     LifX [11] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:30:26] polyglot.nodeserver_manager:     LifX [11] ( 0.00)   Done: {"pong": {}}
INFO     [02-05-2017 23:30:29] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=9681&S.uom56=23601&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.73ms
DEBUG    [02-05-2017 23:30:29] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 23601.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 9681.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:30:30] polyglot.nodeserver_manager:     LifX [11] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:30] polyglot.nodeserver_manager:     LifX [12] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:30] polyglot.nodeserver_manager:     LifX [12] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:30] polyglot.nodeserver_manager:     LifX [13] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:30:37] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=9629&S.uom56=44330&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.72ms
DEBUG    [02-05-2017 23:30:37] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 44330.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 9629.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:30:38] polyglot.nodeserver_manager:     LifX [13] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:38] polyglot.nodeserver_manager:     LifX [14] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:38] polyglot.nodeserver_manager:     LifX [14] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:38] polyglot.nodeserver_manager:     LifX [15] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:39] polyglot.nodeserver_manager:     LifX [15] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:39] polyglot.nodeserver_manager:     LifX [16] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:40] polyglot.nodeserver_manager:     LifX [16] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:40] polyglot.nodeserver_manager:     LifX [17] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:42] polyglot.nodeserver_manager:     LifX [17] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:42] polyglot.nodeserver_manager:     LifX [18] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:42] polyglot.nodeserver_manager:     LifX [18] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:42] polyglot.nodeserver_manager:     LifX [19] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:42] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
DEBUG    [02-05-2017 23:30:42] polyglot.nodeserver_manager:     LifX [19] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:30:42] polyglot.nodeserver_manager:     LifX [19] ( 0.00)   Done: {"pong": {}}
INFO     [02-05-2017 23:30:45] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=22265&S.uom56=49658&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:30:45] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 49658.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 22265.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
INFO     [02-05-2017 23:30:54] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=22549&S.uom56=56614&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:30:54] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 56614.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 22549.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:30:56] polyglot.nodeserver_manager:     LifX [19] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:56] polyglot.nodeserver_manager:     LifX [20] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:56] polyglot.nodeserver_manager:     LifX [20] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:30:56] polyglot.nodeserver_manager:     LifX [21] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:31:02] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=12692&S.uom56=47840&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:31:02] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 47840.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 12692.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:31:04] polyglot.nodeserver_manager:     LifX [21] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:04] polyglot.nodeserver_manager:     LifX [22] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:04] polyglot.nodeserver_manager:     LifX [22] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:04] polyglot.nodeserver_manager:     LifX [23] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:07] polyglot.nodeserver_manager:     LifX [23] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:07] polyglot.nodeserver_manager:     LifX [24] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:08] polyglot.nodeserver_manager:     LifX [24] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:08] polyglot.nodeserver_manager:     LifX [25] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:31:10] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=64072&S.uom56=51189&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.77ms
DEBUG    [02-05-2017 23:31:10] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 51189.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 64072.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:31:15] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
INFO     [02-05-2017 23:31:17] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=53668&S.uom56=41352&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.72ms
DEBUG    [02-05-2017 23:31:17] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 41352.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 53668.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:31:17] polyglot.nodeserver_manager:     LifX [25] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:17] polyglot.nodeserver_manager:     LifX [26] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:17] polyglot.nodeserver_manager:     LifX [26] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:17] polyglot.nodeserver_manager:     LifX [27] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:17] polyglot.nodeserver_manager:     LifX [27] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:31:17] polyglot.nodeserver_manager:     LifX [27] ( 0.00)   Done: {"pong": {}}
DEBUG    [02-05-2017 23:31:18] polyglot.nodeserver_manager:     LifX [27] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:18] polyglot.nodeserver_manager:     LifX [28] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:18] polyglot.nodeserver_manager:     LifX [28] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:18] polyglot.nodeserver_manager:     LifX [29] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:31:25] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=32303&S.uom56=5509&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:31:25] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 5509.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 32303.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:31:26] polyglot.nodeserver_manager:     LifX [29] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:26] polyglot.nodeserver_manager:     LifX [30] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:28] polyglot.nodeserver_manager:     LifX [30] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:28] polyglot.nodeserver_manager:     LifX [31] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:31:33] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=56043&S.uom56=1334&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.93ms
DEBUG    [02-05-2017 23:31:33] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 1334.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 56043.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:31:39] polyglot.nodeserver_manager:     LifX [31] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:39] polyglot.nodeserver_manager:     LifX [32] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:39] polyglot.nodeserver_manager:     LifX [32] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:39] polyglot.nodeserver_manager:     LifX [33] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:31:42] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=53109&S.uom56=37510&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.88ms
DEBUG    [02-05-2017 23:31:42] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 37510.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 53109.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:31:47] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
DEBUG    [02-05-2017 23:31:49] polyglot.nodeserver_manager:     LifX [33] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:49] polyglot.nodeserver_manager:     LifX [34] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:31:50] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=32022&S.uom56=27410&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.85ms
DEBUG    [02-05-2017 23:31:50] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 27410.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 32022.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:31:51] polyglot.nodeserver_manager:     LifX [34] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:51] polyglot.nodeserver_manager:     LifX [35] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:51] polyglot.nodeserver_manager:     LifX [35] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:31:51] polyglot.nodeserver_manager:     LifX [35] ( 0.00)   Done: {"pong": {}}
DEBUG    [02-05-2017 23:31:56] polyglot.nodeserver_manager:     LifX [35] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:56] polyglot.nodeserver_manager:     LifX [36] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:31:58] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=43344&S.uom56=32784&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.87ms
DEBUG    [02-05-2017 23:31:58] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 32784.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 43344.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:31:58] polyglot.nodeserver_manager:     LifX [36] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:31:58] polyglot.nodeserver_manager:     LifX [37] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:00] polyglot.nodeserver_manager:     LifX [37] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:00] polyglot.nodeserver_manager:     LifX [38] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:00] polyglot.nodeserver_manager:     LifX [38] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:00] polyglot.nodeserver_manager:     LifX [39] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:32:05] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=18036&S.uom56=59753&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.77ms
DEBUG    [02-05-2017 23:32:05] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 59753.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 18036.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:32:07] polyglot.nodeserver_manager:     LifX [39] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:07] polyglot.nodeserver_manager:     LifX [40] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:07] polyglot.nodeserver_manager:     LifX [40] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:07] polyglot.nodeserver_manager:     LifX [41] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:32:13] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=21178&S.uom56=56765&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:32:14] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 56765.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 21178.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:32:15] polyglot.nodeserver_manager:     LifX [41] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:15] polyglot.nodeserver_manager:     LifX [42] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:15] polyglot.nodeserver_manager:     LifX [42] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:15] polyglot.nodeserver_manager:     LifX [43] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:19] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
DEBUG    [02-05-2017 23:32:19] polyglot.nodeserver_manager:     LifX [43] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:32:19] polyglot.nodeserver_manager:     LifX [43] ( 0.00)   Done: {"pong": {}}
INFO     [02-05-2017 23:32:21] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=34542&S.uom56=60057&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.77ms
DEBUG    [02-05-2017 23:32:21] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 60057.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 34542.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:32:22] polyglot.nodeserver_manager:     LifX [43] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:22] polyglot.nodeserver_manager:     LifX [44] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:22] polyglot.nodeserver_manager:     LifX [44] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:22] polyglot.nodeserver_manager:     LifX [45] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:32:29] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=40911&S.uom56=43137&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.75ms
DEBUG    [02-05-2017 23:32:29] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 43137.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 40911.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:32:30] polyglot.nodeserver_manager:     LifX [45] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:30] polyglot.nodeserver_manager:     LifX [46] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:30] polyglot.nodeserver_manager:     LifX [46] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:30] polyglot.nodeserver_manager:     LifX [47] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:32:37] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=23399&S.uom56=43057&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.76ms
DEBUG    [02-05-2017 23:32:37] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 43057.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 23399.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
INFO     [02-05-2017 23:32:45] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=34858&S.uom56=31453&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.75ms
DEBUG    [02-05-2017 23:32:45] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 31453.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 34858.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:32:50] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
DEBUG    [02-05-2017 23:32:51] polyglot.nodeserver_manager:     LifX [47] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:51] polyglot.nodeserver_manager:     LifX [48] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:51] polyglot.nodeserver_manager:     LifX [48] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:32:51] polyglot.nodeserver_manager:     LifX [49] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:32:53] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=47251&S.uom56=49814&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.83ms
DEBUG    [02-05-2017 23:32:53] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 49814.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 47251.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
INFO     [02-05-2017 23:33:01] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=25854&S.uom56=22556&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.77ms
DEBUG    [02-05-2017 23:33:01] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 22556.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 25854.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:33:09] polyglot.nodeserver_manager:     LifX [49] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:09] polyglot.nodeserver_manager:     LifX [50] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:09] polyglot.nodeserver_manager:     LifX [50] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:09] polyglot.nodeserver_manager:     LifX [51] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:09] polyglot.nodeserver_manager:     LifX [51] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:33:09] polyglot.nodeserver_manager:     LifX [51] ( 0.00)   Done: {"pong": {}}
INFO     [02-05-2017 23:33:09] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=7891&S.uom56=46582&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.76ms
DEBUG    [02-05-2017 23:33:09] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 46582.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 7891.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:33:10] polyglot.nodeserver_manager:     LifX [51] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:10] polyglot.nodeserver_manager:     LifX [52] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:10] polyglot.nodeserver_manager:     LifX [52] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:10] polyglot.nodeserver_manager:     LifX [53] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:11] polyglot.nodeserver_manager:     LifX [53] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:11] polyglot.nodeserver_manager:     LifX [54] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:11] polyglot.nodeserver_manager:     LifX [54] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:11] polyglot.nodeserver_manager:     LifX [55] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:11] polyglot.nodeserver_manager:     LifX [55] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:11] polyglot.nodeserver_manager:     LifX [56] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:11] polyglot.nodeserver_manager:     LifX [56] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:11] polyglot.nodeserver_manager:     LifX [57] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:33:18] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=21095&S.uom56=43608&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:33:18] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 43608.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 21095.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:33:23] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
DEBUG    [02-05-2017 23:33:23] polyglot.nodeserver_manager:     LifX [57] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:23] polyglot.nodeserver_manager:     LifX [58] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:23] polyglot.nodeserver_manager:     LifX [58] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:23] polyglot.nodeserver_manager:     LifX [59] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:23] polyglot.nodeserver_manager:     LifX [59] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:33:23] polyglot.nodeserver_manager:     LifX [59] ( 0.00)   Done: {"pong": {}}
INFO     [02-05-2017 23:33:26] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=26385&S.uom56=2779&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.85ms
DEBUG    [02-05-2017 23:33:26] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 2779.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 26385.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:33:26] polyglot.nodeserver_manager:     LifX [59] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:26] polyglot.nodeserver_manager:     LifX [60] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:26] polyglot.nodeserver_manager:     LifX [60] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:26] polyglot.nodeserver_manager:     LifX [61] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:33:34] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=56889&S.uom56=64778&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.73ms
DEBUG    [02-05-2017 23:33:34] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 64778.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 56889.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
INFO     [02-05-2017 23:33:41] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=16637&S.uom56=35853&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.76ms
DEBUG    [02-05-2017 23:33:41] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 35853.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 16637.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:33:47] polyglot.nodeserver_manager:     LifX [61] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:47] polyglot.nodeserver_manager:     LifX [62] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:47] polyglot.nodeserver_manager:     LifX [62] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:33:47] polyglot.nodeserver_manager:     LifX [63] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:33:49] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=31088&S.uom56=25594&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.75ms
DEBUG    [02-05-2017 23:33:49] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 25594.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 31088.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:33:54] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
INFO     [02-05-2017 23:33:58] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=59640&S.uom56=64708&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.87ms
DEBUG    [02-05-2017 23:33:58] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 64708.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 59640.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:34:03] polyglot.nodeserver_manager:     LifX [63] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:03] polyglot.nodeserver_manager:     LifX [64] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:04] polyglot.nodeserver_manager:     LifX [64] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:04] polyglot.nodeserver_manager:     LifX [65] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:34:05] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=16585&S.uom56=57864&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.77ms
DEBUG    [02-05-2017 23:34:05] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 57864.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 16585.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
INFO     [02-05-2017 23:34:13] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=25178&S.uom56=8995&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.86ms
DEBUG    [02-05-2017 23:34:13] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 8995.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 25178.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:34:17] polyglot.nodeserver_manager:     LifX [65] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:17] polyglot.nodeserver_manager:     LifX [66] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:21] polyglot.nodeserver_manager:     LifX [66] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:21] polyglot.nodeserver_manager:     LifX [67] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:21] polyglot.nodeserver_manager:     LifX [67] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:34:21] polyglot.nodeserver_manager:     LifX [67] ( 0.00)   Done: {"pong": {}}
INFO     [02-05-2017 23:34:21] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=33487&S.uom56=42384&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.85ms
DEBUG    [02-05-2017 23:34:21] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 42384.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 33487.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:34:23] polyglot.nodeserver_manager:     LifX [67] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:23] polyglot.nodeserver_manager:     LifX [68] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:25] polyglot.nodeserver_manager:     LifX [68] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:25] polyglot.nodeserver_manager:     LifX [69] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:26] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
INFO     [02-05-2017 23:34:29] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=6796&S.uom56=40945&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:34:29] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 40945.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 6796.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:34:32] polyglot.nodeserver_manager:     LifX [69] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:32] polyglot.nodeserver_manager:     LifX [70] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:36] polyglot.nodeserver_manager:     LifX [70] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:36] polyglot.nodeserver_manager:     LifX [71] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:36] polyglot.nodeserver_manager:     LifX [71] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:36] polyglot.nodeserver_manager:     LifX [72] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:34:38] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=52240&S.uom56=50736&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.75ms
DEBUG    [02-05-2017 23:34:38] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 50736.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 52240.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:34:41] polyglot.nodeserver_manager:     LifX [72] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:41] polyglot.nodeserver_manager:     LifX [73] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:41] polyglot.nodeserver_manager:     LifX [73] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:41] polyglot.nodeserver_manager:     LifX [74] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:44] polyglot.nodeserver_manager:     LifX [74] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:44] polyglot.nodeserver_manager:     LifX [75] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:44] polyglot.nodeserver_manager:     LifX [75] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:44] polyglot.nodeserver_manager:     LifX [76] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:34:46] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=49304&S.uom56=51983&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:34:46] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 51983.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 49304.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:34:50] polyglot.nodeserver_manager:     LifX [76] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:34:50] polyglot.nodeserver_manager:     LifX [76] ( 0.00)   Done: {"pong": {}}
DEBUG    [02-05-2017 23:34:54] polyglot.nodeserver_manager:     LifX [76] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:54] polyglot.nodeserver_manager:     LifX [77] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:54] polyglot.nodeserver_manager:     LifX [77] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:34:54] polyglot.nodeserver_manager:     LifX [78] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:34:54] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=57573&S.uom56=58760&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.83ms
DEBUG    [02-05-2017 23:34:54] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 58760.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 57573.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:34:59] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
DEBUG    [02-05-2017 23:35:02] polyglot.nodeserver_manager:     LifX [78] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:02] polyglot.nodeserver_manager:     LifX [79] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:35:02] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=3867&S.uom56=3950&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.74ms
DEBUG    [02-05-2017 23:35:02] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 3950.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 3867.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:35:03] polyglot.nodeserver_manager:     LifX [79] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:03] polyglot.nodeserver_manager:     LifX [80] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:05] polyglot.nodeserver_manager:     LifX [80] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:05] polyglot.nodeserver_manager:     LifX [81] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:06] polyglot.nodeserver_manager:     LifX [81] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:06] polyglot.nodeserver_manager:     LifX [82] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:35:09] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=19601&S.uom56=10134&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.77ms
DEBUG    [02-05-2017 23:35:09] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 10134.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 19601.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:35:13] polyglot.nodeserver_manager:     LifX [82] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:13] polyglot.nodeserver_manager:     LifX [83] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:15] polyglot.nodeserver_manager:     LifX [83] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:15] polyglot.nodeserver_manager:     LifX [84] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:16] polyglot.nodeserver_manager:     LifX [84] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:35:16] polyglot.nodeserver_manager:     LifX [84] ( 0.00)   Done: {"pong": {}}
INFO     [02-05-2017 23:35:17] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=7679&S.uom56=61378&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.80ms
DEBUG    [02-05-2017 23:35:17] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 61378.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 7679.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:35:19] polyglot.nodeserver_manager:     LifX [84] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:19] polyglot.nodeserver_manager:     LifX [85] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:21] polyglot.nodeserver_manager:     LifX [85] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:21] polyglot.nodeserver_manager:     LifX [86] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:35:25] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=25352&S.uom56=49981&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.78ms
DEBUG    [02-05-2017 23:35:25] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 49981.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 25352.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:35:26] polyglot.nodeserver_manager:     LifX [86] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:26] polyglot.nodeserver_manager:     LifX [87] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:26] polyglot.nodeserver_manager:     LifX [87] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:26] polyglot.nodeserver_manager:     LifX [88] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:30] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
INFO     [02-05-2017 23:35:33] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=874&S.uom56=60051&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 2.96ms
DEBUG    [02-05-2017 23:35:33] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 60051.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 874.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
INFO     [02-05-2017 23:35:41] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=60331&S.uom56=12229&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.78ms
DEBUG    [02-05-2017 23:35:41] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 12229.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 60331.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
INFO     [02-05-2017 23:35:49] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=39107&S.uom56=1561&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.75ms
DEBUG    [02-05-2017 23:35:49] polyglot.nodeserver_manager:     LifX [88] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:49] polyglot.nodeserver_manager:     LifX [89] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:49] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 1561.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 39107.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:35:50] polyglot.nodeserver_manager:     LifX [89] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:35:50] polyglot.nodeserver_manager:     LifX [90] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:35:57] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=4466&S.uom56=45504&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.77ms
DEBUG    [02-05-2017 23:35:57] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 45504.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 4466.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
WARNING  [02-05-2017 23:36:02] polyglot.nodeserver_manager: Node Server LifX: time since last pong: 46.26
ERROR    [02-05-2017 23:36:02] polyglot.nodeserver_manager: Node Server LifX has stopped responding.
INFO     [02-05-2017 23:36:05] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=21012&S.uom56=9022&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.76ms
INFO     [02-05-2017 23:36:13] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=42474&S.uom56=30869&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 3.19ms
INFO     [02-05-2017 23:36:21] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=16083&S.uom56=34124&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 3.17ms
INFO     [02-05-2017 23:36:30] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=5184&S.uom56=18658&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 3.29ms
INFO     [02-05-2017 23:36:38] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=56483&S.uom56=56270&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 3.28ms
INFO     [02-05-2017 23:36:46] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=27030&S.uom56=20810&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 3.27ms
INFO     [02-05-2017 23:36:54] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=8917&S.uom56=13904&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 3.26ms
INFO     [02-05-2017 23:37:02] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=8048&S.uom56=56361&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 3.37ms
INFO     [02-05-2017 23:37:10] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=50836&S.uom56=39277&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 3.13ms

kzboray · February 6, 2017

Einstein.42

For reference here's a copy of the log on starting Polyglot. It throws a lot of errors that might help you in your investigation.

INFO     [02-05-2017 23:44:39] polyglot.core: Starting Polyglot
INFO     [02-05-2017 23:44:39] polyglot.element_manager: Loading Elements
INFO     [02-05-2017 23:44:39] polyglot.element_manager.http: Started HTTP server on port 8080
INFO     [02-05-2017 23:44:39] polyglot.element_manager.http: Loaded HTTP element
INFO     [02-05-2017 23:44:39] polyglot.element_manager.api: Loaded API element
DEBUG    [02-05-2017 23:44:39] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/config
DEBUG    [02-05-2017 23:44:39] polyglot.element_manager.isy: ISY: created new Session object.
INFO     [02-05-2017 23:44:39] requests.packages.urllib3.connectionpool: Starting new HTTPS connection (1): 10.0.0.50
WARNING  [02-05-2017 23:44:39] tornado.access: 404 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=9448&S.uom56=7418&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 2.70ms
DEBUG    [02-05-2017 23:44:40] requests.packages.urllib3.connectionpool: "GET /rest/config HTTP/1.1" 200 25252
INFO     [02-05-2017 23:44:40] polyglot.element_manager.isy: ISY: [1] ( 1.43) 200 OK: https://10.0.0.50:443/rest/config
INFO     [02-05-2017 23:44:40] polyglot.element_manager.isy: ISY: firmware version: 5.0.8
INFO     [02-05-2017 23:44:40] polyglot.element_manager.isy: Loaded ISY element
INFO     [02-05-2017 23:44:40] polyglot.element_manager.frontend: Loaded Frontend element
INFO     [02-05-2017 23:44:40] polyglot.nodeserver_manager: Loading Node Servers
INFO     [02-05-2017 23:44:40] polyglot.nodeserver_manager: Starting Node Server: lifx-nodeserver:LifX
INFO     [02-05-2017 23:44:40] polyglot.nodeserver_manager: Config file option not found in server.json
INFO     [02-05-2017 23:44:40] polyglot.nodeserver_manager: Using interface type Default
INFO     [02-05-2017 23:44:41] polyglot.nodeserver_manager: Started Node Server: lifx-nodeserver:LifX (16666)
DEBUG    [02-05-2017 23:44:41] polyglot.nodeserver_manager: LifX STDIN: {"params": {"profile": 2, "pgver": "0.0.6", "name": "LifX", "pgapiver": "1", "mqtt_port": null, "sandbox": "/home/pi/Polyglot/config/lifx-nodeserver", "configfile": null, "interface": "Default", "path": "/home/pi/Polyglot/config/node_servers/lifx-nodeserver", "isyver": "5.0.8", "mqtt_server": null}}
DEBUG    [02-05-2017 23:44:41] polyglot.nodeserver_manager: LifX STDIN: {"config": {"manifest": {"": {"node_def_id": "lifxgroup", "drivers": {"ST": 1}, "added": false, "enabled": false, "name": "LIFX Group "}, "d073d5149bcb": {"node_def_id": "lifxcolor", "drivers": {"RR": 0, "CLITEMP": 2500, "ST": 1, "GV2": 7033, "GV3": 65535, "GV1": 13679, "GV6": 0.0, "GV5": 1}, "added": false, "enabled": true, "name": "LifX BedRm2 Strip Lights"}, "lifxcontrol": {"node_def_id": "lifxcontrol", "drivers": {}, "added": false, "enabled": true, "name": "LIFX Control"}}}}
INFO     [02-05-2017 23:44:42] polyglot.nodeserver_manager: LifX: **INFO: No custom "configfile" found in server.json. Trying the default of config.yaml.
DEBUG    [02-05-2017 23:44:42] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"add": {"node_address": "lifxcontrol", "node_def_id": "l...
INFO     [02-05-2017 23:44:42] polyglot.nodeserver_manager: LifX: **INFO: No config file found, or it is unreadable. This is normal if your nodeserver doesn't need a config file.
DEBUG    [02-05-2017 23:44:42] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"add": {"node_address": "lifxcontrol", "node_def_id": "l...
INFO     [02-05-2017 23:44:42] polyglot.nodeserver_manager: LifX: **INFO: Node initialized: addr="lifxcontrol" name="LIFX Control" added=False enabled=True
DEBUG    [02-05-2017 23:44:42] polyglot.nodeserver_manager: LifX: **DEBUG: node "LIFX Control": parent="<__main__.LIFXNodeServer object at 0x76809130>"
DEBUG    [02-05-2017 23:44:42] polyglot.nodeserver_manager: LifX: **DEBUG: add_node: na="lifxcontrol", id="lifxcontrol", pa="lifxcontrol", nm="LIFX Control"
DEBUG    [02-05-2017 23:44:42] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=add seq=1001
DEBUG    [02-05-2017 23:44:42] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/ns/2/nodes/n002_lifxcontrol/add/lifxcontrol?primary=n002_lifxcontrol&name=LIFX+Control
INFO     [02-05-2017 23:44:42] requests.packages.urllib3.connectionpool: Resetting dropped connection: 10.0.0.50
DEBUG    [02-05-2017 23:44:43] requests.packages.urllib3.connectionpool: "GET /rest/ns/2/nodes/n002_lifxcontrol/add/lifxcontrol?primary=n002_lifxcontrol&name=LIFX+Control HTTP/1.1" 404 0
ERROR    [02-05-2017 23:44:43] polyglot.element_manager.isy: ISY: [1] ( 0.88) 404 ERR: https://10.0.0.50:443/rest/ns/2/nodes/n002_lifxcontrol/add/lifxcontrol?primary=n002_lifxcontrol&name=LIFX+Control
DEBUG    [02-05-2017 23:44:43] polyglot.nodeserver_manager:     LifX [0] ( 0.89) _request_handler: completed.
DEBUG    [02-05-2017 23:44:43] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": null, "elapsed": 0.8847050666809082, "status_code": 404, "seq": 1001, "retries": 0}}
ERROR    [02-05-2017 23:44:43] polyglot.nodeserver_manager: LifX: **ERROR: node "lifxcontrol": node add REST call to ISY failed: 404
ERROR    [02-05-2017 23:44:43] polyglot.nodeserver_manager: LifX: Unsuccessful handling result in function on_result
DEBUG    [02-05-2017 23:44:43] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"add": {"node_address": "d073d5149bcb", "node_def_id": "...
DEBUG    [02-05-2017 23:44:43] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"add": {"node_address": "d073d5149bcb", "node_def_id": "...
DEBUG    [02-05-2017 23:44:43] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=add seq=1002
DEBUG    [02-05-2017 23:44:43] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/add/lifxcolor?primary=n002_lifxcontrol&name=LifX+BedRm2+Strip+Lights
INFO     [02-05-2017 23:44:43] requests.packages.urllib3.connectionpool: Resetting dropped connection: 10.0.0.50
INFO     [02-05-2017 23:44:43] polyglot.nodeserver_manager: LifX: **INFO: Node initialized: addr="d073d5149bcb" name="LifX BedRm2 Strip Lights" added=False enabled=True
DEBUG    [02-05-2017 23:44:43] polyglot.nodeserver_manager: LifX: **DEBUG: node "LifX BedRm2 Strip Lights": parent="<__main__.LIFXNodeServer object at 0x76809130>"
DEBUG    [02-05-2017 23:44:43] polyglot.nodeserver_manager: LifX: **DEBUG: add_node: na="d073d5149bcb", id="lifxcolor", pa="lifxcontrol", nm="LifX BedRm2 Strip Lights"
INFO     [02-05-2017 23:44:44] polyglot.nodeserver_manager: LifX: **INFO: Node initialized: addr="" name="LIFX Group " added=False enabled=False
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager: LifX: **DEBUG: node "LIFX Group ": parent="<__main__.LIFXNodeServer object at 0x76809130>"
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager: LifX: **DEBUG: add_node: na="", id="lifxgroup", pa="lifxcontrol", nm="LIFX Group "
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"add": {"node_address": "", "node_def_id": "lifxgroup", ...
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"add": {"node_address": "", "node_def_id": "lifxgroup", ...
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager:     LifX [1] ( 0.00) STDOUT: {"config": {"manifest": {"": {"node_def_id": "lifxgroup",...
DEBUG    [02-05-2017 23:44:44] polyglot.core: Saving Configuration
INFO     [02-05-2017 23:44:44] polyglot.config_manager: Config file changes detected, updating config file.
DEBUG    [02-05-2017 23:44:44] polyglot.config_manager: Config file succesfully updated.
DEBUG    [02-05-2017 23:44:44] polyglot.config_manager: Wrote configuration file
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager:     LifX [1] ( 0.01)   Done: {"config": {"manifest": {"": {"node_def_id": "lifxgroup",...
DEBUG    [02-05-2017 23:44:44] requests.packages.urllib3.connectionpool: "GET /rest/ns/2/nodes/n002_d073d5149bcb/add/lifxcolor?primary=n002_lifxcontrol&name=LifX+BedRm2+Strip+Lights HTTP/1.1" 404 0
ERROR    [02-05-2017 23:44:44] polyglot.element_manager.isy: ISY: [1] ( 0.89) 404 ERR: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/add/lifxcolor?primary=n002_lifxcontrol&name=LifX+BedRm2+Strip+Lights
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager:     LifX [1] ( 0.89) _request_handler: completed.
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=add seq=1003
DEBUG    [02-05-2017 23:44:44] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/ns/2/nodes/n002_/add/lifxgroup?primary=n002_lifxcontrol&name=LIFX+Group+
DEBUG    [02-05-2017 23:44:44] requests.packages.urllib3.connectionpool: "GET /rest/ns/2/nodes/n002_/add/lifxgroup?primary=n002_lifxcontrol&name=LIFX+Group+ HTTP/1.1" 404 0
ERROR    [02-05-2017 23:44:44] polyglot.element_manager.isy: ISY: [1] ( 0.03) 404 ERR: https://10.0.0.50:443/rest/ns/2/nodes/n002_/add/lifxgroup?primary=n002_lifxcontrol&name=LIFX+Group+
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": null, "elapsed": 0.8873069286346436, "status_code": 404, "seq": 1002, "retries": 0}}
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager:     LifX [0] ( 0.03) _request_handler: completed.
DEBUG    [02-05-2017 23:44:44] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": null, "elapsed": 0.029946088790893555, "status_code": 404, "seq": 1003, "retries": 0}}
ERROR    [02-05-2017 23:44:44] polyglot.nodeserver_manager: LifX: **ERROR: node "d073d5149bcb": node add REST call to ISY failed: 404
ERROR    [02-05-2017 23:44:44] polyglot.nodeserver_manager: LifX: Unsuccessful handling result in function on_result
ERROR    [02-05-2017 23:44:44] polyglot.nodeserver_manager: LifX: **ERROR: node "": node add REST call to ISY failed: 404
ERROR    [02-05-2017 23:44:44] polyglot.nodeserver_manager: LifX: Unsuccessful handling result in function on_result
INFO     [02-05-2017 23:44:47] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=63185&S.uom56=17667&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 6.06ms
DEBUG    [02-05-2017 23:44:47] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 17667.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 63185.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"restcall": {"api": "nodes/n002_lifxcontrol", "seq": 100...
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"restcall": {"api": "nodes/n002_lifxcontrol", "seq": 100...
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=restcall seq=1004
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"restcall": {"api": "nodes/n002_d073d5149bcb", "seq": 10...
DEBUG    [02-05-2017 23:44:52] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/nodes/n002_lifxcontrol
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"restcall": {"api": "nodes/n002_d073d5149bcb", "seq": 10...
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager: LifX: **DEBUG: request_node_probe: na="lifxcontrol" fa="n002_lifxcontrol" api="nodes/n002_lifxcontrol"
INFO     [02-05-2017 23:44:52] requests.packages.urllib3.connectionpool: Resetting dropped connection: 10.0.0.50
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager:     LifX [1] ( 0.00) STDOUT: {"restcall": {"api": "nodes/n002_", "seq": 1006, "timeout...
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager: LifX: **DEBUG: request_node_probe: na="d073d5149bcb" fa="n002_d073d5149bcb" api="nodes/n002_d073d5149bcb"
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager:     LifX [2] ( 0.00)   Done: {"restcall": {"api": "nodes/n002_", "seq": 1006, "timeout...
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager: LifX: **DEBUG: request_node_probe: na="" fa="n002_" api="nodes/n002_"
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager: LifX STDIN: {"ping": {}}
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager:     LifX [2] ( 0.00) STDOUT: {"pong": {}}
DEBUG    [02-05-2017 23:44:52] polyglot.nodeserver_manager:     LifX [2] ( 0.00)   Done: {"pong": {}}
DEBUG    [02-05-2017 23:44:53] requests.packages.urllib3.connectionpool: "GET /rest/nodes/n002_lifxcontrol HTTP/1.1" 200 436
INFO     [02-05-2017 23:44:53] polyglot.element_manager.isy: ISY: [1] ( 0.92) 200 OK: https://10.0.0.50:443/rest/nodes/n002_lifxcontrol
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager:     LifX [2] ( 0.93) _request_handler: completed.
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager:     LifX [1] ( 0.00) _request_handler: command=restcall seq=1005
DEBUG    [02-05-2017 23:44:53] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/nodes/n002_d073d5149bcb
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": "<?xml version=\"1.0\" encoding=\"UTF-8\"?><nodeInfo><node flag=\"128\" nodeDefId=\"lifxcontrol\"><address>n002_lifxcontrol</address><name>LIFX Control</name><family instance=\"2\">10</family><type>1.1.0.0</type><enabled>true</enabled><deviceClass>0</deviceClass><wattage>0</wattage><dcPeriod>0</dcPeriod><startDelay>0</startDelay><endDelay>0</endDelay><pnode>n002_lifxcontrol</pnode><ELK_ID>A02</ELK_ID></node><properties></properties></nodeInfo>", "elapsed": 0.9200811386108398, "status_code": 200, "seq": 1004, "retries": 0}}
DEBUG    [02-05-2017 23:44:53] requests.packages.urllib3.connectionpool: "GET /rest/nodes/n002_d073d5149bcb HTTP/1.1" 200 476
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **DEBUG: probe: st=200 na="lifxcontrol" text: <?xml version="1.0" encoding="UTF-8"?><nodeInfo><node flag="128" nodeDefId="lifxcontrol"><address>n002_lifxcontrol</address><name>LIFX Control</name><family instance="2">10</family><type>1.1.0.0</type><enabled>true</enabled><deviceClass>0</deviceClass><wattage>0</wattage><dcPeriod>0</dcPeriod><startDelay>0</startDelay><endDelay>0</endDelay><pnode>n002_lifxcontrol</pnode><ELK_ID>A02</ELK_ID></node><properties></properties></nodeInfo>
INFO     [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **INFO: probe: fa=n002_lifxcontrol pfa=n002_lifxcontrol id=lifxcontrol fl=128 en=True nm="LIFX Control"
WARNING  [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **WARNING: probe: node state mismatch - node is added on ISY
WARNING  [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **WARNING: probe: correcting local node state
INFO     [02-05-2017 23:44:53] polyglot.element_manager.isy: ISY: [1] ( 0.06) 200 OK: https://10.0.0.50:443/rest/nodes/n002_d073d5149bcb
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager:     LifX [1] ( 0.06) _request_handler: completed.
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=restcall seq=1006
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": "<?xml version=\"1.0\" encoding=\"UTF-8\"?><nodeInfo><node flag=\"0\" nodeDefId=\"lifxcolor\"><address>n002_d073d5149bcb</address><name>LifX BedRm2 Strip Lights</name><family instance=\"2\">10</family><parent type=\"3\">64561</parent><type>1.1.0.0</type><enabled>true</enabled><deviceClass>0</deviceClass><wattage>0</wattage><dcPeriod>0</dcPeriod><startDelay>0</startDelay><endDelay>0</endDelay><pnode>n002_lifxcontrol</pnode><ELK_ID>A03</ELK_ID></node><properties></properties></nodeInfo>", "elapsed": 0.056066036224365234, "status_code": 200, "seq": 1005, "retries": 0}}
DEBUG    [02-05-2017 23:44:53] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/nodes/n002_
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **DEBUG: probe: st=200 na="d073d5149bcb" text: <?xml version="1.0" encoding="UTF-8"?><nodeInfo><node flag="0" nodeDefId="lifxcolor"><address>n002_d073d5149bcb</address><name>LifX BedRm2 Strip Lights</name><family instance="2">10</family><parent type="3">64561</parent><type>1.1.0.0</type><enabled>true</enabled><deviceClass>0</deviceClass><wattage>0</wattage><dcPeriod>0</dcPeriod><startDelay>0</startDelay><endDelay>0</endDelay><pnode>n002_lifxcontrol</pnode><ELK_ID>A03</ELK_ID></node><properties></properties></nodeInfo>
INFO     [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **INFO: probe: fa=n002_d073d5149bcb pfa=n002_lifxcontrol id=lifxcolor fl=0 en=True nm="LifX BedRm2 Strip Lights"
WARNING  [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **WARNING: probe: node state mismatch - node is added on ISY
WARNING  [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **WARNING: probe: correcting local node state
DEBUG    [02-05-2017 23:44:53] requests.packages.urllib3.connectionpool: "GET /rest/nodes/n002_ HTTP/1.1" 404 105
ERROR    [02-05-2017 23:44:53] polyglot.element_manager.isy: ISY: [1] ( 0.04) 404 ERR: https://10.0.0.50:443/rest/nodes/n002_
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager:     LifX [0] ( 0.05) _request_handler: completed.
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": "<?xml version=\"1.0\" encoding=\"UTF-8\"?><RestResponse succeeded=\"false\"><status>404</status></RestResponse>", "elapsed": 0.03752899169921875, "status_code": 404, "seq": 1006, "retries": 0}}
DEBUG    [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **DEBUG: probe: st=404 na="" text: <?xml version="1.0" encoding="UTF-8"?><RestResponse succeeded="false"><status>404</status></RestResponse>
WARNING  [02-05-2017 23:44:53] polyglot.nodeserver_manager: LifX: **WARNING: probe: status code: 404
INFO     [02-05-2017 23:44:55] tornado.access: 200 GET /ns/uA4vB/nodes/n002_d073d5149bcb/cmd/SET_HSBKD?H.uom56=51557&S.uom56=4593&B.uom56=65535&K.uom26=2500&D.uom42=3000 (10.0.0.50) 1.84ms
DEBUG    [02-05-2017 23:44:55] polyglot.nodeserver_manager: LifX STDIN: {"cmd": {"node_address": "d073d5149bcb", "S.uom56": 4593.0, "value": null, "B.uom56": 65535.0, "command": "SET_HSBKD", "H.uom56": 51557.0, "request_id": null, "uom": null, "D.uom42": 3000.0, "K.uom26": 2500.0}}
ERROR    [02-05-2017 23:44:55] polyglot.nodeserver_manager: LifX: Error handling cmd in function on_cmd: error(9, 'Bad file descriptor')Traceback (most recent call last):  File "/tmp/polyglot_6QmIRX/polyglot/nodeserver_api.py", line 1419, in _recv    success.append(fun(**data))  File "/tmp/polyglot_6QmIRX/polyglot/nodeserver_api.py", line 61, in auto_request_report_wrapper    success = fun(*args, **kwargs)  File "/tmp/polyglot_6QmIRX/polyglot/nodeserver_api.py", line 1137, in on_cmd    command, value=value, cmd=command, uom=uom, **kwargs)  File "/tmp/polyglot_6QmIRX/polyglot/nodeserver_api.py", line 137, in run_cmd    success = fun(self, **kwargs)  File "/home/pi/Polyglot/config/node_servers/lifx-nodeserver/polylifx_types.py", line 181, in _sethsbkd    self.device.set_color(color, self.duration, True)  File "/home/pi/Polyglot/config/node_servers/lifx-nodeserver/lifxlan/light.py", line 62, in set_color    self.fire_and_forget(LightSetColor, {"color": color, "duration": duration}, num_repeats=5)  File "/home/pi/Polyglot/config/node_servers/lifx-nodeserver/lifxlan/device.py", line 379, in fire_and_forget    self.sock.sendto(msg.packed_message, (UDP_BROADCAST_IP, self.port))  File "/usr/lib/python2.7/socket.py", line 170, in _dummy    raise error(EBADF, 'Bad file descriptor')error: [Errno 9] Bad file descriptor
DEBUG    [02-05-2017 23:45:01] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:45:01] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:45:01] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=status seq=1007
DEBUG    [02-05-2017 23:45:01] polyglot.nodeserver_manager:     LifX [0] ( 0.00) STDOUT: {"status": {"node_address": "d073d5149bcb", "driver_contr...
DEBUG    [02-05-2017 23:45:01] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/51557/56
DEBUG    [02-05-2017 23:45:01] polyglot.nodeserver_manager:     LifX [1] ( 0.00)   Done: {"status": {"node_address": "d073d5149bcb", "driver_contr...
INFO     [02-05-2017 23:45:01] requests.packages.urllib3.connectionpool: Resetting dropped connection: 10.0.0.50
DEBUG    [02-05-2017 23:45:02] requests.packages.urllib3.connectionpool: "GET /rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/51557/56 HTTP/1.1" 200 0
INFO     [02-05-2017 23:45:02] polyglot.element_manager.isy: ISY: [1] ( 0.90) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV1/51557/56
DEBUG    [02-05-2017 23:45:02] polyglot.nodeserver_manager:     LifX [1] ( 0.91) _request_handler: completed.
DEBUG    [02-05-2017 23:45:02] polyglot.nodeserver_manager:     LifX [0] ( 0.00) _request_handler: command=status seq=1008
DEBUG    [02-05-2017 23:45:02] polyglot.element_manager.isy: ISY: Request: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/4593/56
DEBUG    [02-05-2017 23:45:02] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": null, "elapsed": 0.8959829807281494, "status_code": 200, "seq": 1007, "retries": 0}}
DEBUG    [02-05-2017 23:45:02] requests.packages.urllib3.connectionpool: "GET /rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/4593/56 HTTP/1.1" 200 0
INFO     [02-05-2017 23:45:02] polyglot.element_manager.isy: ISY: [1] ( 0.04) 200 OK: https://10.0.0.50:443/rest/ns/2/nodes/n002_d073d5149bcb/report/status/GV2/4593/56
DEBUG    [02-05-2017 23:45:02] polyglot.nodeserver_manager: LifX: **DEBUG: node "LifX BedRm2 Strip Lights": driver "GV1": status sent to ISY ok.
DEBUG    [02-05-2017 23:45:02] polyglot.nodeserver_manager:     LifX [0] ( 0.05) _request_handler: completed.
DEBUG    [02-05-2017 23:45:02] polyglot.nodeserver_manager: LifX STDIN: {"result": {"text": null, "elapsed": 0.04256010055541992, "status_code": 200, "seq": 1008, "retries": 0}}
DEBUG    [02-05-2017 23:45:02] polyglot.nodeserver_manager: LifX: **DEBUG: node "LifX BedRm2 Strip Lights": driver "GV2": status sent to ISY ok.

einstein.42 · February 6, 2017

DEBUG [02-05-2017 23:45:02] polyglot.nodeserver_manager: LifX: **DEBUG: node "LifX BedRm2 Strip Lights": driver "GV1": status sent to ISY ok.
DEBUG [02-05-2017 23:45:02] polyglot.nodeserver_manager: LifX: **DEBUG: node "LifX BedRm2 Strip Lights": driver "GV2": status sent to ISY ok.

These are two of the last 4 lines. They show the nodeserver still up and working. Did it crash this time?

I tested every button and changing every single value manually and with the Set HSBKD program. All of them worked. All of them updated the ISY gui within 2 seconds, I never had a failure.

What version of Polyglot and what version of ISY?

What are you running Polyglot on raspberry PI? You are using the binaries it looks like correct?

kzboray · February 6, 2017

Einstein.42

The two lines in post #57 are from a normal startup of Polyglot / LifX and at that time it was running fine. I posted that because it shows errors even on startup of LifX before anything is actually happening. In post #56 you can see the LifX NS failed at 23:36:02 which was about 15 minutes after I started the random program. I had zero control over <Duration> with the latest git pull. I have not done any regression testing...yet. I ran out of steam last night .

Yes i'm running on a Pi3 running NOOBS

update/upgrade last performed yesterday

ISY 5.0.8

Python 2.7.9

Polyglot 0.0.6

Pip 9.0.1

Bitstring

LifX version.txt says 0.1.2

The Pi was built last week and is running no other programs. The ISY and PLM were last defaulted and rebuilt from scratch yesterday prior to installing the latest build of LifX NS. This is a test system so I can easily tear it down and restart from scratch in less than 15 minutes. I also have a bit image of a fresh Pi build that takes about as long to reinstall Polyglot and LifX onto. I do my best to eliminate all variables, and I am open to any suggestions. I haven't done any serious product testing since 1989.

On a positive note the LifX server ran all night without crashing and I was able to turn on the strip lights this morning without a problem. It's just that blasted random program that messes everything up. Until you have a set to test with I feel like you have done more than enough, but I am willing to do any other testing you would like. Thank you for all your amazing and timely work. You're really quite inspirational.

Edit ====

Just fired up the random program for fun and <Duration> is still ignored. I think I'll rebuild the Pi again tonight from scratch and see if something has gotten wonky with the bit image.

Have a great day mate.

einstein.42 · February 6, 2017

I hate stuff that doesn't work! I appreciate your words. Can you check the duration and stuff again?

I literally just hit the up and down arrow on each field and the GUI updates a second or so later. That doesn't work for you?

kzboray · February 6, 2017

LOL I here that!

So I went to the ISY interface screen for the bulb itself and changed the duration there and it worked perfectly.

I then went back to the HSBKD entry in the random program and changed <Duration> again and this time it worked. It was hung up in the HSBKD entry in the program for some reason. Now it's working.

Check that one off.

skunkiechris · February 7, 2017

Okay...so I pulled latest to stay up to date, and now it's crashing for me on startup. :shock:

Error log below:

ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX: Traceback (most recent call last):
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/home/pi/Polyglot/config/node_servers/lifx-nodeserver/polylifx.py", line 58, in <module>
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:     main()
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/home/pi/Polyglot/config/node_servers/lifx-nodeserver/polylifx.py", line 53, in main
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:     nserver.setup()
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/home/pi/Polyglot/config/node_servers/lifx-nodeserver/polylifx.py", line 24, in setup
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:     self.controller._discover()
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/home/pi/Polyglot/config/node_servers/lifx-nodeserver/polylifx_types.py", line 70, in _discover
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:     self.parent.bulbs.append(LIFXColor(self.parent, self.parent.get_node('lifxcontrol'), address, name, d, hasColor, manifest))
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/home/pi/Polyglot/config/node_servers/lifx-nodeserver/polylifx_types.py", line 105, in __init__
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:     self.update_info()
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/home/pi/Polyglot/config/node_servers/lifx-nodeserver/polylifx_types.py", line 127, in update_info
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:     self.set_driver('GV6', self.uptime)
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX: AttributeError: 'LIFXColor' object has no attribute 'uptime'
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX: Exception in thread Thread-3 (most likely raised during interpreter shutdown):
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX: Traceback (most recent call last):
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/usr/lib/python2.7/threading.py", line 810, in __bootstrap_inner
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/usr/lib/python2.7/threading.py", line 763, in run
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/home/pi/Polyglot/polyglot/nodeserver_api.py", line 1367, in _send_err
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX:   File "/usr/lib/python2.7/Queue.py", line 174, in get
ERROR    [02-07-2017 20:07:04] polyglot.nodeserver_manager: LIFX: <type 'exceptions.TypeError'>: 'NoneType' object is not callable
ERROR    [02-07-2017 20:07:30] polyglot.nodeserver_manager: Node Server LIFX has exited unexpectedly.

Any thoughts?

Thanks!!

einstein.42 · February 7, 2017

Ahh crap, sorry Chris. Are your bulbs on the latest firmware?

skunkiechris · February 7, 2017

Ahh crap, sorry Chris. Are your bulbs on the latest firmware?

Yep, they are on 1.20. (I see there's a 1.21 on the beta page, but no info on what might have changed.)

einstein.42 · February 7, 2017

Yep, they are on 1.20. (I see there's a 1.21 on the beta page, but no info on what might have changed.)

Ok give me an hour to get home and I'll take a look.

Sent from my iPhone using Tapatalk

skunkiechris · February 7, 2017

Ok give me an hour to get home and I'll take a look.

Sent from my iPhone using Tapatalk

Okay, no huge rush - I reverted back to the Jan 16th commit, so I'm back up and running, so far so good.

Thanks!!

einstein.42 · February 7, 2017

Try it now. Should be good to go. I think had an init somewhere. I'm not sure why we didn't hit that during testing though. You must be special.

-E

einstein.42 · February 7, 2017

Try it now. Should be good to go. I think had an var init off. I'm not sure why we didn't hit that during testing though. You must be special.

-E

skunkiechris · February 7, 2017

Try it now. Should be good to go. I think had an var init off. I'm not sure why we didn't hit that during testing though. You must be special.

-E

Yep, working great now, thanks for the quick fix!!

einstein.42 · February 7, 2017

Good deal. Sorry about that.

paulbram · February 8, 2017

So I've just now started playing with this node server a bit more. One thing that is a little annoying is none of the "scenes" I've created in the App show up in ISY. I've noticed that Alexa does have access to those same scenes so it seems like it should be possible. Or, is that only because Alexa goes external/cloud and the node server remains local?

I wouldn't call this a major problem, but without it, I noticed that when I send a HSBKD command to a group of lights, they all change one at a time. However, when Alexa does a similar thing via a "scene" they all move in unison.

Is there any way to achieve that nice smooth "scene" feeling using the node server?

Thanks!

einstein.42 · February 8, 2017

If you change the group does it do 1 at a time or all at once?

paulbram · February 8, 2017

If you change the group does it do 1 at a time or all at once?

1 at a time.

Sent from my Robin using Tapatalk

skunkiechris · February 8, 2017

From what I've read of the LAN protocol, there isn't really a way to address groups of bulbs simultaneously. (See https://community.lifx.com/t/lan-protocol-how-to-send-messages-to-a-group/1783 for commentary from LIFX. They specify sending messages to bulbs individually; I assume in our case there's a delay because we're being limited by the speed of the ISY/Nodeserver.) The http API does indeed allow up to 50 bulbs to be controlled at one time (via Set States) or activation of a stored scene. Soooo, I've been using the node server to take actions based on bulb status, and to address individual lights, and then using network resources hitting the http API for actions that I want coordinated across bulbs. Overall the combination works quite well!

einstein.42 · February 8, 2017

Oh... that makes me remember something I saw in the code. I think in the new stuff they let me do staging then activate. I'll have to test that, but I only have the 1 bulb at the moment. I never got around to buying the strip, so I'll have to order that. I'll try to do that this weekend.

Sign In

Polyglot LIFX NodeSever

Recommended Posts

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Archived

Recently Browsing

Who's Online (See full list)

Forum Statistics