When stopping mother earth and not playing anything after a while the green light lit and it is impossible to connect to Volumio

gdenneulin · November 14, 2024, 1:01pm

Continuing the discussion from [Plugin] Mother Earth Radio 1.0.0:

Hello

I have installed the plugin Mother Earth Radio 1.2.2 on Rasbery pi B3+.
It works fine BUT…

When stopping mother earth and not playing anything after a while the green light lit and it is impossible to connect to Volumio. I tried IP/dev but nothing. the only solution is to unplug and plug again.

Do you have an idea ?

Here is the log when launching Mother Earth

info: CALLMETHOD: system_controller system setTestPlugins true
info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins
info: Plugins store is now in test mode
info: Preload queue cleared
info: CoreCommandRouter::volumioReplaceandPlayItems
info: CoreStateMachine::ClearQueue
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreStateMachine::stPlaybackTimer
info: CoreStateMachine::updateTrackBlock
info: CorePlayQueue::getTrackBlock
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::serviceStop
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::serviceStop
info: [1731588667437] ControllerWebradio::stop

info: CorePlayQueue::clearPlayQueue
info: CorePlayQueue::saveQueue
info: CoreCommandRouter::volumioPushQueue
info: CoreStateMachine::addQueueItems
info: CorePlayQueue::addQueueItems
info: Preload queue cleared
info: Adding Item to queue: webmer/0
info: Using cached record of: webmer/0
info: CoreCommandRouter::volumioPushQueue
info: CorePlayQueue::saveQueue
info: CoreStateMachine::updateTrackBlock
info: CorePlayQueue::getTrackBlock
info: CoreCommandRouter::volumioPlay
info: CoreStateMachine::play index 0
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreStateMachine::play index undefined
info: CoreStateMachine::setConsumeUpdateService undefined
info: CorePlayQueue::getTrack 0
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 0

SPOTIFY: RECEIVED VOLUMIO VOLUME 0
info:
---------------------------- MPD announces state update: player
info: sendMpdCommand stop took 40 milliseconds
info: ControllerMpd::getState

info: sendMpdCommand stop took 10 milliseconds

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: sendMpdCommand status took 14 milliseconds
info: sendMpdCommand clear took 12 milliseconds
info: sendMpdCommand status took 11 milliseconds
info: sendMpdCommand status took 8 milliseconds
info: sendMpdCommand status took 6 milliseconds






info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ------------------------------ 63ms
info: ------------------------------ 61ms
info: ------------------------------ 59ms
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
error: updateQueue error: null
error: updateQueue error: null
error: updateQueue error: null
error: updateQueue error: null
info: ------------------------------ 67ms
info: sendMpdCommand playlistinfo took 63 milliseconds
info: sendMpdCommand consume 1 took 63 milliseconds
info: ------------------------------ 13ms
info: ------------------------------ 11ms
info: ------------------------------ 9ms

info: [1731588667564] [MotherEarth] set to consume mode, adding url: https://motherearth.streamserver24.com/listen/motherearth/motherearth

error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
info: ------------------------------ 89ms
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth/motherearth" took 12 milliseconds

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: ------------------------------ 24ms
info: sendMpdCommand play took 8 milliseconds
info: ------------------------------ 6ms
info: ------------------------------ 5ms
info: ------------------------------ 3ms
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info: FusionDsp -  ---- read samplerate, raw: 192000,S32_LE,2,32
info: FusionDsp -  ---- read samplerate from file: 192000
info: camilladsp stopping service pid 16000...
i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
info: camilladsp service terminated, instance 1
info: FusionDsp -  If filter freq >samplerate/2 then disable it
info: camilladsp service started and running in background, instance 1
info:
---------------------------- MPD announces state update: player
info: sendMpdCommand status took 51 milliseconds
info: ControllerMpd::getState

info: sendMpdCommand status took 50 milliseconds
info: sendMpdCommand status took 48 milliseconds
info: sendMpdCommand status took 46 milliseconds








info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info: sendMpdCommand status took 48 milliseconds
info: sendMpdCommand playlistinfo took 47 milliseconds
info: sendMpdCommand playlistinfo took 47 milliseconds
info: sendMpdCommand playlistinfo took 47 milliseconds
info: sendMpdCommand playlistinfo took 46 milliseconds
info: sendMpdCommand status took 44 milliseconds
info: sendMpdCommand status took 43 milliseconds
info: sendMpdCommand status took 42 milliseconds












info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ------------------------------ 111ms
info: ------------------------------ 109ms
info: ------------------------------ 107ms
info: ------------------------------ 106ms
info: camilladsp spawned new process with pid 16058, instance 1, run: true
info: sendMpdCommand playlistinfo took 31 milliseconds
info: sendMpdCommand playlistinfo took 30 milliseconds
info: sendMpdCommand playlistinfo took 30 milliseconds
info: sendMpdCommand playlistinfo took 30 milliseconds




info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ------------------------------ 92ms
info: ------------------------------ 86ms
info: ------------------------------ 84ms
info: ------------------------------ 83ms
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus stop
info: [1731588667885] [MotherEarth] setting new timer with duration of 132000 seconds.
i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
info: CorePlayQueue::getTrack 0
info: CorePlayQueue::getTrack 0
info: Prefetching next song
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info: ------------------------------ 23ms
info: sendMpdCommand status took 18 milliseconds
info: ------------------------------ 18ms
info: sendMpdCommand status took 20 milliseconds
info: ------------------------------ 19ms
info: sendMpdCommand status took 15 milliseconds
info: ------------------------------ 15ms
info: sendMpdCommand status took 11 milliseconds








info: sendMpdCommand playlistinfo took 4 milliseconds
info: sendMpdCommand playlistinfo took 4 milliseconds
info: sendMpdCommand playlistinfo took 4 milliseconds
info: sendMpdCommand playlistinfo took 4 milliseconds




info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ------------------------------ 40ms
info: ------------------------------ 34ms
info: ------------------------------ 31ms
info: ------------------------------ 25ms
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: [1731588800225] [MotherEarth] setting new timer with duration of 240000 seconds.
info: CorePlayQueue::getTrack 0
info: CorePlayQueue::getTrack 0
info: Prefetching next song
info: CoreCommandRouter::volumioGetQueue
info: CoreStateMachine::getQueue
info: CorePlayQueue::getQueue
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: [1731589040519] [MotherEarth] setting new timer with duration of 175000 seconds.
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
SPOTIFY: RECEIVED VOLUMIO VOLUME 0

Wheaten · November 14, 2024, 1:16pm

please provide a full log when it happens, partial copying it doesn’t help us.

Thanks

flow · November 14, 2024, 4:02pm

Hi,
from the log you provided i can see that a possible issue might be the timer duration that the plugin sets:
info: [1731588800225] [MotherEarth] setting new timer with duration of 240000 seconds.
…
info: [1731589040519] [MotherEarth] setting new timer with duration of 175000 seconds.
that doesnt look correct. but the logs also say that we are playing at this moment (if i read it correctly). so, you started playback, then stopped, then volumio crashed? what is this log then? did you reboot, then started playback and this is the log we see?
thanks for clarifying, i will try and reproduce myself.

gdenneulin · November 15, 2024, 10:48am

Hello

Thanks for your answer.
Process : I start volumio, Choose Mother earth radio, play few minutes, stop Mother earth… wait around 20 minutes then it is impossible to access Volumio and the green led of my raspberry is on .

The only solution is to unplug the raspberry

I am using the plugin

Here is the full log until it crashes. I am using also Camilla DSP with some filters and Resample ( for other radios )

-------------------------------------------------------------------------------------------------

Starting Live Log...
No alpha test mode
info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

        Improved translations

        Fix Multiroom Buffer Sizes

        Increase results for Kana-Kanji Conversion

        Fix for streaming interruptions

 

NEW ADDITIONS

        Bump RPi kernel to 6.6.56, support for RPi5 2GB
        Dedicated entry for RPi5 on some I2S DACs, restored master mode for older RPi models

        Add support for HifiBerry AMP4 Pro on RPi

 

 
","title":"Update v3.779","updateavailable":true}
info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
info: CALLMETHOD: system_controller system setTestPlugins true
info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins
info: Plugins store is now in test mode
info: CALLMETHOD: system_controller system enableLiveLog true
info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog
info: Launching a new LiveLog session
info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
info: Received Get System Version
info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
info: Received Get System Info
info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
info: Discovery: Getting this device information
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
 volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
pam_unix(sudo:session): session opened for user root by (uid=0)
pam_unix(sudo:session): session closed for user root
 volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
pam_unix(sudo:session): session opened for user root by (uid=0)
pam_unix(sudo:session): session closed for user root

info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
info: CoreCommandRouter::volumioGetVisibleSources
info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
info: Received Get System Info
info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
info: Discovery: Getting this device information
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: Listing playlists
info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
info: CoreCommandRouter::getUIConfigOnPlugin
info: FusionDsp -  IP adress is ---------------------------192.168.1.122
info: CALLMETHOD: system_controller system setTestPlugins true
info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins
info: Plugins store is now in test mode
info: CALLMETHOD: system_controller system setTestSystem true
info: CoreCommandRouter::executeOnPlugin: system , setTestSystem
info: CoreCommandRouter::executeOnPlugin: updater_comm , checkUpdates
info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
info: Device is now in test mode
Test mode enabled
No alpha test mode
info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

        Improved translations

        Fix Multiroom Buffer Sizes

        Increase results for Kana-Kanji Conversion

        Fix for streaming interruptions

 

NEW ADDITIONS

        Bump RPi kernel to 6.6.56, support for RPi5 2GB
        Dedicated entry for RPi5 on some I2S DACs, restored master mode for older RPi models

        Add support for HifiBerry AMP4 Pro on RPi

 

 
","title":"Update v3.779","updateavailable":true}
info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
info: CALLMETHOD: system_controller system setTestPlugins true
info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins
info: Plugins store is now in test mode
info: CALLMETHOD: system_controller system setTestSystem true
info: CoreCommandRouter::executeOnPlugin: system , setTestSystem
info: CoreCommandRouter::executeOnPlugin: updater_comm , checkUpdates
info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
info: Device is now in test mode
Test mode enabled
No alpha test mode
info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

        Improved translations

        Fix Multiroom Buffer Sizes

        Increase results for Kana-Kanji Conversion

        Fix for streaming interruptions

 

NEW ADDITIONS

        Bump RPi kernel to 6.6.56, support for RPi5 2GB
        Dedicated entry for RPi5 on some I2S DACs, restored master mode for older RPi models

        Add support for HifiBerry AMP4 Pro on RPi

 

 
","title":"Update v3.779","updateavailable":true}
info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
info: CALLMETHOD: system_controller system setTestPlugins true
info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins
info: Plugins store is now in test mode
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: [1731664707443] [MotherEarth] setting new timer with duration of 338000 seconds.
info: CoreCommandRouter::volumioGetQueue
info: CoreStateMachine::getQueue
info: CorePlayQueue::getQueue
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
info: CorePlayQueue::getTrack 0
info: CorePlayQueue::getTrack 0
info: Prefetching next song
82.67.41.119 local addr 192.168.1.122 -> 
185.123.84.51 local addr 192.168.1.122 -> 
82.64.247.11 local addr 192.168.1.122 -> 
95.179.212.126 local addr 192.168.1.122 -> 
193.52.136.2 local addr 192.168.1.122 -> 
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: [1731665045789] [MotherEarth] setting new timer with duration of 10000 seconds.
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
5.196.160.139 local addr 192.168.1.122 -> 
51.68.180.114 local addr 192.168.1.122 -> 
51.15.191.239 local addr 192.168.1.122 -> 
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: [1731665056073] [MotherEarth] setting new timer with duration of 223000 seconds.
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
SPOTIFY: RECEIVED VOLUMIO VOLUME 0
info: CorePlayQueue::getTrack 0
info: CorePlayQueue::getTrack 0
info: Prefetching next song
5.39.80.51 local addr 192.168.1.122 -> 
info: CoreCommandRouter::volumioPause
info: CoreStateMachine::pause
info: CoreStateMachine::stPlaybackTimer
info: CoreStateMachine::servicePause
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::servicePause

info:
---------------------------- MPD announces state update: player
info: sendMpdCommand pause took 3 milliseconds
info: ControllerMpd::getState

info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0


info: CoreStateMachine::syncState   stateService pause
info: CoreStateMachine::syncState   currentStatus pause
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::stPlaybackTimer
info: sendMpdCommand status took 23 milliseconds


info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

SPOTIFY: RECEIVED VOLUMIO VOLUME 0
info: sendMpdCommand playlistinfo took 23 milliseconds
info: sendMpdCommand status took 21 milliseconds
info: sendMpdCommand status took 14 milliseconds
info: sendMpdCommand status took 12 milliseconds







info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ------------------------------ 58ms
info: sendMpdCommand playlistinfo took 5 milliseconds
info: sendMpdCommand playlistinfo took 6 milliseconds
info: sendMpdCommand playlistinfo took 5 milliseconds



info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0
info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
info: ------------------------------ 36ms
info: ------------------------------ 34ms
info: ------------------------------ 26ms
i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
info: camilladsp spawned new process with pid 3353, instance 1, run: true
i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
212.85.158.10 local addr 192.168.1.122 -> 
Starting Cleanup of Temporary Directories...
systemd-tmpfiles-clean.service: Succeeded.
Started Cleanup of Temporary Directories.
error: [yt-cast-receiver] RPC connection reader error:
(Error) Premature close
Error: Premature close
    at IncomingMessage. (/data/plugins/music_service/ytcr/node_modules/node-fetch/lib/index.js:1749:18)
    at Object.onceWrapper (events.js:421:28)
    at IncomingMessage.emit (events.js:315:20)
    at TLSSocket.socketCloseListener (_http_client.js:435:11)
    at TLSSocket.emit (events.js:327:22)
    at net.js:673:12
    at TCP.done (_tls_wrap.js:563:7)
error: [yt-cast-receiver] RPC connection reader error:
(Error) Premature close
Error: Premature close
    at IncomingMessage. (/data/plugins/music_service/ytcr/node_modules/node-fetch/lib/index.js:1749:18)
    at Object.onceWrapper (events.js:421:28)
    at IncomingMessage.emit (events.js:315:20)
    at TLSSocket.socketCloseListener (_http_client.js:435:11)
    at TLSSocket.emit (events.js:327:22)
    at net.js:673:12
    at TCP.done (_tls_wrap.js:563:7)

gdenneulin · November 21, 2024, 5:33pm

Hello,

I did some test and it is clearly related with the plugin Fusion DSP.
When it is off o have no problem.

balbuze · November 22, 2024, 3:06pm

Please send a link for the log, not just a live log. TY