Home of the Squeezebox™ & Transporter® network music players.
Page 1 of 2 12 LastLast
Results 1 to 10 of 16
  1. #1

    Random and very annoying glitch

    My Squeezebox setup has LMS on a Vortexbox and I play it mostly through RPi/PcP and Windows Squeezelite clients.

    I'm suffering from a really annoying problem where the music just stops. As it happens on PcP and my Windows PC I am assuming it is a server issue rather than a PcP/Squeeselite one, but happy to be put right on that. It certainly takes place when listening through the iPlayer plugin but also when I listen to My Music.

    Today, as an example, a PcP unit was started at 7am and ran through until 8:07pm when it stopped.

    Meanwhile my Windows PC upstairs had been playing from for a couple of hours before stopping at 8:00pm. I have restarted and it has stopped randomly twice in the last 20 minutes while I write this.

    I have looked at the LMS logs and attach them here:
    The RPi/PcP is 74:da:38:54:5a:69
    The Win Squeezelite is c8:60:00:cc:4f:82

    Does the attached log reveal any problems? I'm sorry I don't know enough to interpret it.

    George
    Attached Files Attached Files

  2. #2
    Senior Member
    Join Date
    Oct 2005
    Location
    Ireland
    Posts
    15,792
    An edited log without detail of what is being played, what log levels have been enabled and on what version of LMS is not that helpful.

    Logs should be supplied complete as sometimes the messages that are missing are as important as the ones that are present. If you edit a log - it is no longer complete. If you worry about size - Zip log file before attaching.

    What version of LMS ? IIRC Vorexbox used to do some tweaks of its own. Any chance of testing a clean latest version of LMS ?

    More details on fault circumstances.
    When iplayer is being played - does it stop when playing live or listen again ?
    When it stops - is it mid track, near beginning, near end, at end ? Don't assume or guess, if you don't know say so.

    Stick to one squeezelite player and find out why player stops - and then work back to LMS to see what can be done. Only have one player playing when testing.
    Usually one of two categories: 1. player doesn't want data/can't play or LMS doesn't want to send any more data or too slow sending data
    Enable logging for Squeezelite and determine why does it stop

  3. #3
    OK thanks for the guidance. Full log attached showing RPi/PcP 3.22 being turned on at 06.35. It then ran (BBC iPlayer live stream) until 20:07 as mentioned in original post.
    The PC with Squeezelite starts at 19:01 and runs (same BBC iPlayer live stream) until 20:00.

    LMS is v7.9.1 Vortexbox 2.4 image (upgraded from 2.3 9 months ago) on a bespoke server. Its been working for 5 years without showing the recent symptoms. I haven't tried setting up another server yet as I was hoping to troubleshoot the one I have. It is not a high power machine but it does serve Plex (but isn't running anything else when the faults occur).

    PcP 3.22 on RPi3. No network issues should exist - mesh network with excellent signal strength and fibre broadband. I've turned on the Squeezelite logging and will post information if/when the problem reoccurs but as it is also happening on my Win10 PC, I presumed that a server issue was more probable.
    Attached Files Attached Files

  4. #4
    Senior Member
    Join Date
    Oct 2005
    Location
    Ireland
    Posts
    15,792
    Where is the Squeezelite log ? (i.e. enable logging by Squeezleite - not logging of squeezelite by LMS)

    Not specific to this but what version of BBCiPlayer are you using ? if it is a 1.5.* then change settings to use DASH and not HLS. HLS implementation can be unreliable and may load a system and network badly.

    edit:

    The problem is probably with the server - but how it appears to the player can indicate the source.

    Strange - why is LMS transcoding the AAC stream when the Squeezelite players can play AAC native ? Have setting been changed from default ? Perhaps it is due to HLS.
    Last edited by bpa; 2018-03-07 at 16:09.

  5. #5
    The iPlayer plugin is v1.5.4.5 and the live stream preferences are HLS 》MP3 》FlashAAC 》FlashMP3

    Allow transcoding is allowed.

    The RPi/PcP that was set going last night was still playing fine this morning. I enclose the log. The channel was changed at 06:22.

    Many thanks


    /usr/local/bin/squeezelite -n 7inches -o equal -a 80:4::1: -d all=info -f /var/log/pcp_squeezelite.log -v -C 15
    [22:07:11.561584] stream_init:294 init stream
    [22:07:11.566124] output_init_alsa:877 init output
    [22:07:11.566247] output_init_alsa:906 requested alsa_buffer: 80 alsa_period: 4 format: any mmap: 1
    [22:07:11.617085] output_init_common:411 supported rates: 384000 352800 192000 176400 96000 88200 48000 44100 32000 24000 22500 16000 12000 11025 8000
    [22:07:11.632983] output_init_alsa:932 memory locked
    [22:07:11.633948] output_vis_init:136 opened visulizer shared memory as /squeezelite-74:da:38:54:5a:69
    [22:07:11.633996] decode_init:153 init decode
    [22:07:11.634173] register_dsd:625 using dsd to decode dsf,dff
    [22:07:11.635170] load_ff:619 dlerror: libavcodec.so.57: cannot open shared object file: No such file or directory
    [22:07:11.635519] load_ff:619 dlerror: libavcodec.so.57: cannot open shared object file: No such file or directory
    [22:07:11.637053] load_faad:611 loaded libfaad.so.2
    [22:07:11.637079] register_faad:641 using faad to decode aac
    [22:07:11.639007] load_vorbis:305 loaded libvorbisfile.so.3
    [22:07:11.639033] register_vorbis:334 using vorbis to decode ogg
    [22:07:11.640691] load_flac:258 loaded libFLAC.so.8
    [22:07:11.640716] register_flac:286 using flac to decode flc
    [22:07:11.640735] register_pcm:415 using pcm to decode aif,pcm
    [22:07:11.641803] load_mad:384 loaded libmad.so.0
    [22:07:11.641829] register_mad:413 using mad to decode mp3
    [22:07:11.642528] discover_server:826 sending discovery
    [22:07:11.649724] discover_server:837 got response from: 192.168.1.76:3483
    [22:07:11.649833] slimproto:925 connecting to 192.168.1.76:3483
    [22:07:11.658082] slimproto:964 connected
    [22:07:11.658120] sendHELO:138 mac: 74:da:38:54:5a:69
    [22:07:11.658144] sendHELO:140 cap: Model=squeezelite,AccuratePlayPoints=1,HasDigitalO ut=1,HasPolarityInversion=1,Firmware=v1.8.7-1052,ModelName=SqueezeLite,MaxSampleRate=384000,ds f,dff,aac,ogg,flc,aif,pcm,mp3
    [22:07:11.669834] decode_flush:227 decode flush
    [22:07:11.669863] output_flush:424 flush output buffer
    [22:07:11.670844] decode_flush:227 decode flush
    [22:07:11.670870] output_flush:424 flush output buffer
    [22:22:02.251541] decode_flush:227 decode flush
    [22:22:02.251624] output_flush:424 flush output buffer
    [22:22:02.298101] codec_open:255 codec open: 'a'
    [22:22:02.298200] faad_open:541 opening adts stream
    [22:22:02.298279] stream_sock:393 connecting to 192.168.1.76:9000
    [22:22:02.302882] stream_sock:422 header: GET /stream.mp3?player=74:da:38:54:5a:69 HTTP/1.0


    [22:22:02.339338] stream_thread:180 headers: len: 130
    HTTP/1.1 200 OK
    Server: Logitech Media Server (7.9.1 - 0.6.20170928git1508251793)
    Connection: close
    Content-Type: audio/aac


    [22:22:02.908700] faad_decode:373 samplerate: 48000 channels: 2
    [22:22:02.908787] faad_decode:378 setting track_start
    [22:22:02.915323] output_thread:632 open output device: equal
    [22:22:02.915388] alsa_open:338 opening device at: 44100
    [22:22:02.926518] alsa_open:389 opened device equal using format: S32_LE sample rate: 44100 mmap: 1
    [22:22:02.932106] alsa_open:468 buffer: 80 period: 4 -> buffer size: 3528 period size: 882
    [22:22:02.983387] _output_frames:62 start buffer frames: 11264
    [22:22:02.983476] _output_frames:147 track start sample rate: 48000 replay_gain: 0
    [22:22:02.993525] output_thread:632 open output device: equal
    [22:22:02.993864] alsa_open:338 opening device at: 48000
    [22:22:03.003114] alsa_open:389 opened device equal using format: S32_LE sample rate: 48000 mmap: 1
    [22:22:03.008624] alsa_open:468 buffer: 80 period: 4 -> buffer size: 3840 period size: 960
    [06:22:36.682882] decode_flush:227 decode flush
    [06:22:36.682973] output_flush:424 flush output buffer
    [06:22:36.683168] decode_flush:227 decode flush
    [06:22:36.683193] output_flush:424 flush output buffer
    [06:22:36.715936] codec_open:255 codec open: 'a'
    [06:22:36.716048] faad_open:541 opening adts stream
    [06:22:36.716162] stream_sock:393 connecting to 192.168.1.76:9000
    [06:22:36.719870] stream_sock:422 header: GET /stream.mp3?player=74:da:38:54:5a:69 HTTP/1.0


    [06:22:36.809912] stream_thread:180 headers: len: 130
    HTTP/1.1 200 OK
    Server: Logitech Media Server (7.9.1 - 0.6.20170928git1508251793)
    Connection: close
    Content-Type: audio/aac


    [06:22:36.813204] output_thread:742 disabling output
    [06:22:37.313725] output_thread:632 open output device: equal
    [06:22:37.313813] alsa_open:338 opening device at: 48000
    [06:22:37.323244] alsa_open:389 opened device equal using format: S32_LE sample rate: 48000 mmap: 1
    [06:22:37.328838] alsa_open:468 buffer: 80 period: 4 -> buffer size: 3840 period size: 960
    [06:22:37.384190] faad_decode:373 samplerate: 48000 channels: 2
    [06:22:37.384278] faad_decode:378 setting track_start
    [06:22:37.439585] _output_frames:62 start buffer frames: 12288
    [06:22:37.439684] _output_frames:147 track start sample rate: 48000 replay_gain: 0






    Sent from my SM-N9005 using Tapatalk

  6. #6
    Senior Member
    Join Date
    Oct 2005
    Location
    Ireland
    Posts
    15,792
    Quote Originally Posted by kingswindsor View Post
    The iPlayer plugin is v1.5.4.5 and the live stream preferences are HLS 》MP3 》FlashAAC 》FlashMP3
    Please change to DASH >> HLS >> MP3 >> FlashAAC

    These are the only options BBC now supports and HLS is unreliable which may be a source of music stopping and so be "muddying the waters" so DASH will be used.


    The log below shows LMS sending a AAC stream toplayer. Yet yesterday's log showed LMS transcoding AAC to Flac. This means somehting has changed in LMS or player setup since yesterday.

    Code:
    [22:22:02.298101] codec_open:255 codec open: 'a'
    [22:22:02.298200] faad_open:541 opening adts stream
    [22:22:02.298279] stream_sock:393 connecting to 192.168.1.76:9000
    [22:22:02.302882] stream_sock:422 header: GET /stream.mp3?player=74:da:38:54:5a:69 HTTP/1.0
    
    [22:22:02.339338] stream_thread:180 headers: len: 130
    HTTP/1.1 200 OK
    Server: Logitech Media Server (7.9.1 - 0.6.20170928git1508251793)
    Connection: close
    Content-Type: audio/aac

  7. #7
    Thanks. I'll change the preferences when I get home and retest this evening.

    On your other point, I have not changed any settings on either server or player (other than turning the squeezelite logging on). Maybe gremlins!

    Sent from my SM-N9005 using Tapatalk

  8. #8
    Senior Member
    Join Date
    Oct 2005
    Location
    Ireland
    Posts
    15,792
    Quote Originally Posted by kingswindsor View Post
    On your other point, I have not changed any settings on either server or player (other than turning the squeezelite logging on). Maybe gremlins!
    That's not good. Do you have your LMS ports exposed 9000 etc. to internet ?

  9. #9
    No, not at all. VPN is set up.

    Sent from my SM-N9005 using Tapatalk

  10. #10
    Senior Member
    Join Date
    Oct 2005
    Location
    Ireland
    Posts
    15,792
    Quote Originally Posted by kingswindsor View Post
    No, not at all. VPN is set up.

    Sent from my SM-N9005 using Tapatalk
    Transcoding setting just don't change !! so either you are doing something different or somehting has changed by someone.

    To track down "random glitches" - things need to be replicated exactly everytime with no changes elsewhere on system or network. Sometime problems are related to things users think could not affect LMS.

Posting Permissions

  • You may not post new threads
  • You may not post replies
  • You may not post attachments
  • You may not edit your posts
  •