MutexImpl::Unlock error 0 (1)

Topics (not sure which fora)
when not sure where to post, post here and mods will move it to right forum.

Moderators: leecollings, remb0

Post Reply
User avatar
Egregius
Posts: 2592
Joined: Thursday 09 April 2015 12:19
Target OS: Linux
Domoticz version: v2024.7
Location: Beitem, BE
Contact:

MutexImpl::Unlock error 0 (1)

Post by Egregius »

Hi all,

since severall days domoticz crashes on my Syno.
I'm running 3.5031, don't know for sure that the latest update caused this.
Because the logfile is cleared upon start of Domoticz I had to create a script to copy it to another location so I could look why the crash appears.
After each crash the logfile ends with this line:

Code: Select all

MutexImpl::Unlock error 0 (1)
I guess the only change I made was including a Fibaro Wall plug for some power measurement of a new device at home.

Another strange thing I notice is that each line that cames from Openzwave starts with strange brackets:

Code: Select all

[39m[39m[39m[39m[39m[39m[39m[39m[39m[32m2016-04-05 11:27:24.908 Always, 

Last 10 minutes of the log:

Code: Select all

2016-04-05 11:25:00.277  (ZWAVE) Usage (wasbakkookplaat2)
2016-04-05 11:25:00.278  (ZWAVE) General/kWh (Kwasbakkookplaat)
2016-04-05 11:25:02.802  (ZWAVE) General/kWh (Kwasbakkookplaat)
2016-04-05 11:25:02.866  (ZWAVE) Usage (wasbakkookplaat2)
2016-04-05 11:25:02.867  (ZWAVE) General/kWh (Kwasbakkookplaat)
2016-04-05 11:25:02.968  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:25:03.060  (ZWAVE) Usage (wasbak2)
2016-04-05 11:25:03.061  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:25:03.161  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:25:03.254  (ZWAVE) Usage (kookplaat2)
2016-04-05 11:25:03.264  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:25:06.310  (ZWAVE) Thermostat (kamerZ)
2016-04-05 11:25:09.471  (ZWAVE) Usage (garageterras)
2016-04-05 11:25:09.473  (ZWAVE) General/kWh (Kgarageterras)
2016-04-05 11:25:10.180  (ZWAVE) Thermostat (alexZ)
2016-04-05 11:25:20.983  (ZWAVE) Thermostat (livingZ)
2016-04-05 11:25:26.373  (RFXCOM) Lighting 2 (pirlivingR)
2016-04-05 11:25:26.940  Executing script: /volume1/web/secure/cron.sh
OPT =
2016-04-05 11:25:29.568  (ZWAVE) Usage (werkbladtuin2)
2016-04-05 11:25:29.569  (ZWAVE) General/kWh (Kwerkbladtuin)
2016-04-05 11:25:29.909  (ZWAVE) Light/Switch (pirliving)
2016-04-05 11:25:29.954  Executing script: /volume1/web/secure/cron.sh
OPT =
2016-04-05 11:25:33.844  (ZWAVE) Light/Switch (pirkeuken)
2016-04-05 11:25:33.967  Executing script: /volume1/web/secure/cron.sh
OPT =
2016-04-05 11:26:04.925  (ZWAVE) Usage (hallzolder)
2016-04-05 11:26:04.927  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:26:34.246  (ZWAVE) Light/Switch (pirkeuken)
2016-04-05 11:26:39.445  (ZWAVE) Thermostat (badkamerZ)
2016-04-05 11:27:02.495  User: Admin initiated a switch command
2016-04-05 11:27:02.495  (RFXCOM) Lighting 2 (pirlivingR)
2016-04-05 11:27:03.724  (ZWAVE) General/kWh (Kinkomvoordeur)
2016-04-05 11:27:03.788  (ZWAVE) Usage (inkomvoordeur2)
2016-04-05 11:27:03.789  (ZWAVE) General/kWh (Kinkomvoordeur)
2016-04-05 11:27:03.889  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:27:03.982  (ZWAVE) Usage (inkom2)
2016-04-05 11:27:03.983  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:27:04.083  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:27:04.175  (ZWAVE) Usage (voordeur2)
2016-04-05 11:27:04.176  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:27:04.815  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:27:04.905  (ZWAVE) Usage (alex Power Meter)
2016-04-05 11:27:04.907  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:27:13.201  (ZWAVE) Light/Switch (pirkeuken)
2016-04-05 11:27:13.354  (ZWAVE) Light/Switch (pirgarage)
2016-04-05 11:27:14.087  Executing script: /volume1/web/secure/cron.sh
OPT =
[31m2016-04-05 11:27:14.905 Error, Node089, ERROR: Dropping command, expected response not received after 1 attempt(s)
[39m[32m2016-04-05 11:27:14.905 Always, 
[39m[32m2016-04-05 11:27:14.905 Always, Dumping queued log messages
[39m[32m2016-04-05 11:27:14.905 Always, 
[39m[39m[39m[39m[39m[39m[39m[39m[39m[32m2016-04-05 11:27:14.905 Always, 
[39m[32m2016-04-05 11:27:14.906 Always, End of queued log message dump
[39m[32m2016-04-05 11:27:14.906 Always, 
[39m2016-04-05 11:27:14.906  OpenZWave: Received timeout notification from HomeID: 25487143, NodeID: 89 (0x59)
2016-04-05 11:27:16.101  Executing script: /volume1/web/secure/cron.sh
OPT =
[31m2016-04-05 11:27:24.908 Error, Node089, ERROR: Dropping command, expected response not received after 1 attempt(s)
[39m[32m2016-04-05 11:27:24.908 Always, 
[39m[32m2016-04-05 11:27:24.908 Always, Dumping queued log messages
[39m[32m2016-04-05 11:27:24.908 Always, 
[39m[39m[39m[39m[39m[39m[39m[39m[39m[32m2016-04-05 11:27:24.908 Always, 
[39m[32m2016-04-05 11:27:24.909 Always, End of queued log message dump
[39m[32m2016-04-05 11:27:24.909 Always, 
[39m2016-04-05 11:27:24.909  OpenZWave: Received timeout notification from HomeID: 25487143, NodeID: 89 (0x59)
2016-04-05 11:27:40.679  (ZWAVE) Thermostat (livingZZ)
2016-04-05 11:27:41.674  (ZWAVE) Thermostat (livingZE)
2016-04-05 11:28:03.280  (ZWAVE) Thermostat (kamerZ)
2016-04-05 11:28:05.205  (ZWAVE) Thermostat (alexZ)
2016-04-05 11:28:05.579  (ZWAVE) Temp (alex)
2016-04-05 11:28:10.080  (ZWAVE) Light/Switch (pirliving)
2016-04-05 11:28:14.081  (ZWAVE) Light/Switch (pirkeuken)
2016-04-05 11:28:17.083  (ZWAVE) Thermostat (livingZ)
2016-04-05 11:28:18.438  (RFXCOM) Lighting 2 (pirlivingR)
2016-04-05 11:28:31.964  (ZWAVE) Light/Switch (pirgarage)
2016-04-05 11:28:33.261  (RFXCOM) Lighting 2 (poort)
2016-04-05 11:28:33.805  (RFXCOM) Lighting 2 (poort)
2016-04-05 11:28:34.194  Executing script: /volume1/web/secure/cron.sh
OPT =
2016-04-05 11:28:36.207  Executing script: /volume1/web/secure/cron.sh
OPT =
2016-04-05 11:28:36.346  (ZWAVE) Light/Switch (pirgarage)
2016-04-05 11:28:39.219  Executing script: /volume1/web/secure/cron.sh
OPT =
2016-04-05 11:28:44.991  (ZWAVE) Usage (lichtbadkamerB)
2016-04-05 11:28:44.992  (ZWAVE) General/kWh (Klichtbadkamer)
2016-04-05 11:29:03.600  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:29:03.719  (ZWAVE) Usage (hallzolder)
2016-04-05 11:29:03.720  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:29:03.874  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:29:04.022  (ZWAVE) Usage (hall)
2016-04-05 11:29:04.024  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:29:04.179  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:29:04.327  (ZWAVE) Usage (zolder)
2016-04-05 11:29:04.338  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:29:06.269  Sending SetPoint to device....
2016-04-05 11:29:28.963  (ZWAVE) Usage (inkomvoordeur2)
2016-04-05 11:29:28.964  (ZWAVE) General/kWh (Kinkomvoordeur)
2016-04-05 11:29:33.458  (ZWAVE) Thermostat (badkamerZ)
2016-04-05 11:29:37.108  (ZWAVE) Light/Switch (pirgarage)
2016-04-05 11:29:48.444  (ZWAVE) Light/Switch (pirgarage)
2016-04-05 11:29:49.309  Executing script: /volume1/web/secure/cron.sh
OPT =
2016-04-05 11:29:53.134  (ZWAVE) Temp (badkamer)
2016-04-05 11:29:57.976  (ZWAVE) Usage (keukenzolderg2)
2016-04-05 11:29:57.977  (ZWAVE) General/kWh (Kkeukenzolderg)
2016-04-05 11:29:58.627  (RFXCOM) Lighting 2 (poort)
2016-04-05 11:30:01.930  (ZWAVE) Usage (wasbakkookplaat2)
2016-04-05 11:30:01.931  (ZWAVE) General/kWh (Kwasbakkookplaat)
2016-04-05 11:30:02.934  (ZWAVE) General/kWh (Kkeukenzolderg)
2016-04-05 11:30:02.998  (ZWAVE) Usage (keukenzolderg2)
2016-04-05 11:30:02.999  (ZWAVE) General/kWh (Kkeukenzolderg)
2016-04-05 11:30:03.099  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:30:03.192  (ZWAVE) Usage (keuken2)
2016-04-05 11:30:03.193  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:30:03.292  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:30:03.385  (ZWAVE) Usage (zolderg2)
2016-04-05 11:30:03.386  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:30:03.855  (ZWAVE) General/kWh (Kwerkbladtuin)
2016-04-05 11:30:03.919  (ZWAVE) Usage (werkbladtuin2)
2016-04-05 11:30:03.921  (ZWAVE) General/kWh (Kwerkbladtuin)
2016-04-05 11:30:04.021  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:30:04.113  (ZWAVE) Usage (werkblad2)
2016-04-05 11:30:04.114  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:30:04.214  (ZWAVE) General/kWh (Ktuin)
2016-04-05 11:30:04.307  (ZWAVE) Usage (tuin2)
2016-04-05 11:30:04.319  (ZWAVE) General/kWh (Ktuin)
2016-04-05 11:30:10.984  (ZWAVE) Usage (garageterras)
2016-04-05 11:30:10.985  (ZWAVE) General/kWh (Kgarageterras)
2016-04-05 11:30:30.410  (ZWAVE) Usage (werkbladtuin2)
2016-04-05 11:30:30.412  (ZWAVE) General/kWh (Kwerkbladtuin)
2016-04-05 11:30:37.900  (ZWAVE) Thermostat (livingZZ)
2016-04-05 11:30:38.785  (ZWAVE) Thermostat (livingZE)
2016-04-05 11:30:49.257  (ZWAVE) Light/Switch (pirgarage)
2016-04-05 11:31:00.233  (ZWAVE) Thermostat (alexZ)
2016-04-05 11:31:00.283  (ZWAVE) Thermostat (kamerZ)
2016-04-05 11:31:00.572  (ZWAVE) Thermostat (alexZ)
2016-04-05 11:31:03.111  (ZWAVE) General/kWh (Klichtbadkamer)
2016-04-05 11:31:03.174  (ZWAVE) Usage (lichtbadkamerB)
2016-04-05 11:31:03.176  (ZWAVE) General/kWh (Klichtbadkamer)
2016-04-05 11:31:03.276  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:31:03.368  (ZWAVE) Usage (lichtbadkamer1B)
2016-04-05 11:31:03.369  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:31:03.469  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:31:03.561  (ZWAVE) Usage (lichtbadkamer2B)
2016-04-05 11:31:03.563  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:31:04.029  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:31:04.197  (ZWAVE) Usage (zoldertrap2)
2016-04-05 11:31:04.208  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:31:06.489  (ZWAVE) Usage (hallzolder)
2016-04-05 11:31:06.490  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:31:13.187  (ZWAVE) Thermostat (livingZ)
2016-04-05 11:32:03.357  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:32:03.421  (ZWAVE) Usage (zithoek)
2016-04-05 11:32:03.431  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:32:27.497  (ZWAVE) Thermostat (badkamerZ)
2016-04-05 11:33:02.982  (ZWAVE) General/kWh (Kmedia_unused)
2016-04-05 11:33:03.016  (ZWAVE) Usage (media_unused)
2016-04-05 11:33:03.017  (ZWAVE) General/kWh (Kmedia_unused)
2016-04-05 11:33:03.052  (ZWAVE) General/kWh (Ktv)
2016-04-05 11:33:03.088  (ZWAVE) Usage (tv2)
2016-04-05 11:33:03.090  (ZWAVE) General/kWh (Ktv)
2016-04-05 11:33:03.124  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:03.161  (ZWAVE) Usage (kristal2)
2016-04-05 11:33:03.162  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:03.197  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:03.239  (ZWAVE) Usage (tvled2)
2016-04-05 11:33:03.240  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:03.275  (ZWAVE) General/kWh (Ksubwoofer)
2016-04-05 11:33:03.311  (ZWAVE) Usage (subwoofer2)
2016-04-05 11:33:03.312  (ZWAVE) General/kWh (Ksubwoofer)
2016-04-05 11:33:03.347  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:03.383  (ZWAVE) Usage (kodi2)
2016-04-05 11:33:03.384  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:03.419  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:03.455  (ZWAVE) Usage (bureel)
2016-04-05 11:33:03.456  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:03.931  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:03.995  (ZWAVE) Usage (tobi2)
2016-04-05 11:33:03.997  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:33:04.448  (ZWAVE) General/Thermostat Mode (brander)
2016-04-05 11:33:35.120  (ZWAVE) Thermostat (livingZZ)
2016-04-05 11:33:35.997  (ZWAVE) Thermostat (livingZE)
2016-04-05 11:33:45.741  (ZWAVE) Usage (lichtbadkamerB)
2016-04-05 11:33:45.743  (ZWAVE) General/kWh (Klichtbadkamer)
2016-04-05 11:33:55.249  (ZWAVE) Thermostat (alexZ)
2016-04-05 11:33:57.272  (ZWAVE) Thermostat (kamerZ)
2016-04-05 11:34:09.454  (ZWAVE) Thermostat (livingZ)
2016-04-05 11:34:30.060  (ZWAVE) Usage (inkomvoordeur2)
2016-04-05 11:34:30.061  (ZWAVE) General/kWh (Kinkomvoordeur)
2016-04-05 11:34:59.358  (ZWAVE) Usage (keukenzolderg2)
2016-04-05 11:34:59.359  (ZWAVE) General/kWh (Kkeukenzolderg)
2016-04-05 11:35:03.212  (ZWAVE) General/kWh (Kgarageterras)
2016-04-05 11:35:03.275  (ZWAVE) Usage (garageterras)
2016-04-05 11:35:03.276  (ZWAVE) General/kWh (Kgarageterras)
2016-04-05 11:35:03.377  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:35:03.469  (ZWAVE) Usage (garage2)
2016-04-05 11:35:03.470  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:35:03.570  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:35:03.609  (ZWAVE) Usage (wasbakkookplaat2)
2016-04-05 11:35:03.611  (ZWAVE) General/kWh (Kwasbakkookplaat)
2016-04-05 11:35:03.663  (ZWAVE) Usage (terras2)
2016-04-05 11:35:03.673  (ZWAVE) General/kWh (kWh Meter)
2016-04-05 11:35:12.667  (ZWAVE) Usage (garageterras)
2016-04-05 11:35:12.668  (ZWAVE) General/kWh (Kgarageterras)
2016-04-05 11:35:21.488  (ZWAVE) Thermostat (badkamerZ)
2016-04-05 11:35:30.875  (ZWAVE) Usage (werkbladtuin2)
2016-04-05 11:35:30.876  (ZWAVE) General/kWh (Kwerkbladtuin)
MutexImpl::Unlock error 0 (1)
For what I can find the Mutex is used so some things don't happen simultaneously, but then, what can cause the unlock error?
User avatar
Egregius
Posts: 2592
Joined: Thursday 09 April 2015 12:19
Target OS: Linux
Domoticz version: v2024.7
Location: Beitem, BE
Contact:

Re: MutexImpl::Unlock error 0 (1)

Post by Egregius »

In the mean time had several beta versions, now on 3.5052
Stops still accur randomly. Luckely not to often, like 1 or 2 times a day.
User avatar
Egregius
Posts: 2592
Joined: Thursday 09 April 2015 12:19
Target OS: Linux
Domoticz version: v2024.7
Location: Beitem, BE
Contact:

Re: MutexImpl::Unlock error 0 (1)

Post by Egregius »

On version V3.5072 with Aeon firmware 3.08 Domoticz has stayed online for 12 days.
Yesterday updated to V3.5096 and guess what? The Mutex error and crash is there again.
Will see if it happens again, if so I'll downgrade to 3.5072 and stay there for a while.
User avatar
gizmocuz
Posts: 2712
Joined: Thursday 11 July 2013 18:59
Target OS: Raspberry Pi / ODroid
Domoticz version: beta
Location: Top of the world
Contact:

Re: MutexImpl::Unlock error 0 (1)

Post by gizmocuz »

I can not find any log message in domoticz with a text like 'MutexImpl'
If you find something, please post a fix/issue on github, found this thread by accident
best to report code related issues on github
Quality outlives Quantity!
User avatar
Egregius
Posts: 2592
Joined: Thursday 09 April 2015 12:19
Target OS: Linux
Domoticz version: v2024.7
Location: Beitem, BE
Contact:

Re: MutexImpl::Unlock error 0 (1)

Post by Egregius »

I can't say much about it. Some weeks ago Domoticz crashed daily on my Syno. For that reason I created a script that copies the logfile and restarts Domoticz automatically.
In each copy of the logfile the last line is "MutexImpl::Unlock error 0 (1)" without a timestamp in front of it.
Now it's online for 29 hours, don't know for how long, don't know why it crashed. I don't see a pattern in it.
Post Reply

Who is online

Users browsing this forum: No registered users and 1 guest