v2.x-master-582-g6ef7b300 MP3 froze mid schedule

Author Topic: v2.x-master-582-g6ef7b300 MP3 froze mid schedule  (Read 540 times)

Offline brichi

  • Sr. Member
  • ****
  • Join Date: Dec 2017
  • Location:
  • Posts: 465
  • Kudos: 1
v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« on: May 16, 2018, 06:04:22 AM »
Not sure which log you would need me to upload to see what happened but I was letting a playlist of 5 MP3's encoded in iTunes, 320kCBR as background music and when I got up this morning and checked it the schedule was still running, the time was running and correct but the 2nd MP3 was frozen at 5 seconds into the track, not sure when it stopped but I know I played it a bunch of times previously with no issue. I hit "restart FPPD" and the playlist continued again.


running
Version:
v2.x-master-582-g6ef7b300 (master branch)



looking at the info in the log below it looks like at 05:31 was when it froze, I then woke up at 6:42 and restarted FPPD as u can see

2018-05-16 05:17:59 (20149) Scheduler.cpp:455:NowSecs = 278279, CurrEndSecs = 319079 (40800 seconds away)
2018-05-16 05:18:33 (20149) mediaoutput/SDLOut.cpp:633:"JINGLE BELL ROCK.mp3" - [mp3 @ 0x12f2410] Estimating duration from bitrate, this may be inaccurate
2018-05-16 05:20:44 (20149) mediaoutput/SDLOut.cpp:633:"LAST CHRISTMAS - WHAM.mp3" - [mp3 @ 0x132a900] Estimating duration from bitrate, this may be inaccurate
2018-05-16 05:22:59 (20149) Scheduler.cpp:455:NowSecs = 278579, CurrEndSecs = 319079 (40500 seconds away)
2018-05-16 05:26:56 (20149) mediaoutput/SDLOut.cpp:633:"LITTLE ST NICK - BEACH BOYS.mp3" - [mp3 @ 0xf130d0] Estimating duration from bitrate, this may be inaccurate
2018-05-16 05:27:59 (20149) Scheduler.cpp:455:NowSecs = 278879, CurrEndSecs = 319079 (40200 seconds away)
2018-05-16 05:28:53 (20149) mediaoutput/SDLOut.cpp:633:"HOLLY JOLLY CHRISTMAS.mp3" - [mp3 @ 0x105a890] Estimating duration from bitrate, this may be inaccurate
2018-05-16 05:31:06 (20149) mediaoutput/SDLOut.cpp:633:"JINGLE BELL ROCK.mp3" - [mp3 @ 0x12f2410] Estimating duration from bitrate, this may be inaccurate
2018-05-16 05:32:59 (20149) Scheduler.cpp:455:NowSecs = 279179, CurrEndSecs = 319079 (39900 seconds away)
2018-05-16 05:37:59 (20149) Scheduler.cpp:455:NowSecs = 279479, CurrEndSecs = 319079 (39600 seconds away)
2018-05-16 05:42:59 (20149) Scheduler.cpp:455:NowSecs = 279779, CurrEndSecs = 319079 (39300 seconds away)
2018-05-16 05:47:59 (20149) Scheduler.cpp:455:NowSecs = 280079, CurrEndSecs = 319079 (39000 seconds away)
2018-05-16 05:52:59 (20149) Scheduler.cpp:455:NowSecs = 280379, CurrEndSecs = 319079 (38700 seconds away)
2018-05-16 05:57:59 (20149) Scheduler.cpp:455:NowSecs = 280679, CurrEndSecs = 319079 (38400 seconds away)
2018-05-16 06:02:59 (20149) Scheduler.cpp:455:NowSecs = 280979, CurrEndSecs = 319079 (38100 seconds away)
2018-05-16 06:07:59 (20149) Scheduler.cpp:455:NowSecs = 281279, CurrEndSecs = 319079 (37800 seconds away)
2018-05-16 06:12:59 (20149) Scheduler.cpp:455:NowSecs = 281579, CurrEndSecs = 319079 (37500 seconds away)
2018-05-16 06:17:59 (20149) Scheduler.cpp:455:NowSecs = 281879, CurrEndSecs = 319079 (37200 seconds away)
2018-05-16 06:22:59 (20149) Scheduler.cpp:455:NowSecs = 282179, CurrEndSecs = 319079 (36900 seconds away)
2018-05-16 06:27:59 (20149) Scheduler.cpp:455:NowSecs = 282479, CurrEndSecs = 319079 (36600 seconds away)
2018-05-16 06:32:59 (20149) Scheduler.cpp:455:NowSecs = 282779, CurrEndSecs = 319079 (36300 seconds away)
2018-05-16 06:37:59 (20149) Scheduler.cpp:455:NowSecs = 283079, CurrEndSecs = 319079 (36000 seconds away)
2018-05-16 06:42:29 (20149) Scheduler.cpp:509:Loading Schedule from /home/fpp/media/schedule
2018-05-16 06:42:29 (20149) Scheduler.cpp:586:Current Schedule: (Status: '+' = Enabled, '-' = Disabled, '!' = Outside Date Range, '*' = Repeat)
2018-05-16 06:42:29 (20149) Scheduler.cpp:587:St  Start & End Dates       Days         Start & End Times   Playlist
2018-05-16 06:42:29 (20149) Scheduler.cpp:588:--- ----------------------- ------------ ------------------- ---------------------------------------------
2018-05-16 06:42:29 (20149) Scheduler.cpp:606:+ * 2018-05-12 - 2018-05-24 Everyday     17:00:00 - 22:57:00 MAIN
2018-05-16 06:42:29 (20149) Scheduler.cpp:606:+ * 2018-05-12 - 2018-05-24 Everyday     00:00:01 - 16:38:00 MUSICONLY
2018-05-16 06:42:29 (20149) Scheduler.cpp:606:+ * 2018-05-12 - 2018-05-24 Everyday     23:00:00 - 23:59:55 MUSICONLY
2018-05-16 06:42:29 (20149) Scheduler.cpp:606:+   2018-05-12 - 2018-05-24 Everyday     16:45:00 - 16:55:00 15MUSIC
2018-05-16 06:42:29 (20149) fppd.c:184:Shutting down main loop.
2018-05-16 06:42:30 (20149) fppd.c:347:Stopping channel output thread.
2018-05-16 06:42:30 (20149) fppd.c:353:Main Loop complete, shutting down.
2018-05-16 06:42:34 (6554) log.c:220:=========================================
2018-05-16 06:42:34 (6554) log.c:221:FPP 2.x-master-582-g6ef7b300
2018-05-16 06:42:34 (6554) log.c:222:Branch: master
2018-05-16 06:42:34 (6554) log.c:223:=========================================
2018-05-16 06:42:34 (6560) channeloutput/E131.cpp:226:Initializing E1.31 output
2018-05-16 06:42:34 (6560) command.c:73:Initializing Command Module
2018-05-16 06:42:34 (6560) Scheduler.cpp:509:Loading Schedule from /home/fpp/media/schedule
2018-05-16 06:42:34 (6560) Scheduler.cpp:586:Current Schedule: (Status: '+' = Enabled, '-' = Disabled, '!' = Outside Date Range, '*' = Repeat)
2018-05-16 06:42:34 (6560) Scheduler.cpp:587:St  Start & End Dates       Days         Start & End Times   Playlist
2018-05-16 06:42:34 (6560) Scheduler.cpp:588:--- ----------------------- ------------ ------------------- ---------------------------------------------
2018-05-16 06:42:34 (6560) Scheduler.cpp:606:+ * 2018-05-12 - 2018-05-24 Everyday     17:00:00 - 22:57:00 MAIN
2018-05-16 06:42:34 (6560) Scheduler.cpp:606:+ * 2018-05-12 - 2018-05-24 Everyday     00:00:01 - 16:38:00 MUSICONLY
2018-05-16 06:42:34 (6560) Scheduler.cpp:606:+ * 2018-05-12 - 2018-05-24 Everyday     23:00:00 - 23:59:55 MUSICONLY
2018-05-16 06:42:34 (6560) Scheduler.cpp:606:+   2018-05-12 - 2018-05-24 Everyday     16:45:00 - 16:55:00 15MUSIC
2018-05-16 06:42:34 (6560) Scheduler.cpp:122:Should be playing now - schedule index = 1 weekly index= 3
2018-05-16 06:42:34 (6560) fppd.c:232:Starting main processing loop
2018-05-16 06:42:34 (6560) mediaoutput/SDLOut.cpp:633:"HOLLY JOLLY CHRISTMAS.mp3" - [mp3 @ 0x7d0f10] Estimating duration from bitrate, this may be inaccurate
2018-05-16 06:42:34 (6560) Scheduler.cpp:509:Loading Schedule from /home/fpp/media/schedule

« Last Edit: May 16, 2018, 06:42:59 AM by brichi »

Offline brichi

  • Sr. Member
  • ****
  • Join Date: Dec 2017
  • Location:
  • Posts: 465
  • Kudos: 1
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #1 on: May 16, 2018, 08:33:53 PM »
Now I have sequences just stopping while playing on one Pi but not the other, I tried formatting the USB and SD and reloading the info on and when I play a sequence it stops FPPD right at 55 seconds in every time. What can I upload here to see what is going on with this, very strange. the sequence plays fine on the other 2 pi's and on schedule .


all 3 pi's are running

Online pixelpuppy

  • Hero Member
  • *****
  • Join Date: Aug 2015
  • Location: Dallas, TX
  • Posts: 867
  • Kudos: 21
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #2 on: May 16, 2018, 10:52:14 PM »
If you swap SD and USB with ones on a Pi that works what happens?
Does the problem stay with the Pi or does it move with the flash memory?
xLights and Vixen3 for sequencing / FPP for scheduling and playing / Falcon controllers for pixels / DIY controllers for everything else

Offline brichi

  • Sr. Member
  • ****
  • Join Date: Dec 2017
  • Location:
  • Posts: 465
  • Kudos: 1
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #3 on: May 17, 2018, 04:34:18 AM »
If you swap SD and USB with ones on a Pi that works what happens?
Does the problem stay with the Pi or does it move with the flash memory?

Moves with the sd card

Once I wipe the card it works good a few times then back to freezing at 55

Online pixelpuppy

  • Hero Member
  • *****
  • Join Date: Aug 2015
  • Location: Dallas, TX
  • Posts: 867
  • Kudos: 21
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #4 on: May 17, 2018, 06:07:42 AM »
If you swap SD and USB with ones on a Pi that works what happens?
Does the problem stay with the Pi or does it move with the flash memory?

Moves with the sd card

Once I wipe the card it works good a few times then back to freezing at 55


Sounds like its time to trash that SD card and get another one to replace it.

Offline brichi

  • Sr. Member
  • ****
  • Join Date: Dec 2017
  • Location:
  • Posts: 465
  • Kudos: 1
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #5 on: May 17, 2018, 02:10:42 PM »
If you swap SD and USB with ones on a Pi that works what happens?
Does the problem stay with the Pi or does it move with the flash memory?

Moves with the sd card

Once I wipe the card it works good a few times then back to freezing at 55


Sounds like its time to trash that SD card and get another one to replace it.


now a completely different Pi, card and files froze just letting it run a schedule. I have a few songs in a playlist to loop and at 8:45 the track just freezes even though FPP is still running


heres the zip of log files - https://drive.google.com/file/d/18mosIE8q8tdWg6vLtt1dOTJHRbRARhGY/view?usp=sharing



2018-05-17 08:35:03 (1213) mediaoutput/SDLOut.cpp:633:"ALL I WANT FOR CHRISTMAS IS YOU.mp3" - [mp3 @ 0x1b298f0] Estimating duration from bitrate, this may be inaccurate
2018-05-17 08:37:59 (1213) Scheduler.cpp:455:NowSecs = 376679, CurrEndSecs = 405479 (28800 seconds away)
2018-05-17 08:38:59 (1213) mediaoutput/SDLOut.cpp:633:"ROCKIN AROUND THE CHRISTMAS TREE.mp3" - [mp3 @ 0x1f62e30] Estimating duration from bitrate, this may be inaccurate
2018-05-17 08:41:02 (1213) mediaoutput/SDLOut.cpp:633:"LITTLE ST NICK - BEACH BOYS.mp3" - [mp3 @ 0x1c75ca0] Estimating duration from bitrate, this may be inaccurate
2018-05-17 08:42:59 (1213) Scheduler.cpp:455:NowSecs = 376979, CurrEndSecs = 405479 (28500 seconds away)
2018-05-17 08:42:59 (1213) mediaoutput/SDLOut.cpp:633:"JINGLE BELL ROCK.mp3" - [mp3 @ 0x1bdbdc0] Estimating duration from bitrate, this may be inaccurate
2018-05-17 08:45:10 (1213) mediaoutput/SDLOut.cpp:633:"HOLLY JOLLY CHRISTMAS.mp3" - [mp3 @ 0x1dcbf20] Estimating duration from bitrate, this may be inaccurate
2018-05-17 08:47:59 (1213) Scheduler.cpp:455:NowSecs = 377279, CurrEndSecs = 405479 (28200 seconds away)
2018-05-17 08:52:59 (1213) Scheduler.cpp:455:NowSecs = 377579, CurrEndSecs = 405479 (27900 seconds away)
2018-05-17 08:57:59 (1213) Scheduler.cpp:455:NowSecs = 377879, CurrEndSecs = 405479 (27600 seconds away)
2018-05-17 09:02:59 (1213) Scheduler.cpp:455:NowSecs = 378179, CurrEndSecs = 405479 (27300 seconds away)
2018-05-17 09:07:59 (1213) Scheduler.cpp:455:NowSecs = 378479, CurrEndSecs = 405479 (27000 seconds away)
2018-05-17 09:12:59 (1213) Scheduler.cpp:455:NowSecs = 378779, CurrEndSecs = 405479 (26700 seconds away)
2018-05-17 09:17:59 (1213) Scheduler.cpp:455:NowSecs = 379079, CurrEndSecs = 405479 (26400 seconds away)
2018-05-17 09:22:59 (1213) Scheduler.cpp:455:NowSecs = 379379, CurrEndSecs = 405479 (26100 seconds away)
2018-05-17 09:27:59 (1213) Scheduler.cpp:455:NowSecs = 379679, CurrEndSecs = 405479 (25800 seconds away)
2018-05-17 09:32:59 (1213) Scheduler.cpp:455:NowSecs = 379979, CurrEndSecs = 405479 (25500 seconds away)
2018-05-17 09:37:59 (1213) Scheduler.cpp:455:NowSecs = 380279, CurrEndSecs = 405479 (25200 seconds away)
2018-05-17 09:42:59 (1213) Scheduler.cpp:455:NowSecs = 380579, CurrEndSecs = 405479 (24900 seconds away)
2018-05-17 09:47:59 (1213) Scheduler.cpp:455:NowSecs = 380879, CurrEndSecs = 405479 (24600 seconds away)
2018-05-17 09:52:59 (1213) Scheduler.cpp:455:NowSecs = 381179, CurrEndSecs = 405479 (24300 seconds away)
2018-05-17 09:57:59 (1213) Scheduler.cpp:455:NowSecs = 381479, CurrEndSecs = 405479 (24000 seconds away)
2018-05-17 10:02:59 (1213) Scheduler.cpp:455:NowSecs = 381779, CurrEndSecs = 405479 (23700 seconds away)
2018-05-17 10:07:59 (1213) Scheduler.cpp:455:NowSecs = 382079, CurrEndSecs = 405479 (23400 seconds away)
2018-05-17 10:12:59 (1213) Scheduler.cpp:455:NowSecs = 382379, CurrEndSecs = 405479 (23100 seconds away)
2018-05-17 10:17:59 (1213) Scheduler.cpp:455:NowSecs = 382679, CurrEndSecs = 405479 (22800 seconds away)
2018-05-17 10:22:59 (1213) Scheduler.cpp:455:NowSecs = 382979, CurrEndSecs = 405479 (22500 seconds away)
2018-05-17 10:27:59 (1213) Scheduler.cpp:455:NowSecs = 383279, CurrEndSecs = 405479 (22200 seconds away)






Offline dkulp

  • Developer
  • ******
  • Join Date: Sep 2013
  • Location: Framingham, MA
  • Posts: 829
  • Kudos: 35
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #6 on: May 17, 2018, 02:23:06 PM »


Is it always during "HOLLY JOLLY CHRISTMAS.mp3"?   If so, could you send me that mp3 so I can see if I can reproduce it?



Dan Kulp

Offline brichi

  • Sr. Member
  • ****
  • Join Date: Dec 2017
  • Location:
  • Posts: 465
  • Kudos: 1
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #7 on: May 17, 2018, 02:31:45 PM »


Is it always during "HOLLY JOLLY CHRISTMAS.mp3"?   If so, could you send me that mp3 so I can see if I can reproduce it?


the first time in the first post it was Jingle Bell Rock, I restarted FPPD thats why you see Holly at the bottom


here is a zip file contains 5 songs, converted in iTunes CBR320 that I have in a playlists to repeat, this was going from 00:01-16:30 and froze around 08:45


https://drive.google.com/file/d/1OKZ39MtdboFDETBfE7QMq9Ds4Rr91Gu5/view?usp=sharing


Thanks Dan for checking into it. I tried everything even new USB and SD cards along with a Pi 3 and the new Pi plus

Offline dkulp

  • Developer
  • ******
  • Join Date: Sep 2013
  • Location: Framingham, MA
  • Posts: 829
  • Kudos: 35
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #8 on: May 17, 2018, 07:43:52 PM »



I stuck the mp3's on my Pi.  It's run through twice now OK.  I'll let it go overnight and see if anything pops up.




Offline brichi

  • Sr. Member
  • ****
  • Join Date: Dec 2017
  • Location:
  • Posts: 465
  • Kudos: 1
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #9 on: May 17, 2018, 07:46:37 PM »



I stuck the mp3's on my Pi.  It's run through twice now OK.  I'll let it go overnight and see if anything pops up.





Yeah definitely let it run for a long time. Mine ran for 9 hours looping those 4 tracks before it froze.

Offline dkulp

  • Developer
  • ******
  • Join Date: Sep 2013
  • Location: Framingham, MA
  • Posts: 829
  • Kudos: 35
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #10 on: May 18, 2018, 06:35:49 AM »


Well, it's still running this morning... I'll let it keep going.

Offline brichi

  • Sr. Member
  • ****
  • Join Date: Dec 2017
  • Location:
  • Posts: 465
  • Kudos: 1
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #11 on: May 18, 2018, 06:40:01 AM »


Well, it's still running this morning... I'll let it keep going.


could it be because I have it as part of a schedule vs just selecting a playlist and letting it run? in the logs to looks like the timers constantly running as it should till the next schedule, maybe thats causing something?


not sure if anything in those logs helps you related to whats happening

Offline dkulp

  • Developer
  • ******
  • Join Date: Sep 2013
  • Location: Framingham, MA
  • Posts: 829
  • Kudos: 35
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #12 on: May 18, 2018, 07:18:42 AM »
could it be because I have it as part of a schedule vs just selecting a playlist and letting it run? in the logs to looks like the timers constantly running as it should till the next schedule, maybe thats causing something?



Hmm... good point.  I'll flip over to that and see if anything happens.

Offline brichi

  • Sr. Member
  • ****
  • Join Date: Dec 2017
  • Location:
  • Posts: 465
  • Kudos: 1
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #13 on: May 18, 2018, 07:21:17 AM »
could it be because I have it as part of a schedule vs just selecting a playlist and letting it run? in the logs to looks like the timers constantly running as it should till the next schedule, maybe thats causing something?



Hmm... good point.  I'll flip over to that and see if anything happens.


sounds good, tonight ill do the opposite when I get home and run the 4 tracks on its own with no schedule to see if theres a difference.


I also reencoded the 4 tracks from 320K to 128 to see if that would matter

Offline dkulp

  • Developer
  • ******
  • Join Date: Sep 2013
  • Location: Framingham, MA
  • Posts: 829
  • Kudos: 35
Re: v2.x-master-582-g6ef7b300 MP3 froze mid schedule
« Reply #14 on: May 18, 2018, 07:25:21 AM »



I also reencoded the 4 tracks from 320K to 128 to see if that would matter


Note:  with the new SDL based output, you should be able to use the m4a file from iTunes directly and not re-encode anything.

 

Back to top