-- Logs begin at Thu 2019-02-14 02:11:59 PST, end at Sun 2025-04-27 18:08:34 PDT. --
Apr 27 18:07:03 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 27 18:07:03 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 27 18:07:03 volumio volumio[1056]: info: Discovery: Getting this device information
Apr 27 18:07:03 volumio volumio[1056]: info: CoreCommandRouter::volumioGetState
Apr 27 18:07:03 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:07:03 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 27 18:07:33 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 27 18:07:33 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 27 18:07:33 volumio volumio[1056]: info: Discovery: Getting this device information
Apr 27 18:07:33 volumio volumio[1056]: info: CoreCommandRouter::volumioGetState
Apr 27 18:07:33 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:07:33 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 27 18:08:02 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:02 volumio volumio[1056]: info: CorePlayQueue::getTrack 1
Apr 27 18:08:02 volumio volumio[1056]: info: Prefetching next song
Apr 27 18:08:02 volumio volumio[1056]: info: DOING PREFETCH IN MPD
Apr 27 18:08:02 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand add "NAS/BrennanB3/[nature sounds]/Lake Louise-Alberta Vacation Theme (Rocky Mountain Suite)/02 Glacier Lake.flac"
Apr 27 18:08:02 volumio volumio[1056]: info:
Apr 27 18:08:02 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Apr 27 18:08:02 volumio volumio[1056]: info: Ignoring MPD Status Update
Apr 27 18:08:02 volumio volumio[1056]: info: sendMpdCommand add "NAS/BrennanB3/[nature sounds]/Lake Louise-Alberta Vacation Theme (Rocky Mountain Suite)/02 Glacier Lake.flac" took 3 milliseconds
Apr 27 18:08:02 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand consume 1
Apr 27 18:08:02 volumio volumio[1056]: info: ------------------------------ 5ms
Apr 27 18:08:02 volumio volumio[1056]: info:
Apr 27 18:08:02 volumio volumio[1056]: ---------------------------- MPD announces state update: options
Apr 27 18:08:02 volumio volumio[1056]: info: sendMpdCommand consume 1 took 4 milliseconds
Apr 27 18:08:02 volumio volumio[1056]: info: ControllerMpd::getState
Apr 27 18:08:02 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Apr 27 18:08:02 volumio volumio[1056]: info: sendMpdCommand status took 2 milliseconds
Apr 27 18:08:02 volumio volumio[1056]: verbose: ControllerMpd::parseState
Apr 27 18:08:02 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 27 18:08:02 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 27 18:08:02 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Apr 27 18:08:02 volumio volumio[1056]: info: ControllerMpd::pushState
Apr 27 18:08:02 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Apr 27 18:08:02 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:02 volumio volumio[1056]: verbose: STATE SERVICE {"status":"play","position":0,"seek":408747,"duration":415,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"711 Kbps","isStreaming":false,"title":"01 The Runoff","artist":"Dan Gibson","album":"Rocky Mountain Suite (Lake Loiuse-Alberta Vaca Theme)","uri":"NAS/BrennanB3/[nature sounds]/Lake Louise-Alberta Vacation Theme (Rocky Mountain Suite)/01 The Runoff.flac","trackType":"flac"}
Apr 27 18:08:02 volumio volumio[1056]: verbose: CURRENT POSITION 0
Apr 27 18:08:02 volumio volumio[1056]: info: CoreStateMachine::syncState stateService play
Apr 27 18:08:02 volumio volumio[1056]: info: CoreStateMachine::syncState currentStatus play
Apr 27 18:08:02 volumio volumio[1056]: info: Received an update from plugin. extracting info from payload
Apr 27 18:08:02 volumio volumio[1056]: info: CoreStateMachine::pushState
Apr 27 18:08:02 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:02 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 18:08:02 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Apr 27 18:08:02 volumio volumio[1056]: info: MRS: Pushing multiroomSync output update for this device
Apr 27 18:08:02 volumio volumio[1056]: info: MRS: Pushing multiroomSync output
Apr 27 18:08:02 volumio volumio[1056]: info: CoreStateMachine::pushState
Apr 27 18:08:02 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:02 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Apr 27 18:08:02 volumio volumio[1056]: info: MRS: Pushing multiroomSync output update for this device
Apr 27 18:08:02 volumio volumio[1056]: info: MRS: Pushing multiroomSync output
Apr 27 18:08:02 volumio volumio[1056]: info: ------------------------------ 115ms
Apr 27 18:08:03 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 27 18:08:03 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 27 18:08:03 volumio volumio[1056]: info: Discovery: Getting this device information
Apr 27 18:08:03 volumio volumio[1056]: info: CoreCommandRouter::volumioGetState
Apr 27 18:08:03 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:03 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 27 18:08:07 volumio volumio[1056]: info: CoreStateMachine::startPlaybackTimer
Apr 27 18:08:07 volumio volumio[1056]: info: CorePlayQueue::getTrack 1
Apr 27 18:08:07 volumio volumio[1056]: info: CoreStateMachine::pushState
Apr 27 18:08:07 volumio volumio[1056]: info: CorePlayQueue::getTrack 1
Apr 27 18:08:07 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 18:08:07 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Apr 27 18:08:07 volumio volumio[1056]: info: MRS: Pushing multiroomSync output update for this device
Apr 27 18:08:07 volumio volumio[1056]: info: MRS: Pushing multiroomSync output
Apr 27 18:08:08 volumio volumio[1056]: info:
Apr 27 18:08:08 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Apr 27 18:08:08 volumio volumio[1056]: info: Ignoring MPD Status Update
Apr 27 18:08:08 volumio volumio[1056]: info:
Apr 27 18:08:08 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Apr 27 18:08:08 volumio volumio[1056]: info: ControllerMpd::getState
Apr 27 18:08:08 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Apr 27 18:08:08 volumio volumio[1056]: info: ------------------------------ 4ms
Apr 27 18:08:08 volumio volumio[1056]: info: sendMpdCommand status took 2 milliseconds
Apr 27 18:08:08 volumio volumio[1056]: verbose: ControllerMpd::parseState
Apr 27 18:08:08 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 27 18:08:08 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 27 18:08:08 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Apr 27 18:08:08 volumio volumio[1056]: info: ControllerMpd::pushState
Apr 27 18:08:08 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Apr 27 18:08:08 volumio volumio[1056]: info: CorePlayQueue::getTrack 1
Apr 27 18:08:08 volumio volumio[1056]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":383,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"853 Kbps","isStreaming":false,"title":"02 Glacier Lake","artist":"Dan Gibson","album":"Rocky Mountain Suite (Lake Loiuse-Alberta Vaca Theme)","uri":"NAS/BrennanB3/[nature sounds]/Lake Louise-Alberta Vacation Theme (Rocky Mountain Suite)/02 Glacier Lake.flac","trackType":"flac"}
Apr 27 18:08:08 volumio volumio[1056]: verbose: CURRENT POSITION 1
Apr 27 18:08:08 volumio volumio[1056]: info: CoreStateMachine::syncState stateService play
Apr 27 18:08:08 volumio volumio[1056]: info: CoreStateMachine::syncState currentStatus play
Apr 27 18:08:08 volumio volumio[1056]: info: Received an update from plugin. extracting info from payload
Apr 27 18:08:08 volumio volumio[1056]: info: CoreStateMachine::pushState
Apr 27 18:08:08 volumio volumio[1056]: info: CorePlayQueue::getTrack 1
Apr 27 18:08:08 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 18:08:08 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Apr 27 18:08:08 volumio volumio[1056]: info: MRS: Pushing multiroomSync output update for this device
Apr 27 18:08:08 volumio volumio[1056]: info: MRS: Pushing multiroomSync output
Apr 27 18:08:08 volumio volumio[1056]: info: CoreStateMachine::pushState
Apr 27 18:08:08 volumio volumio[1056]: info: CorePlayQueue::getTrack 1
Apr 27 18:08:08 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Apr 27 18:08:08 volumio volumio[1056]: info: MRS: Pushing multiroomSync output update for this device
Apr 27 18:08:08 volumio volumio[1056]: info: MRS: Pushing multiroomSync output
Apr 27 18:08:08 volumio volumio[1056]: info: ------------------------------ 89ms
Apr 27 18:08:09 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 27 18:08:09 volumio volumio[1056]: info: CURURI: music-library/NAS/BrennanB3/Adele
Apr 27 18:08:09 volumio volumio[1056]: info: Preload queue cleared
Apr 27 18:08:09 volumio volumio[1056]: info: Preloading song: music-library/NAS/BrennanB3/Adele/James Bond 007 Skyfall by Adele [OFFICIAL FULL MUSIC VIDEO].mp3
Apr 27 18:08:26 volumio volumio[1056]: info: Exploding uri music-library/NAS/BrennanB3/Adele/James Bond 007 Skyfall by Adele [OFFICIAL FULL MUSIC VIDEO].mp3 in service mpd
Apr 27 18:08:26 volumio volumio[1056]: info: Preload queue cleared
Apr 27 18:08:26 volumio volumio[1056]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 27 18:08:26 volumio volumio[1056]: info: CoreStateMachine::ClearQueue
Apr 27 18:08:26 volumio volumio[1056]: info: CoreStateMachine::stop
Apr 27 18:08:26 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 27 18:08:26 volumio volumio[1056]: info: CoreStateMachine::stPlaybackTimer
Apr 27 18:08:26 volumio volumio[1056]: info: CoreStateMachine::updateTrackBlock
Apr 27 18:08:26 volumio volumio[1056]: info: CorePlayQueue::getTrackBlock
Apr 27 18:08:26 volumio volumio[1056]: info: CoreStateMachine::pushState
Apr 27 18:08:26 volumio volumio[1056]: info: CorePlayQueue::getTrack 1
Apr 27 18:08:26 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Apr 27 18:08:27 volumio volumio[1056]: info: MRS: Pushing multiroomSync output update for this device
Apr 27 18:08:27 volumio volumio[1056]: info: MRS: Pushing multiroomSync output
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::serviceStop
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 1
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::serviceStop
Apr 27 18:08:27 volumio volumio[1056]: info: ControllerMpd::stop
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand stop
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::clearPlayQueue
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::saveQueue
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioPushQueue
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::addQueueItems
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::addQueueItems
Apr 27 18:08:27 volumio volumio[1056]: info: Preload queue cleared
Apr 27 18:08:27 volumio volumio[1056]: info: Adding Item to queue: music-library/NAS/BrennanB3/Adele/James Bond 007 Skyfall by Adele [OFFICIAL FULL MUSIC VIDEO].mp3
Apr 27 18:08:27 volumio volumio[1056]: info: Exploding uri music-library/NAS/BrennanB3/Adele/James Bond 007 Skyfall by Adele [OFFICIAL FULL MUSIC VIDEO].mp3 in service mpd
Apr 27 18:08:27 volumio volumio[1056]: info: MRS: Cast player state: BUFFERING
Apr 27 18:08:27 volumio volumio[1056]: info: ALBUMART /albumart?cacheid=366&web=//extralarge&path=%2Fmnt%2FNAS%2FBrennanB3%2FAdele%2FJames%20Bond%20007%20Skyfall%20by%20Adele%20%5BOFFICIAL%20FULL%20MUSIC%20VIDEO%5D.mp3&metadata=false
Apr 27 18:08:27 volumio volumio[1056]: info: URI /mnt/NAS/BrennanB3/Adele/James Bond 007 Skyfall by Adele [OFFICIAL FULL MUSIC VIDEO].mp3
Apr 27 18:08:27 volumio volumio[1056]: info: ALBUMART /albumart?cacheid=366&web=//extralarge&path=%2Fmnt%2FNAS%2FBrennanB3%2FAdele%2FJames%20Bond%20007%20Skyfall%20by%20Adele%20%5BOFFICIAL%20FULL%20MUSIC%20VIDEO%5D.mp3&metadata=false
Apr 27 18:08:27 volumio volumio[1056]: info: URI /mnt/NAS/BrennanB3/Adele/James Bond 007 Skyfall by Adele [OFFICIAL FULL MUSIC VIDEO].mp3
Apr 27 18:08:27 volumio volumio[1056]: info:
Apr 27 18:08:27 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Apr 27 18:08:27 volumio volumio[1056]: info: sendMpdCommand stop took 46 milliseconds
Apr 27 18:08:27 volumio volumio[1056]: info: ControllerMpd::getState
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioPushQueue
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::saveQueue
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::updateTrackBlock
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrackBlock
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioPlay
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::play index 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::stop
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::play index undefined
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::startPlaybackTimer
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::clearAddPlayTracks NAS/BrennanB3/Adele/James Bond 007 Skyfall by Adele [OFFICIAL FULL MUSIC VIDEO].mp3
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand stop
Apr 27 18:08:27 volumio volumio[1056]: info: sendMpdCommand status took 70 milliseconds
Apr 27 18:08:27 volumio volumio[1056]: info: sendMpdCommand stop took 47 milliseconds
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::parseState
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand clear
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 192.168.68.90 from 192.168.68.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 6
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 192.168.68.90:3000 from 192.168.68.73 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 192.168.68.90 from 192.168.68.73 UA: Mozilla/5.0 (Linux; Android 15; Pixel 7 Pro Build/BP1A.250405.007.B1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.111 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 192.168.68.90 from 192.168.68.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 10
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 192.168.68.90 from 192.168.68.73 UA: Mozilla/5.0 (Linux; Android 15; Pixel 7 Pro Build/BP1A.250405.007.B1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.111 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 192.168.68.90 from 192.168.68.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 13
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 27 18:08:27 volumio volumio[1056]: info: Discovery: Getting this device information
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioGetState
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 27 18:08:27 volumio volumio[1056]: info:
Apr 27 18:08:27 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Apr 27 18:08:27 volumio volumio[1056]: info: Ignoring MPD Status Update
Apr 27 18:08:27 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 144 milliseconds
Apr 27 18:08:27 volumio volumio[1056]: info: sendMpdCommand clear took 144 milliseconds
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand add "NAS/BrennanB3/Adele/James Bond 007 Skyfall by Adele [OFFICIAL FULL MUSIC VIDEO].mp3"
Apr 27 18:08:27 volumio volumio[1056]: info: ControllerMpd::pushState
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::pushState
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Apr 27 18:08:27 volumio volumio[1056]: info: MRS: Pushing multiroomSync output update for this device
Apr 27 18:08:27 volumio volumio[1056]: info: MRS: Pushing multiroomSync output
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 Glacier Lake","artist":"Dan Gibson","album":"Rocky Mountain Suite (Lake Loiuse-Alberta Vaca Theme)","uri":"NAS/BrennanB3/[nature sounds]/Lake Louise-Alberta Vacation Theme (Rocky Mountain Suite)/02 Glacier Lake.flac","trackType":"flac"}
Apr 27 18:08:27 volumio volumio[1056]: verbose: CURRENT POSITION 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::syncState stateService stop
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::syncState currentStatus stop
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::pushState
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Apr 27 18:08:27 volumio volumio[1056]: info: MRS: Pushing multiroomSync output update for this device
Apr 27 18:08:27 volumio volumio[1056]: info: MRS: Pushing multiroomSync output
Apr 27 18:08:27 volumio volumio[1056]: info: No code
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::pushState
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Apr 27 18:08:27 volumio volumio[1056]: info: MRS: Pushing multiroomSync output update for this device
Apr 27 18:08:27 volumio volumio[1056]: info: MRS: Pushing multiroomSync output
Apr 27 18:08:27 volumio volumio[1056]: info: ------------------------------ 305ms
Apr 27 18:08:27 volumio volumio[1056]: error: updateQueue error: null
Apr 27 18:08:27 volumio volumio[1056]: info:
Apr 27 18:08:27 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Apr 27 18:08:27 volumio volumio[1056]: info: Ignoring MPD Status Update
Apr 27 18:08:27 volumio volumio[1056]: info: ------------------------------ 124ms
Apr 27 18:08:27 volumio volumio[1056]: info: sendMpdCommand add "NAS/BrennanB3/Adele/James Bond 007 Skyfall by Adele [OFFICIAL FULL MUSIC VIDEO].mp3" took 122 milliseconds
Apr 27 18:08:27 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand play
Apr 27 18:08:27 volumio volumio[1056]: info: touch_display: Setting screensaver timeout to 120 seconds.
Apr 27 18:08:27 volumio volumio[1056]: info: ------------------------------ 48ms
Apr 27 18:08:27 volumio volumio[1056]: info: sendMpdCommand play took 44 milliseconds
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 192.168.68.90 from 192.168.68.73 UA: Mozilla/5.0 (Linux; Android 15; Pixel 7 Pro Build/BP1A.250405.007.B1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.111 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioGetState
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 27 18:08:27 volumio volumio[1056]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Apr 27 18:08:27 volumio volumio[1056]: info: Received Get System Info
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 27 18:08:27 volumio volumio[1056]: info: Discovery: Getting this device information
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioGetState
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioGetState
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Apr 27 18:08:27 volumio volumio[1056]: info: Listing playlists
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::volumioGetQueue
Apr 27 18:08:27 volumio volumio[1056]: info: CoreStateMachine::getQueue
Apr 27 18:08:27 volumio volumio[1056]: info: CorePlayQueue::getQueue
Apr 27 18:08:27 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 27 18:08:27 volumio volumio[1056]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15
Apr 27 18:08:31 volumio volumio[1056]: info: MRS: STARTING volumioStreaming
Apr 27 18:08:31 volumio sudo[6931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream0.ts /tmp/hls/stream1.ts /tmp/hls/stream10.ts /tmp/hls/stream100.ts /tmp/hls/stream101.ts /tmp/hls/stream102.ts /tmp/hls/stream103.ts /tmp/hls/stream104.ts /tmp/hls/stream105.ts /tmp/hls/stream106.ts /tmp/hls/stream107.ts /tmp/hls/stream108.ts /tmp/hls/stream109.ts /tmp/hls/stream11.ts /tmp/hls/stream110.ts /tmp/hls/stream111.ts /tmp/hls/stream112.ts /tmp/hls/stream113.ts /tmp/hls/stream114.ts /tmp/hls/stream115.ts /tmp/hls/stream116.ts /tmp/hls/stream117.ts /tmp/hls/stream118.ts /tmp/hls/stream119.ts /tmp/hls/stream12.ts /tmp/hls/stream120.ts /tmp/hls/stream121.ts /tmp/hls/stream122.ts /tmp/hls/stream123.ts /tmp/hls/stream124.ts /tmp/hls/stream125.ts /tmp/hls/stream126.ts /tmp/hls/stream127.ts /tmp/hls/stream128.ts /tmp/hls/stream129.ts /tmp/hls/stream13.ts /tmp/hls/stream130.ts /tmp/hls/stream131.ts /tmp/hls/stream132.ts /tmp/hls/stream133.ts
Apr 27 18:08:31 volumio sudo[6931]: volumio : (command continued) /tmp/hls/stream134.ts /tmp/hls/stream135.ts /tmp/hls/stream136.ts /tmp/hls/stream137.ts /tmp/hls/stream138.ts /tmp/hls/stream139.ts /tmp/hls/stream14.ts /tmp/hls/stream140.ts /tmp/hls/stream141.ts /tmp/hls/stream142.ts /tmp/hls/stream143.ts /tmp/hls/stream144.ts /tmp/hls/stream145.ts /tmp/hls/stream146.ts /tmp/hls/stream147.ts /tmp/hls/stream148.ts /tmp/hls/stream149.ts /tmp/hls/stream15.ts /tmp/hls/stream150.ts /tmp/hls/stream151.ts /tmp/hls/stream152.ts /tmp/hls/stream153.ts /tmp/hls/stream154.ts /tmp/hls/stream155.ts /tmp/hls/stream156.ts /tmp/hls/stream157.ts /tmp/hls/stream158.ts /tmp/hls/stream159.ts /tmp/hls/stream16.ts /tmp/hls/stream160.ts /tmp/hls/stream161.ts /tmp/hls/stream162.ts /tmp/hls/stream163.ts /tmp/hls/stream164.ts /tmp/hls/stream165.ts /tmp/hls/stream166.ts /tmp/hls/stream167.ts /tmp/hls/stream168.ts /tmp/hls/stream169.ts /tmp/hls/stream17.ts /tmp/hls/stream170.ts /tmp/hls/stream171.ts
Apr 27 18:08:31 volumio sudo[6931]: volumio : (command continued) /tmp/hls/stream18.ts /tmp/hls/stream19.ts /tmp/hls/stream2.ts /tmp/hls/stream20.ts /tmp/hls/stream21.ts /tmp/hls/stream22.ts /tmp/hls/stream23.ts /tmp/hls/stream24.ts /tmp/hls/stream25.ts /tmp/hls/stream26.ts /tmp/hls/stream27.ts /tmp/hls/stream28.ts /tmp/hls/stream29.ts /tmp/hls/stream3.ts /tmp/hls/stream30.ts /tmp/hls/stream31.ts /tmp/hls/stream32.ts /tmp/hls/stream33.ts /tmp/hls/stream34.ts /tmp/hls/stream35.ts /tmp/hls/stream36.ts /tmp/hls/stream37.ts /tmp/hls/stream38.ts /tmp/hls/stream39.ts /tmp/hls/stream4.ts /tmp/hls/stream40.ts /tmp/hls/stream41.ts /tmp/hls/stream42.ts /tmp/hls/stream43.ts /tmp/hls/stream44.ts /tmp/hls/stream45.ts /tmp/hls/stream46.ts /tmp/hls/stream47.ts /tmp/hls/stream48.ts /tmp/hls/stream49.ts /tmp/hls/stream5.ts /tmp/hls/stream50.ts /tmp/hls/stream51.ts /tmp/hls/stream52.ts /tmp/hls/stream53.ts /tmp/hls/stream54.ts /tmp/hls/stream55.ts /tmp/hls/stream56.ts /tmp/hls/stream57.ts
Apr 27 18:08:31 volumio sudo[6931]: volumio : (command continued) /tmp/hls/stream58.ts /tmp/hls/stream59.ts /tmp/hls/stream6.ts /tmp/hls/stream60.ts /tmp/hls/stream61.ts /tmp/hls/stream62.ts /tmp/hls/stream63.ts /tmp/hls/stream64.ts /tmp/hls/stream65.ts /tmp/hls/stream66.ts /tmp/hls/stream67.ts /tmp/hls/stream68.ts /tmp/hls/stream69.ts /tmp/hls/stream7.ts /tmp/hls/stream70.ts /tmp/hls/stream71.ts /tmp/hls/stream72.ts /tmp/hls/stream73.ts /tmp/hls/stream74.ts /tmp/hls/stream75.ts /tmp/hls/stream76.ts /tmp/hls/stream77.ts /tmp/hls/stream78.ts /tmp/hls/stream79.ts /tmp/hls/stream8.ts /tmp/hls/stream80.ts /tmp/hls/stream81.ts /tmp/hls/stream82.ts /tmp/hls/stream83.ts /tmp/hls/stream84.ts /tmp/hls/stream85.ts /tmp/hls/stream86.ts /tmp/hls/stream87.ts /tmp/hls/stream88.ts /tmp/hls/stream89.ts /tmp/hls/stream9.ts /tmp/hls/stream90.ts /tmp/hls/stream91.ts /tmp/hls/stream92.ts /tmp/hls/stream93.ts /tmp/hls/stream94.ts /tmp/hls/stream95.ts /tmp/hls/stream96.ts /tmp/hls/stream97.ts
Apr 27 18:08:31 volumio sudo[6931]: volumio : (command continued) /tmp/hls/stream98.ts /tmp/hls/stream99.ts
Apr 27 18:08:31 volumio sudo[6931]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 18:08:31 volumio sudo[6933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming
Apr 27 18:08:31 volumio sudo[6933]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 18:08:32 volumio sudo[6931]: pam_unix(sudo:session): session closed for user root
Apr 27 18:08:32 volumio volumio[1056]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 27 18:08:32 volumio volumio[1056]: TypeError: Cannot read property 'send' of null
Apr 27 18:08:32 volumio volumio[1056]: at Client.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:128:11)
Apr 27 18:08:32 volumio volumio[1056]: at Channel.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:34:12)
Apr 27 18:08:32 volumio volumio[1056]: at fn.Controller.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:28:16)
Apr 27 18:08:32 volumio volumio[1056]: at fn.RequestResponseController.request (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:34:8)
Apr 27 18:08:32 volumio volumio[1056]: at fn.MediaController.sessionRequest (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/media.js:91:8)
Apr 27 18:08:32 volumio volumio[1056]: at fn.MediaController.stop (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/media.js:107:8)
Apr 27 18:08:32 volumio volumio[1056]: at DefaultMediaReceiver.stop (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/default-media-receiver.js:42:19)
Apr 27 18:08:32 volumio volumio[1056]: at Timeout._onTimeout (/myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:5002)
Apr 27 18:08:32 volumio volumio[1056]: at listOnTimeout (internal/timers.js:554:17)
Apr 27 18:08:32 volumio volumio[1056]: at processTimers (internal/timers.js:497:7)
Apr 27 18:08:32 volumio volumio[1056]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 27 18:08:32 volumio systemd[1]: Stopping VolumioStreamingService...
Apr 27 18:08:32 volumio systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM
Apr 27 18:08:32 volumio systemd[1]: volumioStreaming.service: Succeeded.
Apr 27 18:08:32 volumio systemd[1]: Stopped VolumioStreamingService.
Apr 27 18:08:32 volumio systemd[1]: Started VolumioStreamingService.
Apr 27 18:08:32 volumio sudo[6933]: pam_unix(sudo:session): session closed for user root
Apr 27 18:08:32 volumio sudo[6980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream172.ts
Apr 27 18:08:32 volumio sudo[6980]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 18:08:32 volumio sudo[6980]: pam_unix(sudo:session): session closed for user root
Apr 27 18:08:34 volumio sudo[7008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-27 18:07
Apr 27 18:08:34 volumio sudo[7008]: 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="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST"
VOLUMIO_VERSION="3.799"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"