-- Logs begin at Thu 2019-02-14 04:11:59 CST, end at Wed 2025-05-28 03:58:02 CDT. --
May 28 03:57:00 volumiopi3 volumio[844]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded.
May 28 03:57:00 volumiopi3 sudo[4129]: pam_unix(sudo:session): session closed for user root
May 28 03:57:00 volumiopi3 sudo[3909]: pam_unix(sudo:session): session closed for user root
May 28 03:57:00 volumiopi3 volumio[844]: info: Install script completed
May 28 03:57:00 volumiopi3 volumio[844]: info: Adding reference to registry
May 28 03:57:00 volumiopi3 volumio[844]: info: Done installing plugin.
May 28 03:57:00 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 28 03:57:00 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 28 03:57:00 volumiopi3 volumio[844]: info: Folder /tmp/plugins removed
May 28 03:57:00 volumiopi3 volumio[844]: info: Folder /tmp/downloaded_plugin.zip removed
May 28 03:57:00 volumiopi3 volumio[844]: info: Installing gpio_control
May 28 03:57:00 volumiopi3 volumio[844]: Plugin install end detected on script
May 28 03:57:00 volumiopi3 volumio[844]: info: Folder /data/temp removed
May 28 03:57:02 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
May 28 03:57:02 volumiopi3 volumio[844]: info: browseTIDALUri took 185 milliseconds
May 28 03:57:02 volumiopi3 volumio[844]: info: Preload queue cleared
May 28 03:57:02 volumiopi3 volumio[844]: info: Preload queue cleared
May 28 03:57:05 volumiopi3 volumio[844]: info: Preload queue cleared
May 28 03:57:05 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 28 03:57:05 volumiopi3 volumio[844]: info: CoreStateMachine::ClearQueue
May 28 03:57:05 volumiopi3 volumio[844]: info: CoreStateMachine::stop
May 28 03:57:05 volumiopi3 volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined
May 28 03:57:05 volumiopi3 volumio[844]: info: CorePlayQueue::clearPlayQueue
May 28 03:57:05 volumiopi3 volumio[844]: info: CorePlayQueue::saveQueue
May 28 03:57:05 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPushQueue
May 28 03:57:05 volumiopi3 volumio[844]: info: CoreStateMachine::addQueueItems
May 28 03:57:05 volumiopi3 volumio[844]: info: CorePlayQueue::addQueueItems
May 28 03:57:05 volumiopi3 volumio[844]: info: Preload queue cleared
May 28 03:57:05 volumiopi3 volumio[844]: info: Adding Item to queue: tidal://mymusic/playlists/az/f39cdcd3-8609-4b16-8cc9-73379d8cb701
May 28 03:57:05 volumiopi3 volumio[844]: info: Exploding uri tidal://mymusic/playlists/az/f39cdcd3-8609-4b16-8cc9-73379d8cb701 in service tidal
May 28 03:57:06 volumiopi3 volumio[844]: info: explodeTIDALUri took 272 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPushQueue
May 28 03:57:06 volumiopi3 volumio[844]: info: CorePlayQueue::saveQueue
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::updateTrackBlock
May 28 03:57:06 volumiopi3 volumio[844]: info: CorePlayQueue::getTrackBlock
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPlay
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::play index 0
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::stop
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::play index undefined
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined
May 28 03:57:06 volumiopi3 volumio[844]: info: CorePlayQueue::getTrack 0
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::startPlaybackTimer
May 28 03:57:06 volumiopi3 volumio[844]: info: CorePlayQueue::getTrack 0
May 28 03:57:06 volumiopi3 volumio[844]: info: [1748422626132] ControllerTidal::clearAddPlayTrack
May 28 03:57:06 volumiopi3 volumio[844]: info: Getting stream with soundQuality LOSSLESS
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand stop
May 28 03:57:06 volumiopi3 volumio[844]: info: sendMpdCommand stop took 5 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand clear
May 28 03:57:06 volumiopi3 volumio[844]: info:
May 28 03:57:06 volumiopi3 volumio[844]: ---------------------------- MPD announces system playlist update
May 28 03:57:06 volumiopi3 volumio[844]: info: Ignoring MPD Status Update
May 28 03:57:06 volumiopi3 volumio[844]: info: sendMpdCommand clear took 3 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/20750059&soundQuality=LOSSLESS"
May 28 03:57:06 volumiopi3 volumio[844]: error: updateQueue error: null
May 28 03:57:06 volumiopi3 volumio[844]: info:
May 28 03:57:06 volumiopi3 volumio[844]: ---------------------------- MPD announces system playlist update
May 28 03:57:06 volumiopi3 volumio[844]: info: Ignoring MPD Status Update
May 28 03:57:06 volumiopi3 volumio[844]: info: ------------------------------ 4ms
May 28 03:57:06 volumiopi3 volumio[844]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/20750059&soundQuality=LOSSLESS" took 3 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::setConsumeUpdateService mpd
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand play
May 28 03:57:06 volumiopi3 volumio[844]: info: ------------------------------ 4ms
May 28 03:57:06 volumiopi3 volumio[844]: info: sendMpdCommand play took 3 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: STREAMING PROXY: Handling url /?data=tidal://song/20750059&soundQuality=LOSSLESS
May 28 03:57:06 volumiopi3 volumio[844]: info: Executing endpoint getStreamUrltidal
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI
May 28 03:57:06 volumiopi3 volumio[844]: info: getStreamUrl took 181 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic4NmUxYzdiOWRiZWE4NGE0NmU5Nzk3NWRhYmFlZThkOF82MS5tcDQ/0.flac?Expires=1748425946&Signature=WiiJrm7zWZVgemr7CnFcbZd9LPSPaqUh-ZxPYqiHKr~IkmEVSFA2XJrcVxEeYKiA-Tkuz02cui2J5gg0UIpTgYJoPYm4590ICD1vEaDFLsl3CC60TdWrRj5VFbBdjZvae9uiA~oMW5jevWV9eNyCvXrOeEXGNEwEFv5GHorbRYlSfWjbOsmnAsRQRKa4qzUXqMQ~TZECEoUrWPm9hDyLTw~E1SUHYM5ErGSV7Zaj8K4vy9GJYbj8RT8s-OT1-1p35yLb-OGIAzALkDjPe9cTpo6QdYevUByNbrj~Sutxa5iaAniMwFKik7c2kkus-7Es0~QEHlqliups0Csk7Rrqbg__&Key-Pair-Id=K14LZCZ9QUI4JL
May 28 03:57:06 volumiopi3 volumio[844]: STREAMING PROXY: Response: 200, length: 25426921
May 28 03:57:06 volumiopi3 volumio[844]: info:
May 28 03:57:06 volumiopi3 volumio[844]: ---------------------------- MPD announces state update: player
May 28 03:57:06 volumiopi3 volumio[844]: info: ControllerMpd::getState
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand status
May 28 03:57:06 volumiopi3 volumio[844]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 28 03:57:06 volumiopi3 volumio[844]: info: FusionDsp - ---- read samplerate from file: 44100
May 28 03:57:06 volumiopi3 volumio[844]: error: FusionDsp - TypeError: Cannot read property 'stop' of null
May 28 03:57:06 volumiopi3 volumio[844]: info:
May 28 03:57:06 volumiopi3 volumio[844]: ---------------------------- MPD announces state update: player
May 28 03:57:06 volumiopi3 volumio[844]: info: sendMpdCommand status took 47 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: info: ControllerMpd::getState
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand status
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::parseState
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 03:57:06 volumiopi3 volumio[844]: info: sendMpdCommand status took 8 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::parseState
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::parseTrackInfo
May 28 03:57:06 volumiopi3 volumio[844]: info: ControllerMpd::pushState
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreCommandRouter::servicePushState
May 28 03:57:06 volumiopi3 volumio[844]: info: CorePlayQueue::getTrack 0
May 28 03:57:06 volumiopi3 volumio[844]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"993 Kbps","isStreaming":false,"title":"20750059&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/20750059&soundQuality=LOSSLESS","trackType":"tidal"}
May 28 03:57:06 volumiopi3 volumio[844]: verbose: CURRENT POSITION 0
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::syncState stateService play
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::syncState currentStatus stop
May 28 03:57:06 volumiopi3 volumio[844]: info: ------------------------------ 72ms
May 28 03:57:06 volumiopi3 volumio[844]: info: sendMpdCommand playlistinfo took 12 milliseconds
May 28 03:57:06 volumiopi3 volumio[844]: verbose: ControllerMpd::parseTrackInfo
May 28 03:57:06 volumiopi3 volumio[844]: info: ControllerMpd::pushState
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreCommandRouter::servicePushState
May 28 03:57:06 volumiopi3 volumio[844]: info: CorePlayQueue::getTrack 0
May 28 03:57:06 volumiopi3 volumio[844]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"924 Kbps","isStreaming":false,"title":"20750059&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/20750059&soundQuality=LOSSLESS","trackType":"tidal"}
May 28 03:57:06 volumiopi3 volumio[844]: verbose: CURRENT POSITION 0
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::syncState stateService play
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::syncState currentStatus play
May 28 03:57:06 volumiopi3 volumio[844]: info: Received an update from plugin. extracting info from payload
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::pushState
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPushState
May 28 03:57:06 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output update for this device
May 28 03:57:06 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreStateMachine::pushState
May 28 03:57:06 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPushState
May 28 03:57:06 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output update for this device
May 28 03:57:06 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output
May 28 03:57:06 volumiopi3 volumio[844]: info: ------------------------------ 143ms
May 28 03:57:08 volumiopi3 volumio[844]: STREAMING PROXY: Client dropped request, destroying
May 28 03:57:29 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioRandom
May 28 03:57:29 volumiopi3 volumio[844]: info: CoreCommandRouter::writePlayerControls
May 28 03:57:29 volumiopi3 volumio[844]: info: CoreStateMachine::setRepeat true single false
May 28 03:57:29 volumiopi3 volumio[844]: info: CoreStateMachine::pushState
May 28 03:57:29 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 03:57:29 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPushState
May 28 03:57:29 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output update for this device
May 28 03:57:29 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
May 28 03:57:52 volumiopi3 volumio[844]: info: Pausing Remote Device: http://192.168.4.237
May 28 03:57:52 volumiopi3 volumio[844]: info:
May 28 03:57:52 volumiopi3 volumio[844]: ---------------------------- Client requests Volumio pause
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPause
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreStateMachine::pause
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreStateMachine::stPlaybackTimer
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreStateMachine::servicePause
May 28 03:57:52 volumiopi3 volumio[844]: info: CorePlayQueue::getTrack 0
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreCommandRouter::servicePause
May 28 03:57:52 volumiopi3 volumio[844]: info: [1748422672433] ControllerTidal::pause
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreStateMachine::setConsumeUpdateService mpd
May 28 03:57:52 volumiopi3 volumio[844]: info: ControllerMpd::pause
May 28 03:57:52 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand pause
May 28 03:57:52 volumiopi3 volumio[844]: info:
May 28 03:57:52 volumiopi3 volumio[844]: ---------------------------- MPD announces state update: player
May 28 03:57:52 volumiopi3 volumio[844]: info: sendMpdCommand pause took 2 milliseconds
May 28 03:57:52 volumiopi3 volumio[844]: info: ControllerMpd::getState
May 28 03:57:52 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand status
May 28 03:57:52 volumiopi3 volumio[844]: info: sendMpdCommand status took 4 milliseconds
May 28 03:57:52 volumiopi3 volumio[844]: verbose: ControllerMpd::parseState
May 28 03:57:52 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 03:57:52 volumiopi3 volumio[844]: info: Done pausing:
May 28 03:57:52 volumiopi3 volumio[844]: info: sendMpdCommand playlistinfo took 5 milliseconds
May 28 03:57:52 volumiopi3 volumio[844]: verbose: ControllerMpd::parseTrackInfo
May 28 03:57:52 volumiopi3 volumio[844]: info: ControllerMpd::pushState
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreCommandRouter::servicePushState
May 28 03:57:52 volumiopi3 volumio[844]: info: CorePlayQueue::getTrack 0
May 28 03:57:52 volumiopi3 volumio[844]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1715,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"768 Kbps","isStreaming":false,"title":"20750059&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/20750059&soundQuality=LOSSLESS","trackType":"tidal"}
May 28 03:57:52 volumiopi3 volumio[844]: verbose: CURRENT POSITION 0
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreStateMachine::syncState stateService pause
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreStateMachine::syncState currentStatus pause
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreStateMachine::pushState
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPushState
May 28 03:57:52 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output update for this device
May 28 03:57:52 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output
May 28 03:57:52 volumiopi3 volumio[844]: info: CoreStateMachine::stPlaybackTimer
May 28 03:57:52 volumiopi3 volumio[844]: info: ------------------------------ 43ms
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
May 28 03:57:53 volumiopi3 volumio[844]: info: Playing Remote Device: http://192.168.4.237
May 28 03:57:53 volumiopi3 volumio[844]: info:
May 28 03:57:53 volumiopi3 volumio[844]: ---------------------------- Client requests Volumio play
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPlay
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreStateMachine::play index undefined
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreStateMachine::setConsumeUpdateService undefined
May 28 03:57:53 volumiopi3 volumio[844]: info: CorePlayQueue::getTrack 0
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreStateMachine::startPlaybackTimer
May 28 03:57:53 volumiopi3 volumio[844]: info: CorePlayQueue::getTrack 0
May 28 03:57:53 volumiopi3 volumio[844]: info: [1748422673505] ControllerTidal::resume
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreStateMachine::setConsumeUpdateService mpd
May 28 03:57:53 volumiopi3 volumio[844]: info: ControllerMpd::resume
May 28 03:57:53 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand play
May 28 03:57:53 volumiopi3 volumio[844]: info: Done playing:
May 28 03:57:53 volumiopi3 volumio[844]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
May 28 03:57:53 volumiopi3 volumio[844]: info: FusionDsp - ---- read samplerate from file: 44100
May 28 03:57:53 volumiopi3 volumio[844]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 28 03:57:53 volumiopi3 volumio[844]: info:
May 28 03:57:53 volumiopi3 volumio[844]: ---------------------------- MPD announces state update: player
May 28 03:57:53 volumiopi3 volumio[844]: info: sendMpdCommand play took 26 milliseconds
May 28 03:57:53 volumiopi3 volumio[844]: info: ControllerMpd::getState
May 28 03:57:53 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand status
May 28 03:57:53 volumiopi3 volumio[844]: info: sendMpdCommand status took 1 milliseconds
May 28 03:57:53 volumiopi3 volumio[844]: verbose: ControllerMpd::parseState
May 28 03:57:53 volumiopi3 volumio[844]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 03:57:53 volumiopi3 volumio[844]: error: FusionDsp - WebSocket error: [object Object]
May 28 03:57:53 volumiopi3 volumio[844]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 28 03:57:53 volumiopi3 volumio[844]: verbose: ControllerMpd::parseTrackInfo
May 28 03:57:53 volumiopi3 volumio[844]: info: ControllerMpd::pushState
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreCommandRouter::servicePushState
May 28 03:57:53 volumiopi3 volumio[844]: info: CorePlayQueue::getTrack 0
May 28 03:57:53 volumiopi3 volumio[844]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2951,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"928 Kbps","isStreaming":false,"title":"20750059&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/20750059&soundQuality=LOSSLESS","trackType":"tidal"}
May 28 03:57:53 volumiopi3 volumio[844]: verbose: CURRENT POSITION 0
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreStateMachine::syncState stateService play
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreStateMachine::syncState currentStatus pause
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreStateMachine::pushState
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 03:57:53 volumiopi3 volumio[844]: info: CoreCommandRouter::volumioPushState
May 28 03:57:53 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output update for this device
May 28 03:57:53 volumiopi3 volumio[844]: info: MRS: Pushing multiroomSync output
May 28 03:57:53 volumiopi3 volumio[844]: info: ------------------------------ 47ms
May 28 03:58:01 volumiopi3 volumio[844]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay
May 28 03:58:01 volumiopi3 volumio[844]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom
May 28 03:58:01 volumiopi3 volumio[844]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 03:58:01 volumiopi3 volumio[844]: TypeError: Cannot read property 'then' of undefined
May 28 03:58:01 volumiopi3 volumio[844]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9)
May 28 03:58:01 volumiopi3 volumio[844]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30)
May 28 03:58:01 volumiopi3 volumio[844]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1456:26)
May 28 03:58:01 volumiopi3 volumio[844]: at Socket.emit (events.js:315:20)
May 28 03:58:01 volumiopi3 volumio[844]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
May 28 03:58:01 volumiopi3 volumio[844]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 28 03:58:01 volumiopi3 volumio[844]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 03:58:02 volumiopi3 sudo[4297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-28 03:57
May 28 03:58:02 volumiopi3 sudo[4297]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"