-- Logs begin at Thu 2019-02-14 07:11:58 -03, end at Thu 2025-05-01 22:30:46 -04. --
May 01 22:29:05 volumio volumio[1040]: info: CALLMETHOD: audio_interface fusiondsp importeq [object Object]
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , importeq
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - namepath /oratory1990/over-ear/HIFIMAN%20HE1000se name HIFIMAN HE1000se
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - wget 'https://raw.githubusercontent.com/jaakkopasanen/AutoEq/master/results/oratory1990/over-ear/HIFIMAN%20HE1000se/HIFIMAN%20HE1000se%20ParametricEQ.txt
May 01 22:29:05 volumio volumio[1040]: --2025-05-01 22:29:05-- https://raw.githubusercontent.com/jaakkopasanen/AutoEq/master/results/oratory1990/over-ear/HIFIMAN%20HE1000se/HIFIMAN%20HE1000se%20ParametricEQ.txt
May 01 22:29:05 volumio volumio[1040]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.111.133, 185.199.108.133, 185.199.109.133, ...
May 01 22:29:05 volumio volumio[1040]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.111.133|:443... connected.
May 01 22:29:05 volumio volumio[1040]: HTTP request sent, awaiting response... 200 OK
May 01 22:29:05 volumio volumio[1040]: Length: 480 [text/plain]
May 01 22:29:05 volumio volumio[1040]: Saving to: ‘/tmp/EQfile.txt’
May 01 22:29:05 volumio volumio[1040]: 0K 100% 10.8M=0s
May 01 22:29:05 volumio volumio[1040]: 2025-05-01 22:29:05 (10.8 MB/s) - ‘/tmp/EQfile.txt’ saved [480/480]
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:05 volumio volumio[1040]: info: CoreCommandRouter::Close All Modals sent
May 01 22:29:05 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:06 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:06 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:06 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:06 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:06 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:06 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:06 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:06 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:06 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:07 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:07 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:07 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:07 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:07 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:07 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:07 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:07 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:07 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:17 volumio volumio[1040]: info: CoreCommandRouter::volumioGetQueue
May 01 22:29:17 volumio volumio[1040]: info: CoreStateMachine::getQueue
May 01 22:29:17 volumio volumio[1040]: info: CorePlayQueue::getQueue
May 01 22:29:17 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 01 22:29:17 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 01 22:29:17 volumio volumio[1040]: info: Discovery: Getting this device information
May 01 22:29:17 volumio volumio[1040]: info: CoreCommandRouter::volumioGetState
May 01 22:29:17 volumio volumio[1040]: info: CorePlayQueue::getTrack 10
May 01 22:29:17 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 01 22:29:19 volumio volumio[1040]: info: Preload queue cleared
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::ClearQueue
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::stop
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::stPlaybackTimer
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::pushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 10
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::serviceStop
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 10
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::serviceStop
May 01 22:29:19 volumio volumio[1040]: info: ControllerMpd::stop
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::clearPlayQueue
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::saveQueue
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::addQueueItems
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::addQueueItems
May 01 22:29:19 volumio volumio[1040]: info: Preload queue cleared
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/01 - Wednesday Morning Atonement.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/01 - Wednesday Morning Atonement.flac
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/02 - Face Your Fear.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/02 - Face Your Fear.flac
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/03 - On and On.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/03 - On and On.flac
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/04 - Go as You Are.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/04 - Go as You Are.flac
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/05 - Till the End.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/05 - Till the End.flac
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/06 - Need Your Love.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/06 - Need Your Love.flac
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/07 - Dream Girl.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/07 - Dream Girl.flac
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/08 - Welcome to My World.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/08 - Welcome to My World.flac
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::saveQueue
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPlay
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::play index 7
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::addQueueItems
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::addQueueItems
May 01 22:29:19 volumio volumio[1040]: info: Preload queue cleared
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/09 - Ghost of You.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/09 - Ghost of You.flac
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/10 - Need My Baby.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/10 - Need My Baby.flac
May 01 22:29:19 volumio volumio[1040]: info: Adding Item to queue: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/11 - As I Am.flac
May 01 22:29:19 volumio volumio[1040]: info: Using cached record of: music-library/USB/My_Passport/Curtis Harding/2017 - Face Your Fear/11 - As I Am.flac
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::stop
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::saveQueue
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::play index undefined
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::startPlaybackTimer
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::clearAddPlayTracks USB/My_Passport/Curtis Harding/2017 - Face Your Fear/08 - Welcome to My World.flac
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand stop took 24 milliseconds
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand stop took 5 milliseconds
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand clear
May 01 22:29:19 volumio volumio[1040]: info:
May 01 22:29:19 volumio volumio[1040]: ---------------------------- MPD announces system playlist update
May 01 22:29:19 volumio volumio[1040]: info: Ignoring MPD Status Update
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand clear took 1 milliseconds
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand add "USB/My_Passport/Curtis Harding/2017 - Face Your Fear/08 - Welcome to My World.flac"
May 01 22:29:19 volumio volumio[1040]: info:
May 01 22:29:19 volumio volumio[1040]: ---------------------------- MPD announces system playlist update
May 01 22:29:19 volumio volumio[1040]: info: Ignoring MPD Status Update
May 01 22:29:19 volumio volumio[1040]: error: updateQueue error: null
May 01 22:29:19 volumio volumio[1040]: info:
May 01 22:29:19 volumio volumio[1040]: ---------------------------- MPD announces system playlist update
May 01 22:29:19 volumio volumio[1040]: info: Ignoring MPD Status Update
May 01 22:29:19 volumio volumio[1040]: info: ------------------------------ 5ms
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand add "USB/My_Passport/Curtis Harding/2017 - Face Your Fear/08 - Welcome to My World.flac" took 4 milliseconds
May 01 22:29:19 volumio volumio[1040]: info: ------------------------------ 3ms
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand play
May 01 22:29:19 volumio volumio[1040]: info:
May 01 22:29:19 volumio volumio[1040]: ---------------------------- MPD announces system playlist update
May 01 22:29:19 volumio volumio[1040]: info: Ignoring MPD Status Update
May 01 22:29:19 volumio volumio[1040]: info: ------------------------------ 4ms
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand play took 2 milliseconds
May 01 22:29:19 volumio volumio[1040]: info:
May 01 22:29:19 volumio volumio[1040]: ---------------------------- MPD announces state update: player
May 01 22:29:19 volumio volumio[1040]: info: ------------------------------ 3ms
May 01 22:29:19 volumio volumio[1040]: info: ControllerMpd::getState
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status
May 01 22:29:19 volumio volumio[1040]: info:
May 01 22:29:19 volumio volumio[1040]: ---------------------------- MPD announces state update: player
May 01 22:29:19 volumio volumio[1040]: info: ControllerMpd::getState
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status
May 01 22:29:19 volumio volumio[1040]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32
May 01 22:29:19 volumio volumio[1040]: info: FusionDsp - ---- read samplerate from file: 48000
May 01 22:29:19 volumio volumio[1040]: error: FusionDsp - TypeError: Cannot read property 'stop' of null
May 01 22:29:19 volumio volumio[1040]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32
May 01 22:29:19 volumio volumio[1040]: info: FusionDsp - ---- read samplerate from file: 48000
May 01 22:29:19 volumio volumio[1040]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 01 22:29:19 volumio volumio[1040]: info:
May 01 22:29:19 volumio volumio[1040]: ---------------------------- MPD announces state update: player
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand status took 27 milliseconds
May 01 22:29:19 volumio volumio[1040]: info: ControllerMpd::getState
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand status took 26 milliseconds
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::parseState
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::parseState
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 01 22:29:19 volumio volumio[1040]: info:
May 01 22:29:19 volumio volumio[1040]: ---------------------------- MPD announces state update: player
May 01 22:29:19 volumio volumio[1040]: info: ControllerMpd::getState
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand status took 6 milliseconds
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand status took 3 milliseconds
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::parseState
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::parseState
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 01 22:29:19 volumio volumio[1040]: info: ControllerMpd::pushState
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::servicePushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Welcome to My World","artist":"Curtis Harding","album":"Face Your Fear","uri":"USB/My_Passport/Curtis Harding/2017 - Face Your Fear/08 - Welcome to My World.flac","trackType":"flac"}
May 01 22:29:19 volumio volumio[1040]: verbose: CURRENT POSITION 7
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop
May 01 22:29:19 volumio volumio[1040]: info: ControllerMpd::pushState
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::servicePushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21,"duration":217,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1421 Kbps","isStreaming":false,"title":"Welcome to My World","artist":"Curtis Harding","album":"Face Your Fear","uri":"USB/My_Passport/Curtis Harding/2017 - Face Your Fear/08 - Welcome to My World.flac","trackType":"flac"}
May 01 22:29:19 volumio volumio[1040]: verbose: CURRENT POSITION 7
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play
May 01 22:29:19 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::pushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::pushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState
May 01 22:29:19 volumio volumio[1040]: info: ------------------------------ 45ms
May 01 22:29:19 volumio volumio[1040]: info: ------------------------------ 46ms
May 01 22:29:19 volumio volumio[1040]: error: FusionDsp - WebSocket error: [object Object]
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 15 milliseconds
May 01 22:29:19 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 13 milliseconds
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo
May 01 22:29:19 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo
May 01 22:29:19 volumio volumio[1040]: info: ControllerMpd::pushState
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::servicePushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":217,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1393 Kbps","isStreaming":false,"title":"Welcome to My World","artist":"Curtis Harding","album":"Face Your Fear","uri":"USB/My_Passport/Curtis Harding/2017 - Face Your Fear/08 - Welcome to My World.flac","trackType":"flac"}
May 01 22:29:19 volumio volumio[1040]: verbose: CURRENT POSITION 7
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play
May 01 22:29:19 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::pushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::pushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState
May 01 22:29:19 volumio volumio[1040]: info: ControllerMpd::pushState
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::servicePushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":217,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1393 Kbps","isStreaming":false,"title":"Welcome to My World","artist":"Curtis Harding","album":"Face Your Fear","uri":"USB/My_Passport/Curtis Harding/2017 - Face Your Fear/08 - Welcome to My World.flac","trackType":"flac"}
May 01 22:29:19 volumio volumio[1040]: verbose: CURRENT POSITION 7
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play
May 01 22:29:19 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::pushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState
May 01 22:29:19 volumio volumio[1040]: info: CoreStateMachine::pushState
May 01 22:29:19 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:19 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState
May 01 22:29:19 volumio volumio[1040]: info: ------------------------------ 37ms
May 01 22:29:19 volumio volumio[1040]: info: ------------------------------ 33ms
May 01 22:29:34 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 01 22:29:34 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 01 22:29:38 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 22:29:38 volumio volumio[1040]: info: FusionDsp - Choose a preset
May 01 22:29:38 volumio volumio[1040]: info: FusionDsp -
May 01 22:29:47 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 01 22:29:47 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 01 22:29:47 volumio volumio[1040]: info: Discovery: Getting this device information
May 01 22:29:47 volumio volumio[1040]: info: CoreCommandRouter::volumioGetState
May 01 22:29:47 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:29:47 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 01 22:30:14 volumio volumio[1040]: info: CALLMETHOD: audio_interface fusiondsp importeq [object Object]
May 01 22:30:14 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , importeq
May 01 22:30:14 volumio volumio[1040]: info: FusionDsp - namepath 1981 HIFIMAN HE1000se name HIFIMAN HE1000se
May 01 22:30:14 volumio volumio[1040]: info: FusionDsp - wget 'https://raw.githubusercontent.com/jaakkopasanen/AutoEq/master/results1981 HIFIMAN HE1000se/HIFIMAN%20HE1000se%20ParametricEQ.txt
May 01 22:30:14 volumio volumio[1040]: --2025-05-01 22:30:14-- https://raw.githubusercontent.com/jaakkopasanen/AutoEq/master/results1981%20%20HIFIMAN%20HE1000se/HIFIMAN%20HE1000se%20ParametricEQ.txt
May 01 22:30:14 volumio volumio[1040]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.111.133, 185.199.108.133, 185.199.109.133, ...
May 01 22:30:14 volumio volumio[1040]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.111.133|:443... connected.
May 01 22:30:14 volumio volumio[1040]: HTTP request sent, awaiting response... 404 Not Found
May 01 22:30:14 volumio volumio[1040]: 2025-05-01 22:30:14 ERROR 404: Not Found.
May 01 22:30:14 volumio volumio[1040]: error: FusionDsp - failed to download EqError: Command failed: /usr/bin/wget 'https://raw.githubusercontent.com/jaakkopasanen/AutoEq/master/results1981 HIFIMAN HE1000se/HIFIMAN%20HE1000se%20ParametricEQ.txt' -O /tmp/EQfile.txt
May 01 22:30:14 volumio volumio[1040]: --2025-05-01 22:30:14-- https://raw.githubusercontent.com/jaakkopasanen/AutoEq/master/results1981%20%20HIFIMAN%20HE1000se/HIFIMAN%20HE1000se%20ParametricEQ.txt
May 01 22:30:14 volumio volumio[1040]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.111.133, 185.199.108.133, 185.199.109.133, ...
May 01 22:30:14 volumio volumio[1040]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.111.133|:443... connected.
May 01 22:30:14 volumio volumio[1040]: HTTP request sent, awaiting response... 404 Not Found
May 01 22:30:14 volumio volumio[1040]: 2025-05-01 22:30:14 ERROR 404: Not Found.
May 01 22:30:17 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 01 22:30:17 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 01 22:30:17 volumio volumio[1040]: info: Discovery: Getting this device information
May 01 22:30:17 volumio volumio[1040]: info: CoreCommandRouter::volumioGetState
May 01 22:30:17 volumio volumio[1040]: info: CorePlayQueue::getTrack 7
May 01 22:30:17 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 01 22:30:40 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 01 22:30:40 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 01 22:30:44 volumio volumio[1040]: info: Enabling plugin fusiondsp
May 01 22:30:44 volumio volumio[1040]: info: Loading plugin "fusiondsp"...
May 01 22:30:44 volumio volumio[1040]: info: Applying required configuration parameters for plugin fusiondsp
May 01 22:30:44 volumio volumio[1040]: info: Preparing to generate the ALSA configuration file
May 01 22:30:44 volumio volumio[1040]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
May 01 22:30:44 volumio volumio[1040]: info: Reading ALSA contributions from plugins.
May 01 22:30:44 volumio volumio[1040]: info: Asound.conf file unchanged, so no further update is needed
May 01 22:30:44 volumio volumio[1040]: info: Output device has changed, restarting MPD
May 01 22:30:44 volumio sudo[7662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 01 22:30:44 volumio sudo[7662]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 22:30:44 volumio sudo[7662]: pam_unix(sudo:session): session closed for user root
May 01 22:30:44 volumio volumio[1040]: info: Output device has changed, restarting Shairport Sync
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 01 22:30:44 volumio sudo[7665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 01 22:30:44 volumio sudo[7665]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 22:30:44 volumio systemd[1]: Stopping Music Player Daemon...
May 01 22:30:44 volumio volumio[1040]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 01 22:30:44 volumio volumio[1040]: info: PLUGIN START: fusiondsp
May 01 22:30:44 volumio volumio[1040]: info: Loading i18n strings for locale es
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: FusionDsp - mixtype--------------------- Hardware
May 01 22:30:44 volumio volumio[1040]: info: Preparing to generate the ALSA configuration file
May 01 22:30:44 volumio volumio[1040]: info: Done.
May 01 22:30:44 volumio volumio[1040]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
May 01 22:30:44 volumio volumio[1040]: info: Reading ALSA contributions from plugins.
May 01 22:30:44 volumio volumio[1040]: info: MPD Permissions set
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 01 22:30:44 volumio systemd[1]: mpd.service: Succeeded.
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio systemd[1]: Stopped Music Player Daemon.
May 01 22:30:44 volumio volumio[1040]: info: Starting Shairport Sync
May 01 22:30:44 volumio volumio[1040]: info: Asound.conf file unchanged, so no further update is needed
May 01 22:30:44 volumio volumio[1040]: info: Output device has changed, restarting MPD
May 01 22:30:44 volumio sudo[7676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 01 22:30:44 volumio volumio[1040]: info: Output device has changed, restarting Shairport Sync
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 01 22:30:44 volumio systemd[1]: Starting Music Player Daemon...
May 01 22:30:44 volumio sudo[7676]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 22:30:44 volumio sudo[7679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 01 22:30:44 volumio sudo[7679]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 22:30:44 volumio sudo[7679]: pam_unix(sudo:session): session closed for user root
May 01 22:30:44 volumio sudo[7682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 01 22:30:44 volumio sudo[7682]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 22:30:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 01 22:30:44 volumio systemd[1]: shairport-sync.service: Succeeded.
May 01 22:30:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 01 22:30:44 volumio volumio[1040]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 01 22:30:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 01 22:30:44 volumio volumio[1040]: info: MPD Permissions set
May 01 22:30:44 volumio sudo[7676]: pam_unix(sudo:session): session closed for user root
May 01 22:30:44 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
May 01 22:30:44 volumio systemd[1]: mpd.service: Succeeded.
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio systemd[1]: Stopped Music Player Daemon.
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio systemd[1]: Starting Music Player Daemon...
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 22:30:44 volumio volumio[1040]: info: Shairport-Sync Started
May 01 22:30:44 volumio volumio[1040]: info: Starting Shairport Sync
May 01 22:30:44 volumio sudo[7697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 01 22:30:44 volumio sudo[7697]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 22:30:44 volumio sudo[7688]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 01 22:30:44 volumio sudo[7688]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 22:30:44 volumio sudo[7688]: pam_unix(sudo:session): session closed for user root
May 01 22:30:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 01 22:30:44 volumio systemd[1]: shairport-sync.service: Succeeded.
May 01 22:30:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 01 22:30:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 01 22:30:44 volumio sudo[7697]: pam_unix(sudo:session): session closed for user root
May 01 22:30:44 volumio volumio[1040]: info: Shairport-Sync Started
May 01 22:30:45 volumio volumio[1040]: error: Upnp client error: Error: This socket has been ended by the other party
May 01 22:30:45 volumio mpd[7700]: May 01 22:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 01 22:30:45 volumio volumio[1040]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 01 22:30:45 volumio volumio[1040]: TypeError: Cannot read property 'off' of undefined
May 01 22:30:45 volumio volumio[1040]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15)
May 01 22:30:45 volumio volumio[1040]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
May 01 22:30:45 volumio volumio[1040]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8)
May 01 22:30:45 volumio volumio[1040]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29)
May 01 22:30:45 volumio volumio[1040]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47)
May 01 22:30:45 volumio volumio[1040]: at Socket.emit (events.js:315:20)
May 01 22:30:45 volumio volumio[1040]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
May 01 22:30:45 volumio volumio[1040]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 01 22:30:45 volumio volumio[1040]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 01 22:30:46 volumio systemd[1]: Started Music Player Daemon.
May 01 22:30:46 volumio sudo[7682]: pam_unix(sudo:session): session closed for user root
May 01 22:30:46 volumio sudo[7665]: pam_unix(sudo:session): session closed for user root
May 01 22:30:46 volumio sudo[7716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-01 22:29
May 01 22:30:46 volumio sudo[7716]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST"
VOLUMIO_VERSION="3.804"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"