Image display not reflected on the device despite what the log file says

Hello and sorry to bother you again.

I'm interested in what's happening with image display for the control d016300f2e0ba5c68019bbb2b6388f52.

According to this script :

Code:

[(cc:3,0,1){image:%trevligaspel%/Icons/TrackMuteSolo-1.png}]
[(cc:3,0,2){image:%trevligaspel%/Icons/TrackMuteSolo-2.png}]
[(cc:3,0,3){image:%trevligaspel%/Icons/TrackMuteSolo-3.png}]
[(cc:3,0,4){image:%trevligaspel%/Icons/TrackMuteSolo-4.png}]
[(cc:3,0,5){image:%trevligaspel%/Icons/TrackMuteSolo-5.png}]

... and the midi events that were sent, the control should display the image TrackMuteSolo-1.png but on the the device, the image does not change and TrackMuteSolo-2.png remains displayed.

Please note that other controls are touched in between the two commands.
I have also noticed that there is some kind of delaying involved but i cannot say more.

Any idea ?

Code:

2023-11-15 19:40:28.2033      0,05ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel3, Control: 0, Value: 2)]
2023-11-15 19:40:28.2033      0,01ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=2, ctrl=0, value=2]
2023-11-15 19:40:28.2033      0,01ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:2, Control,:0, Value:2, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.2033      0,00ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=0, value=2]
2023-11-15 19:40:28.2036      0,28ms DEBUG     3  Script           RunActionList                 [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 CC:2,0,2]
2023-11-15 19:40:28.2036      0,05ms DEBUG     3  Script           SetImage                      [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 showing image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackMuteSolo-2.png']
2023-11-15 19:40:28.2036      0,01ms DEBUG     3  ImageController  GetImage                      [d016300f2e0ba5c68019bbb2b6388f52 Image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackMuteSolo-2.png' fetched from image cache]
2023-11-15 19:40:28.2045      0,89ms DEBUG     3  ImageThrottler   SetImage                      [d016300f2e0ba5c68019bbb2b6388f52 Thread waiting to display, storing new image]
2023-11-15 19:40:28.2046      0,08ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel16, Control: 0, Value: 3)]
2023-11-15 19:40:28.2046      0,02ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=15, ctrl=0, value=3]
2023-11-15 19:40:28.2046      0,01ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:15, Control,:0, Value:3, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.2046      0,01ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=0, value=3]
2023-11-15 19:40:28.2050      0,39ms DEBUG     3  Script           RunActionList                 [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 CC:15,0,0-127]
2023-11-15 19:40:28.2052      0,18ms DEBUG     3  Script           SetVariable                   [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 Setting variable 'g_tnum'='4']
2023-11-15 19:40:28.2053      0,08ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel2, Control: 31, Value: 0)]
2023-11-15 19:40:28.2053      0,01ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=1, ctrl=31, value=0]
2023-11-15 19:40:28.2053      0,01ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:1, Control,:31, Value:0, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.2053      0,01ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=31, value=0]
2023-11-15 19:40:28.2054      0,04ms DEBUG     3  Script           RunActionList                 [38f2f1feb6a25e791589c40b87305e13 Row:1, Column:3 CC:1,31,0]
2023-11-15 19:40:28.2054      0,02ms DEBUG     3  Script           SetImage                      [38f2f1feb6a25e791589c40b87305e13 Row:1, Column:3 showing image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackArmOff.png']
2023-11-15 19:40:28.2054      0,01ms DEBUG     3  ImageController  GetImage                      [38f2f1feb6a25e791589c40b87305e13 Image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackArmOff.png' fetched from image cache]
2023-11-15 19:40:28.2064      1,00ms DEBUG     3  ImageThrottler   SetImage                      [38f2f1feb6a25e791589c40b87305e13 Same image hash as displayed image, ignoring new image]
2023-11-15 19:40:28.2065      0,08ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel16, Control: 30, Value: 1)]
2023-11-15 19:40:28.2065      0,01ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=15, ctrl=30, value=1]
2023-11-15 19:40:28.2065      0,01ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:15, Control,:30, Value:1, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.2065      0,01ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=30, value=1]
2023-11-15 19:40:28.2065      0,04ms DEBUG     3  Script           RunActionList                 [f7f424c2fc67c7444bf48545f72e633c Row:1, Column:2 CC:15,30,1]
2023-11-15 19:40:28.2065      0,02ms DEBUG     3  Script           SetImage                      [f7f424c2fc67c7444bf48545f72e633c Row:1, Column:2 showing image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackSMPlay.png']
2023-11-15 19:40:28.2065      0,01ms DEBUG     3  ImageController  GetImage                      [f7f424c2fc67c7444bf48545f72e633c Image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackSMPlay.png' fetched from image cache]
2023-11-15 19:40:28.2066      0,07ms ERROR    28  Dial_Common      GSV                           [9c5298c8805a6061c8e2ce48ca03b30f Unknown property: Press_selectedArea]
2023-11-15 19:40:28.2072      0,62ms DEBUG     3  ImageThrottler   SetImage                      [f7f424c2fc67c7444bf48545f72e633c Same image hash as displayed image, ignoring new image]
2023-11-15 19:40:28.2508     43,59ms DEBUG    44  ImageThrottler   ImageHandler                  [d016300f2e0ba5c68019bbb2b6388f52 Showing image]
2023-11-15 19:40:28.8552    604,37ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel16, Control: 0, Value: 3)]
2023-11-15 19:40:28.8553      0,04ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=15, ctrl=0, value=3]
2023-11-15 19:40:28.8553      0,02ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:15, Control,:0, Value:3, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.8553      0,01ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=0, value=3]
2023-11-15 19:40:28.8553      0,05ms DEBUG     3  Script           RunActionList                 [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 CC:15,0,0-127]
2023-11-15 19:40:28.8554      0,10ms DEBUG     3  Script           SetVariable                   [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 Setting variable 'g_tnum'='4']
2023-11-15 19:40:28.8555      0,06ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel3, Control: 0, Value: 1)]
2023-11-15 19:40:28.8555      0,00ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=2, ctrl=0, value=1]
2023-11-15 19:40:28.8555      0,00ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:2, Control,:0, Value:1, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.8555      0,00ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=0, value=1]
2023-11-15 19:40:28.8555      0,02ms DEBUG     3  Script           RunActionList                 [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 CC:2,0,1]
2023-11-15 19:40:28.8555      0,01ms DEBUG     3  Script           SetImage                      [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 showing image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackMuteSolo-1.png']
2023-11-15 19:40:28.8555      0,00ms DEBUG     3  ImageController  GetImage                      [d016300f2e0ba5c68019bbb2b6388f52 Image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackMuteSolo-1.png' fetched from image cache]
2023-11-15 19:40:28.8566      1,13ms DEBUG     3  Throttle         CanShowImage4                 [d016300f2e0ba5c68019bbb2b6388f52 request queue=1, past request exists, delay untouched. AllowedSendTime=19:40:28.250, delay=50, numberOfContexIDs=0]
2023-11-15 19:40:28.8567      0,01ms DEBUG     3  Throttle         CanShowImage4                 [d016300f2e0ba5c68019bbb2b6388f52 request queue not full=2, adding new request. AllowedSendTime=19:40:28.906, delay=50, numberOfContexIDs=0]
2023-11-15 19:40:28.8567      0,00ms DEBUG     3  ImageThrottler   SetImage                      [d016300f2e0ba5c68019bbb2b6388f52 Delaying image for 50 ms]
2023-11-15 19:40:28.8571      0,45ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel2, Control: 31, Value: 0)]
2023-11-15 19:40:28.8571      0,01ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=1, ctrl=31, value=0]
2023-11-15 19:40:28.8571      0,01ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:1, Control,:31, Value:0, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.8571      0,00ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=31, value=0]
2023-11-15 19:40:28.8571      0,03ms DEBUG     3  Script           RunActionList                 [38f2f1feb6a25e791589c40b87305e13 Row:1, Column:3 CC:1,31,0]
2023-11-15 19:40:28.8572      0,01ms DEBUG     3  Script           SetImage                      [38f2f1feb6a25e791589c40b87305e13 Row:1, Column:3 showing image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackArmOff.png']
2023-11-15 19:40:28.8572      0,01ms DEBUG     3  ImageController  GetImage                      [38f2f1feb6a25e791589c40b87305e13 Image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackArmOff.png' fetched from image cache]
2023-11-15 19:40:28.8576      0,39ms DEBUG     3  ImageThrottler   SetImage                      [38f2f1feb6a25e791589c40b87305e13 Same image hash as displayed image, ignoring new image]
2023-11-15 19:40:28.8576      0,04ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel16, Control: 30, Value: 1)]
2023-11-15 19:40:28.8576      0,00ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=15, ctrl=30, value=1]
2023-11-15 19:40:28.8576      0,00ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:15, Control,:30, Value:1, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.8576      0,00ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=30, value=1]
2023-11-15 19:40:28.8576      0,02ms DEBUG     3  Script           RunActionList                 [f7f424c2fc67c7444bf48545f72e633c Row:1, Column:2 CC:15,30,1]
2023-11-15 19:40:28.8576      0,01ms DEBUG     3  Script           SetImage                      [f7f424c2fc67c7444bf48545f72e633c Row:1, Column:2 showing image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackSMPlay.png']
2023-11-15 19:40:28.8576      0,00ms DEBUG     3  ImageController  GetImage                      [f7f424c2fc67c7444bf48545f72e633c Image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackSMPlay.png' fetched from image cache]
2023-11-15 19:40:28.8577      0,07ms ERROR    28  Dial_Common      GSV                           [9c5298c8805a6061c8e2ce48ca03b30f Unknown property: Press_selectedArea]
2023-11-15 19:40:28.8583      0,64ms DEBUG     3  ImageThrottler   SetImage                      [f7f424c2fc67c7444bf48545f72e633c Same image hash as displayed image, ignoring new image]
2023-11-15 19:40:28.8584      0,04ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel3, Control: 0, Value: 1)]
2023-11-15 19:40:28.8584      0,00ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=2, ctrl=0, value=1]
2023-11-15 19:40:28.8584      0,00ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:2, Control,:0, Value:1, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.8584      0,00ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=0, value=1]
2023-11-15 19:40:28.8584      0,03ms DEBUG     3  Script           RunActionList                 [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 CC:2,0,1]
2023-11-15 19:40:28.8584      0,01ms DEBUG     3  Script           SetImage                      [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 showing image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackMuteSolo-1.png']
2023-11-15 19:40:28.8584      0,00ms DEBUG     3  ImageController  GetImage                      [d016300f2e0ba5c68019bbb2b6388f52 Image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackMuteSolo-1.png' fetched from image cache]
2023-11-15 19:40:28.8601      1,69ms DEBUG     3  ImageThrottler   SetImage                      [d016300f2e0ba5c68019bbb2b6388f52 Thread waiting to display, storing new image]
2023-11-15 19:40:28.8602      0,11ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel16, Control: 0, Value: 3)]
2023-11-15 19:40:28.8602      0,01ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=15, ctrl=0, value=3]
2023-11-15 19:40:28.8602      0,01ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:15, Control,:0, Value:3, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.8603      0,00ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=0, value=3]
2023-11-15 19:40:28.8603      0,03ms DEBUG     3  Script           RunActionList                 [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 CC:15,0,0-127]
2023-11-15 19:40:28.8604      0,10ms DEBUG     3  Script           SetVariable                   [d016300f2e0ba5c68019bbb2b6388f52 Row:1, Column:0 Setting variable 'g_tnum'='4']
2023-11-15 19:40:28.8604      0,04ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel2, Control: 31, Value: 0)]
2023-11-15 19:40:28.8604      0,00ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=1, ctrl=31, value=0]
2023-11-15 19:40:28.8604      0,00ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:1, Control,:31, Value:0, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.8604      0,00ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=31, value=0]
2023-11-15 19:40:28.8604      0,01ms DEBUG     3  Script           RunActionList                 [38f2f1feb6a25e791589c40b87305e13 Row:1, Column:3 CC:1,31,0]
2023-11-15 19:40:28.8605      0,01ms DEBUG     3  Script           SetImage                      [38f2f1feb6a25e791589c40b87305e13 Row:1, Column:3 showing image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackArmOff.png']
2023-11-15 19:40:28.8605      0,00ms DEBUG     3  ImageController  GetImage                      [38f2f1feb6a25e791589c40b87305e13 Image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackArmOff.png' fetched from image cache]
2023-11-15 19:40:28.8612      0,74ms DEBUG     3  ImageThrottler   SetImage                      [38f2f1feb6a25e791589c40b87305e13 Same image hash as displayed image, ignoring new image]
2023-11-15 19:40:28.8612      0,04ms DEBUG     3  MidiController   MidiIn_ControlChange          [msg(Channel: Channel16, Control: 30, Value: 1)]
2023-11-15 19:40:28.8612      0,00ms DEBUG     3  MidiController   MidiIn_ControlChange          [port:BMT 5, channel=15, ctrl=30, value=1]
2023-11-15 19:40:28.8613      0,01ms DEBUG     3  MidiStateCtrl    SaveMidiState                 [Saving state for ControlChangeMessage, ID:MidiController, MidiIn:BMT 5, MidiOut:, Channel:15, Control,:30, Value:1, time=15/11/2023 19:40:28]
2023-11-15 19:40:28.8613      0,00ms DEBUG     3  MCUDevice        ReceiveControlChange          [control=30, value=1]
2023-11-15 19:40:28.8613      0,03ms DEBUG     3  Script           RunActionList                 [f7f424c2fc67c7444bf48545f72e633c Row:1, Column:2 CC:15,30,1]
2023-11-15 19:40:28.8613      0,01ms DEBUG     3  Script           SetImage                      [f7f424c2fc67c7444bf48545f72e633c Row:1, Column:2 showing image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackSMPlay.png']
2023-11-15 19:40:28.8613      0,00ms DEBUG     3  ImageController  GetImage                      [f7f424c2fc67c7444bf48545f72e633c Image 'C:\Users\LPA\Documents\Trevliga Spel\Icons\TrackSMPlay.png' fetched from image cache]
2023-11-15 19:40:28.8614      0,06ms ERROR    28  Dial_Common      GSV                           [9c5298c8805a6061c8e2ce48ca03b30f Unknown property: Press_selectedArea]
2023-11-15 19:40:28.8617      0,32ms DEBUG     3  ImageThrottler   SetImage                      [f7f424c2fc67c7444bf48545f72e633c Same image hash as displayed image, ignoring new image]
2023-11-15 19:40:28.9068     45,17ms DEBUG     7  ImageThrottler   ImageHandler                  [d016300f2e0ba5c68019bbb2b6388f52 Showing image]
2023-11-15 19:40:38.3679   9461,06ms DEBUG    50  Script           OnSendToPlugin                [d016300f2e0ba5c68019bbb2b6388f52

According to the log, TrackMuteSolo-2.png is displayed when the value 2 is received, and TrackMuteSolo-1.png is displayed when the value 1 is received.

If there is no change on the device, it is either a problem with the device or a case of renamed/changed images.

The plugin caches all images in an in-memory cache to avoid bottlenecks where images are read from disk. If you make changes to images that are already cached, these changes will not be visible until you have restarted the plugin (or the Stream Deck software).

You will get the situation you describe if the in-memory cache has the same image content for TrackMuteSolo-1.png as for TrackMuteSolo-2.png.

Things can happen very fast on the Midi port, and if I send updates to Stream Deck too often, things start to queue up and lag. To avoid this, the plugin throttles updates to Stream Deck, and that's the delay you see.

Thank you for your explanation.
In fact it did happen randomly, including on another control.

I've rebooted my system and could not reproduce since.
Should it happen again I will let you know.