Can only run playlist once via MQTT

[erdccc]

I have a couple MQTT events to toggle the scheduler power, and another to play a playlist. It works fine for the first time. But after that I can not do either of them. But I can manually control these functions even after I have sent the MQTT commands. I tried a restart all Schedules, but that still did not work.

What do I have to do to have full constant MQTT control?

[keithsw1111]

Would need to see the logs to see what is happening.

[erdccc]

Here is when I first toggle the power on and then play a playlist, Next I try to turn off the power and run the same playlist again. All using MQTT


2019-12-27 09:25:00,443 20276 log_base [DEBUG] Checking the schedule ...
2019-12-27 09:25:00,443 20276 log_base [DEBUG]    Active scheduled playlists: 0
2019-12-27 09:25:17,421 18436 log_base [DEBUG] MQTT Topic: xSchedule/Event/Toggle.
2019-12-27 09:25:17,421 18436 log_base [DEBUG] Event fired MQTT:Toggle -> Toggle output to lights:
2019-12-27 09:25:17,421 18436 log_base [DEBUG] Action 'Toggle output to lights':'' arrived not on main thread ... switching threads.
2019-12-27 09:25:17,421 18436 log_base [DEBUG]     Event processed.
2019-12-27 09:25:17,421 20276 log_base [DEBUG]     Thread switched command = Toggle output to lights
2019-12-27 09:25:17,421 20276 log_base [DEBUG] Action 'Toggle output to lights':''.
2019-12-27 09:25:17,421 20276 log_base [DEBUG] Starting light output.
2019-12-27 09:25:20,893 18436 log_base [DEBUG] MQTT Topic: xSchedule/Playlist.
2019-12-27 09:25:20,893 18436 log_base [DEBUG] Event fired MQTT:Megatree -> Play specified playlist:MegaToggle
2019-12-27 09:25:20,893 18436 log_base [DEBUG] Action 'Play specified playlist':'MegaToggle' arrived not on main thread ... switching threads.
2019-12-27 09:25:20,894 18436 log_base [DEBUG]     Event processed.
2019-12-27 09:25:20,894 20276 log_base [DEBUG]     Thread switched command = Play specified playlist
2019-12-27 09:25:20,894 20276 log_base [DEBUG] Action 'Play specified playlist':'MegaToggle'.
2019-12-27 09:25:20,894 20276 log_base [INFO] Playing playlist MegaToggle.
2019-12-27 09:25:20,894 20276 log_base [DEBUG] Copying playlist MegaToggle [30.050] steps 2.
2019-12-27 09:25:20,894 20276 log_base [INFO] ******** Playlist MegaToggle [30.050] starting to play.
2019-12-27 09:25:20,894 20276 log_base [INFO] ********       
2019-12-27 09:25:20,894 20276 log_base [INFO]          ######## Playlist step Megatree starting.
2019-12-27 09:25:20,894 20276 log_base [DEBUG]   Prepared to read/write a ZSTD compress fseq file.
2019-12-27 09:25:20,894 20276 log_base [DEBUG] Sequence File Information
2019-12-27 09:25:20,895 20276 log_base [DEBUG] seqFilename           : E:\Xlights Tree\Sequences\My Medga Tree\Megatree.fseq
2019-12-27 09:25:20,895 20276 log_base [DEBUG] seqVersion            : 2.0
2019-12-27 09:25:20,895 20276 log_base [DEBUG] seqChanDataOffset     : 252
2019-12-27 09:25:20,895 20276 log_base [DEBUG] seqChannelCount       : 4428
2019-12-27 09:25:20,895 20276 log_base [DEBUG] seqNumPeriods         : 600
2019-12-27 09:25:20,895 20276 log_base [DEBUG] seqStepTime           : 50ms
2019-12-27 09:25:20,895 20276 log_base [DEBUG] Sequence File Information
2019-12-27 09:25:20,895 20276 log_base [DEBUG] compressionType       : 1
2019-12-27 09:25:20,895 20276 log_base [DEBUG] numBlocks             : 21
2019-12-27 09:25:20,895 20276 log_base [DEBUG] numRanges             : 0
2019-12-27 09:25:51,743 20276 log_base [DEBUG] PlayList: Frame moving to next step because step 'Megatree' is done.
2019-12-27 09:25:51,743 20276 log_base [DEBUG] PlayList: MoveToNextStep
2019-12-27 09:25:51,743 20276 log_base [INFO]          ######## Playlist step Megatree stopping.
2019-12-27 09:25:51,743 20276 log_base [INFO]          ######## Playlist step show_end starting.
2019-12-27 09:25:51,743 20276 log_base [DEBUG] Move to next step moved to show_end.
2019-12-27 09:25:51,769 20276 log_base [INFO] Sending MQTT Event to 192.168.1.52:1883 xSchedule/sensor/end
2019-12-27 09:25:51,769 20276 log_base [DEBUG] PlayList: Frame moving to next step because step 'show_end' is done.
2019-12-27 09:25:51,769 20276 log_base [DEBUG] PlayList: MoveToNextStep
2019-12-27 09:25:51,769 20276 log_base [INFO]          ######## Playlist step show_end stopping.
2019-12-27 09:25:51,769 20276 log_base [DEBUG] Move to next step found no step to move to.
2019-12-27 09:25:51,769 20276 log_base [DEBUG] Turning all the lights off.
2019-12-27 09:25:51,770 6044 log_base [DEBUG] PlayListMQTT in thread.
2019-12-27 09:25:51,770 6044 log_base [DEBUG] Connecting to broker.
2019-12-27 09:25:51,770 20276 log_base [DEBUG] Checking the schedule ...
2019-12-27 09:25:51,770 20276 log_base [DEBUG]    Active scheduled playlists: 0
2019-12-27 09:25:51,774 6044 log_base [DEBUG]     Connected.
2019-12-27 09:25:51,774 6044 log_base [DEBUG]     Sending connect packet.
2019-12-27 09:25:53,961 6044 log_base [DEBUG]     Response received.
2019-12-27 09:25:53,961 6044 log_base [DEBUG]     Connected ok.
2019-12-27 09:25:53,962 6044 log_base [INFO] MQTT Sent.
2019-12-27 09:25:56,324 6044 log_base [DEBUG] PlayListMQTT thread done.
2019-12-27 09:26:00,772 20276 log_base [DEBUG] Checking the schedule ...
2019-12-27 09:26:00,772 20276 log_base [DEBUG]    Active scheduled playlists: 0
2019-12-27 09:26:05,507 20276 log_base [WARN] Frame interval greater than 200% of what it should have been [50] 144
2019-12-27 09:26:05,513 20276 log_frame [WARN] Timer: Frame event fire interval 6ms less than 1/4 frame time 12ms
2019-12-27 09:26:07,251 20276 log_base [WARN] Frame interval greater than 200% of what it should have been [50] 192
2019-12-27 09:26:07,675 20276 log_base [WARN] Frame interval greater than 200% of what it should have been [50] 280
2019-12-27 09:26:07,787 20276 log_base [WARN] Frame interval greater than 200% of what it should have been [50] 112
2019-12-27 09:26:07,791 20276 log_base [DEBUG] Viewing log file C:\Users\SuperComputer\AppData\Roaming/xSchedule_l4cpp.log.
2019-12-27 09:26:07,798 20276 log_frame [WARN] Timer: Frame event fire interval 11ms less than 1/4 frame time 12ms