job queue runs full after upgrade to v4.1.0

Official announcements from Z-Wave.Me team. Check this forum to get information about new releases and bug fixes.
Post Reply
RolfKunkel
Posts: 55
Joined: 03 Jan 2017 18:35

job queue runs full after upgrade to v4.1.0

Post by RolfKunkel »

Hi Folks,

Two days ago I upgraded Z-Way SW from v4.0.3 to v4.1.0 and since that time my smart home is no longer working stable. Two times per day I have to restart Z-Way because there are jobs hanging in the job queue blocking the processing of commands. Switching a light on or off is no longer working then.

It seems some jobs are blocking the job queue and new actions let the queue growing and growing without being processed. A Z-Way restart clears the queue and at least for a few hours the system works stable.

Am I the only one having this problem with v4.1.0? Any idea what could trigger the issue?

Rolf
User avatar
PoltoS
Posts: 7391
Joined: 26 Jan 2011 19:36

Re: job queue runs full after upgrade to v4.1.0

Post by PoltoS »

Please provide us more information: log, queue screenshot, description of the error
RolfKunkel
Posts: 55
Joined: 03 Jan 2017 18:35

Re: job queue runs full after upgrade to v4.1.0

Post by RolfKunkel »

Can you instruct me please how to find the log file
J.nissen
Posts: 94
Joined: 02 Sep 2016 22:12

Re: job queue runs full after upgrade to v4.1.0

Post by J.nissen »

Hello,
same issue.

--- Log ---

[2023-05-23 19:17:39.284] [D] [zway] SETDATA devices.56.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:17:39.285] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.precision = 0 (0x00000000)
[2023-05-23 19:17:39.285] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:17:39.285] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:17:39.285] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.delta = 0 (0x00000000)
[2023-05-23 19:17:39.285] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:17:39.285] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:17:39.295] [core] HK: updated ZWayVDev_zway_56-0-50-2
[2023-05-23 19:17:39.493] [D] [zway] Job 0x3b (Get background noise level): removing duplicate
[2023-05-23 19:17:51.471] [D] [zway] RECEIVED: ( 01 24 00 04 00 33 1A 9F 03 F3 00 86 52 5B 2C DA FD AB DE E3 17 2C 2A 84 34 7D C0 B3 EB 95 65 00 87 AD 00 01 05 11 )
[2023-05-23 19:17:51.472] [D] [zway] SENT ACK
[2023-05-23 19:17:51.472] [D] [zway] SETDATA devices.51.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:17:51.472] [zway] Node 51:0 CC SecurityS2: passing S2 Unauthenticated decrypted packet to application level: [ 32 02 21 44 80 00 1f ee 01 2d 80 00 1f ee ]
[2023-05-23 19:17:51.473] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.0.precision = 2 (0x00000002)
[2023-05-23 19:17:51.473] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.0.intVal = -2147475474 (0x80001fee)
[2023-05-23 19:17:51.473] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.0.val = -21474754.000000
[2023-05-23 19:17:51.473] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.0.delta = 301 (0x0000012d)
[2023-05-23 19:17:51.473] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.0.ratetype = 1 (0x00000001)
[2023-05-23 19:17:51.473] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.0.previous = -21474754.000000
[2023-05-23 19:17:51.473] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.0 = Empty
[2023-05-23 19:17:51.484] [core] HK: updated ZWayVDev_zway_51-0-50-0
[2023-05-23 19:17:52.056] [D] [zway] RECEIVED: ( 01 24 00 04 00 33 1A 9F 03 F4 00 C0 9D FB 34 43 EC 3B 5E 2A 5B 76 07 44 7A 68 FE 4F 87 BE 1F 66 4C AD 00 01 05 84 )
[2023-05-23 19:17:52.056] [D] [zway] SENT ACK
[2023-05-23 19:17:52.056] [D] [zway] SETDATA devices.51.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:17:52.057] [zway] Node 51:0 CC SecurityS2: passing S2 Unauthenticated decrypted packet to application level: [ 32 02 21 54 00 00 00 00 01 2d 00 00 00 00 ]
[2023-05-23 19:17:52.057] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.2.precision = 2 (0x00000002)
[2023-05-23 19:17:52.057] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:17:52.057] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:17:52.058] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.2.delta = 301 (0x0000012d)
[2023-05-23 19:17:52.058] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:17:52.058] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.2.previous = 0.000000
[2023-05-23 19:17:52.058] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:17:52.061] [core] HK: updated ZWayVDev_zway_51-0-50-2
[2023-05-23 19:17:52.626] [D] [zway] RECEIVED: ( 01 20 00 04 00 33 16 9F 03 F5 00 C5 D7 61 B5 F0 B9 F2 66 71 6D F0 67 A2 E9 8B B3 CE 8E AA 00 01 05 9A )
[2023-05-23 19:17:52.627] [D] [zway] SENT ACK
[2023-05-23 19:17:52.627] [D] [zway] SETDATA devices.51.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:17:52.627] [zway] Node 51:0 CC SecurityS2: passing S2 Unauthenticated decrypted packet to application level: [ 32 02 a1 42 5d 7d 01 2d 5d 69 ]
[2023-05-23 19:17:52.628] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.4.precision = 2 (0x00000002)
[2023-05-23 19:17:52.628] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.4.intVal = 23933 (0x00005d7d)
[2023-05-23 19:17:52.628] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.4.val = 239.330002
[2023-05-23 19:17:52.628] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.4.delta = 301 (0x0000012d)
[2023-05-23 19:17:52.628] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.4.ratetype = 1 (0x00000001)
[2023-05-23 19:17:52.628] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.4.previous = 239.130005
[2023-05-23 19:17:52.628] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.4 = Empty
[2023-05-23 19:17:52.640] [core] HK: updated ZWayVDev_zway_51-0-50-4
[2023-05-23 19:17:52.666] [core] [BaseModule-19] Set lastLevel to 239.3299968 for ZWayVDev_zway_51-0-50-4 (was 239.1300096)
[2023-05-23 19:17:53.194] [D] [zway] RECEIVED: ( 01 20 00 04 00 33 16 9F 03 F6 00 8A 47 A4 05 74 FC 0A 8B CD CE 79 13 B1 34 EB 55 11 CA AC 00 01 05 D0 )
[2023-05-23 19:17:53.195] [D] [zway] SENT ACK
[2023-05-23 19:17:53.195] [D] [zway] SETDATA devices.51.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:17:53.195] [zway] Node 51:0 CC SecurityS2: passing S2 Unauthenticated decrypted packet to application level: [ 32 02 a1 4a 00 00 01 2d 00 00 ]
[2023-05-23 19:17:53.195] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.5.precision = 2 (0x00000002)
[2023-05-23 19:17:53.196] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.5.intVal = 0 (0x00000000)
[2023-05-23 19:17:53.196] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.5.val = 0.000000
[2023-05-23 19:17:53.196] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.5.delta = 301 (0x0000012d)
[2023-05-23 19:17:53.196] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.5.ratetype = 1 (0x00000001)
[2023-05-23 19:17:53.196] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.5.previous = 0.000000
[2023-05-23 19:17:53.196] [D] [zway] SETDATA devices.51.instances.0.commandClasses.50.data.5 = Empty
[2023-05-23 19:17:53.208] [core] HK: updated ZWayVDev_zway_51-0-50-5
[2023-05-23 19:18:09.287] [D] [zway] RECEIVED: ( 01 13 00 04 00 38 0A 32 02 21 12 00 00 00 00 00 00 C8 00 00 11 )
[2023-05-23 19:18:09.287] [D] [zway] SENT ACK
[2023-05-23 19:18:09.287] [D] [zway] SETDATA devices.56.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:18:09.287] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.precision = 0 (0x00000000)
[2023-05-23 19:18:09.287] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:18:09.287] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:18:09.287] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.delta = 0 (0x00000000)
[2023-05-23 19:18:09.287] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:18:09.288] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:18:09.290] [I] [core] HK: updated ZWayVDev_zway_56-0-50-2
[2023-05-23 19:18:09.504] [D] [zway] Job 0x3b (Get background noise level): removing duplicate
[2023-05-23 19:18:38.406] [I] [core] [Astronomy] Calculate
[2023-05-23 19:18:38.411] [I] [core] Notification: device-info (device-status): {"dev":"Solar altitude","l":"16.72 °","location":0}
[2023-05-23 19:18:38.412] [I] [core] HK: updated Astronomy_15_altitude
[2023-05-23 19:18:38.423] [I] [core] Notification: device-info (device-status): {"dev":"Solar azimuth","l":"282.12 °","location":0}
[2023-05-23 19:18:38.424] [I] [core] HK: updated Astronomy_15_azimuth
[2023-05-23 19:18:38.472] [I] [core] [BaseModule-19] Set lastLevel to 16.72 for Astronomy_15_altitude (was 16.87)
[2023-05-23 19:18:38.475] [I] [core] [BaseModule-19] Set lastLevel to 282.12 for Astronomy_15_azimuth (was 281.92)
[2023-05-23 19:18:39.290] [D] [zway] RECEIVED: ( 01 13 00 04 00 38 0A 32 02 21 12 00 00 00 00 00 00 C8 00 00 11 )
[2023-05-23 19:18:39.290] [D] [zway] SENT ACK
[2023-05-23 19:18:39.290] [D] [zway] SETDATA devices.56.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:18:39.290] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.precision = 0 (0x00000000)
[2023-05-23 19:18:39.291] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:18:39.291] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:18:39.291] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.delta = 0 (0x00000000)
[2023-05-23 19:18:39.291] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:18:39.291] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:18:39.299] [I] [core] HK: updated ZWayVDev_zway_56-0-50-2
[2023-05-23 19:18:39.507] [D] [zway] Job 0x3b (Get background noise level): removing duplicate
[2023-05-23 19:18:54.652] [D] [zway] RECEIVED: ( 01 0C 00 04 00 09 02 84 07 B6 00 01 24 EC )
[2023-05-23 19:18:54.652] [D] [zway] SENT ACK
[2023-05-23 19:18:54.652] [D] [zway] SETDATA devices.9.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:18:54.652] [I] [zway] Node 9:0 CC Wakeup: Wakeup notification
[2023-05-23 19:18:54.653] [D] [zway] SETDATA devices.9.instances.0.commandClasses.132.data.lastWakeup = 1684862334 (0x646cf57e)
[2023-05-23 19:18:54.653] [D] [zway] SETDATA devices.9.data.lastSendInternal = **********
[2023-05-23 19:18:54.653] [D] [zway] SETDATA devices.9.data.lastNonceGet = 4719486 (0x0048037e)
[2023-05-23 19:18:54.653] [D] [zway] Running wakeup handler for node 9
[2023-05-23 19:18:54.653] [D] [zway] SETDATA devices.9.instances.0.commandClasses.132.data.lastSleep = 1684862334 (0x646cf57e)
[2023-05-23 19:18:54.653] [I] [zway] Node 9:0 CC Wakeup: Send node to sleep
[2023-05-23 19:18:54.653] [D] [zway] Job 0x13 (Wakeup Sleep): removing duplicate
[2023-05-23 19:19:09.293] [D] [zway] RECEIVED: ( 01 13 00 04 00 38 0A 32 02 21 12 00 00 00 00 00 00 C8 00 00 11 )
[2023-05-23 19:19:09.293] [D] [zway] SENT ACK
[2023-05-23 19:19:09.293] [D] [zway] SETDATA devices.56.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:19:09.293] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.precision = 0 (0x00000000)
[2023-05-23 19:19:09.293] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:19:09.294] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:19:09.294] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.delta = 0 (0x00000000)
[2023-05-23 19:19:09.294] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:19:09.294] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:19:09.329] [I] [core] HK: updated ZWayVDev_zway_56-0-50-2
[2023-05-23 19:19:09.525] [D] [zway] Job 0x3b (Get background noise level): removing duplicate
[2023-05-23 19:19:23.703] [D] [zway] Job 0x3a (Get statistics gathered by the Z-Wave protocol): removing duplicate
[2023-05-23 19:19:38.409] [I] [core] [Astronomy] Calculate
[2023-05-23 19:19:38.416] [I] [core] Notification: device-info (device-status): {"dev":"Solar altitude","l":"16.58 °","location":0}
[2023-05-23 19:19:38.419] [I] [core] HK: updated Astronomy_15_altitude
[2023-05-23 19:19:38.429] [I] [core] Notification: device-info (device-status): {"dev":"Solar azimuth","l":"282.31 °","location":0}
[2023-05-23 19:19:38.429] [I] [core] HK: updated Astronomy_15_azimuth
[2023-05-23 19:19:38.472] [I] [core] [BaseModule-19] Set lastLevel to 16.58 for Astronomy_15_altitude (was 16.72)
[2023-05-23 19:19:38.474] [I] [core] [BaseModule-19] Set lastLevel to 282.31 for Astronomy_15_azimuth (was 282.12)
[2023-05-23 19:19:39.296] [D] [zway] RECEIVED: ( 01 13 00 04 00 38 0A 32 02 21 12 00 00 00 00 00 00 C8 00 00 11 )
[2023-05-23 19:19:39.296] [D] [zway] SENT ACK
[2023-05-23 19:19:39.296] [D] [zway] SETDATA devices.56.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:19:39.296] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.precision = 0 (0x00000000)
[2023-05-23 19:19:39.296] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:19:39.297] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:19:39.297] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.delta = 0 (0x00000000)
[2023-05-23 19:19:39.297] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:19:39.297] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:19:39.309] [I] [core] HK: updated ZWayVDev_zway_56-0-50-2
[2023-05-23 19:19:39.535] [D] [zway] Job 0x3b (Get background noise level): removing duplicate
[2023-05-23 19:20:09.299] [D] [zway] RECEIVED: ( 01 13 00 04 00 38 0A 32 02 21 12 00 00 00 00 00 00 C8 00 00 11 )
[2023-05-23 19:20:09.299] [D] [zway] SENT ACK
[2023-05-23 19:20:09.299] [D] [zway] SETDATA devices.56.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:20:09.299] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.precision = 0 (0x00000000)
[2023-05-23 19:20:09.299] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:20:09.300] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:20:09.300] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.delta = 0 (0x00000000)
[2023-05-23 19:20:09.300] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:20:09.300] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:20:09.304] [I] [core] HK: updated ZWayVDev_zway_56-0-50-2
[2023-05-23 19:20:09.554] [D] [zway] Job 0x3b (Get background noise level): removing duplicate
[2023-05-23 19:20:38.410] [I] [core] [Astronomy] Calculate
[2023-05-23 19:20:38.416] [I] [core] Notification: device-info (device-status): {"dev":"Solar altitude","l":"16.44 °","location":0}
[2023-05-23 19:20:38.417] [I] [core] HK: updated Astronomy_15_altitude
[2023-05-23 19:20:38.427] [I] [core] Notification: device-info (device-status): {"dev":"Solar azimuth","l":"282.51 °","location":0}
[2023-05-23 19:20:38.427] [I] [core] HK: updated Astronomy_15_azimuth
[2023-05-23 19:20:38.475] [I] [core] [BaseModule-19] Set lastLevel to 16.44 for Astronomy_15_altitude (was 16.58)
[2023-05-23 19:20:38.478] [I] [core] [BaseModule-19] Set lastLevel to 282.51 for Astronomy_15_azimuth (was 282.31)
[2023-05-23 19:20:39.302] [D] [zway] RECEIVED: ( 01 13 00 04 00 38 0A 32 02 21 12 00 00 00 00 00 00 C8 00 00 11 )
[2023-05-23 19:20:39.302] [D] [zway] SENT ACK
[2023-05-23 19:20:39.302] [D] [zway] SETDATA devices.56.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:20:39.302] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.precision = 0 (0x00000000)
[2023-05-23 19:20:39.302] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:20:39.302] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:20:39.303] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.delta = 0 (0x00000000)
[2023-05-23 19:20:39.303] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:20:39.303] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:20:39.312] [I] [core] HK: updated ZWayVDev_zway_56-0-50-2
[2023-05-23 19:20:39.571] [D] [zway] Job 0x3b (Get background noise level): removing duplicate
[2023-05-23 19:21:09.305] [D] [zway] RECEIVED: ( 01 13 00 04 00 38 0A 32 02 21 12 00 00 00 00 00 00 C8 00 00 11 )
[2023-05-23 19:21:09.305] [D] [zway] SENT ACK
[2023-05-23 19:21:09.305] [D] [zway] SETDATA devices.56.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:21:09.305] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.precision = 0 (0x00000000)
[2023-05-23 19:21:09.305] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:21:09.306] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:21:09.306] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.delta = 0 (0x00000000)
[2023-05-23 19:21:09.306] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:21:09.306] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:21:09.340] [I] [core] HK: updated ZWayVDev_zway_56-0-50-2
[2023-05-23 19:21:09.575] [D] [zway] Job 0x3b (Get background noise level): removing duplicate
[2023-05-23 19:21:38.438] [I] [core] [Astronomy] Calculate
[2023-05-23 19:21:38.447] [I] [core] Notification: device-info (device-status): {"dev":"Solar altitude","l":"16.3 °","location":0}
[2023-05-23 19:21:38.450] [I] [core] HK: updated Astronomy_15_altitude
[2023-05-23 19:21:38.464] [I] [core] Notification: device-info (device-status): {"dev":"Solar azimuth","l":"282.7 °","location":0}
[2023-05-23 19:21:38.465] [I] [core] HK: updated Astronomy_15_azimuth
[2023-05-23 19:21:38.510] [I] [core] [BaseModule-19] Set lastLevel to 16.3 for Astronomy_15_altitude (was 16.44)
[2023-05-23 19:21:38.512] [I] [core] [BaseModule-19] Set lastLevel to 282.7 for Astronomy_15_azimuth (was 282.51)
[2023-05-23 19:21:39.308] [D] [zway] RECEIVED: ( 01 13 00 04 00 38 0A 32 02 21 12 00 00 00 00 00 00 C8 00 00 11 )
[2023-05-23 19:21:39.308] [D] [zway] SENT ACK
[2023-05-23 19:21:39.312] [D] [zway] SETDATA devices.56.data.lastReceived = 0 (0x00000000)
[2023-05-23 19:21:39.312] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.precision = 0 (0x00000000)
[2023-05-23 19:21:39.312] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.intVal = 0 (0x00000000)
[2023-05-23 19:21:39.312] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.val = 0.000000
[2023-05-23 19:21:39.312] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.delta = 0 (0x00000000)
[2023-05-23 19:21:39.313] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2.ratetype = 1 (0x00000001)
[2023-05-23 19:21:39.313] [D] [zway] SETDATA devices.56.instances.0.commandClasses.50.data.2 = Empty
[2023-05-23 19:21:39.317] [I] [core] HK: updated ZWayVDev_zway_56-0-50-2
[2023-05-23 19:21:39.589] [D] [zway] Job 0x3b (Get background noise level): removing duplicate


I have Downgrade per Bash. GUI doesn´t work.

export BUILD=4.0.3-lws16; cd /tmp/ && wget https://storage.z-wave.me/z-way-server/ ... _armhf.deb && sudo dpkg -i z-way-${BUILD}_armhf.deb
Last edited by J.nissen on 23 May 2023 20:43, edited 1 time in total.
Greetings from germany
Jörg

Raspi 4(Buster), Zwave Version 4.0.2 Raz 7 Pro, Serial API Version:07.13(SDK 7.17)
J.nissen
Posts: 94
Joined: 02 Sep 2016 22:12

Re: job queue runs full after upgrade to v4.1.0

Post by J.nissen »

RolfKunkel wrote:
23 May 2023 15:05
Can you instruct me please how to find the log file
/var/log/z-way-server.log
Greetings from germany
Jörg

Raspi 4(Buster), Zwave Version 4.0.2 Raz 7 Pro, Serial API Version:07.13(SDK 7.17)
RolfKunkel
Posts: 55
Joined: 03 Jan 2017 18:35

Re: job queue runs full after upgrade to v4.1.0

Post by RolfKunkel »

My system worked fine the last 6 days but today the issue is back. The job queue is growing and growing and for example switching lamps on / off via the GUI is not working.With each new command given via the GUI the job queue is growing and even without giving commands via GUI it is growing. Only a restart helps. Screenshot attached

The job queue is full with "Security S2 Nonce Report" entries.

Taking a log file is a bit difficult on my side. I hope the log file provided by J. is sufficient.
Attachments
job queue end screenshot 2023-05-28 12_42_19-Z-Wave Expert UI – Mozilla Firefox.png
job queue end screenshot 2023-05-28 12_42_19-Z-Wave Expert UI – Mozilla Firefox.png (42.14 KiB) Viewed 322 times
Job Queue counter 20230528 12-16 Z-Wave Expert UI.png
Job Queue counter 20230528 12-16 Z-Wave Expert UI.png (69.01 KiB) Viewed 322 times
harre
Posts: 84
Joined: 24 Nov 2020 02:22

Re: job queue runs full after upgrade to v4.1.0

Post by harre »

I have the same problem on and off, i have sent logs in another thread without any attention on how to proceed with further debug instructions

https://forum.z-wave.me/posting.php?mod ... 22&p=98241
Post Reply