<0x712db520> 06 12/30/18 20:04:51.645 Device_Variable::m_szValue_set device: 42 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 163,711,1032,1546196685,2086 now: 161,709,1032,1546196691,2092 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:51.646 Device_Variable::m_szValue_set device: 42 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:26 now: 13:07:32 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:51.646 Device_Variable::m_szValue_set device: 42 service: urn:upnp-org:serviceId:TemperatureSensor1 variable: CurrentTemperature was: 28.9 now: 29.0 #hooks: 0 upnp: 0 skip: 0 v:0x116a0d0/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:53.593 Device_Variable::m_szValue_set device: 40 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:32 now: 13:07:34 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:53.615 Device_Variable::m_szValue_set device: 43 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 995 now: 1053 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:53.670 Device_Variable::m_szValue_set device: 43 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 995,663,2072,1546196687,2088 now: 1053,663,2072,1546196693,2094 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:53.670 Device_Variable::m_szValue_set device: 43 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:27 now: 13:07:34 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:53.671 Device_Variable::m_szValue_set device: 43 service: urn:upnp-org:serviceId:TemperatureSensor1 variable: CurrentTemperature was: 28.9 now: 29.0 #hooks: 0 upnp: 0 skip: 0 v:0x116a0d0/NONE duplicate:0 <0x712db520> 50 12/30/18 20:04:55.101 luup_log:0: EnergyMonitor Logger: Updating with: https://emoncms.org/input/post?apikey=5b574aedfe6af7e4269080cc68b12f41&node=10&fulljson={"Conso_Globale":1111,"Conso_Globale_HP":1111,"Conso_Globale_HC":0,"Conso_Clim":161,"Conso_Clim_HP":161,"Conso_Clim_HC":0,"Conso_Tempo":1053,"Conso_Tempo_HP":1053,"Conso_Tempo_HC":0} <0x72cdb520> 50 12/30/18 20:04:56.101 luup_log:0: EnergyMonitor Logger: Updating with: https://emoncms.org/input/post?apikey=5b574aedfe6af7e4269080cc68b12f41&node=10&fulljson={"Conso_Globale":1111,"Conso_Globale_HP":1111,"Conso_Globale_HC":0,"Conso_Clim":161,"Conso_Clim_HP":161,"Conso_Clim_HC":0,"Conso_Tempo":1053,"Conso_Tempo_HP":1053,"Conso_Tempo_HC":0} <0x72cdb520> 06 12/30/18 20:04:57.620 Device_Variable::m_szValue_set device: 40 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:34 now: 13:07:38 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:57.637 Device_Variable::m_szValue_set device: 41 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 1111 now: 1169 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:57.684 Device_Variable::m_szValue_set device: 41 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 1111,2328,5251,1546196691,2092 now: 1169,2324,5251,1546196697,2098 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:57.695 Device_Variable::m_szValue_set device: 41 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:31 now: 13:07:38 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:57.695 Device_Variable::m_szValue_set device: 40 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 1111 now: 1169 #hooks: 0 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:57.696 Device_Variable::m_szValue_set device: 40 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 1111,2319,5251,1546196691,2092 now: 1169,2315,5251,1546196697,2098 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:04:59.613 Device_Variable::m_szValue_set device: 40 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:38 now: 13:07:40 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 01 12/30/18 20:04:59.781 LuaInterface::CallFunction-2 lu_incoming failed [string "module ("L_CurrentCostEnviR1", package.seea..."]:417: attempt to concatenate field 'sensor' (a nil value) <0x712db520> 06 12/30/18 20:05:00.045 Device_Variable::m_szValue_set device: 43 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 1053 now: 1152 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:00.082 Device_Variable::m_szValue_set device: 43 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 1053,663,2072,1546196693,2094 now: 1152,664,2072,1546196700,2101 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:00.083 Device_Variable::m_szValue_set device: 43 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:34 now: 13:07:40 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:00.101 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: Timers was: [ { "armed": true, "data": "312#1#8af2e648-f8f8-451e-9c6b-9d81b5458a7f#00992030-6474-4a1d-92b6-6b12b054401d#2e55878f-a82f-4d5e-9b10-99b46b372fb0", "callback": "workflowTimerCB", "expireson": 1546196700 } ] now: [ ] #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x74d36520> 50 12/30/18 20:05:00.102 luup_log:312: ALTUI: Wkflow - workflowTimerCB(312#1#8af2e648-f8f8-451e-9c6b-9d81b5458a7f#00992030-6474-4a1d-92b6-6b12b054401d#2e55878f-a82f-4d5e-9b10-99b46b372fb0) <0x74d36520> 50 12/30/18 20:05:00.104 luup_log:312: ALTUI: Wkflow - Workflow: 0-1, Valid Transition found:Timer:Après le Timer Normal, Active State:Timer Normal=>Lampe éteinte <0x74d36520> 06 12/30/18 20:05:00.104 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: Timers was: [ ] now: [ ] #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:1 <0x74d36520> 06 12/30/18 20:05:00.106 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: WorkflowsActiveState was: { "0-2": "a6019de0-dcbf-49e9-8157-978a44c127f8", "0-3": "2e6731b8-ccc5-4bca-9239-3133edccfc42", "0-1": "8af2e648-f8f8-451e-9c6b-9d81b5458a7f", "0-4": "748255a0-c2a5-4c89-b226-9b10395eb455", "0-5": "79066cbd-0729-4581-8c19-c099d59cbdaf" } now: { "0-2": "a6019de0-dcbf-49e9-8157-978a44c127f8", "0-3": "2e6731b8-ccc5-4bca-9239-3133edccfc42", "0-1": "00992030-6474-4a1d-92b6-6b12b054401d", "0-4": "748255a0-c2a5-4c89-b226-9b10395eb455", "0-5": "79066cbd-0729-4581-8c19-c099d59cbdaf" } #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x74d36520> 08 12/30/18 20:05:00.109 JobHandler_LuaUPnP::HandleActionRequest device: 6 service: urn:upnp-org:serviceId:SwitchPower1 action: SetTarget <0x74d36520> 08 12/30/18 20:05:00.109 JobHandler_LuaUPnP::HandleActionRequest argument newTargetValue=0 <0x74d36520> 06 12/30/18 20:05:00.121 Device_Variable::m_szValue_set device: 6 service: urn:upnp-org:serviceId:SwitchPower1 variable: Target was: 0 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0x1118af8/NONE duplicate:1 <0x74d36520> 08 12/30/18 20:05:00.123 JobHandler_LuaUPnP::HandleActionRequest device: 10 service: urn:upnp-org:serviceId:SwitchPower1 action: SetTarget <0x74d36520> 08 12/30/18 20:05:00.124 JobHandler_LuaUPnP::HandleActionRequest argument newTargetValue=0 <0x74d36520> 06 12/30/18 20:05:00.124 Device_Variable::m_szValue_set device: 10 service: urn:upnp-org:serviceId:SwitchPower1 variable: Target was: 0 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0x1118af8/NONE duplicate:1 <0x74d36520> 50 12/30/18 20:05:00.143 luup_log:312: ALTUI: Wkflow - Workflow: 0-1, Valid Transition found:Lampe est allumée, Active State:Lampe éteinte=>Lampe allumée <0x74d36520> 06 12/30/18 20:05:00.143 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: Timers was: [ ] now: [ ] #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:1 <0x74d36520> 06 12/30/18 20:05:00.147 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: WorkflowsActiveState was: { "0-2": "a6019de0-dcbf-49e9-8157-978a44c127f8", "0-3": "2e6731b8-ccc5-4bca-9239-3133edccfc42", "0-1": "00992030-6474-4a1d-92b6-6b12b054401d", "0-4": "748255a0-c2a5-4c89-b226-9b10395eb455", "0-5": "79066cbd-0729-4581-8c19-c099d59cbdaf" } now: { "0-2": "a6019de0-dcbf-49e9-8157-978a44c127f8", "0-3": "2e6731b8-ccc5-4bca-9239-3133edccfc42", "0-1": "fdc74708-2da4-430c-861e-332c99e15414", "0-4": "748255a0-c2a5-4c89-b226-9b10395eb455", "0-5": "79066cbd-0729-4581-8c19-c099d59cbdaf" } #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x74d36520> 50 12/30/18 20:05:00.186 luup_log:312: ALTUI: Wkflow - Workflow: 0-1, Valid Transition found:Mode normal, Active State:Lampe allumée=>Timer Normal <0x74d36520> 06 12/30/18 20:05:00.187 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: Timers was: [ ] now: [ ] #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:1 <0x74d36520> 06 12/30/18 20:05:00.189 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: WorkflowsActiveState was: { "0-2": "a6019de0-dcbf-49e9-8157-978a44c127f8", "0-3": "2e6731b8-ccc5-4bca-9239-3133edccfc42", "0-1": "fdc74708-2da4-430c-861e-332c99e15414", "0-4": "748255a0-c2a5-4c89-b226-9b10395eb455", "0-5": "79066cbd-0729-4581-8c19-c099d59cbdaf" } now: { "0-2": "a6019de0-dcbf-49e9-8157-978a44c127f8", "0-3": "2e6731b8-ccc5-4bca-9239-3133edccfc42", "0-1": "8af2e648-f8f8-451e-9c6b-9d81b5458a7f", "0-4": "748255a0-c2a5-4c89-b226-9b10395eb455", "0-5": "79066cbd-0729-4581-8c19-c099d59cbdaf" } #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x74d36520> 06 12/30/18 20:05:00.210 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: Timers was: [ ] now: [ { "armed": true, "data": "312#1#8af2e648-f8f8-451e-9c6b-9d81b5458a7f#00992030-6474-4a1d-92b6-6b12b054401d#2e55878f-a82f-4d5e-9b10-99b46b372fb0", "callback": "workflowTimerCB", "expireson": 1546196730 } ] #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x74d36520> 06 12/30/18 20:05:00.427 Device_Variable::m_szValue_set device: 6 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 1 now: 0 #hooks: 2 upnp: 0 skip: 0 v:0x1118b70/NONE duplicate:0 <0x76936520> 50 12/30/18 20:05:01.072 luup_log:312: ALTUI: _deferredWgetThingspeak(url=https://api.thingspeak.com/update?api_key=57UG4KV6W6YWUE5V&field1=1169&field5=1152&field2=161) ==> code=0 httpcode=200 data=224758 <0x74d36520> 50 12/30/18 20:05:01.101 luup_log:312: ALTUI: Wkflow - Workflow: 0-1, Valid Transition found:Lampe est éteinte, Active State:Timer Normal=>Lampe éteinte <0x76936520> 06 12/30/18 20:05:01.102 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: Timers was: [ { "armed": true, "data": "312#1#8af2e648-f8f8-451e-9c6b-9d81b5458a7f#00992030-6474-4a1d-92b6-6b12b054401d#2e55878f-a82f-4d5e-9b10-99b46b372fb0", "callback": "workflowTimerCB", "expireson": 1546196730 } ] now: [ ] #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x76936520> 06 12/30/18 20:05:01.108 Device_Variable::m_szValue_set device: 312 service: urn:upnp-org:serviceId:altui1 variable: WorkflowsActiveState was: { "0-2": "a6019de0-dcbf-49e9-8157-978a44c127f8", "0-3": "2e6731b8-ccc5-4bca-9239-3133edccfc42", "0-1": "8af2e648-f8f8-451e-9c6b-9d81b5458a7f", "0-4": "748255a0-c2a5-4c89-b226-9b10395eb455", "0-5": "79066cbd-0729-4581-8c19-c099d59cbdaf" } now: { "0-2": "a6019de0-dcbf-49e9-8157-978a44c127f8", "0-3": "2e6731b8-ccc5-4bca-9239-3133edccfc42", "0-1": "00992030-6474-4a1d-92b6-6b12b054401d", "0-4": "748255a0-c2a5-4c89-b226-9b10395eb455", "0-5": "79066cbd-0729-4581-8c19-c099d59cbdaf" } #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x76936520> 08 12/30/18 20:05:01.121 JobHandler_LuaUPnP::HandleActionRequest device: 6 service: urn:upnp-org:serviceId:SwitchPower1 action: SetTarget <0x76936520> 08 12/30/18 20:05:01.121 JobHandler_LuaUPnP::HandleActionRequest argument newTargetValue=0 <0x76936520> 06 12/30/18 20:05:01.121 Device_Variable::m_szValue_set device: 6 service: urn:upnp-org:serviceId:SwitchPower1 variable: Target was: 0 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0x1118af8/NONE duplicate:1 <0x76936520> 08 12/30/18 20:05:01.123 JobHandler_LuaUPnP::HandleActionRequest device: 10 service: urn:upnp-org:serviceId:SwitchPower1 action: SetTarget <0x76936520> 08 12/30/18 20:05:01.123 JobHandler_LuaUPnP::HandleActionRequest argument newTargetValue=0 <0x76936520> 06 12/30/18 20:05:01.123 Device_Variable::m_szValue_set device: 10 service: urn:upnp-org:serviceId:SwitchPower1 variable: Target was: 0 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0x1118af8/NONE duplicate:1 <0x76936520> 04 12/30/18 20:05:01.125 <0x76936520> 04 12/30/18 20:05:01.165 <0x76936520> 06 12/30/18 20:05:01.455 Device_Variable::m_szValue_set device: 6 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 0 now: 0 #hooks: 2 upnp: 0 skip: 0 v:0x1118b70/NONE duplicate:1 <0x76936520> 04 12/30/18 20:05:01.456 <0x76936520> 06 12/30/18 20:05:01.567 Device_Variable::m_szValue_set device: 10 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 0 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0x1118b70/NONE duplicate:1 <0x76936520> 04 12/30/18 20:05:01.568 <0x76936520> 06 12/30/18 20:05:02.695 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 0 now: 0 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:02.695 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: ActualUsage was: 1 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x111a890/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:03.111 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 0 now: 0 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:03.111 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: ActualUsage was: 1 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x111a890/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:03.439 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 0 now: 0 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:03.439 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: ActualUsage was: 1 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x111a890/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:03.475 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 0 now: 0 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:03.475 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: ActualUsage was: 1 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x111a890/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:03.631 Device_Variable::m_szValue_set device: 40 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:40 now: 13:07:44 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:03.643 Device_Variable::m_szValue_set device: 42 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 161 now: 163 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:03.680 Device_Variable::m_szValue_set device: 42 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 161,709,1032,1546196691,2092 now: 163,705,1032,1546196703,2104 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:03.681 Device_Variable::m_szValue_set device: 42 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:32 now: 13:07:44 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:04.125 Device_Variable::m_szValue_set device: 41 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 1169 now: 1188 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:04.587 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 0 now: 0 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:04.587 Device_Variable::m_szValue_set device: 364 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: ActualUsage was: 1 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x111a890/NONE duplicate:1 <0x76936520> 50 12/30/18 20:05:04.806 luup_log:312: ALTUI: _deferredWgetThingspeak(url=https://api.thingspeak.com/update?api_key=57UG4KV6W6YWUE5V&field2=163) ==> code=0 httpcode=200 data=0 <0x74d36520> 50 12/30/18 20:05:04.840 luup_log:0: ALTUI: runLua(--local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "Pause", { groupID = "RINCON_5CAAFDF5D49C01400:3291522576"} , 491) --print (pretty(returnArguments)) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "SetGroupMembers", { ["groupID"] = "RINCON_5CAAFDF5D49C01400:3291522576",playerIDs = "RINCON_5CAAFDF5D49C01400,RINCON_949F3E85D3D001400"} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "GetVolume", { groupID = "RINCON_5CAAFDF5D49C01400:3291522576"} , 491) --print (string.gsub((pretty(returnArguments),"{LastVolume = "))) --local Newvolume = 25 --local CurrentVolume = string.gsub(string.gsub(string.gsub(pretty(returnArguments), "{LastVolume = ", ""),"}",""),'"','') --local Delta = Newvolume-CurrentVolume --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "SetVolumeRelative", { groupID = "RINCON_5CAAFDF5D49C01400:3291522576",volumeDelta=Delta} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "SetVolumeRelative", { groupID = "RINCON_5CAAFDF5D49C01400:3291522576",volumeDelta="+60"} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "LoadFavorite", { groupID = "RINCON_5CAAFDF5D49C01400:3291522576",favID=12} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "AudioClip", { ["groupID"] = "RINCON_5CAAFDF5D49C01400:3291522576",urlClip = "http://192.168.1.27:8085/Annonce.mp3",Duration=3,Volume="+50"} , 491) -- --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altui1", "SayTTS", {newMessage = "La lessive est terminée.", newVolume = 70, newGroupDevices = "RINCON_5CAAFDF5D49C01400:3291522576"}, 312) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "SetGroupMembers", { ["groupID"] = "RINCON_5CAAFDF5D49C01400:3291522576",playerIDs = "RINCON_5CAAFDF5D49C01400,RINCON_949F3E85D3D001400"} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "SetVolumeRelative", { groupID_playerID = "RINCON_5CAAFDF5D49C01400:3291522576",volumeDelta="-100"} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "SetVolumeRelative", { groupID_playerID = "RINCON_5CAAFDF5D49C01400:3291522576",volumeDelta=40} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "AudioClip", { ["groupID_playerID"] = "RINCON_5CAAFDF5D49C01400",urlClip = "http://192.168.1.27:8085/Annonce.mp3",Volume=40} , 491) --socket.sleep(7) local resultCode2, resultString2, job2, returnArguments2 = luup.call_action("urn:upnp-org:serviceId:altsonos1", "AudioClip", { ["groupID_playerID"] = "RINCON_5CAAFDF5D49C01400",urlClip = "http://192.168.1.27:8085/Code message incorrecte.mp3"} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "AudioClip", { ["groupID_playerID"] = "RINCON_5CAAFDF5D49C01400",urlClip = "http://192.168.1.27:8085/Annonce.mp3",Duration=2,Volume=20} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altsonos1", "LoadFavorite", { groupID_playerID = "RINCON_5CAAFDF5D49C01400:3291522576",favID=12} , 491) --local resultCode, resultString, job, returnArguments = luup.call_action("urn:upnp-org:serviceId:altui1", "SayTTS", {newMessage = "Ceci est un test de message", newVolume = 80, newGroupDevices = "RINCON_5CAAFDF5D49C01400:3291522576"}, 312) ) <0x716db520> 08 12/30/18 20:05:04.842 JobHandler_LuaUPnP::HandleActionRequest device: 491 service: urn:upnp-org:serviceId:altsonos1 action: AudioClip <0x716db520> 08 12/30/18 20:05:04.842 JobHandler_LuaUPnP::HandleActionRequest argument urlClip=http://192.168.1.27:8085/Code message incorrecte.mp3 <0x716db520> 08 12/30/18 20:05:04.842 JobHandler_LuaUPnP::HandleActionRequest argument groupID_playerID=RINCON_5CAAFDF5D49C01400 <0x716db520> 50 12/30/18 20:05:04.844 luup_log:0: ALTUI: Evaluation of lua code returned: nil <0x716db520> 50 12/30/18 20:05:04.846 luup_log:491: ALTSonos: debug: loadStreamUrl(491,RINCON_5CAAFDF5D49C01400,http://192.168.1.27:8085/Code message incorrecte.mp3,,) <0x775c6320> 50 12/30/18 20:05:04.847 luup_log:491: ALTSonos: debug: loadStreamUrlGid(491,RINCON_5CAAFDF5D49C01400,http://192.168.1.27:8085/Code message incorrecte.mp3,,) <0x775c6320> 50 12/30/18 20:05:04.847 luup_log:491: ALTSonos: debug: warning -- duration is ignored now. ( corrected duration:7 ) <0x775c6320> 50 12/30/18 20:05:04.850 luup_log:491: ALTSonos: debug: resolveGroup( RINCON_5CAAFDF5D49C01400 ): is a player, the group is RINCON_5CAAFDF5D49C01400:3291522576 <0x775c6320> 50 12/30/18 20:05:04.850 luup_log:491: ALTSonos: debug: corrected groupID:RINCON_5CAAFDF5D49C01400:3291522576 <0x775c6320> 50 12/30/18 20:05:04.850 luup_log:491: ALTSonos: debug: createSession(491,RINCON_5CAAFDF5D49C01400:3291522576) <0x775c6320> 50 12/30/18 20:05:04.851 luup_log:491: ALTSonos: debug: SonosHTTP(491,api.ws.sonos.com/control/api/v1/groups/RINCON_5CAAFDF5D49C01400:3291522576/playbackSession,POST,{ "appId": "com.getvera.amg0.altsonos", "appContext": "altsonos_audioClip" },Bearer ab8f688a-15c0-44ba-8b81-c8ff2683373f,application/json,{ "householdId": "Sonos_wFPVFKCnR9Fyxq0Gwy0xgxTz3Q.-KgfWIJj0GLlXDBN3Nyu", "groupId": "RINCON_5CAAFDF5D49C01400:3291522576" }) <0x775c6320> 50 12/30/18 20:05:04.852 luup_log:491: ALTSonos: debug: request headers:{ "Authorization": "Bearer ab8f688a-15c0-44ba-8b81-c8ff2683373f", "householdId": "Sonos_wFPVFKCnR9Fyxq0Gwy0xgxTz3Q.-KgfWIJj0GLlXDBN3Nyu", "groupId": "RINCON_5CAAFDF5D49C01400:3291522576", "Content-Type": "application/json", "Cache-Control": "no-cache", "Content-Length": 76 } <0x775c6320> 06 12/30/18 20:05:04.843 Device_Variable::m_szValue_set device: 41 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 1169,2324,5251,1546196697,2098 now: 1188,2320,5251,1546196704,2105 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:04.854 Device_Variable::m_szValue_set device: 41 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:38 now: 13:07:44 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:04.865 Device_Variable::m_szValue_set device: 40 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 1169 now: 1188 #hooks: 0 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:04.865 Device_Variable::m_szValue_set device: 40 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 1169,2315,5251,1546196697,2098 now: 1188,2311,5251,1546196704,2105 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 50 12/30/18 20:05:05.353 luup_log:491: ALTSonos: debug: response request:1 <0x775c6320> 50 12/30/18 20:05:05.353 luup_log:491: ALTSonos: debug: code:200 <0x775c6320> 50 12/30/18 20:05:05.355 luup_log:491: ALTSonos: debug: headers:{ "connection": "close", "date": "Sun, 30 Dec 2018 19:05:05 GMT", "pragma": "no-cache", "x-sonos-user-id": "117838608", "cache-control": "max-age=0, no-cache, no-store", "access-control-allow-origin": "", "expires": "Sun, 30 Dec 2018 19:05:05 GMT", "x-sonos-session": "RINCON_5CAAFDF5D49C01400:3291522576@1531888093", "x-sonos-household-id": "Sonos_wFPVFKCnR9Fyxq0Gwy0xgxTz3Q.-KgfWIJj0GLlXDBN3Nyu", "content-length": "124", "content-type": "application/json", "x-sonos-type": "sessionStatus", "x-sonos-group-id": "RINCON_5CAAFDF5D49C01400:3291522576", "x-sonos-mac": "5caafdf5d49c", "server": "Apache-Coyote/1.1" } <0x775c6320> 50 12/30/18 20:05:05.356 luup_log:491: ALTSonos: debug: data:"{\"sessionId\":\"RINCON_5CAAFDF5D49C01400:3291522576@493981250\",\"sessionState\":\"SESSION_STATE_CONNECTED\",\"sessionCreated\":true}" <0x775c6320> 50 12/30/18 20:05:05.356 luup_log:491: ALTSonos: debug: setVariableIfChanged(urn:upnp-org:serviceId:altsonos1,IconCode,100,491) <0x775c6320> 50 12/30/18 20:05:05.357 luup_log:491: ALTSonos: debug: setDBValue(491,0,Sonos_wFPVFKCnR9Fyxq0Gwy0xgxTz3Q.-KgfWIJj0GLlXDBN3Nyu,groupId,RINCON_5CAAFDF5D49C01400:3291522576,altsonos) <0x775c6320> 50 12/30/18 20:05:05.358 luup_log:491: ALTSonos: debug: target:RINCON_5CAAFDF5D49C01400:3291522576 type:altsonos body is { "trigger": false, "action": "stopAfterPlay", "params": "{ \"sessionid\": \"RINCON_5CAAFDF5D49C01400:3291522576@493981250\", \"gid\": \"RINCON_5CAAFDF5D49C01400:3291522576\", \"delta\": 0, \"lul_device\": 491 }" } <0x775c6320> 50 12/30/18 20:05:05.359 luup_log:491: ALTSonos: debug: onDefaultNotification(491,0,Sonos_wFPVFKCnR9Fyxq0Gwy0xgxTz3Q.-KgfWIJj0GLlXDBN3Nyu,groupId,RINCON_5CAAFDF5D49C01400:3291522576,altsonos,{ "trigger": false, "action": "stopAfterPlay", "params": "{ \"sessionid\": \"RINCON_5CAAFDF5D49C01400:3291522576@493981250\", \"gid\": \"RINCON_5CAAFDF5D49C01400:3291522576\", \"delta\": 0, \"lul_device\": 491 }" }) <0x775c6320> 50 12/30/18 20:05:05.359 luup_log:491: ALTSonos: debug: SonosHTTP(491,api.ws.sonos.com/control/api/v1/playbackSessions/RINCON_5CAAFDF5D49C01400:3291522576@493981250/playbackSession/loadStreamUrl,POST,{ "playOnCompletion": true, "streamUrl": "http://192.168.1.27:8085/Code message incorrecte.mp3" },Bearer ab8f688a-15c0-44ba-8b81-c8ff2683373f,application/json,[ ]) <0x775c6320> 50 12/30/18 20:05:05.360 luup_log:491: ALTSonos: debug: request headers:{ "Content-Type": "application/json", "Authorization": "Bearer ab8f688a-15c0-44ba-8b81-c8ff2683373f", "Cache-Control": "no-cache", "Content-Length": 97 } <0x775c6320> 50 12/30/18 20:05:05.769 luup_log:491: ALTSonos: debug: response request:1 <0x775c6320> 50 12/30/18 20:05:05.769 luup_log:491: ALTSonos: debug: code:200 <0x775c6320> 50 12/30/18 20:05:05.771 luup_log:491: ALTSonos: debug: headers:{ "connection": "close", "date": "Sun, 30 Dec 2018 19:05:05 GMT", "pragma": "no-cache", "x-sonos-user-id": "117838608", "cache-control": "max-age=0, no-cache, no-store", "access-control-allow-origin": "", "expires": "Sun, 30 Dec 2018 19:05:05 GMT", "x-sonos-session": "RINCON_5CAAFDF5D49C01400:3291522576@493981250", "x-sonos-household-id": "Sonos_wFPVFKCnR9Fyxq0Gwy0xgxTz3Q.-KgfWIJj0GLlXDBN3Nyu", "content-length": "2", "content-type": "application/json", "x-sonos-type": "none", "x-sonos-group-id": "RINCON_5CAAFDF5D49C01400:3291522576", "x-sonos-mac": "5caafdf5d49c", "server": "Apache-Coyote/1.1" } <0x775c6320> 50 12/30/18 20:05:05.771 luup_log:491: ALTSonos: debug: data:"{}" <0x775c6320> 50 12/30/18 20:05:05.772 luup_log:491: ALTSonos: debug: setVariableIfChanged(urn:upnp-org:serviceId:altsonos1,IconCode,100,491) <0x775c6320> 50 12/30/18 20:05:05.772 luup_log:491: ALTSonos: debug: resetRefreshMetadataLoop(491), SeqId 6 <0x775c6320> 04 12/30/18 20:05:05.773 <0x775c6320> 06 12/30/18 20:05:06.239 Device_Variable::m_szValue_set device: 40 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:44 now: 13:07:47 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:06.251 Device_Variable::m_szValue_set device: 43 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 1152 now: 1142 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:06.289 Device_Variable::m_szValue_set device: 43 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 1152,664,2072,1546196700,2101 now: 1142,665,2072,1546196706,2107 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:06.290 Device_Variable::m_szValue_set device: 43 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:40 now: 13:07:47 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:09.612 Device_Variable::m_szValue_set device: 40 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:47 now: 13:07:50 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:09.723 Device_Variable::m_szValue_set device: 319 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 0 now: 0 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:1 <0x76936520> 06 12/30/18 20:05:09.723 Device_Variable::m_szValue_set device: 319 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: ActualUsage was: 1 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x111a890/NONE duplicate:1 <0x76936520> 01 12/30/18 20:05:09.792 LuaInterface::CallFunction-2 lu_incoming failed [string "module ("L_CurrentCostEnviR1", package.seea..."]:417: attempt to concatenate field 'sensor' (a nil value) <0x712db520> 06 12/30/18 20:05:09.796 Device_Variable::m_szValue_set device: 42 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 163 now: 162 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:09.833 Device_Variable::m_szValue_set device: 42 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 163,705,1032,1546196703,2104 now: 162,703,1032,1546196709,2110 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:09.834 Device_Variable::m_szValue_set device: 42 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:44 now: 13:07:50 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:10.569 Device_Variable::m_szValue_set device: 40 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:50 now: 13:07:51 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:10.570 Device_Variable::m_szValue_set device: 41 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 1188 now: 1172 #hooks: 1 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:10.620 Device_Variable::m_szValue_set device: 41 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 1188,2320,5251,1546196704,2105 now: 1172,2316,5251,1546196710,2111 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:10.621 Device_Variable::m_szValue_set device: 41 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:44 now: 13:07:51 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:10.621 Device_Variable::m_szValue_set device: 40 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 1188 now: 1172 #hooks: 0 upnp: 0 skip: 0 v:0x1126610/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:10.621 Device_Variable::m_szValue_set device: 40 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Log was: 1188,2311,5251,1546196704,2105 now: 1172,2307,5251,1546196710,2111 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x712db520> 06 12/30/18 20:05:11.046 Device_Variable::m_szValue_set device: 282 service: urn:rfxcom-com:serviceId:rfxtrx1 variable: LastReceivedMsg was: 0A 52 01 01 76 02 00 C0 2D 00 79 now: 08 50 02 01 89 04 00 33 59 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x70edb520> 06 12/30/18 20:05:11.053 Device_Variable::m_szValue_set device: 455 service: urn:micasaverde-com:serviceId:HaDevice1 variable: BatteryDate was: 1546196668 now: 1546196711 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x70edb520> 06 12/30/18 20:05:17.015 Device_Variable::m_szValue_set device: 40 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 13:07:51 now: 13:07:57 #hooks: 0 upnp: 0 skip: 0 v:0x112a850/NONE duplicate:0