RaZberry stopped working

Tags: #<Tag:0x00007efedde890f8> #<Tag:0x00007efedde89008>

Hello!
I had to switch to a newly installed SD-Card due to the old one dying. After copying all the old files over, after starting the new instance of OpenHAB (1.81) the Zwave-Network did not start up as it used to.

A Razberry Board is used, which worked fine before.

Is this a sign of the board dying, too?

Attached the log file, has anybody seen something similar?

Bye, Frido

2016-03-04 16:45:08.537 [DEBUG] [.zwave.internal.ZWaveActivator:36 ]- Z-Wave binding started. Version 1.8.1 2016-03-04 16:45:08.798 [DEBUG] [.z.internal.ZWaveActiveBinding:175 ]- ConverterHandler not initialised. Polling disabled. 2016-03-04 16:45:08.812 [INFO ] [.z.internal.ZWaveActiveBinding:325 ]- Update config, port = /dev/ttyAMA0 2016-03-04 16:45:08.814 [INFO ] [.z.internal.ZWaveActiveBinding:330 ]- Update config, healtime = 2 2016-03-04 16:45:08.816 [INFO ] [.z.internal.ZWaveActiveBinding:375 ]- Update config, setSUC = false 2016-03-04 16:45:08.817 [INFO ] [.z.internal.ZWaveActiveBinding:393 ]- Update config, masterController = true 2016-03-04 16:45:08.819 [DEBUG] [.z.internal.ZWaveActiveBinding:282 ]- Initialising zwave binding 2016-03-04 16:45:09.011 [INFO ] [b.z.i.protocol.ZWaveController:148 ]- Starting Z-Wave controller 2016-03-04 16:45:09.013 [INFO ] [b.z.i.protocol.ZWaveController:156 ]- Z-Wave timeout is set to 5000ms. Soft reset is false. 2016-03-04 16:45:09.015 [INFO ] [b.z.i.protocol.ZWaveController:322 ]- Connecting to serial port /dev/ttyAMA0 2016-03-04 16:45:09.203 [ERROR] [b.z.i.protocol.ZWaveController:344 ]- Serial Error: Port /dev/ttyAMA0 does not exist 2016-03-04 16:46:53.854 [DEBUG] [.zwave.internal.ZWaveActivator:36 ]- Z-Wave binding started. Version 1.8.1 2016-03-04 16:46:54.056 [DEBUG] [.z.internal.ZWaveActiveBinding:175 ]- ConverterHandler not initialised. Polling disabled. 2016-03-04 16:46:57.915 [INFO ] [.z.internal.ZWaveActiveBinding:325 ]- Update config, port = /dev/ttyAMA0 2016-03-04 16:47:02.620 [INFO ] [.z.internal.ZWaveActiveBinding:330 ]- Update config, healtime = 2 2016-03-04 16:47:02.633 [INFO ] [.z.internal.ZWaveActiveBinding:375 ]- Update config, setSUC = false 2016-03-04 16:47:02.638 [INFO ] [.z.internal.ZWaveActiveBinding:393 ]- Update config, masterController = true 2016-03-04 16:47:02.641 [DEBUG] [.z.internal.ZWaveActiveBinding:282 ]- Initialising zwave binding 2016-03-04 16:47:02.855 [INFO ] [b.z.i.protocol.ZWaveController:148 ]- Starting Z-Wave controller 2016-03-04 16:47:02.857 [INFO ] [b.z.i.protocol.ZWaveController:156 ]- Z-Wave timeout is set to 5000ms. Soft reset is false. 2016-03-04 16:47:02.859 [INFO ] [b.z.i.protocol.ZWaveController:322 ]- Connecting to serial port /dev/ttyAMA0 2016-03-04 16:47:03.074 [DEBUG] [eController$ZWaveReceiveThread:1413]- Starting Z-Wave thread: Receive 2016-03-04 16:47:03.095 [DEBUG] [WaveController$ZWaveSendThread:1197]- Starting Z-Wave thread: Send 2016-03-04 16:47:03.116 [INFO ] [b.z.i.protocol.ZWaveController:342 ]- Serial port is initialized 2016-03-04 16:47:03.118 [DEBUG] [b.z.i.protocol.ZWaveController:1154]- Starting Z-Wave thread: Input 2016-03-04 16:47:06.136 [DEBUG] [veController$WatchDogTimerTask:178 ]- Initialising network 2016-03-04 16:47:06.162 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 255: Creating empty message of class = GetVersion (0x15), type = Request (0x00) 2016-03-04 16:47:06.164 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 1 2016-03-04 16:47:06.164 [DEBUG] [WaveController$ZWaveSendThread:1211]- Took message from queue for sending. Queue length = 0 2016-03-04 16:47:06.169 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 255: Creating empty message of class = MemoryGetId (0x20), type = Request (0x00) 2016-03-04 16:47:06.171 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 1 2016-03-04 16:47:06.174 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 03 00 15 E9 2016-03-04 16:47:06.177 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 255: Creating empty message of class = SerialApiGetCapabilities (0x07), type = Request (0x00) 2016-03-04 16:47:06.179 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 2 2016-03-04 16:47:06.178 [DEBUG] [WaveController$ZWaveSendThread:1268]- NODE 255: Sending REQUEST Message = 01 03 00 15 E9 2016-03-04 16:47:06.188 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 255: Creating empty message of class = SerialApiSetTimeouts (0x06), type = Request (0x00) 2016-03-04 16:47:06.190 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 3 2016-03-04 16:47:06.194 [DEBUG] [i.p.s.GetSucNodeIdMessageClass:30 ]- Get SUC NodeID 2016-03-04 16:47:06.196 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 255: Creating empty message of class = GetSucNodeId (0x56), type = Request (0x00) 2016-03-04 16:47:06.197 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 4 2016-03-04 16:47:07.676 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ]- Network Monitor: Queue length is 4 - deferring network monitor functions. 2016-03-04 16:47:11.192 [ERROR] [WaveController$ZWaveSendThread:1309]- NODE 255: Timeout while sending message. Requeueing - 2 attempts left! 2016-03-04 16:47:11.195 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 5 2016-03-04 16:47:11.197 [DEBUG] [WaveController$ZWaveSendThread:1211]- Took message from queue for sending. Queue length = 4 2016-03-04 16:47:11.201 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 03 00 15 E9 2016-03-04 16:47:11.204 [DEBUG] [WaveController$ZWaveSendThread:1268]- NODE 255: Sending REQUEST Message = 01 03 00 15 E9 2016-03-04 16:47:12.679 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ]- Network Monitor: Queue length is 4 - deferring network monitor functions. 2016-03-04 16:47:16.225 [ERROR] [WaveController$ZWaveSendThread:1309]- NODE 255: Timeout while sending message. Requeueing - 1 attempts left! 2016-03-04 16:47:16.227 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 5 2016-03-04 16:47:16.230 [DEBUG] [WaveController$ZWaveSendThread:1211]- Took message from queue for sending. Queue length = 4 2016-03-04 16:47:16.235 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 03 00 15 E9 2016-03-04 16:47:16.238 [DEBUG] [WaveController$ZWaveSendThread:1268]- NODE 255: Sending REQUEST Message = 01 03 00 15 E9 2016-03-04 16:47:17.681 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ]- Network Monitor: Queue length is 4 - deferring network monitor functions. 2016-03-04 16:47:21.256 [ERROR] [WaveController$ZWaveSendThread:1309]- NODE 255: Timeout while sending message. Requeueing - 0 attempts left! 2016-03-04 16:47:21.257 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 5 2016-03-04 16:47:21.259 [DEBUG] [WaveController$ZWaveSendThread:1211]- Took message from queue for sending. Queue length = 4 2016-03-04 16:47:21.263 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 03 00 15 E9 2016-03-04 16:47:21.268 [DEBUG] [WaveController$ZWaveSendThread:1268]- NODE 255: Sending REQUEST Message = 01 03 00 15 E9 2016-03-04 16:47:22.682 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ]- Network Monitor: Queue length is 4 - deferring network monitor functions. 2016-03-04 16:47:26.306 [WARN ] [WaveController$ZWaveSendThread:1318]- NODE 255: Too many retries. Discarding message: Message: class = GetVersion (0x15), type = Request (0x00), payload = 2016-03-04 16:47:26.308 [DEBUG] [WaveController$ZWaveSendThread:1211]- Took message from queue for sending. Queue length = 3 2016-03-04 16:47:26.311 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 03 00 20 DC 2016-03-04 16:47:26.314 [DEBUG] [WaveController$ZWaveSendThread:1268]- NODE 255: Sending REQUEST Message = 01 03 00 20 DC 2016-03-04 16:47:27.684 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ]- Network Monitor: Queue length is 3 - deferring network monitor functions. 2016-03-04 16:47:31.335 [ERROR] [WaveController$ZWaveSendThread:1309]- NODE 255: Timeout while sending message. Requeueing - 2 attempts left! 2016-03-04 16:47:31.337 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 4 2016-03-04 16:47:32.921 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ]- Network Monitor: Queue length is 4 - deferring network monitor functions. 2016-03-04 16:47:35.396 [DEBUG] [WaveController$ZWaveSendThread:1211]- Took message from queue for sending. Queue length = 3 2016-03-04 16:47:35.400 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 03 00 20 DC 2016-03-04 16:47:35.402 [DEBUG] [WaveController$ZWaveSendThread:1268]- NODE 255: Sending REQUEST Message = 01 03 00 20 DC 2016-03-04 16:47:40.398 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ]- Network Monitor: Queue length is 3 - deferring network monitor functions. 2016-03-04 16:47:40.415 [ERROR] [WaveController$ZWaveSendThread:1309]- NODE 255: Timeout while sending message. Requeueing - 1 attempts left! 2016-03-04 16:47:40.417 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 4 2016-03-04 16:47:40.418 [DEBUG] [WaveController$ZWaveSendThread:1211]- Took message from queue for sending. Queue length = 3 2016-03-04 16:47:40.421 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 03 00 20 DC 2016-03-04 16:47:40.424 [DEBUG] [WaveController$ZWaveSendThread:1268]- NODE 255: Sending REQUEST Message = 01 03 00 20 DC 2016-03-04 16:47:45.399 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ]- Network Monitor: Queue length is 3 - deferring network monitor functions. 2016-03-04 16:47:45.445 [ERROR] [WaveController$ZWaveSendThread:1309]- NODE 255: Timeout while sending message. Requeueing - 0 attempts left! 2016-03-04 16:47:45.446 [DEBUG] [b.z.i.protocol.ZWaveController:620 ]- Enqueueing message. Queue length = 4 2016-03-04 16:47:45.447 [DEBUG] [WaveController$ZWaveSendThread:1211]- Took message from queue for sending. Queue length = 3 2016-03-04 16:47:45.450 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 03 00 20 DC 2016-03-04 16:47:45.453 [DEBUG] [WaveController$ZWaveSendThread:1268]- NODE 255: Sending REQUEST Message = 01 03 00 20 DC 2016-03-04 16:47:45.455 [ERROR] [WaveController$ZWaveSendThread:1278]- Got I/O exception Eingabe-/Ausgabefehler in writeArray during sending. exiting thread. 2016-03-04 16:47:45.456 [DEBUG] [WaveController$ZWaveSendThread:1338]- Stopped Z-Wave thread: Send 2016-03-04 16:47:50.401 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ]- Network Monitor: Queue length is 3 - deferring network monitor functions. 2016-03-04 16:47:53.130 [WARN ] [veController$WatchDogTimerTask:1554]- Threads not alive, respawning

Got it fixed:

The culprit was the Serial Console, which was blocking the /dev/ttyAMA0 port.
Switched off the serial console via raspi-config/Advanced/Serial, rebooted and all was well.

Thanks for listening…:slight_smile:

Bye, Frido.