Can anyone tell me what FPP is doing in the logs?

[JonD]

I went outside this morning and my Mega-tree was frozen with lights on from a sequence.  I have had this happen a few times this last month.
I went back to the security cameras and could tell it froze at 5:32.55pm so my mega-tree was out most of the night.  Could these be related? [/pre]

2023-11-29 05:33:38.706 (4686) [General] /opt/fpp/src/fppd.cpp:795: Shutting down main loop.
2023-11-29 05:33:39.706 (4686) [General] /opt/fpp/src/fppd.cpp:1014: Stopping channel output thread.
2023-11-29 05:33:39.706 (4686) [General] /opt/fpp/src/fppd.cpp:1018: Main Loop complete, shutting down.
2023-11-29 05:34:29.095 (20651) [General] /opt/fpp/src/log.cpp:349: =========================================
2023-11-29 05:34:29.096 (20651) [General] /opt/fpp/src/log.cpp:350: FPP 7.3.5
2023-11-29 05:34:29.096 (20651) [General] /opt/fpp/src/log.cpp:351: Branch: v7.3
2023-11-29 05:34:29.096 (20651) [General] /opt/fpp/src/log.cpp:352: =========================================
2023-11-29 05:34:29.097 (20651) [General] /opt/fpp/src/fppd.cpp:703: Creating Scheduler, Playlist, and Sequence
2023-11-29 05:34:29.101 (20651) [Schedule] /opt/fpp/src/Scheduler.cpp:718: Current Schedule: (Status: '+' = Enabled, '-' = Disabled, '!' = Outside Date Range, '*' = Repeat, Stop (G)raceful/(L)oop/(H)ard
2023-11-29 05:34:29.101 (20651) [Schedule] /opt/fpp/src/Scheduler.cpp:719: Stat Start & End Dates       Days          Start & End Times   Playlist/Command
2023-11-29 05:34:29.101 (20651) [Schedule] /opt/fpp/src/Scheduler.cpp:720: ---- ----------------------- ------------- ------------------- ---------------------------------------------
2023-11-29 05:34:29.101 (20651) [Schedule] /opt/fpp/src/Scheduler.cpp:723: + *G 2023-11-04 - 2024-01-01 Sun-Thurs     17:00:00 - 22:00:00 NightlyShow
2023-11-29 05:34:29.101 (20651) [Schedule] /opt/fpp/src/Scheduler.cpp:723: + *G 2023-11-04 - 2024-01-01 Fri/Sat       17:00:00 - 23:00:00 NightlyShow
2023-11-29 05:34:29.116 (20651) [General] /opt/fpp/src/fppd.cpp:706: Creation of Scheduler, Playlist, and Sequence Complete
2023-11-29 05:34:32.894 (20651) [ChannelOut] /opt/fpp/src/channeloutput/UDPOutput.cpp:690: Could not ping host 10.12.25.220, removing from output
2023-11-29 05:34:32.894 (20651) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 5 - 4748
2023-11-29 05:34:32.894 (20651) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 4748 - 11135
2023-11-29 05:34:32.894 (20651) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 11135 - 12920
2023-11-29 05:34:32.894 (20651) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 12920 - 13283
2023-11-29 05:34:32.894 (20651) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 13283 - 13733
2023-11-29 05:34:32.894 (20651) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 13733 - 16373
2023-11-29 05:34:32.894 (20651) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 16373 - 17549

[CaptainMurdoch]

I don't know about the shutdown and restart, but if 10.12.25.220 is the IP of your mega tree controller?  If so, then the "UDPOutput.cpp:690: Could not ping host 10.12.25.220, removing from output" message is related to why it stopped working.  Is this Wired or Wireless?  Could you be having network issues?  We're probably going to need to see more logs before 5:33 to see what caused that.  The logs don't look like an error occurred, it looks like fppd was told to shutdown/restart.  I'm not sure why it took almost a minute to come back up with the first log entry at 5:34.

[JonD]

I am so sorry... I was reviewing logs and failed to notice the date change.  Logs are from 5:34am the next day.  Nothing in logs around 17:00 the time it happened. 

It is wired ethernet, Fluke certified to support 1GB connection.

I did reboot/reload the FPP Player around 17:18.  The tree froze at 17:33.55.  Interesting that FPP player says " 2023-11-28 19:19:48.166 (4686) [Sync] /opt/fpp/src/MultiSync.cpp:1148: Have not seen 10.12.25.220 in over 2 hours, removing "  Two hours from tree freeze is 19:33.55.   At 19:19:48 that would have been closer to the time I restarted the FPP player???

Doesn't seem enough to go on yet.  I will keep an eye on it.   Thanks so much for looking!!!!

Update:  I upgraded the F16v4 to firmware build 30... maybe that will help!?

2023-11-28 17:18:00.601 (1986) [General] /opt/fpp/src/fppd.cpp:795: Shutting down main loop.
2023-11-28 17:18:01.602 (1986) [General] /opt/fpp/src/fppd.cpp:1014: Stopping channel output thread.
2023-11-28 17:18:01.602 (1986) [General] /opt/fpp/src/fppd.cpp:1018: Main Loop complete, shutting down.
2023-11-28 17:18:47.938 (4686) [General] /opt/fpp/src/log.cpp:349: =========================================
2023-11-28 17:18:47.938 (4686) [General] /opt/fpp/src/log.cpp:350: FPP 7.3.5
2023-11-28 17:18:47.938 (4686) [General] /opt/fpp/src/log.cpp:351: Branch: v7.3
2023-11-28 17:18:47.938 (4686) [General] /opt/fpp/src/log.cpp:352: =========================================
2023-11-28 17:18:47.940 (4686) [General] /opt/fpp/src/fppd.cpp:703: Creating Scheduler, Playlist, and Sequence
2023-11-28 17:18:47.943 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:718: Current Schedule: (Status: '+' = Enabled, '-' = Disabled, '!' = Outside Date Range, '*' = Repeat, Stop (G)raceful/(L)oop/(H)ard
2023-11-28 17:18:47.943 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:719: Stat Start & End Dates       Days          Start & End Times   Playlist/Command
2023-11-28 17:18:47.943 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:720: ---- ----------------------- ------------- ------------------- ---------------------------------------------
2023-11-28 17:18:47.944 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:723: + *G 2023-11-04 - 2024-01-01 Sun-Thurs     17:00:00 - 22:00:00 NightlyShow
2023-11-28 17:18:47.944 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:723: + *G 2023-11-04 - 2024-01-01 Fri/Sat       17:00:00 - 23:00:00 NightlyShow
2023-11-28 17:18:47.959 (4686) [General] /opt/fpp/src/fppd.cpp:706: Creation of Scheduler, Playlist, and Sequence Complete
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 5 - 4748
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 4748 - 11135
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 11135 - 12920
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 12920 - 13283
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 13283 - 13733
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 13733 - 16373
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 16373 - 17549
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 17549 - 18812
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 18812 - 20297
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:318: UDPOutput:  Determined range needed 20297 - 33227
2023-11-28 17:18:47.984 (4686) [ChannelOut] /opt/fpp/src/channeloutput/ChannelOutputSetup.cpp:348: Determined range needed 5 - 33227
2023-11-28 17:18:47.985 (4686) [Command] /opt/fpp/src/command.cpp:70: Initializing Command Module
2023-11-28 17:18:47.986 (4686) [E131Bridge] /opt/fpp/src/e131bridge.cpp:313: Universe Count = 0
2023-11-28 17:18:49.183 (4686) [General] /opt/fpp/src/fppd.cpp:886: Starting main processing loop
2023-11-28 17:19:31.361 (4686) [General] /opt/fpp/src/fppd.cpp:1081: Not Publishing statistics as mode is 'Disabled'
2023-11-28 18:03:30.143 (4686) [MediaOut] /opt/fpp/src/mediaoutput/SDLOut.cpp:917: Warn: "My Favorite Things.m4a" - [mov,mp4,m4a,3gp,3g2,mj2 @ 0x4dca50] stream 0, timescale not set
2023-11-28 18:03:30.325 (4686) [MediaOut] /opt/fpp/src/mediaoutput/SDLOut.cpp:917: Warn: "My Favorite Things.m4a" - [mov,mp4,m4a,3gp,3g2,mj2 @ 0x4dca50] stream 0, timescale not set
2023-11-28 18:06:19.586 (4686) [MediaOut] /opt/fpp/src/mediaoutput/SDLOut.cpp:917: Warn: "Santa Claus is Coming to Town.m4a" - [mov,mp4,m4a,3gp,3g2,mj2 @ 0x6693b0] stream 0, timescale not set
2023-11-28 18:06:19.824 (4686) [MediaOut] /opt/fpp/src/mediaoutput/SDLOut.cpp:917: Warn: "Santa Claus is Coming to Town.m4a" - [mov,mp4,m4a,3gp,3g2,mj2 @ 0x6693b0] stream 0, timescale not set
2023-11-28 19:19:48.166 (4686) [Sync] /opt/fpp/src/MultiSync.cpp:1148: Have not seen 10.12.25.220 in over 2 hours, removing
2023-11-29 00:00:00.062 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:718: Current Schedule: (Status: '+' = Enabled, '-' = Disabled, '!' = Outside Date Range, '*' = Repeat, Stop (G)raceful/(L)oop/(H)ard
2023-11-29 00:00:00.062 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:719: Stat Start & End Dates       Days          Start & End Times   Playlist/Command
2023-11-29 00:00:00.062 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:720: ---- ----------------------- ------------- ------------------- ---------------------------------------------
2023-11-29 00:00:00.062 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:723: + *G 2023-11-04 - 2024-01-01 Sun-Thurs     17:00:00 - 22:00:00 NightlyShow
2023-11-29 00:00:00.062 (4686) [Schedule] /opt/fpp/src/Scheduler.cpp:723: + *G 2023-11-04 - 2024-01-01 Fri/Sat       17:00:00 - 23:00:00 NightlyShow
2023-11-29 05:06:19.272 (4686) [General] /opt/fpp/src/fppd.cpp:795: Shutting down main loop.
2023-11-29 05:06:19.273 (4686) [General] /opt/fpp/src/fppd.cpp:1014: Stopping channel output thread.
2023-11-29 05:06:19.273 (4686) [General] /opt/fpp/src/fppd.cpp:1018: Main Loop complete, shutting down.
2023-11-29 05:06:19.282 (4686) [General] /opt/fpp/src/fppd.cpp:778: Performing Restart.
2023-11-29 05:06:19.538 (4686) [General] /opt/fpp/src/log.cpp:349: =========================================
2023-11-29 05:06:19.538 (4686) [General] /opt/fpp/src/log.cpp:350: FPP 7.3.5
2023-11-29 05:06:19.538 (4686) [General] /opt/fpp/src/log.cpp:351: Branch: v7.3