Binding Modbus 2.5.7. Stops working after unsuccessful read attempt

[BHall (Brian Hall)]

@ssalonen,

I ran the previous test overnight last night with the extra logging as before and it ran all night, it would still log changes in the register this morning and I did not notice any errors. The refresh was set for 1000 ms.

This morning, without shutting down openhab, I changed the refresh to 250 ms and it has ran since then and will still log changes in the register and I haven’t noticed any errors, repeatedly logging the HVAC_Temp_Last_Success message in the event log.

The purpose of all of this was to produce some errors in the logs that I could send but everything seems to run good when the logging is in place.

I guess I will try again later this evening with some of the extra logging removed and see what happens. The last time I tried running it without the extra logging it wasn’t long before it quit logging changes in the register.

It almost seems like when you keep it constantly busy everything works but when the extra logging is removed it goes back to not logging register changes for very long.

For what it’s worth, all openhab is currently doing is the reading and logging of the single Modbus register. I have held off on doing anything else with openhab until I could get this issue resolved.

Maybe I could turn the extra stuff off one item at a time and see if/when it quits again. I wouldn’t mind some logging being in place all the time if that would keep it working, but it seems like that should be unnecessary and I am using solid state drives and understand there is limit on total writes before the drive expires although that limit is probably a lot.

It seems to work very well except for this one issue.

I may be doing something very stupid here but I don’t know what it is. I feel very bad about wasting your time and the time of others that have tried to help. I have been reading a lot of posts in another thread where there was a lot of heated arguments back and forth over time wasted fooling with inexperienced users and I really don’t want to be one of those they are talking about.

I will proceed with what I mentioned unless you might have a better idea.

Thanks again!

[ssalonen]

Thanks @BHall for troubleshooting this

I am quite curious to get bottom of this so appreciate the help.

For what it’s worth, we have other user reporting similar behavior at Modbus stops without any errors so maybe there is something in the code that stops working.

[BHall (Brian Hall)]

@ssalonen,

Everything continued to work with the logging enabled until late last night.

I then issued the following commands:
openhab> log:set INFO org.openhab.io.transport.modbus
openhab> log:set INFO org.openhab.binding.modbus

This was the final entry in "openhab.log" since last night when I issued the last command changing from DEBUG to INFO.

2020-08-30 22:57:48.040 [INFO ] [port.EventAdminConfigurationNotifier] - Sending Event Admin nofification (configuration successful) to org/ops4j/pax/logging/Configuration

Timeline of some of my final activity in “events.log” on 8/30/2020:

The following “register change logged in events log” were the result of operating an input:
22:54 - register change logged in events log
22:59 - register change logged in events log
23:00 - register change logged in events log
23:01 - register change logged in events log
23:03 - register change logged in events log

The very last entry in “events.log” - Up until this point entries in the log were normal and regular:
23:26 - final entry in “events.log” - “HVAC_Temp_Last_Success”

As I mentioned before, not long after changing from DEBUG to INFO I stop getting entries in the events log. This appears to be a repeatable thing. I can repeat this test again tonight if you need me to.

I hope this information might be of some help.

[stfn82 (Stefan)]

I’m also affected by this problem. It started after the update to 2.5.7. I’m om 2.5.8 now, but the problem is still here.

The binding works for max. 24 hours and then just stops. Since I set the log level to DEBUG I no longer see an error message, which was there with the default logging settings (Will see if I can find it somewhere). Now it is just this:

2020-08-30 22:06:51.592 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_AC_VAR_SF channels updated: {modbus:data:SE7K:Registers:I_AC_VAR_SF:number=0}. readValueType=int16, readIndex=Optional[90], readSubIndex(or 0)=0, extractIndex=21 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.593 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_AC_PF channels updated: {modbus:data:SE7K:Registers:I_AC_PF:number=0}. readValueType=int16, readIndex=Optional[91], readSubIndex(or 0)=0, extractIndex=22 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.593 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_AC_PF_SF channels updated: {modbus:data:SE7K:Registers:I_AC_PF_SF:number=0}. readValueType=int16, readIndex=Optional[92], readSubIndex(or 0)=0, extractIndex=23 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.593 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_AC_Energy_WH channels updated: {modbus:data:SE7K:Registers:I_AC_Energy_WH:number=2094373}. readValueType=int32, readIndex=Optional[93], readSubIndex(or 0)=0, extractIndex=24 -> numeric value 2094373 and boolValue=true. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.593 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_AC_Energy_WH_SF channels updated: {modbus:data:SE7K:Registers:I_AC_Energy_WH_SF:number=0}. readValueType=uint16, readIndex=Optional[95], readSubIndex(or 0)=0, extractIndex=26 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.593 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_DC_Current channels updated: {modbus:data:SE7K:Registers:I_DC_Current:number=0}. readValueType=uint16, readIndex=Optional[96], readSubIndex(or 0)=0, extractIndex=27 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.594 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_DC_Current_SF channels updated: {modbus:data:SE7K:Registers:I_DC_Current_SF:number=0}. readValueType=int16, readIndex=Optional[97], readSubIndex(or 0)=0, extractIndex=28 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.594 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_DC_Voltage channels updated: {modbus:data:SE7K:Registers:I_DC_Voltage:number=0}. readValueType=uint16, readIndex=Optional[98], readSubIndex(or 0)=0, extractIndex=29 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.594 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_DC_Voltage_SF channels updated: {modbus:data:SE7K:Registers:I_DC_Voltage_SF:number=-1}. readValueType=int16, readIndex=Optional[99], readSubIndex(or 0)=0, extractIndex=30 -> numeric value -1 and boolValue=true. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.594 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_DC_Power channels updated: {modbus:data:SE7K:Registers:I_DC_Power:number=0}. readValueType=int16, readIndex=Optional[100], readSubIndex(or 0)=0, extractIndex=31 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.594 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_DC_Power_SF channels updated: {modbus:data:SE7K:Registers:I_DC_Power_SF:number=0}. readValueType=int16, readIndex=Optional[101], readSubIndex(or 0)=0, extractIndex=32 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.594 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_Temp_Sink channels updated: {modbus:data:SE7K:Registers:I_Temp_Sink:number=0}. readValueType=int16, readIndex=Optional[103], readSubIndex(or 0)=0, extractIndex=34 -> numeric value 0 and boolValue=false. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.595 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_Temp_SF channels updated: {modbus:data:SE7K:Registers:I_Temp_SF:number=-2}. readValueType=int16, readIndex=Optional[106], readSubIndex(or 0)=0, extractIndex=37 -> numeric value -2 and boolValue=true. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.595 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_Status channels updated: {modbus:data:SE7K:Registers:I_Status:number=2}. readValueType=uint16, readIndex=Optional[107], readSubIndex(or 0)=0, extractIndex=38 -> numeric value 2 and boolValue=true. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.595 [DEBUG] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:SE7K:Registers:I_Status_Vendor channels updated: {}. readValueType=uint16, readIndex=Optional[109], readSubIndex(or 0)=0, extractIndex=40 -> numeric value 65535 and boolValue=true. Registers ModbusRegisterArrayImpl(00 67 00 32 00 00 00 00 00 00 00 00 ff fe 10 25 10 27 10 2f 09 59 09 4d 09 58 ff ff 00 00 00 00 13 86 ff fe 00 00 00 00 00 00 00 00 00 00 00 00 00 1f f5 25 00 00 00 00 00 00 00 00 ff ff 00 00 00 00 80 00 00 00 80 00 80 00 ff fe 00 02 00 00 ff ff ff ff ff ff ff ff 00 00 00 00 ff ff ff ff ff ff ff ff) for request ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3]
2020-08-30 22:06:51.595 [DEBUG] [rt.modbus.internal.ModbusManagerImpl] - Modbus operation ended, timing info: {total: 65 ms, connection: 0, transaction=47, callback=18} [operation ID 860ea78f-6b1d-4b52-ba7c-7e7cd3282621]
2020-08-30 22:06:51.595 [DEBUG] [rt.modbus.internal.ModbusManagerImpl] - Execution of scheduled (5000ms) poll task BasicPollTask@298f7c24[request=ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3],endpoint=ModbusTCPSlaveEndpoint@1cf3e710[address=10.0.0.34,port=502],resultCallback=org.openhab.binding.modbus.handler.ModbusPollerThingHandler$ReadCallbackDelegator@79ce8f44,failureCallback=org.openhab.binding.modbus.handler.ModbusPollerThingHandler$ReadCallbackDelegator@79ce8f44] finished at 1598818011595. Was started at millis: 1598818011529 (=duration of 66 millis)
2020-08-30 22:06:56.867 [DEBUG] [rt.modbus.internal.ModbusManagerImpl] - Executing scheduled (5000ms) poll task BasicPollTask@298f7c24[request=ModbusPollerThingHandler.ModbusPollerReadRequest@686274eb[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=69,length=50,maxTries=3],endpoint=ModbusTCPSlaveEndpoint@1cf3e710[address=10.0.0.34,port=502],resultCallback=org.openhab.binding.modbus.handler.ModbusPollerThingHandler$ReadCallbackDelegator@79ce8f44,failureCallback=org.openhab.binding.modbus.handler.ModbusPollerThingHandler$ReadCallbackDelegator@79ce8f44]. Current millis: 1598818016863

My thing (SolarEDGE SE7K inverter):

Bridge modbus:tcp:SE7K [ host="10.0.0.34", port=502, id=1, timeBetweenTransactionsMillis=150, 
timeBetweenReconnectMillis=1000, connectMaxTries=3, reconnectAfterMillis=60000, connectTimeoutMillis=1000 ] {  //Tried this with many different settings as recommended in various modbus topics.

Bridge poller Registers [ start=69, length=50, refresh=5000, type="holding" ] {
  // Setting polling to 1000 ms sometimes led to strange values in I_AC_POWER

    //Thing data C_DeviceAddress   [ readStart="68", readValueType="uint16" ]        // MODBUS Unit ID
    Thing data C_SunSpec_DID     [ readStart="69", readValueType="uint16" ]        // 101 = single phase, 102 = split phase, 103 = three phase 
    Thing data C_SunSpec_Length  [ readStart="70", readValueType="uint16" ]        // 50 = Length of model block
    Thing data I_AC_Current      [ readStart="71", readValueType="uint16" ]        // AC Total Current value
    Thing data I_AC_CurrentA     [ readStart="72", readValueType="uint16" ]        // AC Phase A Current value
    Thing data I_AC_CurrentB     [ readStart="73", readValueType="uint16" ]        // AC Phase B Current value
    Thing data I_AC_CurrentC     [ readStart="74", readValueType="uint16" ]        // AC Phase C Current value
    Thing data I_AC_Current_SF   [ readStart="75", readValueType="int16"  ]        // AC Current scale factor
    Thing data I_AC_VoltageAB    [ readStart="76", readValueType="uint16" ]        // AC Voltage Phase AB value
    Thing data I_AC_VoltageBC    [ readStart="77", readValueType="uint16" ]        // AC Voltage Phase BC value
    Thing data I_AC_VoltageCA    [ readStart="78", readValueType="uint16" ]        // AC Voltage Phase CA value
    Thing data I_AC_VoltageAN    [ readStart="79", readValueType="uint16" ]        // AC Voltage Phase A to N value
    Thing data I_AC_VoltageBN    [ readStart="80", readValueType="uint16" ]        // AC Voltage Phase B to N value
    Thing data I_AC_VoltageCN    [ readStart="81", readValueType="uint16" ]        // AC Voltage Phase C to N value
    Thing data I_AC_Voltage_SF   [ readStart="82", readValueType="int16"  ]        // AC Voltage scale factor
    Thing data I_AC_Power        [ readStart="83", readValueType="int16"  ]        // AC Power value
    Thing data I_AC_Power_SF     [ readStart="84", readValueType="int16"  ]        // AC Power scale factor
    Thing data I_AC_Frequency    [ readStart="85", readValueType="uint16" ]        // AC Frequency value
    Thing data I_AC_Frequency_SF [ readStart="86", readValueType="int16"  ]        // Scale factor
    Thing data I_AC_VA           [ readStart="87", readValueType="int16"  ]        // Apparent Power
    Thing data I_AC_VA_SF        [ readStart="88", readValueType="int16"  ]        // Scale factor
    Thing data I_AC_VAR          [ readStart="89", readValueType="int16"  ]        // Reactive Power
    Thing data I_AC_VAR_SF       [ readStart="90", readValueType="int16"  ]        // Scale factor
    Thing data I_AC_PF           [ readStart="91", readValueType="int16"  ]        // Power Factor
    Thing data I_AC_PF_SF        [ readStart="92", readValueType="int16"  ]        // Scale factor
    Thing data I_AC_Energy_WH    [ readStart="93", readValueType="int32"  ]        // AC Lifetime Energy Production
    Thing data I_AC_Energy_WH_SF [ readStart="95", readValueType="uint16" ]        // Scale factor
    Thing data I_DC_Current      [ readStart="96", readValueType="uint16" ]        // DC Current value
    Thing data I_DC_Current_SF   [ readStart="97", readValueType="int16"  ]        // Scale factor
    Thing data I_DC_Voltage      [ readStart="98", readValueType="uint16" ]        // DC Voltage value
    Thing data I_DC_Voltage_SF   [ readStart="99", readValueType="int16"  ]        // Scale factor
    Thing data I_DC_Power        [ readStart="100", readValueType="int16" ]        // DC Power value
    Thing data I_DC_Power_SF     [ readStart="101", readValueType="int16" ]        // Scale factor
    Thing data I_Temp_Sink       [ readStart="103", readValueType="int16" ]        // Heat sink temperature
    Thing data I_Temp_SF         [ readStart="106", readValueType="int16" ]        // Scale factor
    Thing data I_Status          [ readStart="107", readValueType="uint16"]        // Operating state
    Thing data I_Status_Vendor   [ readStart="109", readValueType="uint16"]        //     Vendor-defined operating state and error codes

    }

}

Modbus binding:

300 │ Active │  80 │ 2.5.8                   │ org.openhab.binding.modbus
301 │ Active │  80 │ 2.5.8                   │ org.openhab.binding.modbus.sunspec
302 │ Active │  80 │ 2.5.8                   │ org.openhab.io.transport.modbus

Running on Ubuntu 20.04.1 (and before yesterday 18.04.5) in a LXC container on an Ubuntu 18.04.5 host.

I’ll delete the sunspec bundle for now, lets see if that makes any difference.

Edit: After changing something in my thing this error comes up, after which the binding starts to work. Still a NPE is not good I guess:

==> /var/log/openhab2/openhab.log <==2020-08-31 18:01:13.832 [INFO ]...

[ssalonen]

@stfn82

Edit: After changing something in my thing this error comes up, after which the binding starts to work. Still a NPE is not good I guess:

What do you mean? I do not see any NullPointerException (NPE).

@BHall I do not understand what you are trying to say with the log levels … Sounds you can reproduce the polling issue by changing log level? That’s great if that is the case – we can use that to troubleshoot it faster. I did not manage to do this myself with simple setup so there must be more to it.

Both @BHall & @stfn82: when the polling stops, please follow the advice set in this post

Modbus stops without any errors

Do you have full logs to send me please? how does the last success item update? Does it stop updating? how does the last error item update? Does it stop updating? Can you also execute the following two commands in karaf console when the polling stops threads --locks --monitors and threads The output of those commands should help to understand what the binding is doing.

i.e.

Please execute the following two commands in karaf console when the polling stops

threads --locks --monitors

and

threads

Looks like logs are not helping much at the moment… All I can say is that it looks that there is some sort of deadlock happening somewhere in the binding.

[stfn82 (Stefan)]

@ssalonen

What do you mean? I do not see any NullPointerException (NPE).

Sorry, I read to fast. Line 5 in the pastebin:

Error was: java.lang.InterruptedException null

Next time the polling stops I’ll run those 2 commands.

[BHall (Brian Hall)]

@ssalonen

@BHall I do not understand what you are trying to say with the log levels … Sounds you can reproduce the polling issue by changing log level? That’s great if that is the case – we can use that to troubleshoot it faster. I did not manage to do this myself with simple setup so there must be more to it.

I’m sorry I did not explain clearly, I will try again:

I did a clean install with the openhab stable 2.5.8 that you recommended and installed the modbus binding from the PaperUI.

Lately I have been using these prior instructions for testing:

@ssalonen

I suggest considering to update your openHAB and binding to stable 2.5.8, now that it is out. This also introduces some small logging fixes that are needed to diagnose traffic using DEBUG level.

You can reduce the amount of logging by

• lowering poll rate to 30 s
• simplifying your item configuration, leave only Number HVAC_Temp , DateTime HVAC_Temp_Last_Success and DateTime HVAC_Temp_Last_Error
• Simplify your things, remove diXX things and leave only the tcp , poller and data reg32768
• Setting log level to DEBUG instead of TRACE: log:set DEBUG org.openhab.io.transport.modbus and log:set DEBUG org.openhab.binding.modbus .

Let it run as long as needed, so it eventually stops working.

With logging set as above and poll rate of 30 sec everything worked well for hours.

I later tried setting poll rate of 1000 ms and everything continued to work well for hours.

Most recently I tried poll rate of 250 ms and once again everything continued to work well for hours.

I then issued the following commands to try without all the DEBUG entries.
openhab> log:set INFO org.openhab.io.transport.modbus
openhab> log:set INFO org.openhab.binding.modbus

After this change I operated a discrete input to cause the value of the register being read to change, and the change was reflected in the events log. I did this multiple times.

After a short period of time the event logging stopped completely, no
HVAC_Temp_Last_Success entries or entries when operating a discrete input to cause the value of the register being read to change.

I have found this to be repeatable,

@ssalonen

Please execute the following two commands in karaf console when the polling stops

I will try to reproduce the problem and execute the two commands you requested earlier.

Thanks!

[BHall (Brian Hall)]

@ssalonen,

Reproducing the issue did not take long.
Following is the result of the first command per your request:
The results of the second command will follow in another post.

openhab> threads --locks --monitors
"CM Configuration Updater" Id=28 in WAITING on lock=java.util.LinkedList@1c9f2b75
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:79)
    at java.lang.Thread.run(Thread.java:748)

"CM Event Dispatcher" Id=29 in WAITING on lock=java.util.LinkedList@5382a099
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:79)
    at java.lang.Thread.run(Thread.java:748)

"fileinstall-C:\openhab2/addons" Id=43 in TIMED_WAITING on lock=org.apache.felix.fileinstall.internal.DirectoryWatcher@2e8c2bcf
    at java.lang.Object.wait(Native Method)
    at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:320)

"encryption-1-thread-1" Id=54 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@29e665e1
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingDeque.pollFirst(LinkedBlockingDeque.java:522)
    at java.util.concurrent.LinkedBlockingDeque.poll(LinkedBlockingDeque.java:684)
    at sun.nio.fs.AbstractWatchService.poll(AbstractWatchService.java:108)
    at org.apache.karaf.jaas.modules.properties.AutoEncryptionSupport.run(AutoEncryptionSupport.java:94)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@690d00f8

"openHAB-job-scheduler_QuartzSchedulerThread" Id=120 in TIMED_WAITING on lock=java.lang.Object@27a8ac47
    at java.lang.Object.wait(Native Method)
    at org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:410)

"main" Id=1 in WAITING on lock=java.util.concurrent.atomic.AtomicReference@787675d4
    at java.lang.Object.wait(Native Method)
    at org.eclipse.osgi.container.SystemModule.waitForStop(SystemModule.java:168)
    at org.eclipse.osgi.internal.framework.EquinoxBundle$SystemBundle.waitForStop(EquinoxBundle.java:250)
    at org.eclipse.osgi.launch.Equinox.waitForStop(Equinox.java:181)
    at org.apache.karaf.main.Main.awaitShutdown(Main.java:661)
    at org.apache.karaf.main.Main.main(Main.java:188)

"Framework Event Dispatcher: org.eclipse.osgi.internal.framework.EquinoxEventPublisher@16150369" Id=14 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@5b4191be
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Bundle File Closer" Id=15 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@3ee0c194
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Start Level: Equinox Container: 6ca2d9d4-f86a-4fe1-9e2e-7fa6c540ee15" Id=16 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@23e72627
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Karaf Lock Monitor Thread" Id=17 in TIMED_WAITING
    at java.lang.Thread.sleep(Native Method)
    at org.apache.karaf.main.Main.doMonitor(Main.java:410)
    at org.apache.karaf.main.Main.access$100(Main.java:74)
    at org.apache.karaf.main.Main$3.run(Main.java:377)

"Karaf Shutdown Socket Thread" Id=18 in RUNNABLE (running in native)
    at java.net.DualStackPlainSocketImpl.accept0(Native Method)
    at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131)
    at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
    at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)
      - locked java.net.SocksSocketImpl@78203061
    at java.net.ServerSocket.implAccept(ServerSocket.java:562)
    at java.net.ServerSocket.accept(ServerSocket.java:530)
    at org.apache.karaf.main.ShutdownSocketThread.run(ShutdownSocketThread.java:66)

    Locked monitors: count = 1
      - java.net.SocksSocketImpl@78203061 locked at
          3 java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)

"fileinstall-C:\openhab2\userdata/etc" Id=32 in TIMED_WAITING on lock=org.apache.felix.fileinstall.internal.DirectoryWatcher@7b8aeb47
    at java.lang.Object.wait(Native Method)
    at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:320)

"WindowsStreamPump" Id=41 in RUNNABLE (running in native)
    at org.fusesource.jansi.internal.Kernel32.WaitForSingleObject(Native Method)
    at org.fusesource.jansi.internal.WindowsSupport.readConsoleInput(WindowsSupport.java:97)
    at org.jline.terminal.impl.jansi.win.JansiWinSysTerminal.processConsoleInput(JansiWinSysTerminal.java:112)
    at org.jline.terminal.impl.AbstractWindowsTerminal.pump(AbstractWindowsTerminal.java:458)
    at org.jline.terminal.impl.AbstractWindowsTerminal$$Lambda$36/1828489944.run(Unknown Source)
    at java.lang.Thread.run(Thread.java:748)

"Karaf local console user openhab" Id=45 in WAITING on lock=org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl@559b92dc
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl.start(CommandSessionImpl.java:802)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:300)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:169)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:149)
    at org.apache.felix.gogo.runtime.CommandSessionImpl.execute(CommandSessionImpl.java:179)
    at org.apache.karaf.shell.impl.console.ConsoleSessionImpl.doExecute(ConsoleSessionImpl.java:467)
    at org.apache.karaf.shell.impl.console.ConsoleSessionImpl.run(ConsoleSessionImpl.java:407)
    at java.lang.Thread.run(Thread.java:748)

"SCR Component Actor" Id=51 in WAITING on lock=java.util.LinkedList@7037f5a3
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.scr.impl.ComponentActorThread.run(ComponentActorThread.java:83)
    at java.lang.Thread.run(Thread.java:748)

"encryption-3-thread-1" Id=58 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@245661e5
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingDeque.pollFirst(LinkedBlockingDeque.java:522)
    at java.util.concurrent.LinkedBlockingDeque.poll(LinkedBlockingDeque.java:684)
    at sun.nio.fs.AbstractWatchService.poll(AbstractWatchService.java:108)
    at org.apache.karaf.jaas.modules.properties.AutoEncryptionSupport.run(AutoEncryptionSupport.java:94)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@8e6490b

"EMF Reference Cleaner" Id=70 in WAITING on lock=java.lang.ref.ReferenceQueue$Lock@61a715f3
    at java.lang.Object.wait(Native Method)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
    at org.eclipse.emf.common.util.CommonUtil$1ReferenceClearingQueuePollingThread.run(CommonUtil.java:70)

"OH-OSGiEventManager" Id=71 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@2814b523
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467)
    at org.eclipse.smarthome.core.internal.events.ThreadedEventHandler.lambda$0(ThreadedEventHandler.java:60)
    at org.eclipse.smarthome.core.internal.events.ThreadedEventHandler$$Lambda$340/586337187.run(Unknown Source)
    at java.lang.Thread.run(Thread.java:748)

"qtp2109812754-77" Id=77 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@2e9090f0
      - locked java.util.Collections$UnmodifiableSet@7cc6a79d
      - locked sun.nio.ch.WindowsSelectorImpl@d14b11
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@2e9090f0 locked at 
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@7cc6a79d locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@d14b11 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"qtp2109812754-78" Id=78 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@51f07e89
      - locked java.util.Collections$UnmodifiableSet@23abe81c
      - locked sun.nio.ch.WindowsSelectorImpl@31e6638e
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@51f07e89 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@23abe81c locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@31e6638e locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"qtp2109812754-80-acceptor-0@5bfd5f8c-0.0.0.0:8443@f037769{SSL,[ssl, http/1.1]}{0.0.0.0:8443}" Id=80 in RUNNABLE (running in native)
    at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:419)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)
      - locked java.lang.Object@659ef827
    at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:385)
    at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:664)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 1
      - java.lang.Object@659ef827 locked at
          2 sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)

"qtp2109812754-81" Id=81 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@3d539cf6
      - locked java.util.Collections$UnmodifiableSet@4ecb64b2
      - locked sun.nio.ch.WindowsSelectorImpl@7c81d50e
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@3d539cf6 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@4ecb64b2 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@7c81d50e locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"qtp2109812754-82" Id=82 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@35c8d46a
      - locked java.util.Collections$UnmodifiableSet@5d3de8a5
      - locked sun.nio.ch.WindowsSelectorImpl@2be64c1d
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@35c8d46a locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@5d3de8a5 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@2be64c1d locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"qtp2109812754-83-acceptor-0@30785c11-default@41b769d2{HTTP/1.1,[http/1.1]}{0.0.0.0:8080}" Id=83 in RUNNABLE (running in native)
    at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:419)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)
      - locked java.lang.Object@31d4eef1
    at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:385)
    at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:664)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 1
      - java.lang.Object@31d4eef1 locked at
          2 sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)

"Dir Watcher" Id=90 in WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@1d7d7a0d
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
    at java.util.concurrent.LinkedBlockingDeque.takeFirst(LinkedBlockingDeque.java:492)
    at java.util.concurrent.LinkedBlockingDeque.take(LinkedBlockingDeque.java:680)
    at sun.nio.fs.AbstractWatchService.take(AbstractWatchService.java:118)
    at org.eclipse.smarthome.core.service.WatchQueueReader.run(WatchQueueReader.java:210)
    at java.lang.Thread.run(Thread.java:748)

"com.google.inject.internal.util.$Finalizer" Id=102 in WAITING on lock=java.lang.ref.ReferenceQueue$Lock@10d78a51
    at java.lang.Object.wait(Native Method)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
    at com.google.inject.internal.util.$Finalizer.run(Finalizer.java:114)

"openHAB-job-scheduler_Worker-1" Id=110 in TIMED_WAITING on lock=java.lang.Object@6bdeddb1
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-2" Id=111 in TIMED_WAITING on lock=java.lang.Object@137fada3
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-3" Id=112 in TIMED_WAITING on lock=java.lang.Object@60a7ff7a
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-4" Id=113 in TIMED_WAITING on lock=java.lang.Object@4e6861a4
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-5" Id=114 in TIMED_WAITING on lock=java.lang.Object@40071bd6
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-6" Id=115 in TIMED_WAITING on lock=java.lang.Object@62023538
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-7" Id=116 in TIMED_WAITING on lock=java.lang.Object@3c125e65
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-8" Id=117 in TIMED_WAITING on lock=java.lang.Object@5eba1b61
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-9" Id=118 in TIMED_WAITING on lock=java.lang.Object@70ca5dab
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-10" Id=119 in TIMED_WAITING on lock=java.lang.Object@301dda6d
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"lsp-1" Id=126 in RUNNABLE (running in native)
    at java.net.DualStackPlainSocketImpl.accept0(Native Method)
    at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131)
    at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
    at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)
      - locked java.net.SocksSocketImpl@a91bb79
    at java.net.ServerSocket.implAccept(ServerSocket.java:562)
    at java.net.ServerSocket.accept(ServerSocket.java:530)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer.listen(ModelServer.java:98)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer.lambda$0(ModelServer.java:77)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer$$Lambda$448/1295336421.run(Unknown Source)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@12d462ac

    Locked monitors: count = 1
      - java.net.SocksSocketImpl@a91bb79 locked at
          3 java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)

"ServletModel-12-133" Id=133 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@3b2960ca
      - locked java.util.Collections$UnmodifiableSet@10dc8051
      - locked sun.nio.ch.WindowsSelectorImpl@3efd6d6d
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@3b2960ca locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@10dc8051 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@3efd6d6d locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"ServletModel-12-134" Id=134 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-135" Id=135 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-136" Id=136 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-137" Id=137 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-138" Id=138 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-139" Id=139 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-140" Id=140 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@4136dbaf
      - locked java.util.Collections$UnmodifiableSet@2f5091d7
      - locked sun.nio.ch.WindowsSelectorImpl@40cdc857
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@4136dbaf locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@2f5091d7 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@40cdc857 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"OH-modbusManagerPollerThreadPool-2" Id=144 in WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4f041ed4
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
    at org.apache.commons.pool2.impl.LinkedBlockingDeque.takeFirst(LinkedBlockingDeque.java:587)
    at org.apache.commons.pool2.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:366)
    at org.apache.commons.pool2.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:281)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.borrowConnection(ModbusManagerImpl.java:380)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.lambda$3(ModbusManagerImpl.java:463)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$$Lambda$532/403166972.get(Unknown Source)
    at org.openhab.io.transport.modbus.internal.SimpleStopWatch.timeSupplier(SimpleStopWatch.java:118)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.getConnection(ModbusManagerImpl.java:463)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.executeOperation(ModbusManagerImpl.java:556)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.access$2(ModbusManagerImpl.java:525)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$ModbusCommunicationInterfaceImpl.lambda$1(ModbusManagerImpl.java:782)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$ModbusCommunicationInterfaceImpl$$Lambda$530/578027160.run(Unknown Source)        
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@782829b3

"SocketListener(JmDNS-/192.168.1.43)" Id=165 in RUNNABLE (running in native)
    at java.net.TwoStacksPlainDatagramSocketImpl.receive0(Native Method)
      - locked java.net.TwoStacksPlainDatagramSocketImpl@3086a3fc
    at java.net.TwoStacksPlainDatagramSocketImpl.receive(TwoStacksPlainDatagramSocketImpl.java:114)
      - locked java.net.TwoStacksPlainDatagramSocketImpl@3086a3fc
    at java.net.DatagramSocket.receive(DatagramSocket.java:812)
      - locked java.net.DatagramPacket@3137424d
      - locked java.net.MulticastSocket@2dd87a04
    at javax.jmdns.impl.SocketListener.run(SocketListener.java:41)

    Locked monitors: count = 4
      - java.net.TwoStacksPlainDatagramSocketImpl@3086a3fc locked at
          0 java.net.TwoStacksPlainDatagramSocketImpl.receive0(Native Method)
      - java.net.TwoStacksPlainDatagramSocketImpl@3086a3fc locked at
          1 java.net.TwoStacksPlainDatagramSocketImpl.receive(TwoStacksPlainDatagramSocketImpl.java:114)
      - java.net.DatagramPacket@3137424d locked at
          2 java.net.DatagramSocket.receive(DatagramSocket.java:812)
      - java.net.MulticastSocket@2dd87a04 locked at
          2 java.net.DatagramSocket.receive(DatagramSocket.java:812)

"job controller 1" Id=472 in WAITING on lock=java.util.concurrent.FutureTask@312cb1e5
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:429)
    at java.util.concurrent.FutureTask.get(FutureTask.java:191)
    at java.util.concurrent.AbstractExecutorService.invokeAll(AbstractExecutorService.java:244)
    at org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl.run(CommandSessionImpl.java:827)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@5f658561

"pipe-threads --locks --monitors" Id=473 in RUNNABLE
    at sun.management.ThreadImpl.dumpThreads0(Native Method)
    at sun.management.ThreadImpl.dumpAllThreads(ThreadImpl.java:454)
    at org.apache.karaf.shell.commands.impl.ThreadsAction.execute(ThreadsAction.java:78)
    at org.apache.karaf.shell.impl.action.command.ActionCommand.execute(ActionCommand.java:84)
    at org.apache.karaf.shell.impl.console.osgi.secured.SecuredCommand.execute(SecuredCommand.java:68)
    at org.apache.karaf.shell.impl.console.osgi.secured.SecuredCommand.execute(SecuredCommand.java:86)
    at org.apache.felix.gogo.runtime.Closure.executeCmd(Closure.java:599)
    at org.apache.felix.gogo.runtime.Closure.executeStatement(Closure.java:526)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:415)
    at org.apache.felix.gogo.runtime.Pipe.doCall(Pipe.java:416)
    at org.apache.felix.gogo.runtime.Pipe.call(Pipe.java:229)
    at org.apache.felix.gogo.runtime.Pipe.call(Pipe.java:59)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@6eec27cc

openhab> 

[BHall (Brian Hall)]

@ssalonen,
Following is the result of the second command per your request:
I had a little issue so if the results from either of the commands does not look right let me know and I will repeat the test.

openhab> threads
"CM Configuration Updater" Id=28 in WAITING on lock=java.util.LinkedList@1c9f2b75
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:79)
    at java.lang.Thread.run(Thread.java:748)

"CM Event Dispatcher" Id=29 in WAITING on lock=java.util.LinkedList@5382a099
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:79)
    at java.lang.Thread.run(Thread.java:748)

"fileinstall-C:\openhab2/addons" Id=43 in TIMED_WAITING on lock=org.apache.felix.fileinstall.internal.DirectoryWatcher@2e8c2bcf
    at java.lang.Object.wait(Native Method)
    at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:320)

"encryption-1-thread-1" Id=54 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@29e665e1
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingDeque.pollFirst(LinkedBlockingDeque.java:522)
    at java.util.concurrent.LinkedBlockingDeque.poll(LinkedBlockingDeque.java:684)
    at sun.nio.fs.AbstractWatchService.poll(AbstractWatchService.java:108)
    at org.apache.karaf.jaas.modules.properties.AutoEncryptionSupport.run(AutoEncryptionSupport.java:94)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"openHAB-job-scheduler_QuartzSchedulerThread" Id=120 in TIMED_WAITING on lock=java.lang.Object@27a8ac47
    at java.lang.Object.wait(Native Method)
    at org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:410)

"main" Id=1 in WAITING on lock=java.util.concurrent.atomic.AtomicReference@787675d4
    at java.lang.Object.wait(Native Method)
    at org.eclipse.osgi.container.SystemModule.waitForStop(SystemModule.java:168)
    at org.eclipse.osgi.internal.framework.EquinoxBundle$SystemBundle.waitForStop(EquinoxBundle.java:250)
    at org.eclipse.osgi.launch.Equinox.waitForStop(Equinox.java:181)
    at org.apache.karaf.main.Main.awaitShutdown(Main.java:661)
    at org.apache.karaf.main.Main.main(Main.java:188)

"Framework Event Dispatcher: org.eclipse.osgi.internal.framework.EquinoxEventPublisher@16150369" Id=14 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@5b4191be
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Bundle File Closer" Id=15 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@3ee0c194
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Start Level: Equinox Container: 6ca2d9d4-f86a-4fe1-9e2e-7fa6c540ee15" Id=16 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@23e72627
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Karaf Lock Monitor Thread" Id=17 in TIMED_WAITING
    at java.lang.Thread.sleep(Native Method)
    at org.apache.karaf.main.Main.doMonitor(Main.java:410)
    at org.apache.karaf.main.Main.access$100(Main.java:74)
    at org.apache.karaf.main.Main$3.run(Main.java:377)

"Karaf Shutdown Socket Thread" Id=18 in RUNNABLE (running in native)
    at java.net.DualStackPlainSocketImpl.accept0(Native Method)
    at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131)
    at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
    at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)
      - locked java.net.SocksSocketImpl@78203061
    at java.net.ServerSocket.implAccept(ServerSocket.java:562)
    at java.net.ServerSocket.accept(ServerSocket.java:530)
    at org.apache.karaf.main.ShutdownSocketThread.run(ShutdownSocketThread.java:66)

"fileinstall-C:\openhab2\userdata/etc" Id=32 in TIMED_WAITING on lock=org.apache.felix.fileinstall.internal.DirectoryWatcher@7b8aeb47
    at java.lang.Object.wait(Native Method)
    at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:320)

"WindowsStreamPump" Id=41 in RUNNABLE (running in native)
    at org.fusesource.jansi.internal.Kernel32.WaitForSingleObject(Native Method)
    at org.fusesource.jansi.internal.WindowsSupport.readConsoleInput(WindowsSupport.java:97)
    at org.jline.terminal.impl.jansi.win.JansiWinSysTerminal.processConsoleInput(JansiWinSysTerminal.java:112)
    at org.jline.terminal.impl.AbstractWindowsTerminal.pump(AbstractWindowsTerminal.java:458)
    at org.jline.terminal.impl.AbstractWindowsTerminal$$Lambda$36/1828489944.run(Unknown Source)
    at java.lang.Thread.run(Thread.java:748)

"Karaf local console user openhab" Id=45 in WAITING on lock=org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl@334c72b
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl.start(CommandSessionImpl.java:802)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:300)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:169)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:149)
    at org.apache.felix.gogo.runtime.CommandSessionImpl.execute(CommandSessionImpl.java:179)
    at org.apache.karaf.shell.impl.console.ConsoleSessionImpl.doExecute(ConsoleSessionImpl.java:467)
    at org.apache.karaf.shell.impl.console.ConsoleSessionImpl.run(ConsoleSessionImpl.java:407)
    at java.lang.Thread.run(Thread.java:748)

"SCR Component Actor" Id=51 in WAITING on lock=java.util.LinkedList@7037f5a3
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.scr.impl.ComponentActorThread.run(ComponentActorThread.java:83)
    at java.lang.Thread.run(Thread.java:748)

"encryption-3-thread-1" Id=58 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@245661e5
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingDeque.pollFirst(LinkedBlockingDeque.java:522)
    at java.util.concurrent.LinkedBlockingDeque.poll(LinkedBlockingDeque.java:684)
    at sun.nio.fs.AbstractWatchService.poll(AbstractWatchService.java:108)
    at org.apache.karaf.jaas.modules.properties.AutoEncryptionSupport.run(AutoEncryptionSupport.java:94)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"EMF Reference Cleaner" Id=70 in WAITING on lock=java.lang.ref.ReferenceQueue$Lock@61a715f3
    at java.lang.Object.wait(Native Method)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
    at org.eclipse.emf.common.util.CommonUtil$1ReferenceClearingQueuePollingThread.run(CommonUtil.java:70)

"OH-OSGiEventManager" Id=71 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@2814b523
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467)
    at org.eclipse.smarthome.core.internal.events.ThreadedEventHandler.lambda$0(ThreadedEventHandler.java:60)
    at org.eclipse.smarthome.core.internal.events.ThreadedEventHandler$$Lambda$340/586337187.run(Unknown Source)
    at java.lang.Thread.run(Thread.java:748)

"qtp2109812754-77" Id=77 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@2e9090f0
      - locked java.util.Collections$UnmodifiableSet@7cc6a79d
      - locked sun.nio.ch.WindowsSelectorImpl@d14b11
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp2109812754-78" Id=78 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@51f07e89
      - locked java.util.Collections$UnmodifiableSet@23abe81c
      - locked sun.nio.ch.WindowsSelectorImpl@31e6638e
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp2109812754-80-acceptor-0@5bfd5f8c-0.0.0.0:8443@f037769{SSL,[ssl, http/1.1]}{0.0.0.0:8443}" Id=80 in RUNNABLE (running in native)
    at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:419)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)
      - locked java.lang.Object@659ef827
    at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:385)
    at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:664)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp2109812754-81" Id=81 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@3d539cf6
      - locked java.util.Collections$UnmodifiableSet@4ecb64b2
      - locked sun.nio.ch.WindowsSelectorImpl@7c81d50e
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp2109812754-82" Id=82 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@35c8d46a
      - locked java.util.Collections$UnmodifiableSet@5d3de8a5
      - locked sun.nio.ch.WindowsSelectorImpl@2be64c1d
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp2109812754-83-acceptor-0@30785c11-default@41b769d2{HTTP/1.1,[http/1.1]}{0.0.0.0:8080}" Id=83 in RUNNABLE (running in native)
    at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:419)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)
      - locked java.lang.Object@31d4eef1
    at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:385)
    at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:664)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"Dir Watcher" Id=90 in WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@1d7d7a0d
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
    at java.util.concurrent.LinkedBlockingDeque.takeFirst(LinkedBlockingDeque.java:492)
    at java.util.concurrent.LinkedBlockingDeque.take(LinkedBlockingDeque.java:680)
    at sun.nio.fs.AbstractWatchService.take(AbstractWatchService.java:118)
    at org.eclipse.smarthome.core.service.WatchQueueReader.run(WatchQueueReader.java:210)
    at java.lang.Thread.run(Thread.java:748)

"com.google.inject.internal.util.$Finalizer" Id=102 in WAITING on lock=java.lang.ref.ReferenceQueue$Lock@10d78a51
    at java.lang.Object.wait(Native Method)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
    at com.google.inject.internal.util.$Finalizer.run(Finalizer.java:114)

"openHAB-job-scheduler_Worker-1" Id=110 in TIMED_WAITING on lock=java.lang.Object@6bdeddb1
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-2" Id=111 in TIMED_WAITING on lock=java.lang.Object@137fada3
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-3" Id=112 in TIMED_WAITING on lock=java.lang.Object@60a7ff7a
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-4" Id=113 in TIMED_WAITING on lock=java.lang.Object@4e6861a4
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-5" Id=114 in TIMED_WAITING on lock=java.lang.Object@40071bd6
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-6" Id=115 in TIMED_WAITING on lock=java.lang.Object@62023538
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-7" Id=116 in TIMED_WAITING on lock=java.lang.Object@3c125e65
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-8" Id=117 in TIMED_WAITING on lock=java.lang.Object@5eba1b61
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-9" Id=118 in TIMED_WAITING on lock=java.lang.Object@70ca5dab
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-10" Id=119 in TIMED_WAITING on lock=java.lang.Object@301dda6d
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"lsp-1" Id=126 in RUNNABLE (running in native)
    at java.net.DualStackPlainSocketImpl.accept0(Native Method)
    at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131)
    at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
    at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)
      - locked java.net.SocksSocketImpl@a91bb79
    at java.net.ServerSocket.implAccept(ServerSocket.java:562)
    at java.net.ServerSocket.accept(ServerSocket.java:530)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer.listen(ModelServer.java:98)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer.lambda$0(ModelServer.java:77)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer$$Lambda$448/1295336421.run(Unknown Source)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-133" Id=133 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@3b2960ca
      - locked java.util.Collections$UnmodifiableSet@10dc8051
      - locked sun.nio.ch.WindowsSelectorImpl@3efd6d6d
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-134" Id=134 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-135" Id=135 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-136" Id=136 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-137" Id=137 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-138" Id=138 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-139" Id=139 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4cb53150
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-140" Id=140 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@4136dbaf
      - locked java.util.Collections$UnmodifiableSet@2f5091d7
      - locked sun.nio.ch.WindowsSelectorImpl@40cdc857
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/1331947632.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"OH-modbusManagerPollerThreadPool-2" Id=144 in WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4f041ed4
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
    at org.apache.commons.pool2.impl.LinkedBlockingDeque.takeFirst(LinkedBlockingDeque.java:587)
    at org.apache.commons.pool2.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:366)
    at org.apache.commons.pool2.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:281)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.borrowConnection(ModbusManagerImpl.java:380)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.lambda$3(ModbusManagerImpl.java:463)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$$Lambda$532/403166972.get(Unknown Source)
    at org.openhab.io.transport.modbus.internal.SimpleStopWatch.timeSupplier(SimpleStopWatch.java:118)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.getConnection(ModbusManagerImpl.java:463)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.executeOperation(ModbusManagerImpl.java:556)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.access$2(ModbusManagerImpl.java:525)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$ModbusCommunicationInterfaceImpl.lambda$1(ModbusManagerImpl.java:782)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$ModbusCommunicationInterfaceImpl$$Lambda$530/578027160.run(Unknown Source)        
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"SocketListener(JmDNS-/192.168.1.43)" Id=165 in RUNNABLE (running in native)
    at java.net.TwoStacksPlainDatagramSocketImpl.receive0(Native Method)
      - locked java.net.TwoStacksPlainDatagramSocketImpl@3086a3fc
    at java.net.TwoStacksPlainDatagramSocketImpl.receive(TwoStacksPlainDatagramSocketImpl.java:114)
      - locked java.net.TwoStacksPlainDatagramSocketImpl@3086a3fc
    at java.net.DatagramSocket.receive(DatagramSocket.java:812)
      - locked java.net.DatagramPacket@3137424d
      - locked java.net.MulticastSocket@2dd87a04
    at javax.jmdns.impl.SocketListener.run(SocketListener.java:41)

"job controller 1" Id=544 in WAITING on lock=java.util.concurrent.FutureTask@7e58ad81
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:429)
    at java.util.concurrent.FutureTask.get(FutureTask.java:191)
    at java.util.concurrent.AbstractExecutorService.invokeAll(AbstractExecutorService.java:244)
    at org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl.run(CommandSessionImpl.java:827)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"pipe-threads" Id=545 in RUNNABLE
    at sun.management.ThreadImpl.dumpThreads0(Native Method)
    at sun.management.ThreadImpl.dumpAllThreads(ThreadImpl.java:454)
    at org.apache.karaf.shell.commands.impl.ThreadsAction.execute(ThreadsAction.java:78)
    at org.apache.karaf.shell.impl.action.command.ActionCommand.execute(ActionCommand.java:84)
    at org.apache.karaf.shell.impl.console.osgi.secured.SecuredCommand.execute(SecuredCommand.java:68)
    at org.apache.karaf.shell.impl.console.osgi.secured.SecuredCommand.execute(SecuredCommand.java:86)
    at org.apache.felix.gogo.runtime.Closure.executeCmd(Closure.java:599)
    at org.apache.felix.gogo.runtime.Closure.executeStatement(Closure.java:526)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:415)
    at org.apache.felix.gogo.runtime.Pipe.doCall(Pipe.java:416)
    at org.apache.felix.gogo.runtime.Pipe.call(Pipe.java:229)
    at org.apache.felix.gogo.runtime.Pipe.call(Pipe.java:59)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

openhab> 

[ssalonen]

Thank you @BHall

Since I cannot reproduce the issue myself this is a bit shot in the dark but let’s see…

Please install the following versions of modbus binding and transport:

modbus-2.5.8-disabled-eviction.zip.pdf (309.5 KB)

For installation instructions, please follow the step outlined in this post:

Binding Modbus 2.5.7. Stops working after unsuccessful read attempt

EDIT: users are reporting that these steps do not necessarily work out (missing dependencies) EDIT2: Added couple of additional steps to finish the installation and resolve the dependency issues EDIT3: openhab 2.5.8 stable has been now released. The stable version is recommended for most users and the instructions below are not needed. Alternatively, you can now just download SNAPSHOT versions of modbus binding and modbus transport from ci.openhab.org, and just use them Uninstall 2.5.7 modb…

Instead of using files from ci.openhab.org, please use the attached zip file (rename the .pdf to .zip for extraction).

After executing the installation steps, please output bundle:list -s|grep modbus and try to get the reproduce the issue with the new version.

[stfn82 (Stefan)]

Mine stopped around midnight. So not sure if this is still relevant.

Welcome to Ubuntu 20.04.1 LTS (GNU/Linux 5.4.0-42-generic x86_64) * Document...

Welcome to Ubuntu 20.04.1 LTS (GNU/Linux 5.4.0-42-generic x86_64) * Document...

[ssalonen]

Thanks @stfn82, your threads show the same as @BHall.

Please try what is adviced above

[stfn82 (Stefan)]

@ssalonen

bundle:list -s|grep modbus

303 │ Active │ 80 │ 2.5.8 │ org.openhab.binding.modbus
304 │ Active │ 80 │ 2.5.9.202009010439 │ org.openhab.io.transport.modbus

[ssalonen]

Looks good (transport has the correct version 2.5.9.202009010439, and binding should be release 2.5.8), let’s see if the problem shows with this.

[stfn82 (Stefan)]

It stopped again. It seems to got worse. Every few hours the binding stops working.

Welcome to Ubuntu 20.04.1 LTS (GNU/Linux 5.4.0-42-generic x86_64) * Document...

Welcome to Ubuntu 20.04.1 LTS (GNU/Linux 5.4.0-42-generic x86_64) * Document...

[BHall (Brian Hall)]

@ssalonen,

openhab> bundle:list -s |grep modbus
222 │ Active │ 80 │ 2.5.9.202009010439 │ org.openhab.io.transport.modbus
223 │ Active │ 80 │ 2.5.8 │ org.openhab.binding.modbus

It ran awhile and then stopped again.

Following is the result of the first command:
The results of the second command will be in the next post.

openhab> threads --locks --monitors
"CM Configuration Updater" Id=30 in WAITING on lock=java.util.LinkedList@5ed6a8d5
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:79)
    at java.lang.Thread.run(Thread.java:748)

"CM Event Dispatcher" Id=31 in WAITING on lock=java.util.LinkedList@308f9fbf
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:79)
    at java.lang.Thread.run(Thread.java:748)

"fileinstall-C:\openhab2/addons" Id=43 in TIMED_WAITING on lock=org.apache.felix.fileinstall.internal.DirectoryWatcher@6940feed
    at java.lang.Object.wait(Native Method)
    at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:320)

"encryption-2-thread-1" Id=54 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@71a4a545
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingDeque.pollFirst(LinkedBlockingDeque.java:522)
    at java.util.concurrent.LinkedBlockingDeque.poll(LinkedBlockingDeque.java:684)
    at sun.nio.fs.AbstractWatchService.poll(AbstractWatchService.java:108)
    at org.apache.karaf.jaas.modules.properties.AutoEncryptionSupport.run(AutoEncryptionSupport.java:94)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@26efcd61

"openHAB-job-scheduler_QuartzSchedulerThread" Id=119 in TIMED_WAITING on lock=java.lang.Object@23d15165
    at java.lang.Object.wait(Native Method)
    at org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:410)

"main" Id=1 in WAITING on lock=java.util.concurrent.atomic.AtomicReference@5d8a82c
    at java.lang.Object.wait(Native Method)
    at org.eclipse.osgi.container.SystemModule.waitForStop(SystemModule.java:168)
    at org.eclipse.osgi.internal.framework.EquinoxBundle$SystemBundle.waitForStop(EquinoxBundle.java:250)
    at org.eclipse.osgi.launch.Equinox.waitForStop(Equinox.java:181)
    at org.apache.karaf.main.Main.awaitShutdown(Main.java:661)
    at org.apache.karaf.main.Main.main(Main.java:188)

"Framework Event Dispatcher: org.eclipse.osgi.internal.framework.EquinoxEventPublisher@491b9b8" Id=14 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@3279812
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Bundle File Closer" Id=15 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@685c15cc
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Start Level: Equinox Container: c05da991-a1bb-4b9e-b19c-663031d5bda5" Id=16 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@5a7091f2
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Karaf Lock Monitor Thread" Id=17 in TIMED_WAITING
    at java.lang.Thread.sleep(Native Method)
    at org.apache.karaf.main.Main.doMonitor(Main.java:410)
    at org.apache.karaf.main.Main.access$100(Main.java:74)
    at org.apache.karaf.main.Main$3.run(Main.java:377)

"Karaf Shutdown Socket Thread" Id=18 in RUNNABLE (running in native)
    at java.net.DualStackPlainSocketImpl.accept0(Native Method)
    at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131)
    at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
    at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)
      - locked java.net.SocksSocketImpl@24e20488
    at java.net.ServerSocket.implAccept(ServerSocket.java:562)
    at java.net.ServerSocket.accept(ServerSocket.java:530)
    at org.apache.karaf.main.ShutdownSocketThread.run(ShutdownSocketThread.java:66)

    Locked monitors: count = 1
      - java.net.SocksSocketImpl@24e20488 locked at 
          3 java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)

"fileinstall-C:\openhab2\userdata/etc" Id=32 in TIMED_WAITING on lock=org.apache.felix.fileinstall.internal.DirectoryWatcher@4fabfff1
    at java.lang.Object.wait(Native Method)
    at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:320)

"WindowsStreamPump" Id=41 in RUNNABLE (running in native)
    at org.fusesource.jansi.internal.Kernel32.WaitForSingleObject(Native Method)
    at org.fusesource.jansi.internal.WindowsSupport.readConsoleInput(WindowsSupport.java:97)
    at org.jline.terminal.impl.jansi.win.JansiWinSysTerminal.processConsoleInput(JansiWinSysTerminal.java:112)
    at org.jline.terminal.impl.AbstractWindowsTerminal.pump(AbstractWindowsTerminal.java:458)
    at org.jline.terminal.impl.AbstractWindowsTerminal$$Lambda$36/1639556207.run(Unknown Source)
    at java.lang.Thread.run(Thread.java:748)

"Karaf local console user openhab" Id=45 in WAITING on lock=org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl@fea99
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl.start(CommandSessionImpl.java:802)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:300)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:169)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:149)
    at org.apache.felix.gogo.runtime.CommandSessionImpl.execute(CommandSessionImpl.java:179)
    at org.apache.karaf.shell.impl.console.ConsoleSessionImpl.doExecute(ConsoleSessionImpl.java:467)
    at org.apache.karaf.shell.impl.console.ConsoleSessionImpl.run(ConsoleSessionImpl.java:407)
    at java.lang.Thread.run(Thread.java:748)

"SCR Component Actor" Id=51 in WAITING on lock=java.util.LinkedList@299b7b04
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.scr.impl.ComponentActorThread.run(ComponentActorThread.java:83)
    at java.lang.Thread.run(Thread.java:748)

"encryption-3-thread-1" Id=58 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6df08ac7
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingDeque.pollFirst(LinkedBlockingDeque.java:522)
    at java.util.concurrent.LinkedBlockingDeque.poll(LinkedBlockingDeque.java:684)
    at sun.nio.fs.AbstractWatchService.poll(AbstractWatchService.java:108)
    at org.apache.karaf.jaas.modules.properties.AutoEncryptionSupport.run(AutoEncryptionSupport.java:94)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@136d7bae

"EMF Reference Cleaner" Id=69 in WAITING on lock=java.lang.ref.ReferenceQueue$Lock@355db752
    at java.lang.Object.wait(Native Method)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
    at org.eclipse.emf.common.util.CommonUtil$1ReferenceClearingQueuePollingThread.run(CommonUtil.java:70)

"OH-OSGiEventManager" Id=70 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e1e5ad6
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467)
    at org.eclipse.smarthome.core.internal.events.ThreadedEventHandler.lambda$0(ThreadedEventHandler.java:60)
    at org.eclipse.smarthome.core.internal.events.ThreadedEventHandler$$Lambda$340/2027198246.run(Unknown Source)
    at java.lang.Thread.run(Thread.java:748)

"qtp1461981977-76" Id=76 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@4d774099
      - locked java.util.Collections$UnmodifiableSet@331d00bf
      - locked sun.nio.ch.WindowsSelectorImpl@5fb96826
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@4d774099 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@331d00bf locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@5fb96826 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"qtp1461981977-77" Id=77 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@2d3a65c5
      - locked java.util.Collections$UnmodifiableSet@1efe56cc
      - locked sun.nio.ch.WindowsSelectorImpl@6b85ac11
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@2d3a65c5 locked at 
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@1efe56cc locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@6b85ac11 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"qtp1461981977-79-acceptor-0@2f867b36-0.0.0.0:8443@648c245c{SSL,[ssl, http/1.1]}{0.0.0.0:8443}" Id=79 in RUNNABLE (running in native)
    at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:419)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)
      - locked java.lang.Object@7ff15ff5
    at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:385)
    at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:664)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 1
      - java.lang.Object@7ff15ff5 locked at
          2 sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)

"qtp1461981977-80" Id=80 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@62c9a53b
      - locked java.util.Collections$UnmodifiableSet@66236b54
      - locked sun.nio.ch.WindowsSelectorImpl@7638a9ff
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@62c9a53b locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@66236b54 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@7638a9ff locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"qtp1461981977-81" Id=81 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@778e6c0a
      - locked java.util.Collections$UnmodifiableSet@4a2853a
      - locked sun.nio.ch.WindowsSelectorImpl@11c31075
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@778e6c0a locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@4a2853a locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@11c31075 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"qtp1461981977-82-acceptor-0@aeee8a7-default@3bd51cab{HTTP/1.1,[http/1.1]}{0.0.0.0:8080}" Id=82 in RUNNABLE (running in native)
    at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:419)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)
      - locked java.lang.Object@178c9ea8
    at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:385)
    at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:664)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 1
      - java.lang.Object@178c9ea8 locked at
          2 sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)

"Dir Watcher" Id=89 in WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@787da12a
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
    at java.util.concurrent.LinkedBlockingDeque.takeFirst(LinkedBlockingDeque.java:492)
    at java.util.concurrent.LinkedBlockingDeque.take(LinkedBlockingDeque.java:680)
    at sun.nio.fs.AbstractWatchService.take(AbstractWatchService.java:118)
    at org.eclipse.smarthome.core.service.WatchQueueReader.run(WatchQueueReader.java:210)
    at java.lang.Thread.run(Thread.java:748)

"com.google.inject.internal.util.$Finalizer" Id=101 in WAITING on lock=java.lang.ref.ReferenceQueue$Lock@322ba6b3
    at java.lang.Object.wait(Native Method)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
    at com.google.inject.internal.util.$Finalizer.run(Finalizer.java:114)

"openHAB-job-scheduler_Worker-1" Id=109 in TIMED_WAITING on lock=java.lang.Object@579ebee3
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-2" Id=110 in TIMED_WAITING on lock=java.lang.Object@5ab5c9b1
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-3" Id=111 in TIMED_WAITING on lock=java.lang.Object@38186277
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-4" Id=112 in TIMED_WAITING on lock=java.lang.Object@667b2366
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-5" Id=113 in TIMED_WAITING on lock=java.lang.Object@870bace
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-6" Id=114 in TIMED_WAITING on lock=java.lang.Object@74d2c3b6
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-7" Id=115 in TIMED_WAITING on lock=java.lang.Object@1ab890be
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-8" Id=116 in TIMED_WAITING on lock=java.lang.Object@33cba5db
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-9" Id=117 in TIMED_WAITING on lock=java.lang.Object@7b50e1db
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-10" Id=118 in TIMED_WAITING on lock=java.lang.Object@4ae49c1b
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"lsp-1" Id=126 in RUNNABLE (running in native)
    at java.net.DualStackPlainSocketImpl.accept0(Native Method)
    at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131)
    at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
    at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)
      - locked java.net.SocksSocketImpl@d208ef8
    at java.net.ServerSocket.implAccept(ServerSocket.java:562)
    at java.net.ServerSocket.accept(ServerSocket.java:530)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer.listen(ModelServer.java:98)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer.lambda$0(ModelServer.java:77)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer$$Lambda$446/2118944187.run(Unknown Source)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@1b1b9c4b

    Locked monitors: count = 1
      - java.net.SocksSocketImpl@d208ef8 locked at
          3 java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)

"ServletModel-12-133" Id=133 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@13e8dffe
      - locked java.util.Collections$UnmodifiableSet@68434efa
      - locked sun.nio.ch.WindowsSelectorImpl@69a2e266
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@13e8dffe locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@68434efa locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@69a2e266 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"ServletModel-12-134" Id=134 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@3749933a
      - locked java.util.Collections$UnmodifiableSet@76aee9d5
      - locked sun.nio.ch.WindowsSelectorImpl@3df0109e
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

    Locked monitors: count = 3
      - sun.nio.ch.Util$3@3749933a locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - java.util.Collections$UnmodifiableSet@76aee9d5 locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - sun.nio.ch.WindowsSelectorImpl@3df0109e locked at
          4 sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)

"ServletModel-12-135" Id=135 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-136" Id=136 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-137" Id=137 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-138" Id=138 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-139" Id=139 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-140" Id=140 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"SocketListener(JmDNS-/192.168.1.43)" Id=163 in RUNNABLE (running in native)
    at java.net.TwoStacksPlainDatagramSocketImpl.receive0(Native Method)
      - locked java.net.TwoStacksPlainDatagramSocketImpl@2de878e4
    at java.net.TwoStacksPlainDatagramSocketImpl.receive(TwoStacksPlainDatagramSocketImpl.java:114)
      - locked java.net.TwoStacksPlainDatagramSocketImpl@2de878e4
    at java.net.DatagramSocket.receive(DatagramSocket.java:812)
      - locked java.net.DatagramPacket@1072cfd5
      - locked java.net.MulticastSocket@40703adc
    at javax.jmdns.impl.SocketListener.run(SocketListener.java:41)

    Locked monitors: count = 4
      - java.net.TwoStacksPlainDatagramSocketImpl@2de878e4 locked at
          0 java.net.TwoStacksPlainDatagramSocketImpl.receive0(Native Method)
      - java.net.TwoStacksPlainDatagramSocketImpl@2de878e4 locked at 
          1 java.net.TwoStacksPlainDatagramSocketImpl.receive(TwoStacksPlainDatagramSocketImpl.java:114)
      - java.net.DatagramPacket@1072cfd5 locked at
          2 java.net.DatagramSocket.receive(DatagramSocket.java:812)
      - java.net.MulticastSocket@40703adc locked at
          2 java.net.DatagramSocket.receive(DatagramSocket.java:812)

"OH-modbusManagerPollerThreadPool-6" Id=458 in WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@634bdd99       
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
    at org.apache.commons.pool2.impl.LinkedBlockingDeque.takeFirst(LinkedBlockingDeque.java:587)
    at org.apache.commons.pool2.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:366)
    at org.apache.commons.pool2.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:281)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.borrowConnection(ModbusManagerImpl.java:380)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.lambda$3(ModbusManagerImpl.java:463)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$$Lambda$527/1453430689.get(Unknown Source)
    at org.openhab.io.transport.modbus.internal.SimpleStopWatch.timeSupplier(SimpleStopWatch.java:118)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.getConnection(ModbusManagerImpl.java:463)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.executeOperation(ModbusManagerImpl.java:556)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.access$2(ModbusManagerImpl.java:525)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$ModbusCommunicationInterfaceImpl.lambda$1(ModbusManagerImpl.java:782)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$ModbusCommunicationInterfaceImpl$$Lambda$525/53476295.run(Unknown Source)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@56daab5e

"job controller 1" Id=2013 in WAITING on lock=java.util.concurrent.FutureTask@62cbefdc
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:429)
    at java.util.concurrent.FutureTask.get(FutureTask.java:191)
    at java.util.concurrent.AbstractExecutorService.invokeAll(AbstractExecutorService.java:244)
    at org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl.run(CommandSessionImpl.java:827)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@726f8418

"pipe-threads --locks --monitors" Id=2014 in RUNNABLE
    at sun.management.ThreadImpl.dumpThreads0(Native Method)
    at sun.management.ThreadImpl.dumpAllThreads(ThreadImpl.java:454)
    at org.apache.karaf.shell.commands.impl.ThreadsAction.execute(ThreadsAction.java:78)
    at org.apache.karaf.shell.impl.action.command.ActionCommand.execute(ActionCommand.java:84)
    at org.apache.karaf.shell.impl.console.osgi.secured.SecuredCommand.execute(SecuredCommand.java:68)
    at org.apache.karaf.shell.impl.console.osgi.secured.SecuredCommand.execute(SecuredCommand.java:86)
    at org.apache.felix.gogo.runtime.Closure.executeCmd(Closure.java:599)
    at org.apache.felix.gogo.runtime.Closure.executeStatement(Closure.java:526)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:415)
    at org.apache.felix.gogo.runtime.Pipe.doCall(Pipe.java:416)
    at org.apache.felix.gogo.runtime.Pipe.call(Pipe.java:229)
    at org.apache.felix.gogo.runtime.Pipe.call(Pipe.java:59)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

    Locked synchronizers: count = 1
      - java.util.concurrent.ThreadPoolExecutor$Worker@6557038e

openhab>

[BHall (Brian Hall)]

@ssalonen,

Following is the result of the second command:

openhab> threads
"CM Configuration Updater" Id=30 in WAITING on lock=java.util.LinkedList@5ed6a8d5
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:79)
    at java.lang.Thread.run(Thread.java:748)

"CM Event Dispatcher" Id=31 in WAITING on lock=java.util.LinkedList@308f9fbf
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:79)
    at java.lang.Thread.run(Thread.java:748)

"fileinstall-C:\openhab2/addons" Id=43 in TIMED_WAITING on lock=org.apache.felix.fileinstall.internal.DirectoryWatcher@6940feed
    at java.lang.Object.wait(Native Method)
    at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:320)

"encryption-2-thread-1" Id=54 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@71a4a545
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingDeque.pollFirst(LinkedBlockingDeque.java:522)
    at java.util.concurrent.LinkedBlockingDeque.poll(LinkedBlockingDeque.java:684)
    at sun.nio.fs.AbstractWatchService.poll(AbstractWatchService.java:108)
    at org.apache.karaf.jaas.modules.properties.AutoEncryptionSupport.run(AutoEncryptionSupport.java:94)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"openHAB-job-scheduler_QuartzSchedulerThread" Id=119 in TIMED_WAITING on lock=java.lang.Object@23d15165
    at java.lang.Object.wait(Native Method)
    at org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:410)

"main" Id=1 in WAITING on lock=java.util.concurrent.atomic.AtomicReference@5d8a82c
    at java.lang.Object.wait(Native Method)
    at org.eclipse.osgi.container.SystemModule.waitForStop(SystemModule.java:168)
    at org.eclipse.osgi.internal.framework.EquinoxBundle$SystemBundle.waitForStop(EquinoxBundle.java:250)
    at org.eclipse.osgi.launch.Equinox.waitForStop(Equinox.java:181)
    at org.apache.karaf.main.Main.awaitShutdown(Main.java:661)
    at org.apache.karaf.main.Main.main(Main.java:188)

"Framework Event Dispatcher: org.eclipse.osgi.internal.framework.EquinoxEventPublisher@491b9b8" Id=14 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@3279812
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Bundle File Closer" Id=15 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@685c15cc
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Start Level: Equinox Container: c05da991-a1bb-4b9e-b19c-663031d5bda5" Id=16 in WAITING on lock=org.eclipse.osgi.framework.eventmgr.EventManager$EventThread@5a7091f2
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
    at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:336)

"Karaf Lock Monitor Thread" Id=17 in TIMED_WAITING
    at java.lang.Thread.sleep(Native Method)
    at org.apache.karaf.main.Main.doMonitor(Main.java:410)
    at org.apache.karaf.main.Main.access$100(Main.java:74)
    at org.apache.karaf.main.Main$3.run(Main.java:377)

"Karaf Shutdown Socket Thread" Id=18 in RUNNABLE (running in native)
    at java.net.DualStackPlainSocketImpl.accept0(Native Method)
    at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131)
    at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
    at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)
      - locked java.net.SocksSocketImpl@24e20488
    at java.net.ServerSocket.implAccept(ServerSocket.java:562)
    at java.net.ServerSocket.accept(ServerSocket.java:530)
    at org.apache.karaf.main.ShutdownSocketThread.run(ShutdownSocketThread.java:66)

"fileinstall-C:\openhab2\userdata/etc" Id=32 in TIMED_WAITING on lock=org.apache.felix.fileinstall.internal.DirectoryWatcher@4fabfff1
    at java.lang.Object.wait(Native Method)
    at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:320)

"WindowsStreamPump" Id=41 in RUNNABLE (running in native)
    at org.fusesource.jansi.internal.Kernel32.WaitForSingleObject(Native Method)
    at org.fusesource.jansi.internal.WindowsSupport.readConsoleInput(WindowsSupport.java:97)
    at org.jline.terminal.impl.jansi.win.JansiWinSysTerminal.processConsoleInput(JansiWinSysTerminal.java:112)
    at org.jline.terminal.impl.AbstractWindowsTerminal.pump(AbstractWindowsTerminal.java:458)
    at org.jline.terminal.impl.AbstractWindowsTerminal$$Lambda$36/1639556207.run(Unknown Source)
    at java.lang.Thread.run(Thread.java:748)

"Karaf local console user openhab" Id=45 in WAITING on lock=org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl@4820f098
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl.start(CommandSessionImpl.java:802)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:300)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:169)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:149)
    at org.apache.felix.gogo.runtime.CommandSessionImpl.execute(CommandSessionImpl.java:179)
    at org.apache.karaf.shell.impl.console.ConsoleSessionImpl.doExecute(ConsoleSessionImpl.java:467)
    at org.apache.karaf.shell.impl.console.ConsoleSessionImpl.run(ConsoleSessionImpl.java:407)
    at java.lang.Thread.run(Thread.java:748)

"SCR Component Actor" Id=51 in WAITING on lock=java.util.LinkedList@299b7b04
    at java.lang.Object.wait(Native Method)
    at java.lang.Object.wait(Object.java:502)
    at org.apache.felix.scr.impl.ComponentActorThread.run(ComponentActorThread.java:83)
    at java.lang.Thread.run(Thread.java:748)

"encryption-3-thread-1" Id=58 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6df08ac7
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingDeque.pollFirst(LinkedBlockingDeque.java:522)
    at java.util.concurrent.LinkedBlockingDeque.poll(LinkedBlockingDeque.java:684)
    at sun.nio.fs.AbstractWatchService.poll(AbstractWatchService.java:108)
    at org.apache.karaf.jaas.modules.properties.AutoEncryptionSupport.run(AutoEncryptionSupport.java:94)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"EMF Reference Cleaner" Id=69 in WAITING on lock=java.lang.ref.ReferenceQueue$Lock@355db752
    at java.lang.Object.wait(Native Method)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
    at org.eclipse.emf.common.util.CommonUtil$1ReferenceClearingQueuePollingThread.run(CommonUtil.java:70)

"OH-OSGiEventManager" Id=70 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e1e5ad6
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467)
    at org.eclipse.smarthome.core.internal.events.ThreadedEventHandler.lambda$0(ThreadedEventHandler.java:60)
    at org.eclipse.smarthome.core.internal.events.ThreadedEventHandler$$Lambda$340/2027198246.run(Unknown Source)
    at java.lang.Thread.run(Thread.java:748)

"qtp1461981977-76" Id=76 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@4d774099
      - locked java.util.Collections$UnmodifiableSet@331d00bf
      - locked sun.nio.ch.WindowsSelectorImpl@5fb96826
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp1461981977-77" Id=77 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@2d3a65c5
      - locked java.util.Collections$UnmodifiableSet@1efe56cc
      - locked sun.nio.ch.WindowsSelectorImpl@6b85ac11
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp1461981977-79-acceptor-0@2f867b36-0.0.0.0:8443@648c245c{SSL,[ssl, http/1.1]}{0.0.0.0:8443}" Id=79 in RUNNABLE (running in native)
    at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:419)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)
      - locked java.lang.Object@7ff15ff5
    at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:385)
    at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:664)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp1461981977-80" Id=80 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@62c9a53b
      - locked java.util.Collections$UnmodifiableSet@66236b54
      - locked sun.nio.ch.WindowsSelectorImpl@7638a9ff
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp1461981977-81" Id=81 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@778e6c0a
      - locked java.util.Collections$UnmodifiableSet@4a2853a
      - locked sun.nio.ch.WindowsSelectorImpl@11c31075
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"qtp1461981977-82-acceptor-0@aeee8a7-default@3bd51cab{HTTP/1.1,[http/1.1]}{0.0.0.0:8080}" Id=82 in RUNNABLE (running in native)
    at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:419)
    at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:247)
      - locked java.lang.Object@178c9ea8
    at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:385)
    at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:664)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"Dir Watcher" Id=89 in WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@787da12a
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
    at java.util.concurrent.LinkedBlockingDeque.takeFirst(LinkedBlockingDeque.java:492)
    at java.util.concurrent.LinkedBlockingDeque.take(LinkedBlockingDeque.java:680)
    at sun.nio.fs.AbstractWatchService.take(AbstractWatchService.java:118)
    at org.eclipse.smarthome.core.service.WatchQueueReader.run(WatchQueueReader.java:210)
    at java.lang.Thread.run(Thread.java:748)

"com.google.inject.internal.util.$Finalizer" Id=101 in WAITING on lock=java.lang.ref.ReferenceQueue$Lock@322ba6b3
    at java.lang.Object.wait(Native Method)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
    at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
    at com.google.inject.internal.util.$Finalizer.run(Finalizer.java:114)

"openHAB-job-scheduler_Worker-1" Id=109 in TIMED_WAITING on lock=java.lang.Object@579ebee3
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-2" Id=110 in TIMED_WAITING on lock=java.lang.Object@5ab5c9b1
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-3" Id=111 in TIMED_WAITING on lock=java.lang.Object@38186277
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-4" Id=112 in TIMED_WAITING on lock=java.lang.Object@667b2366
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-5" Id=113 in TIMED_WAITING on lock=java.lang.Object@870bace
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-6" Id=114 in TIMED_WAITING on lock=java.lang.Object@74d2c3b6
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-7" Id=115 in TIMED_WAITING on lock=java.lang.Object@1ab890be
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-8" Id=116 in TIMED_WAITING on lock=java.lang.Object@33cba5db
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-9" Id=117 in TIMED_WAITING on lock=java.lang.Object@7b50e1db
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"openHAB-job-scheduler_Worker-10" Id=118 in TIMED_WAITING on lock=java.lang.Object@4ae49c1b
    at java.lang.Object.wait(Native Method)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:568)

"lsp-1" Id=126 in RUNNABLE (running in native)
    at java.net.DualStackPlainSocketImpl.accept0(Native Method)
    at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131)
    at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
    at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199)
      - locked java.net.SocksSocketImpl@d208ef8
    at java.net.ServerSocket.implAccept(ServerSocket.java:562)
    at java.net.ServerSocket.accept(ServerSocket.java:530)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer.listen(ModelServer.java:98)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer.lambda$0(ModelServer.java:77)
    at org.eclipse.smarthome.model.lsp.internal.ModelServer$$Lambda$446/2118944187.run(Unknown Source)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-133" Id=133 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@13e8dffe
      - locked java.util.Collections$UnmodifiableSet@68434efa
      - locked sun.nio.ch.WindowsSelectorImpl@69a2e266
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-134" Id=134 in RUNNABLE (running in native)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:314)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:293)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:174)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
      - locked sun.nio.ch.Util$3@3749933a
      - locked java.util.Collections$UnmodifiableSet@76aee9d5
      - locked sun.nio.ch.WindowsSelectorImpl@3df0109e
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
    at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:466)
    at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:403)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
    at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
    at org.eclipse.jetty.io.ManagedSelector$$Lambda$373/2146178306.run(Unknown Source)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-135" Id=135 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-136" Id=136 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-137" Id=137 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-138" Id=138 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-139" Id=139 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"ServletModel-12-140" Id=140 in TIMED_WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@31c3eeb0
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
    at org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:851)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:890)
    at java.lang.Thread.run(Thread.java:748)

"SocketListener(JmDNS-/192.168.1.43)" Id=163 in RUNNABLE (running in native)
    at java.net.TwoStacksPlainDatagramSocketImpl.receive0(Native Method)
      - locked java.net.TwoStacksPlainDatagramSocketImpl@2de878e4
    at java.net.TwoStacksPlainDatagramSocketImpl.receive(TwoStacksPlainDatagramSocketImpl.java:114)
      - locked java.net.TwoStacksPlainDatagramSocketImpl@2de878e4
    at java.net.DatagramSocket.receive(DatagramSocket.java:812)
      - locked java.net.DatagramPacket@1072cfd5
      - locked java.net.MulticastSocket@40703adc
    at javax.jmdns.impl.SocketListener.run(SocketListener.java:41)

"OH-modbusManagerPollerThreadPool-6" Id=458 in WAITING on lock=java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@634bdd99       
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
    at org.apache.commons.pool2.impl.LinkedBlockingDeque.takeFirst(LinkedBlockingDeque.java:587)
    at org.apache.commons.pool2.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:366)
    at org.apache.commons.pool2.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:281)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.borrowConnection(ModbusManagerImpl.java:380)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.lambda$3(ModbusManagerImpl.java:463)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$$Lambda$527/1453430689.get(Unknown Source)
    at org.openhab.io.transport.modbus.internal.SimpleStopWatch.timeSupplier(SimpleStopWatch.java:118)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.getConnection(ModbusManagerImpl.java:463)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.executeOperation(ModbusManagerImpl.java:556)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl.access$2(ModbusManagerImpl.java:525)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$ModbusCommunicationInterfaceImpl.lambda$1(ModbusManagerImpl.java:782)
    at org.openhab.io.transport.modbus.internal.ModbusManagerImpl$ModbusCommunicationInterfaceImpl$$Lambda$525/53476295.run(Unknown Source)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"job controller 1" Id=2051 in WAITING on lock=java.util.concurrent.FutureTask@67f5f762
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
    at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:429)
    at java.util.concurrent.FutureTask.get(FutureTask.java:191)
    at java.util.concurrent.AbstractExecutorService.invokeAll(AbstractExecutorService.java:244)
    at org.apache.felix.gogo.runtime.CommandSessionImpl$JobImpl.run(CommandSessionImpl.java:827)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

"pipe-threads" Id=2052 in RUNNABLE
    at sun.management.ThreadImpl.dumpThreads0(Native Method)
    at sun.management.ThreadImpl.dumpAllThreads(ThreadImpl.java:454)
    at org.apache.karaf.shell.commands.impl.ThreadsAction.execute(ThreadsAction.java:78)
    at org.apache.karaf.shell.impl.action.command.ActionCommand.execute(ActionCommand.java:84)
    at org.apache.karaf.shell.impl.console.osgi.secured.SecuredCommand.execute(SecuredCommand.java:68)
    at org.apache.karaf.shell.impl.console.osgi.secured.SecuredCommand.execute(SecuredCommand.java:86)
    at org.apache.felix.gogo.runtime.Closure.executeCmd(Closure.java:599)
    at org.apache.felix.gogo.runtime.Closure.executeStatement(Closure.java:526)
    at org.apache.felix.gogo.runtime.Closure.execute(Closure.java:415)
    at org.apache.felix.gogo.runtime.Pipe.doCall(Pipe.java:416)
    at org.apache.felix.gogo.runtime.Pipe.call(Pipe.java:229)
    at org.apache.felix.gogo.runtime.Pipe.call(Pipe.java:59)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
    at java.lang.Thread.run(Thread.java:748)

openhab>

[ssalonen]

@BHall My trouble is that so far I am not able to reproduce this, making troubleshooting and fixes very slow.

Do you have easy means to get the erratic behavior? Can you please explain the steps, one step at a time

[BHall (Brian Hall)]

@ssalonen,

Good evening

The behavior is really pretty easy to reproduce on my end. I execute the “start.bat” and the “HVAC_Temp_Last_Success” entries will start showing up in the “events.log” at a very fast rate since I am currently set for 250 ms. I normally will operate an input so the register value will change and trigger an entry in the “events.log”. Then I basically wait for the logging to stop which normally will happen within an hour or so but the last time was a little over an hour.

I executed the full “bundle:list” and “log:display” commands so you can hopefully see how things are set up.

PS C:\openhab2>
PS C:\openhab2> c:\openhab2\start.bat
Launching the openHAB runtime...

                          __  _____    ____      
  ____  ____  ___  ____  / / / /   |  / __ )     
 / __ \/ __ \/ _ \/ __ \/ /_/ / /| | / __  |     
/ /_/ / /_/ /  __/ / / / __  / ___ |/ /_/ /      
\____/ .___/\___/_/ /_/_/ /_/_/  |_/_____/       
    /_/                        2.5.8
                               Release Build     

Hit '<tab>' for a list of available commands
and '[cmd] --help' for help on a specific command.
Hit '<ctrl-d>' or type 'system:shutdown' or 'logout' to shutdown openHAB.

openhab> 
openhab> bundle:list
START LEVEL 100 , List Threshold: 50
 ID │ State    │ Lvl │ Version                 │ Name
────┼──────────┼─────┼─────────────────────────┼─────────────────────────────────────────────────────────────────────────────────────────────────── 
 19 │ Active   │  80 │ 5.3.1.201602281253      │ OSGi JAX-RS Connector
 20 │ Active   │  80 │ 2.8.2.v20180104-1110    │ Gson: Google Json Library for Java
 21 │ Active   │  80 │ 18.0.0                  │ Guava: Google Core Libraries for Java
 22 │ Active   │  80 │ 27.1.0.jre              │ Guava: Google Core Libraries for Java
 23 │ Active   │  80 │ 1.0.1                   │ Guava InternalFutureFailureAccess and InternalFutures
 24 │ Active   │  80 │ 3.0.0.v201312141243     │ Google Guice (No AOP)
 25 │ Active   │  80 │ 4.8.35.v20190528-1517   │ ClassGraph
 26 │ Active   │  80 │ 3.18.1.GA               │ Javassist
 29 │ Active   │  80 │ 3.5.5                   │ JmDNS
 31 │ Active   │  80 │ 1.0.0                   │ Units of Measurement API
 33 │ Active   │  80 │ 1.1.0.Final             │ Bean Validation API
 35 │ Active   │  80 │ 2.0.1                   │ javax.ws.rs-api
 36 │ Active   │  80 │ 2.9.2                   │ Joda-Time
 37 │ Active   │  80 │ 0.5.8                   │ Jollyday
 38 │ Active   │  80 │ 3.2.0.v201101311130     │ ANTLR Runtime
 40 │ Active   │  80 │ 1.1                     │ Commons Exec
 41 │ Active   │  80 │ 2.2.0                   │ Commons IO
 42 │ Active   │  80 │ 2.6                     │ Commons Lang
 51 │ Active   │  80 │ 4.2.7                   │ Apache Karaf :: OSGi Services :: Event
 66 │ Active   │  80 │ 1.4.7.1                 │ Apache ServiceMix :: Bundles :: xstream
 69 │ Active   │  80 │ 4.14.0                  │ Apache XBean OSGI Bundle Utilities
 70 │ Active   │  80 │ 4.14.0                  │ Apache XBean :: Classpath Resource Finder
 71 │ Active   │  80 │ 2.12.0.v20160420-0247   │ EMF Common
 72 │ Active   │  80 │ 2.12.0.v20160420-0247   │ EMF Ecore
 73 │ Active   │  80 │ 2.11.0.v20160420-0247   │ EMF Change Model
 74 │ Active   │  80 │ 2.12.0.v20160420-0247   │ EMF XML/XMI Persistence
 75 │ Active   │  80 │ 3.10.400.v20190516-1504 │ Common Eclipse Runtime
104 │ Active   │  80 │ 0.8.0.v20190822-0801    │ org.eclipse.lsp4j
105 │ Active   │  80 │ 0.8.0.v20190822-0801    │ org.eclipse.lsp4j.jsonrpc
106 │ Active   │  80 │ 2.19.0.v20190902-0728   │ Xtend Runtime Library
107 │ Active   │  80 │ 2.19.0.v20190902-0728   │ Xtend Macro Interfaces
108 │ Active   │  80 │ 2.19.0.v20190902-0737   │ Xtext
109 │ Active   │  80 │ 2.19.0.v20190902-0952   │ Xtext Common Types
110 │ Active   │  80 │ 2.19.0.v20190902-0737   │ Xtext IDE Core
111 │ Active   │  80 │ 2.19.0.v20190902-0737   │ Xtext Utility
112 │ Active   │  80 │ 2.19.0.v20190902-0952   │ Xbase Model
113 │ Active   │  80 │ 2.19.0.v20190902-0952   │ Xbase Generic IDE Services
114 │ Active   │  80 │ 2.19.0.v20190902-0728   │ Xbase Runtime Library
129 │ Active   │  80 │ 1.9.6                   │ MIME streaming extension
131 │ Active   │  80 │ 7.1.0                   │ org.objectweb.asm.commons
132 │ Active   │  80 │ 7.1.0                   │ org.objectweb.asm.tree
133 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Core
134 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Audio
135 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: OAuth2Client
136 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Binding XML
137 │ Active   │  90 │ 2.5.0                   │ openHAB Core :: Bundles :: Boot
138 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Configuration Core
139 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Configuration Discovery
140 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Configuration mDNS Discovery
141 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Configuration Dispatcher
142 │ Active   │  75 │ 2.5.0                   │ openHAB Core :: Bundles :: Configuration XML
143 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Ephemeris
144 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: ID
145 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Console
146 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Console for OSGi runtime Karaf
147 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: HTTP Interface
149 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Monitor
150 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Network I/O
151 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: REST Interface
152 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Audio REST Interface
153 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: REST Interface :: Core
154 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: REST mDNS Announcer
155 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: REST JAX-RS Optimizations
156 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Sitemap REST Interface
157 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: SSE Interface
158 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Voice REST Interface
159 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: mDNS Service
160 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Karaf Integration
161 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Core
162 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Items
163 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Item IDE
164 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Items Runtime
165 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Language Server
166 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Persistence
167 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Persistence IDE
168 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Persistence Runtime
169 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Rules
170 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Rule IDE
171 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Rules Runtime
172 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Script
173 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Script IDE
174 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Script Runtime
175 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Sitemap
176 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Sitemap IDE
177 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Sitemap Runtime
178 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Thing
179 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Thing IDE
180 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Model Thing Runtime
181 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Persistence
182 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Scheduler Service
183 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Semantics
184 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: JSON Storage
185 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Thing
186 │ Active   │  75 │ 2.5.0                   │ openHAB Core :: Bundles :: Thing XML
187 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Transformation Service
188 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: UI
189 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: UI Icon Support
190 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Voice
191 │ Active   │  80 │ 2.5.8                   │ openHAB UI :: Bundles :: Dashboard UI
200 │ Active   │  80 │ 1.4.0                   │ ThreeTen-Extra
201 │ Active   │  80 │ 1.0.3                   │ Units of Measurement Common Library
202 │ Active   │  80 │ 1.0.10                  │ Units of Measurement Implementation for Java SE
203 │ Active   │  80 │ 2.5.8                   │ openHAB Add-ons :: Bundles :: IO :: Java Sound Support
204 │ Active   │  80 │ 2.5.8                   │ openHAB Add-ons :: Bundles :: IO :: Web Audio Support
205 │ Active   │  80 │ 2.5.8                   │ openHAB UI :: Bundles :: Basic UI
206 │ Active   │  80 │ 2.5.8                   │ openHAB UI :: Bundles :: HABPanel UI
207 │ Active   │  80 │ 2.5.8                   │ openHAB UI :: Bundles :: HomeBuilder UI
208 │ Active   │  80 │ 2.5.8                   │ openHAB UI :: Bundles :: Icon Set :: Classic
209 │ Active   │  80 │ 2.5.8                   │ openHAB UI :: Bundles :: Paper UI
222 │ Active   │  80 │ 2.5.9.202009010439      │ openHAB Add-ons :: Bundles :: IO :: Modbus Transport
223 │ Active   │  80 │ 2.5.8                   │ openHAB Add-ons :: Bundles :: Modbus Binding
224 │ Active   │  80 │ 3.15.0.OH2              │ nrjavaserial
225 │ Active   │  80 │ 3.3.0                   │ Commons Net
226 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Configuration USB-Serial Discovery
227 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Configuration USB-Serial Discovery for Linux using sysfs scanning       
228 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Configuration Serial
229 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Serial Transport
230 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Serial Transport for RXTX
231 │ Active   │  80 │ 2.5.0                   │ openHAB Core :: Bundles :: Serial Transport for RFC2217
232 │ Resolved │  80 │ 2.4.3                   │ Apache Commons Pool
openhab>

openhab> log:list
Logger                                             │ Level
───────────────────────────────────────────────────┼──────
ROOT                                               │ INFO
javax.jmdns                                        │ ERROR
javax.mail                                         │ ERROR
org.apache.karaf.jaas.modules.audit                │ INFO
org.apache.karaf.kar.internal.KarServiceImpl       │ ERROR
org.apache.karaf.shell.ssh.SshUtils                │ ERROR
org.apache.karaf.shell.support                     │ OFF
org.eclipse.lsp4j                                  │ OFF
org.eclipse.smarthome                              │ INFO
org.jupnp                                          │ ERROR
org.openhab                                        │ INFO
org.openhab.binding.modbus                         │ INFO
org.openhab.io.transport.modbus                    │ INFO
org.openhab.ui.paper                               │ WARN
org.openhab.ui.paper.internal                      │ INFO
org.ops4j.pax.url.mvn.internal.AetherBasedResolver │ ERROR
org.ops4j.pax.web.pax-web-runtime                  │ OFF
smarthome.event                                    │ INFO
smarthome.event.InboxUpdatedEvent                  │ ERROR
smarthome.event.ItemAddedEvent                     │ ERROR
smarthome.event.ItemRemovedEvent                   │ ERROR
smarthome.event.ItemStateEvent                     │ ERROR
smarthome.event.ThingAddedEvent                    │ ERROR
smarthome.event.ThingRemovedEvent                  │ ERROR
smarthome.event.ThingStatusInfoEvent               │ ERROR
openhab>

Were you able to see anything helpful in the information that I sent after it quits logging?

The thought did cross my mind if it might possibly help if you had my entire installation directory “C:\openhab2” . But then I guess there would be the issue of the modbus device that I am reading the single register from. I really think the modbus device is ok because I have been using it with my other software successfully for a long time.

I hope issues you have had with other users have not been this difficult. This seems to have been a tough one, especially since it doesn’t seem to produce errors.

I find it particularly interesting that if I make the two changes shown below to the logging then everything seems to work great and from the several times I tried it did not stop, even after some pretty long periods of time. I was hoping that might have been a clue, it seems almost like if you keep it busy it works better.

log:set DEBUG org.openhab.io.transport.modbus
log:set DEBUG org.openhab.binding.modbus

[BHall (Brian Hall)]

@ssalonen,

I had it running and saw something different, a bunch of warnings and errors in “openhab.log”:
Will include some of “events.log” in the following post.

2020-09-01 21:50:55.838 [INFO ] [org.quartz.core.QuartzScheduler     ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started.
2020-09-02 21:03:33.006 [INFO ] [port.EventAdminConfigurationNotifier] - Sending Event Admin nofification (configuration successful) to org/ops4j/pax/logging/Configuration
2020-09-02 21:03:33.304 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.shell.commands/4.2.7
2020-09-02 21:03:33.308 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.deployer.kar/4.2.7
2020-09-02 21:03:33.685 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.wrapper.core/4.2.7
2020-09-02 21:03:34.556 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.bundle.core/4.2.7
2020-09-02 21:03:34.601 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.config.core/4.2.7
2020-09-02 21:03:34.959 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.diagnostic.core/4.2.7
2020-09-02 21:03:34.990 [INFO ] [ll.impl.action.osgi.CommandExtension] - Command registration delayed for bundle org.apache.karaf.features.command/4.2.7. Missing dependencies: [org.apache.karaf.features.FeaturesService]
2020-09-02 21:03:35.016 [INFO ] [ll.impl.action.osgi.CommandExtension] - Command registration delayed for bundle org.apache.karaf.http.core/4.2.7. Missing dependencies: [org.apache.karaf.http.core.ProxyService, org.apache.karaf.http.core.ServletService]
2020-09-02 21:03:35.053 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.instance.core/4.2.7
2020-09-02 21:03:35.099 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.jaas.command/4.2.7
2020-09-02 21:03:35.104 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.jaas.command/4.2.7
2020-09-02 21:03:35.105 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.jaas.command/4.2.7
2020-09-02 21:03:35.178 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.jaas.command/4.2.7
2020-09-02 21:03:35.181 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.jaas.command/4.2.7
2020-09-02 21:03:35.199 [INFO ] [ll.impl.action.osgi.CommandExtension] - Updating commands for bundle org.apache.karaf.jaas.command/4.2.7
2020-09-02 21:03:35.218 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.features.command/4.2.7
2020-09-02 21:03:35.228 [INFO ] [raf.deployer.features.osgi.Activator] - Deployment finished. Registering FeatureDeploymentListener
2020-09-02 21:03:35.280 [INFO ] [ll.impl.action.osgi.CommandExtension] - Command registration delayed for bundle org.apache.karaf.kar.core/4.2.7. Missing dependencies: [org.apache.karaf.kar.KarService]
2020-09-02 21:03:35.305 [INFO ] [ll.impl.action.osgi.CommandExtension] - Command registration delayed for bundle org.apache.karaf.log.core/4.2.7. Missing dependencies: [org.apache.karaf.log.core.LogService, org.apache.karaf.log.core.LogEventFormatter]
2020-09-02 21:03:35.319 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.log.core/4.2.7
2020-09-02 21:03:35.334 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.package.core/4.2.7
2020-09-02 21:03:35.338 [INFO ] [ll.impl.action.osgi.CommandExtension] - Unregistering commands for bundle org.apache.karaf.log.core/4.2.7
2020-09-02 21:03:35.341 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.kar.core/4.2.7
2020-09-02 21:03:35.342 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.log.core/4.2.7
2020-09-02 21:03:35.363 [INFO ] [ll.impl.action.osgi.CommandExtension] - Unregistering commands for bundle org.apache.karaf.kar.core/4.2.7
2020-09-02 21:03:35.369 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.kar.core/4.2.7
2020-09-02 21:03:35.370 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.scr.state/4.2.7
2020-09-02 21:03:35.390 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.service.core/4.2.7
2020-09-02 21:03:35.533 [INFO ] [ll.impl.action.osgi.CommandExtension] - Command registration delayed for bundle org.apache.karaf.shell.ssh/4.2.7. Missing dependencies: [org.apache.sshd.server.SshServer]
2020-09-02 21:03:35.552 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.system.core/4.2.7
2020-09-02 21:03:35.762 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Examining bundle for SPI provider: org.eclipse.jetty.http
2020-09-02 21:03:35.764 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Found SPI resource: bundleentry://80.fwk418958713/META-INF/services/org.eclipse.jetty.http.HttpFieldPreEncoder
2020-09-02 21:03:35.815 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.http.Http1FieldPreEncoder
2020-09-02 21:03:35.824 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {org.eclipse.jetty.http.HttpFieldPreEncoder}={serviceloader.mediator=39, service.id=115, service.bundleid=80, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.http.Http1FieldPreEncoder}
2020-09-02 21:03:35.825 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: org.eclipse.jetty.http.HttpFieldPreEncoder in bundle org.eclipse.jetty.http
2020-09-02 21:03:35.845 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Examining bundle for SPI provider: org.eclipse.jetty.websocket.common
2020-09-02 21:03:35.846 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Found SPI resource: bundleentry://98.fwk418958713/META-INF/services/org.eclipse.jetty.websocket.api.extensions.Extension
2020-09-02 21:03:35.867 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.identity.IdentityExtension
2020-09-02 21:03:35.869 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {org.eclipse.jetty.websocket.api.extensions.Extension}={serviceloader.mediator=39, service.id=116, service.bundleid=98, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.websocket.common.extensions.identity.IdentityExtension}
2020-09-02 21:03:35.870 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2020-09-02 21:03:35.871 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.fragment.FragmentExtension
2020-09-02 21:03:35.872 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {org.eclipse.jetty.websocket.api.extensions.Extension}={serviceloader.mediator=39, service.id=117, service.bundleid=98, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.websocket.common.extensions.fragment.FragmentExtension}
2020-09-02 21:03:35.874 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2020-09-02 21:03:35.880 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension
2020-09-02 21:03:35.886 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {org.eclipse.jetty.websocket.api.extensions.Extension}={serviceloader.mediator=39, service.id=118, service.bundleid=98, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension}
2020-09-02 21:03:35.887 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2020-09-02 21:03:35.889 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.compress.DeflateFrameExtension
2020-09-02 21:03:35.903 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {org.eclipse.jetty.websocket.api.extensions.Extension}={serviceloader.mediator=39, service.id=119, service.bundleid=98, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.websocket.common.extensions.compress.DeflateFrameExtension}
2020-09-02 21:03:35.904 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2020-09-02 21:03:35.906 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.compress.XWebkitDeflateFrameExtension
2020-09-02 21:03:35.907 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {org.eclipse.jetty.websocket.api.extensions.Extension}={serviceloader.mediator=39, service.id=120, service.bundleid=98, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.websocket.common.extensions.compress.XWebkitDeflateFrameExtension}
2020-09-02 21:03:35.907 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
2020-09-02 21:03:35.909 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Examining bundle for SPI provider: org.eclipse.jetty.websocket.javax.websocket
2020-09-02 21:03:35.911 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Found SPI resource: bundleentry://99.fwk418958713/META-INF/services/javax.websocket.ContainerProvider
2020-09-02 21:03:35.913 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.websocket.jsr356.JettyClientContainerProvider
2020-09-02 21:03:35.915 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {javax.websocket.ContainerProvider}={serviceloader.mediator=39, service.id=121, service.bundleid=99, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.websocket.jsr356.JettyClientContainerProvider}
2020-09-02 21:03:35.915 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: javax.websocket.ContainerProvider in bundle org.eclipse.jetty.websocket.javax.websocket
2020-09-02 21:03:35.917 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Examining bundle for SPI provider: org.eclipse.jetty.websocket.javax.websocket.server
2020-09-02 21:03:35.917 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Found SPI resource: bundleentry://100.fwk418958713/META-INF/services/javax.servlet.ServletContainerInitializer
2020-09-02 21:03:35.919 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.websocket.jsr356.server.deploy.WebSocketServerContainerInitializer
2020-09-02 21:03:35.921 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {javax.servlet.ServletContainerInitializer}={serviceloader.mediator=39, service.id=122, service.bundleid=100, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.websocket.jsr356.server.deploy.WebSocketServerContainerInitializer}
2020-09-02 21:03:35.921 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: javax.servlet.ServletContainerInitializer in bundle org.eclipse.jetty.websocket.javax.websocket.server
2020-09-02 21:03:35.922 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Found SPI resource: bundleentry://100.fwk418958713/META-INF/services/javax.websocket.server.ServerEndpointConfig$Configurator
2020-09-02 21:03:35.924 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.websocket.jsr356.server.ContainerDefaultConfigurator
2020-09-02 21:03:35.925 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {javax.websocket.server.ServerEndpointConfig$Configurator}={serviceloader.mediator=39, service.id=123, service.bundleid=100, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.websocket.jsr356.server.ContainerDefaultConfigurator}
2020-09-02 21:03:35.926 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: javax.websocket.server.ServerEndpointConfig$Configurator in bundle org.eclipse.jetty.websocket.javax.websocket.server
2020-09-02 21:03:35.927 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Examining bundle for SPI provider: org.eclipse.jetty.websocket.server
2020-09-02 21:03:35.928 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Found SPI resource: bundleentry://101.fwk418958713/META-INF/services/javax.servlet.ServletContainerInitializer
2020-09-02 21:03:35.929 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Loaded SPI provider: class org.eclipse.jetty.websocket.server.NativeWebSocketServletContainerInitializer
2020-09-02 21:03:35.931 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered service: {javax.servlet.ServletContainerInitializer}={serviceloader.mediator=39, service.id=124, service.bundleid=101, service.scope=bundle, .org.apache.aries.spifly.provider.implclass=org.eclipse.jetty.websocket.server.NativeWebSocketServletContainerInitializer}
2020-09-02 21:03:35.931 [INFO ] [rg.apache.aries.spifly.BaseActivator] - Registered provider: javax.servlet.ServletContainerInitializer in bundle org.eclipse.jetty.websocket.server
2020-09-02 21:03:36.051 [INFO ] [org.eclipse.jetty.util.log          ] - Logging initialized @6241ms to org.eclipse.jetty.util.log.Slf4jLog
2020-09-02 21:03:36.054 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.shell.ssh/4.2.7
2020-09-02 21:03:36.093 [INFO ] [j.pax.web.service.internal.Activator] - EventAdmin support enabled, servlet events will be postet to topics.
2020-09-02 21:03:36.095 [INFO ] [j.pax.web.service.internal.Activator] - LogService support enabled, log events will be created.
2020-09-02 21:03:36.099 [INFO ] [j.pax.web.service.internal.Activator] - Pax Web started
2020-09-02 21:03:36.559 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.event/4.2.7
2020-09-02 21:03:37.042 [INFO ] [org.eclipse.jetty.util.TypeUtil     ] - JVM Runtime does not support Modules
2020-09-02 21:03:37.184 [INFO ] [rvice.jetty.internal.JettyServerImpl] - Pax Web available at [0.0.0.0]:[8443]
2020-09-02 21:03:37.188 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Location set to '31.581895999999997,-94.465492'.
2020-09-02 21:03:37.220 [INFO ] [vice.jetty.internal.JettyFactoryImpl] - No ALPN class available
2020-09-02 21:03:37.221 [INFO ] [vice.jetty.internal.JettyFactoryImpl] - HTTP/2 not available, creating standard ServerConnector for Http
2020-09-02 21:03:37.222 [INFO ] [rvice.jetty.internal.JettyServerImpl] - Pax Web available at [0.0.0.0]:[8080]
2020-09-02 21:03:37.226 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.ops4j.pax.web.pax-web-extender-whiteboard_7.2.11 [193]] to http service
2020-09-02 21:03:37.252 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.apache.karaf.http.core_4.2.7 [53]] to http service
2020-09-02 21:03:37.258 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [19]] to http service
2020-09-02 21:03:37.280 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.apache.karaf.http.core/4.2.7
2020-09-02 21:03:38.083 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.core.audio_2.5.0 [134]] to http service
2020-09-02 21:03:38.099 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:38.147 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.core.audio_2.5.0 [134], contextID=default], with context-name: 
2020-09-02 21:03:38.163 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:38.236 [INFO ] [org.eclipse.jetty.server.session    ] - DefaultSessionIdManager workerName=node0
2020-09-02 21:03:38.236 [INFO ] [org.eclipse.jetty.server.session    ] - No SessionScavenger set, using defaults
2020-09-02 21:03:38.239 [INFO ] [org.eclipse.jetty.server.session    ] - node0 Scavenging every 660000ms
2020-09-02 21:03:38.253 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.core.audio_2.5.0 [134], contextID=default]}
2020-09-02 21:03:38.264 [INFO ] [org.eclipse.jetty.server.Server     ] - jetty-9.4.20.v20190813; built: 2019-08-13T21:28:18.144Z; git: 84700530e645e812b336747464d6fbbf370c9a20; jvm 1.8.0_252-b14
2020-09-02 21:03:38.287 [INFO ] [.jetty.server.handler.ContextHandler] - Started o.e.j.s.h.ContextHandler@d785f1c{/static,null,AVAILABLE}
2020-09-02 21:03:38.314 [INFO ] [pse.jetty.util.ssl.SslContextFactory] - x509=X509@57251ee5(mykey,h=[openhab.org],w=[]) for Server@4cbca070[provider=null,keyStore=file:///C:/openhab2/userdata/etc/keystore,trustStore=file:///C:/openhab2/userdata/etc/keystore]
2020-09-02 21:03:38.377 [INFO ] [lipse.jetty.server.AbstractConnector] - Started 0.0.0.0:8443@1711946{SSL,[ssl, http/1.1]}{0.0.0.0:8443}
2020-09-02 21:03:38.383 [INFO ] [lipse.jetty.server.AbstractConnector] - Started default@6a2158a0{HTTP/1.1,[http/1.1]}{0.0.0.0:8080}
2020-09-02 21:03:38.384 [INFO ] [org.eclipse.jetty.server.Server     ] - Started @8576ms
2020-09-02 21:03:38.858 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:38.859 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [19], contextID=default], with context-name: 
2020-09-02 21:03:38.860 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:38.871 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [19], contextID=default]}
2020-09-02 21:03:38.911 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.core.io.http_2.5.0 [147]] to http service
2020-09-02 21:03:41.400 [INFO ] [ll.impl.action.osgi.CommandExtension] - Registering commands for bundle org.openhab.core.karaf/2.5.0
2020-09-02 21:03:42.720 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'hvac.items'
2020-09-02 21:03:43.274 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'modbus.things'
2020-09-02 21:03:43.371 [INFO ] [org.quartz.impl.StdSchedulerFactory ] - Using default implementation for ThreadExecutor
2020-09-02 21:03:43.393 [INFO ] [rg.quartz.core.SchedulerSignalerImpl] - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2020-09-02 21:03:43.393 [INFO ] [org.quartz.core.QuartzScheduler     ] - Quartz Scheduler v.2.2.1 created.
2020-09-02 21:03:43.395 [INFO ] [org.quartz.simpl.RAMJobStore        ] - RAMJobStore initialized.
2020-09-02 21:03:43.396 [INFO ] [org.quartz.core.QuartzScheduler     ] - Scheduler meta-data: Quartz Scheduler (v2.2.1) 'openHAB-job-scheduler' with instanceId 'NON_CLUSTERED'
  Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
  NOT STARTED.
  Currently in standby mode.
  Number of jobs executed: 0
  Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 10 threads.
  Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.

2020-09-02 21:03:43.397 [INFO ] [org.quartz.impl.StdSchedulerFactory ] - Quartz scheduler 'openHAB-job-scheduler' initialized from specified file: 'C:\openhab2\runtime/etc/quartz.properties'
2020-09-02 21:03:43.397 [INFO ] [org.quartz.impl.StdSchedulerFactory ] - Quartz scheduler version: 2.2.1
2020-09-02 21:03:43.398 [INFO ] [org.quartz.core.QuartzScheduler     ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started.
2020-09-02 21:03:44.420 [INFO ] [org.quartz.core.QuartzScheduler     ] - JobFactory set to: org.eclipse.smarthome.model.rule.runtime.internal.engine.GuiceAwareJobFactory@5d556418
2020-09-02 21:03:44.421 [INFO ] [org.quartz.core.QuartzScheduler     ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED paused.
2020-09-02 21:03:44.499 [INFO ] [thome.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2020-09-02 21:03:44.855 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.core.ui_2.5.0 [188]] to http service
2020-09-02 21:03:44.860 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:44.861 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.core.ui_2.5.0 [188], contextID=custom], with context-name: 
2020-09-02 21:03:44.862 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:44.881 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.core.ui_2.5.0 [188], contextID=custom]}
2020-09-02 21:03:44.993 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:44.994 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.core.ui_2.5.0 [188], contextID=default], with context-name: 
2020-09-02 21:03:44.995 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:45.056 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.core.ui_2.5.0 [188], contextID=default]}
2020-09-02 21:03:45.066 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.core.ui.icon_2.5.0 [189]] to http service
2020-09-02 21:03:45.070 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:45.071 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.core.ui.icon_2.5.0 [189], contextID=default], with context-name: 
2020-09-02 21:03:45.072 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:45.090 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.core.ui.icon_2.5.0 [189], contextID=default]}
2020-09-02 21:03:45.136 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.ui.dashboard_2.5.8 [191]] to http service
2020-09-02 21:03:45.143 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:45.144 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.ui.dashboard_2.5.8 [191], contextID=default], with context-name: 
2020-09-02 21:03:45.145 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:45.180 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.dashboard_2.5.8 [191], contextID=default]}
2020-09-02 21:03:45.185 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:45.186 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.ui.dashboard_2.5.8 [191], contextID=custom], with context-name: 
2020-09-02 21:03:45.189 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:45.235 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.dashboard_2.5.8 [191], contextID=custom]}
2020-09-02 21:03:45.238 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at http://192.168.1.43:8080
2020-09-02 21:03:45.239 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at https://192.168.1.43:8443
2020-09-02 21:03:45.375 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.ui.basic_2.5.8 [205]] to http service
2020-09-02 21:03:45.380 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:45.381 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.ui.basic_2.5.8 [205], contextID=custom], with context-name: 
2020-09-02 21:03:45.387 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:45.433 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.basic_2.5.8 [205], contextID=custom]}
2020-09-02 21:03:45.483 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:45.484 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.ui.basic_2.5.8 [205], contextID=custom], with context-name: 
2020-09-02 21:03:45.485 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:45.544 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.basic_2.5.8 [205], contextID=custom]}
2020-09-02 21:03:45.554 [INFO ] [d.internal.element.ServletWebElement] - Ignoring servlet [356] without valid alias or url patterns property.
2020-09-02 21:03:45.589 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.ui.habpanel_2.5.8 [206]] to http service
2020-09-02 21:03:45.610 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:45.611 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.ui.habpanel_2.5.8 [206], contextID=default], with context-name: 
2020-09-02 21:03:45.612 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:45.648 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.habpanel_2.5.8 [206], contextID=default]}
2020-09-02 21:03:45.650 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2020-09-02 21:03:45.659 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.ui.homebuilder_2.5.8 [207]] to http service
2020-09-02 21:03:45.663 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:45.664 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.ui.homebuilder_2.5.8 [207], contextID=default], with context-name: 
2020-09-02 21:03:45.664 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:45.687 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.homebuilder_2.5.8 [207], contextID=default]}
2020-09-02 21:03:45.689 [INFO ] [ebuilder.internal.HomeBuilderServlet] - Started Home Builder at /homebuilder
2020-09-02 21:03:45.704 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.ui.paper_2.5.8 [209]] to http service
2020-09-02 21:03:45.708 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:45.709 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.ui.paper_2.5.8 [209], contextID=custom], with context-name: 
2020-09-02 21:03:45.710 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:45.735 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.paper_2.5.8 [209], contextID=custom]}
2020-09-02 21:03:45.737 [INFO ] [openhab.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui
2020-09-02 21:03:45.786 [INFO ] [rt.modbus.internal.ModbusManagerImpl] - Modbus manager activated
2020-09-02 21:03:47.929 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.core.boot_2.5.0 [137]] to http service
2020-09-02 21:03:47.932 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2020-09-02 21:03:47.933 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.core.boot_2.5.0 [137], contextID=default], with context-name: 
2020-09-02 21:03:47.934 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2020-09-02 21:03:47.952 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.core.boot_2.5.0 [137], contextID=default]}
2020-09-02 21:03:49.432 [INFO ] [org.quartz.core.QuartzScheduler     ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started.
2020-09-02 21:03:57.760 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 17af5426-82aa-442e-b4c4-9be183a960b2]
2020-09-02 21:04:05.348 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID d4cbb8b5-ea0e-47c4-85ec-9bf92a102808]
2020-09-02 21:04:09.907 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 8cd598a1-2586-4567-8eb5-fa32c6b589a5]
2020-09-02 21:04:18.341 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 3216ae76-6f37-4a29-96cc-044c2a3f8a7c]
2020-09-02 21:04:29.390 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - connect try 1/1 error: connect timed out. Connection TCPMasterConnection@3d91f308[socket=Socket[unconnected]]. Endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]
2020-09-02 21:04:29.392 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - re-connect reached max tries 1, throwing last error: connect timed out. Connection TCPMasterConnection@3d91f308[socket=Socket[unconnected]]. Endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]
2020-09-02 21:04:29.394 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - Error connecting connection TCPMasterConnection@3d91f308[socket=Socket[unconnected]] for endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]: connect timed out
2020-09-02 21:04:29.401 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Could not connect to endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502] -- aborting request ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3] [operation ID 17af5426-82aa-442e-b4c4-9be183a960b2]
2020-09-02 21:04:29.416 [ERROR] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:HVAC:hvacpoll:reg32768 'Modbus Data' had ModbusConnectionException error on read: ModbusConnectionException(Error connecting to endpoint=ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502])
2020-09-02 21:04:34.403 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 2 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID d4cbb8b5-ea0e-47c4-85ec-9bf92a102808]
2020-09-02 21:04:42.196 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 2 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 8cd598a1-2586-4567-8eb5-fa32c6b589a5]
2020-09-02 21:04:48.992 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 2 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 3216ae76-6f37-4a29-96cc-044c2a3f8a7c]
2020-09-02 21:05:02.296 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID c879363c-cdbe-4c36-a439-69ab9e4b0df0]
2020-09-02 21:05:05.123 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID fe77ebe2-edf4-46e4-89b1-75d46f700d11]
2020-09-02 21:05:07.709 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID 4e035d25-a50f-47c7-bfaa-109a5844da4c]
2020-09-02 21:05:40.014 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID 5a16c0fa-3763-47da-a662-fb76af2e5c84]
2020-09-02 21:06:14.713 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID be8b91f8-70cc-45c4-9ca4-bb7ffefb9f44]
2020-09-02 21:09:26.880 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID b3b22032-eca5-4d09-b405-dafac1cbe7d6]
2020-09-02 21:09:39.212 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 3e5a0158-e03f-440f-b0a8-99859020dc4f]
2020-09-02 21:09:51.909 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 2 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 3e5a0158-e03f-440f-b0a8-99859020dc4f]
2020-09-02 21:10:01.788 [ERROR] [rt.modbus.internal.ModbusManagerImpl] - Last try 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Aborting. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 3e5a0158-e03f-440f-b0a8-99859020dc4f]
2020-09-02 21:10:02.608 [ERROR] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:HVAC:hvacpoll:reg32768 'Modbus Data' had ModbusSlaveIOExceptionImpl error on read: ModbusSlaveIOException(cause=ModbusIOException, EOF=false, message='I/O exception: SocketTimeoutException Read timed out', cause2=null)
2020-09-02 21:10:10.484 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID afc633c3-459f-446d-9a60-81d841c276e4]
2020-09-02 21:10:21.516 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - connect try 1/1 error: connect timed out. Connection TCPMasterConnection@33ee7825[socket=Socket[unconnected]]. Endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]
2020-09-02 21:10:21.518 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - re-connect reached max tries 1, throwing last error: connect timed out. Connection TCPMasterConnection@33ee7825[socket=Socket[unconnected]]. Endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]
2020-09-02 21:10:21.519 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - Error connecting connection TCPMasterConnection@33ee7825[socket=Socket[unconnected]] for endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]: connect timed out
2020-09-02 21:10:21.520 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Could not connect to endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502] -- aborting request ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3] [operation ID afc633c3-459f-446d-9a60-81d841c276e4]
2020-09-02 21:10:21.522 [ERROR] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:HVAC:hvacpoll:reg32768 'Modbus Data' had ModbusConnectionException error on read: ModbusConnectionException(Error connecting to endpoint=ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502])
2020-09-02 21:10:31.800 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - connect try 1/1 error: connect timed out. Connection TCPMasterConnection@37a02772[socket=Socket[unconnected]]. Endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]
2020-09-02 21:10:31.801 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - re-connect reached max tries 1, throwing last error: connect timed out. Connection TCPMasterConnection@37a02772[socket=Socket[unconnected]]. Endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]
2020-09-02 21:10:31.802 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - Error connecting connection TCPMasterConnection@37a02772[socket=Socket[unconnected]] for endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]: connect timed out
2020-09-02 21:10:31.803 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Could not connect to endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502] -- aborting request ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3] [operation ID 7bff0744-02b4-4cef-a0e1-4ec6f9a25208]
2020-09-02 21:10:31.805 [ERROR] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:HVAC:hvacpoll:reg32768 'Modbus Data' had ModbusConnectionException error on read: ModbusConnectionException(Error connecting to endpoint=ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502])
2020-09-02 21:10:37.793 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID c2061362-790d-4485-a41d-b96eb10b8148]
2020-09-02 21:10:48.853 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - connect try 1/1 error: connect timed out. Connection TCPMasterConnection@4daa2adb[socket=Socket[unconnected]]. Endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]
2020-09-02 21:10:48.854 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - re-connect reached max tries 1, throwing last error: connect timed out. Connection TCPMasterConnection@4daa2adb[socket=Socket[unconnected]]. Endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]
2020-09-02 21:10:48.857 [ERROR] [ing.ModbusSlaveConnectionFactoryImpl] - Error connecting connection TCPMasterConnection@4daa2adb[socket=Socket[unconnected]] for endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502]: connect timed out
2020-09-02 21:10:48.858 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Could not connect to endpoint ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502] -- aborting request ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3] [operation ID c2061362-790d-4485-a41d-b96eb10b8148]
2020-09-02 21:10:48.860 [ERROR] [ernal.handler.ModbusDataThingHandler] - Thing modbus:data:HVAC:hvacpoll:reg32768 'Modbus Data' had ModbusConnectionException error on read: ModbusConnectionException(Error connecting to endpoint=ModbusTCPSlaveEndpoint@5064b4a1[address=192.168.1.111,port=502])
2020-09-02 21:11:08.757 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID 305234c2-f14d-4f7e-8fa0-2f161b07ccee]
2020-09-02 21:11:16.895 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID 5b2045dc-beb0-431f-af93-1418fbc3fbbf]
2020-09-02 21:17:51.065 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketException Connection reset [operation ID 55b7614f-7d13-43c4-b472-f2ffa1d5887d]
2020-09-02 21:40:57.156 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 0de49bf7-e146-44f1-86f6-09bc2b860d1b]
2020-09-02 21:41:09.817 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request (ModbusPollerThingHandler.ModbusPollerReadRequest@327b1bb1[slaveId=1,functionCode=READ_MULTIPLE_REGISTERS,start=32768,length=1,maxTries=3]). Will try again soon. Error was I/O error, so reseting the connection. Error details: net.wimpi.modbus.ModbusIOException I/O exception: SocketTimeoutException Read timed out [operation ID 1d7effe0-f57c-4709-854b-c1c26e3be3b5]
2020-09-02 21:41:20.307 [WARN ] [rt.modbus.internal.ModbusManagerImpl] - Try 1 out of 3 failed when executing request