-- Logs begin at Tue 2025-11-04 12:06:11 CST, end at Tue 2025-11-04 12:25:53 CST. --
Nov 04 12:24:09 volumio-x86 volumio[1135]: info: MyVolumio login type: Token
Nov 04 12:24:15 volumio-x86 volumio[1135]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object]
Nov 04 12:24:15 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf
Nov 04 12:24:15 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:15 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:15 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:15 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync
Nov 04 12:24:15 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:24:15 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:15 volumio-x86 volumio[1135]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 04 12:24:16 volumio-x86 volumio[1135]: info: Starting Shairport Sync
Nov 04 12:24:16 volumio-x86 sudo[5546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 04 12:24:16 volumio-x86 sudo[5546]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:24:16 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 04 12:24:16 volumio-x86 systemd[1]: shairport-sync.service: Succeeded.
Nov 04 12:24:16 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:24:17 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:24:17 volumio-x86 sudo[5546]: pam_unix(sudo:session): session closed for user root
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: Shairport-Sync Started
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object]
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: Starting Shairport Sync
Nov 04 12:24:17 volumio-x86 sudo[5557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 04 12:24:17 volumio-x86 sudo[5557]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:24:17 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 04 12:24:17 volumio-x86 systemd[1]: shairport-sync.service: Succeeded.
Nov 04 12:24:17 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:24:17 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:24:17 volumio-x86 sudo[5557]: pam_unix(sudo:session): session closed for user root
Nov 04 12:24:17 volumio-x86 volumio[1135]: info: Shairport-Sync Started
Nov 04 12:24:39 volumio-x86 volumio[1135]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Nov 04 12:24:39 volumio-x86 volumio[1135]: info: Retrying Login Due to Network Error
Nov 04 12:24:41 volumio-x86 volumio[1135]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object]
Nov 04 12:24:41 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf
Nov 04 12:24:41 volumio-x86 volumio[1135]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 04 12:24:41 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:24:49 volumio-x86 volumio[1135]: info: MyVolumio login type: Token
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioNext
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::next
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::stop
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::stPlaybackTimer
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::updateTrackBlock
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrackBlock
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::pushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 1
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioPushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::serviceStop
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 1
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::serviceStop
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ControllerMpd::stop
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand stop
Nov 04 12:24:53 volumio-x86 volumio[1135]: info:
Nov 04 12:24:53 volumio-x86 volumio[1135]: ---------------------------- MPD announces state update: player
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand stop took 23 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ControllerMpd::getState
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand status
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::play index undefined
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::startPlaybackTimer
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::clearAddPlayTracks USB/新加卷/欧美流行/Sara K - Play On Words 1994 (Chesky 2004)/03. If I Could Sing Your Blues.wav
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand stop
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::updateTrackBlock
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrackBlock
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand status took 4 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand stop took 3 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::parseState
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand clear
Nov 04 12:24:53 volumio-x86 volumio[1135]: info:
Nov 04 12:24:53 volumio-x86 volumio[1135]: ---------------------------- MPD announces system playlist update
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: Ignoring MPD Status Update
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand playlistinfo took 3 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand clear took 3 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::parseTrackInfo
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand add "USB/新加卷/欧美流行/Sara K - Play On Words 1994 (Chesky 2004)/03. If I Could Sing Your Blues.wav"
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ControllerMpd::pushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::servicePushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::pushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioPushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: 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":"Stop Those Bells","artist":"Sara K.","album":"Play On Words","uri":"USB/新加卷/欧美流行/Sara K - Play On Words 1994 (Chesky 2004)/02. Stop Those Bells.wav","trackType":"wav"}
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: CURRENT POSITION 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::syncState stateService stop
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::syncState currentStatus stop
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::pushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioPushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: No code
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::pushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioPushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ------------------------------ 76ms
Nov 04 12:24:53 volumio-x86 volumio[1135]: error: updateQueue error: null
Nov 04 12:24:53 volumio-x86 volumio[1135]: info:
Nov 04 12:24:53 volumio-x86 volumio[1135]: ---------------------------- MPD announces system playlist update
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: Ignoring MPD Status Update
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ------------------------------ 69ms
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand add "USB/新加卷/欧美流行/Sara K - Play On Words 1994 (Chesky 2004)/03. If I Could Sing Your Blues.wav" took 67 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand play
Nov 04 12:24:53 volumio-x86 volumio[1135]: info:
Nov 04 12:24:53 volumio-x86 volumio[1135]: ---------------------------- MPD announces state update: player
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ------------------------------ 26ms
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand play took 26 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ControllerMpd::getState
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand status
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: FusionDsp - ---- read samplerate from file: 44100
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Nov 04 12:24:53 volumio-x86 volumio[1135]: info:
Nov 04 12:24:53 volumio-x86 volumio[1135]: ---------------------------- MPD announces state update: player
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand status took 35 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ControllerMpd::getState
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand status
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::parseState
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand status took 147 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand playlistinfo took 146 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::parseState
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::parseTrackInfo
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ControllerMpd::pushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::servicePushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"If I Could Sing Your Blues","artist":"Sara K.","album":"Play On Words","uri":"USB/新加卷/欧美流行/Sara K - Play On Words 1994 (Chesky 2004)/03. If I Could Sing Your Blues.wav","trackType":"wav"}
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: CURRENT POSITION 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::syncState stateService play
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::syncState currentStatus stop
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ------------------------------ 194ms
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: sendMpdCommand playlistinfo took 5 milliseconds
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: ControllerMpd::parseTrackInfo
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: ControllerMpd::pushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::servicePushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1104,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"If I Could Sing Your Blues","artist":"Sara K.","album":"Play On Words","uri":"USB/新加卷/欧美流行/Sara K - Play On Words 1994 (Chesky 2004)/03. If I Could Sing Your Blues.wav","trackType":"wav"}
Nov 04 12:24:53 volumio-x86 volumio[1135]: verbose: CURRENT POSITION 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::syncState stateService play
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::syncState currentStatus play
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: Received an update from plugin. extracting info from payload
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreStateMachine::pushState
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 04 12:24:53 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioPushState
Nov 04 12:24:54 volumio-x86 volumio[1135]: info: CoreStateMachine::pushState
Nov 04 12:24:54 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:24:54 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioPushState
Nov 04 12:24:54 volumio-x86 volumio[1135]: info: ------------------------------ 218ms
Nov 04 12:24:54 volumio-x86 volumio[1135]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Nov 04 12:24:57 volumio-x86 volumio[1135]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11
Nov 04 12:24:57 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioGetState
Nov 04 12:24:57 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioPause
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreStateMachine::pause
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreStateMachine::stPlaybackTimer
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreStateMachine::servicePause
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreCommandRouter::servicePause
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: ControllerMpd::pause
Nov 04 12:25:05 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand pause
Nov 04 12:25:05 volumio-x86 volumio[1135]: info:
Nov 04 12:25:05 volumio-x86 volumio[1135]: ---------------------------- MPD announces state update: player
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: sendMpdCommand pause took 2 milliseconds
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: ControllerMpd::getState
Nov 04 12:25:05 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand status
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: sendMpdCommand status took 1 milliseconds
Nov 04 12:25:05 volumio-x86 volumio[1135]: verbose: ControllerMpd::parseState
Nov 04 12:25:05 volumio-x86 volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: sendMpdCommand playlistinfo took 0 milliseconds
Nov 04 12:25:05 volumio-x86 volumio[1135]: verbose: ControllerMpd::parseTrackInfo
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: ControllerMpd::pushState
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreCommandRouter::servicePushState
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:25:05 volumio-x86 volumio[1135]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":16608,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"If I Could Sing Your Blues","artist":"Sara K.","album":"Play On Words","uri":"USB/新加卷/欧美流行/Sara K - Play On Words 1994 (Chesky 2004)/03. If I Could Sing Your Blues.wav","trackType":"wav"}
Nov 04 12:25:05 volumio-x86 volumio[1135]: verbose: CURRENT POSITION 2
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreStateMachine::syncState stateService pause
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreStateMachine::syncState currentStatus pause
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreStateMachine::pushState
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CorePlayQueue::getTrack 2
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: CoreStateMachine::stPlaybackTimer
Nov 04 12:25:05 volumio-x86 volumio[1135]: info: ------------------------------ 33ms
Nov 04 12:25:05 volumio-x86 volumio[1135]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 04 12:25:05 volumio-x86 volumio[1135]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Object.readdirSync (fs.js:1048:3)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12)
Nov 04 12:25:05 volumio-x86 volumio[1135]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) {
Nov 04 12:25:05 volumio-x86 volumio[1135]: errno: -20,
Nov 04 12:25:05 volumio-x86 volumio[1135]: syscall: 'scandir',
Nov 04 12:25:05 volumio-x86 volumio[1135]: code: 'ENOTDIR',
Nov 04 12:25:05 volumio-x86 volumio[1135]: path: '/tmp/peppyrunning'
Nov 04 12:25:05 volumio-x86 volumio[1135]: }
Nov 04 12:25:05 volumio-x86 volumio[1135]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 04 12:25:05 volumio-x86 sudo[5740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-04 12:24
Nov 04 12:25:05 volumio-x86 sudo[5740]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:05 volumio-x86 sudo[5740]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:07 volumio-x86 volumio-remote-updater[787]: [2025-11-04 12:25:07] [info] asio async_read_at_least error: system:104 (Connection reset by peer)
Nov 04 12:25:07 volumio-x86 volumio-remote-updater[787]: [2025-11-04 12:25:07] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error)
Nov 04 12:25:07 volumio-x86 volumio-remote-updater[787]: [2025-11-04 12:25:07] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006]
Nov 04 12:25:07 volumio-x86 systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 12:25:07 volumio-x86 ntfs-3g[4537]: Unmounting /dev/sdb1 (新加卷)
Nov 04 12:25:07 volumio-x86 systemd[1]: media-\xe6\x96\xb0\xe5\x8a\xa0\xe5\x8d\xb7.mount: Succeeded.
Nov 04 12:25:07 volumio-x86 systemd[1]: volumio.service: Failed with result 'exit-code'.
Nov 04 12:25:07 volumio-x86 systemd[1]: Started dynamicswap service.
Nov 04 12:25:07 volumio-x86 systemd[1]: dynamicswap.service: Succeeded.
Nov 04 12:25:07 volumio-x86 systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Nov 04 12:25:07 volumio-x86 systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Nov 04 12:25:07 volumio-x86 systemd[1]: Started dynamicswap service.
Nov 04 12:25:07 volumio-x86 systemd[1]: Stopped Volumio Backend Module.
Nov 04 12:25:07 volumio-x86 systemd[1]: Started Volumio Backend Module.
Nov 04 12:25:07 volumio-x86 systemd[1]: dynamicswap.service: Succeeded.
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: -------------------------------------------
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: ----- Volumio3 ----
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: -------------------------------------------
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: ----- System startup ----
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: -------------------------------------------
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: MYVOLUMIO Environment detected
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Plugin folders cleanup
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning into folder /volumio/app/plugins/
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category audio_interface
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category miscellanea
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category music_service
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category plugins.json
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category system_controller
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category user_interface
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning into folder /data/plugins/
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category audio_interface
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category music_service
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category system_controller
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Scanning category user_interface
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Plugin folders cleanup completed
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: -------------------------------------------
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: ----- Core plugins startup ----
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: -------------------------------------------
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Loading plugins from folder /volumio/app/plugins/
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Adding plugin upnp to MyMusic Plugins
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Adding plugin airplay_emulation to MyMusic Plugins
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Adding plugin upnp_browser to MyMusic Plugins
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Loading plugins from folder /data/plugins/
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Loading plugin "system"...
Nov 04 12:25:08 volumio-x86 volumio[5772]: info: Loading plugin "appearance"...
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Loading plugin "network"...
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Refreshing Cached IP Addresses
Nov 04 12:25:09 volumio-x86 sudo[5798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 04 12:25:09 volumio-x86 sudo[5798]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:09 volumio-x86 sudo[5798]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:09 volumio-x86 sudo[5800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 04 12:25:09 volumio-x86 sudo[5800]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:09 volumio-x86 sudo[5800]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Loading plugin "services"...
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Loading plugin "alsa_controller"...
Nov 04 12:25:09 volumio-x86 sudo[5811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Nov 04 12:25:09 volumio-x86 sudo[5811]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Loading plugin "wizard"...
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Loading plugin "networkfs"...
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Cannot mount NAS local at system boot, trial number 1 ,retrying in 5 seconds
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Starting Udev Watcher for removable devices
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Ignoring mount for partition: efi-boot
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Ignoring mount for partition: DaphileBoot
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Ignoring mount for partition: DaphileData
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Ignoring mount for partition: boot
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Ignoring mount for partition: volumio
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Ignoring mount for partition: volumio_data
Nov 04 12:25:09 volumio-x86 volumio[5772]: info: Mounting Device 新加卷
Nov 04 12:25:09 volumio-x86 sudo[5836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/新加卷 -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Nov 04 12:25:09 volumio-x86 sudo[5836]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:10 volumio-x86 ntfs-3g[5839]: Version 2017.3.23AR.3 integrated FUSE 28
Nov 04 12:25:10 volumio-x86 ntfs-3g[5839]: Mounted /dev/sdb1 (Read-Write, label "新加卷", NTFS 3.1)
Nov 04 12:25:10 volumio-x86 ntfs-3g[5839]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
Nov 04 12:25:10 volumio-x86 ntfs-3g[5839]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096
Nov 04 12:25:10 volumio-x86 ntfs-3g[5839]: Global ownership and permissions enforced, configuration type 7
Nov 04 12:25:10 volumio-x86 sudo[5836]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:10 volumio-x86 ntfs-3g[5839]: Unmounting /dev/sdb1 (新加卷)
Nov 04 12:25:10 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 04 12:25:10 volumio-x86 volumio[5772]: info: Loading plugin "volumio_command_line_client"...
Nov 04 12:25:10 volumio-x86 volumio[5772]: info: Loading plugin "upnp"...
Nov 04 12:25:10 volumio-x86 volumio[5772]: info: [1762230310486] Starting Upmpd Daemon
Nov 04 12:25:10 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 04 12:25:10 volumio-x86 volumio[5772]: info: Loading plugin "my_music"...
Nov 04 12:25:10 volumio-x86 volumio[5772]: info: Loading plugin "mpd"...
Nov 04 12:25:10 volumio-x86 volumio[5772]: info: Loading plugin "upnp_browser"...
Nov 04 12:25:10 volumio-x86 volumio[5772]: info: Loading plugin "alarm-clock"...
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Loading plugin "airplay_emulation"...
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Starting Shairport Sync
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Loading plugin "last_100"...
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Loading plugin "webradio"...
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Loading plugin "i2s_dacs"...
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: I2S DAC not set, start Auto-detection
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Loading plugin "volumiodiscovery"...
Nov 04 12:25:11 volumio-x86 volumio[5772]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 04 12:25:11 volumio-x86 volumio[5772]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 04 12:25:11 volumio-x86 node[5772]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 04 12:25:11 volumio-x86 volumio[5772]: *** WARNING *** For more information see
Nov 04 12:25:11 volumio-x86 volumio[5772]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 04 12:25:11 volumio-x86 volumio[5772]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 04 12:25:11 volumio-x86 volumio[5772]: *** WARNING *** For more information see
Nov 04 12:25:11 volumio-x86 node[5772]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 04 12:25:11 volumio-x86 node[5772]: *** WARNING *** For more information see
Nov 04 12:25:11 volumio-x86 node[5772]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 04 12:25:11 volumio-x86 node[5772]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 04 12:25:11 volumio-x86 node[5772]: *** WARNING *** For more information see
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Applying required configuration parameters for plugin volumiodiscovery
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Discovery: Started advertising with name: Volumio-x86
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Loading plugin "calmradio"...
Nov 04 12:25:11 volumio-x86 volumio[5772]: info: Loading plugin "autostart"...
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Applying required configuration parameters for plugin autostart
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: AutoStart - onVolumioStart - read config.json
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Loading plugin "peppy_screensaver"...
Nov 04 12:25:12 volumio-x86 volumio-remote-updater[787]: [2025-11-04 12:25:12] [connect] Successful connection
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Applying required configuration parameters for plugin peppy_screensaver
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Loading plugin "outputs"...
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Loading plugin "albumart"...
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Plugin example_plugin is not enabled
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Loading plugin "inputs"...
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Loading plugin "updater_comm"...
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Plugin mpdemulation is not enabled
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Loading plugin "rest_api"...
Nov 04 12:25:12 volumio-x86 sudo[5811]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Loading plugin "websocket"...
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Starting Socket.io Server version 2.3.0
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Loading plugin "fusiondsp"...
Nov 04 12:25:12 volumio-x86 volumio[5772]: Forking 3 albumart workers
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Applying required configuration parameters for plugin fusiondsp
Nov 04 12:25:12 volumio-x86 volumio[5772]: info: Loading plugin "mpdoutput"...
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: Loading plugin "RoonBridge"...
Nov 04 12:25:13 volumio-x86 volumio[5772]: Starting albumart workers
Nov 04 12:25:13 volumio-x86 volumio[5772]: Starting albumart workers
Nov 04 12:25:13 volumio-x86 volumio[5772]: Starting albumart workers
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: Applying required configuration parameters for plugin RoonBridge
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: Loading plugin "minidlna"...
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: Applying required configuration parameters for plugin minidlna
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: Loading plugin "Systeminfo"...
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: Loading plugin "randomizer"...
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: Applying required configuration parameters for plugin randomizer
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: Loading i18n strings for locale zh
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
Nov 04 12:25:13 volumio-x86 volumio[5772]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
Nov 04 12:25:13 volumio-x86 volumio[5772]: Updating browse sources language
Nov 04 12:25:13 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::initPlayerControls
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: Express server listening on port 3000
Nov 04 12:25:14 volumio-x86 volumio[5772]: [Metrics] WebUI: 6s 117.73ms
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Setting Device type: x86
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreStateMachine::resetVolumioState
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreStateMachine::getcurrentVolume
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioRetrievevolume
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Completed loading Core Plugins
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Preparing to generate the ALSA configuration file
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Volumio Network Manager: Network status updated: 2
Nov 04 12:25:14 volumio-x86 volumio[5772]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,1,0) appears twice or more
Nov 04 12:25:14 volumio-x86 volumio[5772]: amixer: Mixer hw:0 load error: Invalid argument
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Reading ALSA contributions from plugins.
Nov 04 12:25:14 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.103 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 1
Nov 04 12:25:14 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Nov 04 12:25:14 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 3
Nov 04 12:25:14 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 4
Nov 04 12:25:14 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Nov 04 12:25:14 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.103 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6
Nov 04 12:25:14 volumio-x86 volumio-remote-updater[787]: [2025-11-04 12:25:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1762230312 101
Nov 04 12:25:14 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7
Nov 04 12:25:14 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: VolumeController:: Volume=undefined Mute =false
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreStateMachine::updateTrackBlock
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrackBlock
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioRetrievevolume
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Reloading queue from file
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreStateMachine::setRepeat null single undefined
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreStateMachine::setRandom null
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:14 volumio-x86 volumio[5772]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,1,0) appears twice or more
Nov 04 12:25:14 volumio-x86 volumio[5772]: amixer: Mixer hw:0 load error: Invalid argument
Nov 04 12:25:14 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: VolumeController:: Volume=undefined Mute =false
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Asound.conf file unchanged, so no further update is needed
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Output device has changed, restarting MPD
Nov 04 12:25:14 volumio-x86 sudo[5905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 04 12:25:14 volumio-x86 sudo[5905]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Output device has changed, restarting Shairport Sync
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:14 volumio-x86 sudo[5905]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:14 volumio-x86 sudo[5908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 04 12:25:14 volumio-x86 sudo[5908]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:14 volumio-x86 systemd[1]: Stopping Music Player Daemon...
Nov 04 12:25:14 volumio-x86 systemd[1]: mpd.service: Succeeded.
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 04 12:25:14 volumio-x86 systemd[1]: Stopped Music Player Daemon.
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: ___________ START PLUGINS ___________
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: ControllerMpd::onStart: Initializing MPD
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Creating MPD Configuration file
Nov 04 12:25:14 volumio-x86 systemd[1]: Starting Music Player Daemon...
Nov 04 12:25:14 volumio-x86 sudo[5915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 04 12:25:14 volumio-x86 sudo[5915]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:14 volumio-x86 sudo[5915]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: [1762230314725] CoreMusicLibrary::Adding element 媒体服务器
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 04 12:25:14 volumio-x86 sudo[5919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 04 12:25:14 volumio-x86 sudo[5919]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:14 volumio-x86 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Nov 04 12:25:14 volumio-x86 systemd[1]: mpd.service: Succeeded.
Nov 04 12:25:14 volumio-x86 systemd[1]: Stopped Music Player Daemon.
Nov 04 12:25:14 volumio-x86 systemd[1]: Starting Music Player Daemon...
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: [1762230314837] CoreMusicLibrary::Adding element Last_100
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: [1762230314842] CoreMusicLibrary::Adding element Webradio
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Initializing BBC Radios
Nov 04 12:25:14 volumio-x86 sudo[5922]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Nov 04 12:25:14 volumio-x86 sudo[5922]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:14 volumio-x86 sudo[5922]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Adding Calm Radio to Browse Sources
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: [1762230314945] CoreMusicLibrary::Adding element Calm Radio
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 04 12:25:14 volumio-x86 volumio[5772]: Cannot find translation for source Calm Radio
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: AutoStart - onStart
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Loading i18n strings for locale zh
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
Nov 04 12:25:14 volumio-x86 volumio[5772]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
Nov 04 12:25:14 volumio-x86 volumio[5772]: info: /tmp/myfifo created
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: /tmp/myfifosa created
Nov 04 12:25:15 volumio-x86 sudo[5945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0
Nov 04 12:25:15 volumio-x86 sudo[5945]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:15 volumio-x86 sudo[5945]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: snd-dummy loaded
Nov 04 12:25:15 volumio-x86 volumio[5772]: error: Plugin peppy_screensaver failed to start! Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Loading i18n strings for locale zh
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
Nov 04 12:25:15 volumio-x86 volumio[5772]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: FusionDsp - mixtype--------------------- undefined
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Loading i18n strings for locale zh
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
Nov 04 12:25:15 volumio-x86 volumio[5772]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
Nov 04 12:25:15 volumio-x86 sudo[5948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Nov 04 12:25:15 volumio-x86 sudo[5948]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:15 volumio-x86 sudo[5948]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: [1762230315216] CoreMusicLibrary::Adding element Randomizer
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 04 12:25:15 volumio-x86 volumio[5772]: Cannot find translation for source Calm Radio
Nov 04 12:25:15 volumio-x86 volumio[5772]: Cannot find translation for source Randomizer
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Volumio Calling Home
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Preparing to generate the ALSA configuration file
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Cannot mount NAS local at system boot, trial number 2 ,retrying in 5 seconds
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Discovery: adding 495d9a88-17c5-4731-81ea-956915b1778f
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Discovery: Found device Volumio-x86
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Reading ALSA contributions from plugins.
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:15 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10
Nov 04 12:25:15 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: minidlna: Found miniDLNA version 1.2.1
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: minidlna: Starting minidlna.service
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: MPD Permissions set
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Listing playlists
Nov 04 12:25:15 volumio-x86 sudo[5958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service
Nov 04 12:25:15 volumio-x86 sudo[5958]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:15 volumio-x86 sudo[5958]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:15 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12
Nov 04 12:25:15 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: minidlna: systemctl start minidlna.service succeeded.
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Volumio called home
Nov 04 12:25:15 volumio-x86 volumio[5772]: info: Starting Shairport Sync
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Starting Shairport Sync
Nov 04 12:25:16 volumio-x86 mpd[5930]: Nov 04 12:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Nov 04 12:25:16 volumio-x86 sudo[5987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 04 12:25:16 volumio-x86 sudo[5987]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Starting Shairport Sync
Nov 04 12:25:16 volumio-x86 systemd[1]: Started Music Player Daemon.
Nov 04 12:25:16 volumio-x86 sudo[5919]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:16 volumio-x86 sudo[5908]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:16 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 04 12:25:16 volumio-x86 systemd[1]: shairport-sync.service: Succeeded.
Nov 04 12:25:16 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:25:16 volumio-x86 sudo[5990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:16 volumio-x86 sudo[5990]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:16 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:25:16 volumio-x86 sudo[5995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 04 12:25:16 volumio-x86 sudo[5995]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:16 volumio-x86 sudo[5987]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:16 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 04 12:25:16 volumio-x86 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Nov 04 12:25:16 volumio-x86 systemd[1]: shairport-sync.service: Succeeded.
Nov 04 12:25:16 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:25:16 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:25:16 volumio-x86 sudo[5990]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:16 volumio-x86 sudo[5995]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Completed starting Core Plugins
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: -------------------------------------------
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: ----- MyVolumio plugins startup ----
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: -------------------------------------------
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Fetching plans data....
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Asound.conf file unchanged, so no further update is needed
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Output device has changed, restarting MPD
Nov 04 12:25:16 volumio-x86 sudo[6008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 04 12:25:16 volumio-x86 sudo[6008]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Output device has changed, restarting Shairport Sync
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 sudo[6008]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:16 volumio-x86 sudo[6011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 04 12:25:16 volumio-x86 sudo[6011]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:16 volumio-x86 systemd[1]: Stopping Music Player Daemon...
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 04 12:25:16 volumio-x86 systemd[1]: mpd.service: Succeeded.
Nov 04 12:25:16 volumio-x86 systemd[1]: Stopped Music Player Daemon.
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: MPD running with PID5930
Nov 04 12:25:16 volumio-x86 volumio[5772]: ,establishing connection
Nov 04 12:25:16 volumio-x86 systemd[1]: Starting Music Player Daemon...
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Shairport-Sync Started
Nov 04 12:25:16 volumio-x86 volumio[5772]: Error adding Membership: Error: addMembership EINVAL
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Shairport-Sync Started
Nov 04 12:25:16 volumio-x86 volumio[5772]: error: MPD error: Error: write EPIPE
Nov 04 12:25:16 volumio-x86 volumio[5772]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Nov 04 12:25:16 volumio-x86 sudo[6017]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Nov 04 12:25:16 volumio-x86 volumio[5772]: error: MPD error: The expression evaluated to a falsy value:
Nov 04 12:25:16 volumio-x86 volumio[5772]: assert.ok(self.idling)
Nov 04 12:25:16 volumio-x86 volumio[5772]: error: The expression evaluated to a falsy value:
Nov 04 12:25:16 volumio-x86 volumio[5772]: assert.ok(self.idling)
Nov 04 12:25:16 volumio-x86 sudo[6017]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:16 volumio-x86 volumio[5772]: error: MPD error: Error: write EPIPE
Nov 04 12:25:16 volumio-x86 volumio[5772]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Nov 04 12:25:16 volumio-x86 volumio[5772]: error: MPD error: The expression evaluated to a falsy value:
Nov 04 12:25:16 volumio-x86 volumio[5772]: assert.ok(self.idling)
Nov 04 12:25:16 volumio-x86 volumio[5772]: error: The expression evaluated to a falsy value:
Nov 04 12:25:16 volumio-x86 volumio[5772]: assert.ok(self.idling)
Nov 04 12:25:16 volumio-x86 sudo[6017]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:16 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.103 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 14
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: MPD Permissions set
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: VolumeController::SetAlsaVolume0
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:16 volumio-x86 volumio[5772]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,1,0) appears twice or more
Nov 04 12:25:16 volumio-x86 volumio[5772]: amixer: Mixer hw:0 load error: Invalid argument
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Listing playlists
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetQueue
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreStateMachine::getQueue
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CorePlayQueue::getQueue
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Starting Shairport Sync
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPause
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: CoreStateMachine::pause
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: mpdhttpout --- Volumio set on pause
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: mpdhttpout ---Configuration successfully added to mpd.conf.
Nov 04 12:25:16 volumio-x86 sudo[6033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 04 12:25:16 volumio-x86 sudo[6033]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:16 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 04 12:25:16 volumio-x86 systemd[1]: shairport-sync.service: Succeeded.
Nov 04 12:25:16 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:25:16 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 04 12:25:16 volumio-x86 sudo[6033]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:16 volumio-x86 volumio[5772]: info: Shairport-Sync Started
Nov 04 12:25:17 volumio-x86 volumio[5772]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Nov 04 12:25:17 volumio-x86 volumio[5772]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Nov 04 12:25:17 volumio-x86 volumio[5772]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: camilladsp service started and running in background, instance 1
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:17 volumio-x86 volumio[5772]: cannot open device 'volumioHw': Device or resource busy
Nov 04 12:25:17 volumio-x86 volumio[5772]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Nov 04 12:25:17 volumio-x86 volumio[5772]: cannot open device 'volumioHw': Device or resource busy
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: FusionDsp loaded
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 04 12:25:17 volumio-x86 sudo[6055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Nov 04 12:25:17 volumio-x86 sudo[6055]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: FusionDsp - Reporting Fusion DSP Enabled
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: Adding Signal Path Element [object Object]
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: Adding fusiondspeq DSP Signal Path Element
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: FusionDsp - ---- installed callbackRead
Nov 04 12:25:17 volumio-x86 sudo[6055]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Nov 04 12:25:17 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15
Nov 04 12:25:17 volumio-x86 volumio[5772]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Nov 04 12:25:17 volumio-x86 mpd[6020]: Nov 04 12:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Nov 04 12:25:17 volumio-x86 systemd[1]: Started Music Player Daemon.
Nov 04 12:25:17 volumio-x86 sudo[6011]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:17 volumio-x86 volumio[5772]: error: updateQueue error: null
Nov 04 12:25:17 volumio-x86 volumio[5772]: error: updateQueue error: null
Nov 04 12:25:17 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16
Nov 04 12:25:18 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd
Nov 04 12:25:18 volumio-x86 sudo[6064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 04 12:25:18 volumio-x86 sudo[6064]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:18 volumio-x86 systemd[1]: Stopping Music Player Daemon...
Nov 04 12:25:18 volumio-x86 systemd[1]: mpd.service: Succeeded.
Nov 04 12:25:18 volumio-x86 systemd[1]: Stopped Music Player Daemon.
Nov 04 12:25:19 volumio-x86 systemd[1]: Starting Music Player Daemon...
Nov 04 12:25:19 volumio-x86 sudo[6068]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Nov 04 12:25:19 volumio-x86 sudo[6068]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:19 volumio-x86 sudo[6068]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:20 volumio-x86 mpd[6098]: Nov 04 12:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Nov 04 12:25:20 volumio-x86 systemd[1]: Started Music Player Daemon.
Nov 04 12:25:20 volumio-x86 sudo[6064]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:20 volumio-x86 volumio[5772]: error: updateQueue error: null
Nov 04 12:25:20 volumio-x86 sudo[6135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 04 12:25:20 volumio-x86 sudo[6135]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:20 volumio-x86 sudo[6135]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:20 volumio-x86 volumio[5772]: info: Cannot mount NAS local at system boot, trial number 3 ,retrying in 5 seconds
Nov 04 12:25:20 volumio-x86 sudo[6138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 04 12:25:20 volumio-x86 sudo[6138]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:20 volumio-x86 sudo[6138]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:20 volumio-x86 sudo[6141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Nov 04 12:25:20 volumio-x86 sudo[6141]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:20 volumio-x86 sudo[6141]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:20 volumio-x86 volumio[5772]: info: Upmpdcli Daemon Started
Nov 04 12:25:21 volumio-x86 volumio[5772]: verbose: ControllerMpd::sendMpdCommand update
Nov 04 12:25:21 volumio-x86 volumio[5772]: verbose: ControllerMpd::sendMpdCommand status
Nov 04 12:25:21 volumio-x86 volumio[5772]: info:
Nov 04 12:25:21 volumio-x86 volumio[5772]: ---------------------------- MPD announces state update: update
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: sendMpdCommand update took 142 milliseconds
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: ControllerMpd::getState
Nov 04 12:25:21 volumio-x86 volumio[5772]: verbose: ControllerMpd::sendMpdCommand status
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: MPD Database updated - AlbumList cache refreshed
Nov 04 12:25:21 volumio-x86 volumio[5772]: info:
Nov 04 12:25:21 volumio-x86 volumio[5772]: ---------------------------- MPD announces state update: database
Nov 04 12:25:21 volumio-x86 volumio[5772]: verbose: ControllerMpd::sendMpdCommand status
Nov 04 12:25:21 volumio-x86 volumio[5772]: info:
Nov 04 12:25:21 volumio-x86 volumio[5772]: ---------------------------- MPD announces state update: update
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: ControllerMpd::getState
Nov 04 12:25:21 volumio-x86 volumio[5772]: verbose: ControllerMpd::sendMpdCommand status
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: ControllerMpd::getState
Nov 04 12:25:21 volumio-x86 volumio[5772]: verbose: ControllerMpd::sendMpdCommand status
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: sendMpdCommand status took 38 milliseconds
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: sendMpdCommand status took 36 milliseconds
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: sendMpdCommand status took 33 milliseconds
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: sendMpdCommand status took 33 milliseconds
Nov 04 12:25:21 volumio-x86 volumio[5772]: info: sendMpdCommand status took 32 milliseconds
Nov 04 12:25:21 volumio-x86 volumio[5772]: verbose: ControllerMpd::parseState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: Command Router : Notfying DB Updatefalse
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::Close All Modals sent
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: ControllerMpd::parseState
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: ControllerMpd::parseState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: Command Router : Notfying DB Updatefalse
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::Close All Modals sent
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: ControllerMpd::parseState
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: ControllerMpd::parseState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: ControllerMpd::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::servicePushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: CURRENT POSITION 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::syncState stateService stop
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::syncState currentStatus stop
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: No code
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: ControllerMpd::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::servicePushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: CURRENT POSITION 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::syncState stateService stop
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::syncState currentStatus stop
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: No code
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: ControllerMpd::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::servicePushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Nov 04 12:25:22 volumio-x86 volumio[5772]: verbose: CURRENT POSITION 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::syncState stateService stop
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::syncState currentStatus stop
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: No code
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: ------------------------------ 660ms
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: ------------------------------ 656ms
Nov 04 12:25:22 volumio-x86 volumio[5772]: info: ------------------------------ 657ms
Nov 04 12:25:25 volumio-x86 volumio[5772]: info: Cannot mount NAS local at system boot, trial number 4 ,retrying in 5 seconds
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: Adding plugin bluetooth to MyMusic Plugins
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: Adding plugin multiroom to MyMusic Plugins
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: Adding plugin metavolumio to MyMusic Plugins
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: Adding plugin cd_controller to MyMusic Plugins
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: Adding plugin qobuzconnect to MyMusic Plugins
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: Adding plugin smart_inputs to MyMusic Plugins
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: Adding plugin tidalconnect to MyMusic Plugins
Nov 04 12:25:26 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: Starting MyVolumio Remote Streaming Endpoints
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: MyVolumio login type: Token
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: Starting Streaming Service Transparent Proxy
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: Streaming services startup
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: Starting Streaming Daemon
Nov 04 12:25:27 volumio-x86 sudo[6203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Nov 04 12:25:27 volumio-x86 sudo[6203]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 04 12:25:27 volumio-x86 sudo[6203]: pam_unix(sudo:session): session closed for user root
Nov 04 12:25:27 volumio-x86 volumio[5772]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Nov 04 12:25:27 volumio-x86 volumio[5772]: error: Cannot start Volumio Streaming Daemon
Nov 04 12:25:27 volumio-x86 volumio[5772]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Nov 04 12:25:27 volumio-x86 volumio[5772]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Nov 04 12:25:28 volumio-x86 volumio[5772]: STREAMING PROXY: Starting server on port 3245
Nov 04 12:25:28 volumio-x86 volumio[5772]: Node JS runtime: 14
Nov 04 12:25:30 volumio-x86 volumio[5772]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: AutoStart - Plugin is starting
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetQueue
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreStateMachine::getQueue
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CorePlayQueue::getQueue
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: AutoStart - start playing
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: AutoStart - start playing with no specific position
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPlay
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreStateMachine::play index 0
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreStateMachine::stop
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreStateMachine::play index undefined
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CoreStateMachine::startPlaybackTimer
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:34 volumio-x86 volumio[5772]: verbose: ControllerMpd::clearAddPlayTracks USB/新加卷/欧美流行/Sara K - Play On Words 1994 (Chesky 2004)/01. Horse I Used To Ride.wav
Nov 04 12:25:34 volumio-x86 volumio[5772]: verbose: ControllerMpd::sendMpdCommand stop
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: sendMpdCommand stop took 1 milliseconds
Nov 04 12:25:34 volumio-x86 volumio[5772]: verbose: ControllerMpd::sendMpdCommand clear
Nov 04 12:25:34 volumio-x86 volumio[5772]: info:
Nov 04 12:25:34 volumio-x86 volumio[5772]: ---------------------------- MPD announces system playlist update
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: Ignoring MPD Status Update
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: sendMpdCommand clear took 1 milliseconds
Nov 04 12:25:34 volumio-x86 volumio[5772]: verbose: ControllerMpd::sendMpdCommand add "USB/新加卷/欧美流行/Sara K - Play On Words 1994 (Chesky 2004)/01. Horse I Used To Ride.wav"
Nov 04 12:25:34 volumio-x86 volumio[5772]: error: updateQueue error: null
Nov 04 12:25:34 volumio-x86 volumio[5772]: info: ------------------------------ 2ms
Nov 04 12:25:42 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Nov 04 12:25:42 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16
Nov 04 12:25:42 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:42 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:44 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.103 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 11
Nov 04 12:25:44 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:44 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:44 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Nov 04 12:25:44 volumio-x86 volumio[5772]: info: Listing playlists
Nov 04 12:25:44 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetQueue
Nov 04 12:25:44 volumio-x86 volumio[5772]: info: CoreStateMachine::getQueue
Nov 04 12:25:44 volumio-x86 volumio[5772]: info: CorePlayQueue::getQueue
Nov 04 12:25:44 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 04 12:25:44 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 04 12:25:45 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 04 12:25:45 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:45 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Nov 04 12:25:45 volumio-x86 volumio-remote-updater[787]: No test mode
Nov 04 12:25:45 volumio-x86 volumio-remote-updater[787]: No alpha test mode
Nov 04 12:25:45 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Nov 04 12:25:46 volumio-x86 volumio[5772]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Nov 04 12:25:46 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetBrowseSources
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: Discovery: Getting this device information
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 04 12:25:47 volumio-x86 volumio[5772]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: Completed starting MyVolumio Plugin
Nov 04 12:25:47 volumio-x86 volumio[5772]: [Metrics] CommandRouter: 39s 592.63ms
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumiosetStartupVolume
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: VolumeController:: Setting startup Volume 5
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: VolumeController::SetAlsaVolume5
Nov 04 12:25:47 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: CoreCommandRouter::Close All Modals sent
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: CoreCommandRouter::Close All Modals sent
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: CoreStateMachine::pushState
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioPushState
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: FusionDsp - ---- read samplerate from file: 44100
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: camilladsp stopping service pid 6044...
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: camilladsp service terminated, instance 1
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Nov 04 12:25:48 volumio-x86 volumio[5772]: info: camilladsp service started and running in background, instance 1
Nov 04 12:25:48 volumio-x86 volumio[5772]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,1,0) appears twice or more
Nov 04 12:25:48 volumio-x86 volumio[5772]: amixer: Mixer hw:0 load error: Invalid argument
Nov 04 12:25:49 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Nov 04 12:25:49 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Nov 04 12:25:49 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Nov 04 12:25:52 volumio-x86 volumio[5772]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.103 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 11
Nov 04 12:25:52 volumio-x86 volumio[5772]: info: CoreCommandRouter::volumioGetState
Nov 04 12:25:52 volumio-x86 volumio[5772]: info: CorePlayQueue::getTrack 0
Nov 04 12:25:52 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Nov 04 12:25:52 volumio-x86 volumio[5772]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Nov 04 12:25:53 volumio-x86 volumio[5772]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 04 12:25:53 volumio-x86 volumio[5772]: Error: connect ECONNREFUSED 199.59.148.7:443
Nov 04 12:25:53 volumio-x86 volumio[5772]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Nov 04 12:25:53 volumio-x86 volumio[5772]: errno: -111,
Nov 04 12:25:53 volumio-x86 volumio[5772]: code: 'ECONNREFUSED',
Nov 04 12:25:53 volumio-x86 volumio[5772]: syscall: 'connect',
Nov 04 12:25:53 volumio-x86 volumio[5772]: address: '199.59.148.7',
Nov 04 12:25:53 volumio-x86 volumio[5772]: port: 443
Nov 04 12:25:53 volumio-x86 volumio[5772]: }
Nov 04 12:25:53 volumio-x86 volumio[5772]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 04 12:25:53 volumio-x86 sudo[6304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-04 12:24
Nov 04 12:25:53 volumio-x86 sudo[6304]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"