amg0 / ALTUI

Enhancement Interface for VERA home automation system
16 stars 8 forks source link

Workflow doesn't work since last commit (attempt to index field 'text' (a nil value)) #42

Open RHCPNG opened 2 years ago

RHCPNG commented 2 years ago

Hi,

I have only one workflow running, but it stopped working after the last commit. See here my log:

2022-03-19 10:10:58.106 luup.call_action:: 3.urn:upnp-org:serviceId:altui1.ResetWorkflow 2022-03-19 10:10:58.107 openLuup.server:: request completed (66 bytes, 1 chunks, 0 ms) tcp{client}: 0x563d740327a8 2022-03-19 10:10:58.107 luup_log:3: ALTUI: Wkflow - resetWorkflow(3,0-3) 2022-03-19 10:10:58.107 luup.variable_set:: 3.urn:upnp-org:serviceId:altui1.Timers was: [] now: [] #hooks:0 2022-03-19 10:10:58.107 luup_log:3: ALTUI: Wkflow - Workflow: 0-3, Valid Transition found:Reset to Start, Active State:*=>Start 2022-03-19 10:10:58.107 luup.variable_set:: 3.urn:upnp-org:serviceId:altui1.WorkflowsActiveState was: {"0-4":"7e9a2fb8-ccc3-4518-abce-ab7102d5a891","0-3":"24b63b42-ce96-4b07-a07e-9e5ee810e225","0-1":"36aa9e9b-1402-4ca... now: {"0-4":"7e9a2fb8-ccc3-4518-abce-ab7102d5a891","0-3":"24b63b42-ce96-4b07-a07e-9e5ee810e225","0-1":"36aa9e9b-1402-4ca... #hooks:0 2022-03-19 10:10:58.109 openLuup.context_switch:: ERROR: [dev #3] [string "L_ALTUI.lua"]:1398: attempt to index field 'text' (a nil value) 2022-03-19 10:10:58.109 openLuup.scheduler:: job aborted : [string "L_ALTUI.lua"]:1398: attempt to index field 'text' (a nil value) 2022-03-19 10:10:58.519 openLuup.server:: request completed (137778 bytes, 9 chunks, 633 ms) tcp{client}: 0x563d7357a918 2022-03-19 10:10:58.683 openLuup.server:: GET /data_request?id=lu_status2&output_format=json&DataVersion=680842243&Timeout=60&MinimumDelay=1500&_=1647681046531 HTTP/1.1 tcp{client}: 0x563d7357a918 2022-03-19 10:10:58.755 openLuup.server:: GET /data_request?id=lu_status2&output_format=json&DataVersion=680842240&Timeout=60&MinimumDelay=1500&_=1647680835927 HTTP/1.1 tcp{client}: 0x563d740327a8 2022-03-19 10:10:58.863 openLuup.server:: request completed (137778 bytes, 9 chunks, 108 ms) tcp{client}: 0x563d740327a8 2022-03-19 10:10:59.756 openLuup.server:: GET /data_request?id=lu_status2&output_format=json&DataVersion=680842243&Timeout=60&MinimumDelay=1500&_=1647680835928 HTTP/1.1 tcp{client}: 0x563d740327a8 2022-03-19 10:10:59.872 openLuup.server:: GET /data_request?id=lr_ALTUI_Handler&command=getWorkflowsStatus&_=1647681046532 HTTP/1.1 tcp{client}: 0x563d734da568 2022-03-19 10:10:59.973 openLuup.server:: request completed (195 bytes, 1 chunks, 101 ms) tcp{client}: 0x563d734da568 2022-03-19 10:11:00.022 openLuup.server:: GET /data_request?id=lr_ALTUI_Handler&command=oscommand&oscommand=cat%20%2Fvar%2Flog%2Fcmh%2FLuaUPnP.log%20%7C%20grep%20-E%20%27%5B0123456789%5D%3A%20ALTUI%3A%20Wkflow%20-%20Workflow%3A%200-3%2C%20Valid%20Transition%20found%27&_=1647681046533 HTTP/1.1 tcp{client}: 0x563d734da568 2022-03-19 10:11:00.130 openLuup.server:: request completed (132 bytes, 1 chunks, 107 ms) tcp{client}: 0x563d734da568 2022-03-19 10:11:00.231 luup.variable_set:: 47.urn:rboer-com:serviceId:SolarMeter1.AppMemoryUsed was: 32723 now: 24763 #hooks:0 2022-03-19 10:11:00.765 openLuup.server:: request completed (25809 bytes, 2 chunks, 2082 ms) tcp{client}: 0x563d7357a918 2022-03-19 10:11:00.769 openLuup.server:: request completed (25809 bytes, 2 chunks, 1012 ms) tcp{client}: 0x563d740327a8 2022-03-19 10:11:00.875 openLuup.server:: GET /data_request?id=lu_status2&output_format=json&DataVersion=680842244&Timeout=60&MinimumDelay=1500&_=1647681046534 HTTP/1.1 tcp{client}: 0x563d740327a8 2022-03-19 10:11:01.525 openLuup.io.server:: HTTP:3480 connection closed openLuup.server.receive closed tcp{client}: 0x563d734da568 2022-03-19 10:11:01.525 openLuup.io.server:: HTTP:3480 connection closed openLuup.server.receive closed tcp{client}: 0x563d7357a918 2022-03-19 10:11:01.630 openLuup.io.server:: HTTP:3480 connection from 192.168.1.174 tcp{client}: 0x563d73de2728 2022-03-19 10:11:01.630 openLuup.server:: GET /data_request?id=lu_status2&output_format=json&DataVersion=680842244&Timeout=60&MinimumDelay=1500&_=1647680835929 HTTP/1.1 tcp{client}: 0x563d73de2728 2022-03-19 10:11:03.752 openLuup.io.server:: HTTP:3480 connection from 192.168.1.174 tcp{client}: 0x563d735e5b98 2022-03-19 10:11:03.752 openLuup.server:: GET /data_request?id=lr_ALTUI_Handler&command=getWorkflowsStatus&_=1647681046535 HTTP/1.1 tcp{client}: 0x563d735e5b98 2022-03-19 10:11:03.853 openLuup.server:: request completed (195 bytes, 1 chunks, 101 ms) tcp{client}: 0x563d735e5b98 2022-03-19 10:11:03.895 openLuup.server:: GET /data_request?id=lr_ALTUI_Handler&command=oscommand&oscommand=cat%20%2Fvar%2Flog%2Fcmh%2FLuaUPnP.log%20%7C%20grep%20-E%20%27%5B0123456789%5D%3A%20ALTUI%3A%20Wkflow%20-%20Workflow%3A%200-3%2C%20Valid%20Transition%20found%27&_=1647681046536 HTTP/1.1 tcp{client}: 0x563d735e5b98 2022-03-19 10:11:04.002 openLuup.server:: request completed (132 bytes, 1 chunks, 107 ms) tcp{client}: 0x563d735e5b98 2022-03-19 10:11:06.409 openLuup.server:: GET /console?page=log HTTP/1.1 tcp{client}: 0x563d735e5b98

This is after I do a reset of the workflow (as you can see from the log).

Can you please check what's going wrong?

amg0 commented 2 years ago

please send me private mail with your actual version of ALTUI ( bottom of the page) , the logs after you put ALTUI in DEBUG mode and reloaded luup. Apparently you are using openluup. and the problem is around openLuup.context_switch:: ERROR: [dev #3] [string "L_ALTUI.lua"]:1398: attempt to index field 'text' (a nil value) 2022-03-19 10:10:58.109 openLuup.scheduler:: job aborted : [string "L_ALTUI.lua"]:1398: attempt to index field 'text' (a nil value)

RHCPNG commented 2 years ago

Sent via the Ezlo forum my logs. How the heck do you send a private message through github?