-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2024-05-05 13:29:53 UTC. --
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b333c5b does not match aorg 0000000000.00000000 from server@109.205.49.8 xmt 0xe9e207f4.7eedf241
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b2d2f50 does not match aorg 0000000000.00000000 from server@91.212.242.21 xmt 0xe9e207f4.7ee1b3df
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b2411ec does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xe9e207f4.7edb683d
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b2bbafe does not match aorg 0000000000.00000000 from server@91.227.212.78 xmt 0xe9e207f4.7f3b65b8
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b2a139b does not match aorg 0000000000.00000000 from server@185.157.13.96 xmt 0xe9e207f4.7f8b2b24
May 05 13:28:20 volumio systemd[1]: Starting Daily apt download activities...
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b2e9295 does not match aorg 0000000000.00000000 from server@185.231.150.1 xmt 0xe9e207f4.805cd81d
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b35f156 does not match aorg 0000000000.00000000 from server@156.17.20.254 xmt 0xe9e207f4.82b4ff5d
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b38e245 does not match aorg 0000000000.00000000 from server@178.215.228.24 xmt 0xe9e207f4.80ffd828
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b3000c5 does not match aorg 0000000000.00000000 from server@188.165.17.91 xmt 0xe9e207f4.815e7685
May 05 13:28:20 volumio ntpd[668]: receive: Unexpected origin timestamp 0xe7acdcc1.5b31c27b does not match aorg 0000000000.00000000 from server@80.50.102.114 xmt 0xe9e207f4.82ea1b99
May 05 13:28:20 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:20 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:20 volumio volumio[854]: info: Prefetching next song
May 05 13:28:20 volumio volumio[854]: info: Discovery: A device disappeared from network
May 05 13:28:20 volumio volumio[854]: info: Discovery: Device volumio disappeared from network
May 05 13:28:21 volumio volumio[854]: info: Discovery: adding 1d033035-8543-4d57-a163-c278afa00236
May 05 13:28:21 volumio volumio[854]: info: Discovery: Found device Volumio
May 05 13:28:21 volumio volumio[854]: info: CoreCommandRouter::volumioGetState
May 05 13:28:21 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 05 13:28:21 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 05 13:28:21 volumio volumio[854]: info: Discovery: Getting this device information
May 05 13:28:21 volumio volumio[854]: info: CoreCommandRouter::volumioGetState
May 05 13:28:21 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 05 13:28:22 volumio volumio[854]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 05 13:28:22 volumio volumio[854]: info: Received Get System Version
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 05 13:28:22 volumio volumio[854]: info: Received Get System Info
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 05 13:28:22 volumio volumio[854]: info: Discovery: Getting this device information
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::volumioGetState
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 05 13:28:22 volumio volumio[854]: verbose: New Socket.io Connection to 192.168.0.191 from 192.168.0.132 UA: unknown Total Clients: 7
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::volumioGetState
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 05 13:28:22 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 05 13:28:22 volumio volumio[854]: info: CURURI: music-library
May 05 13:28:23 volumio systemd[1]: apt-daily.service: Succeeded.
May 05 13:28:23 volumio systemd[1]: Started Daily apt download activities.
May 05 13:28:23 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
May 05 13:28:25 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
May 05 13:28:25 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand update
May 05 13:28:25 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:25 volumio volumio[854]: info:
May 05 13:28:25 volumio volumio[854]: ---------------------------- MPD announces state update: update
May 05 13:28:25 volumio volumio[854]: info: sendMpdCommand update took 6 milliseconds
May 05 13:28:25 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:28:25 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:25 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:25 volumio volumio[854]: info:
May 05 13:28:25 volumio volumio[854]: ---------------------------- MPD announces state update: update
May 05 13:28:25 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:28:25 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:25 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:25 volumio volumio[854]: info:
May 05 13:28:25 volumio volumio[854]: ---------------------------- MPD announces state update: update
May 05 13:28:25 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:28:25 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:25 volumio volumio[854]: info: sendMpdCommand status took 12 milliseconds
May 05 13:28:25 volumio volumio[854]: info: sendMpdCommand status took 10 milliseconds
May 05 13:28:25 volumio volumio[854]: info: sendMpdCommand status took 9 milliseconds
May 05 13:28:25 volumio volumio[854]: info: sendMpdCommand status took 7 milliseconds
May 05 13:28:25 volumio volumio[854]: info: sendMpdCommand status took 7 milliseconds
May 05 13:28:25 volumio volumio[854]: info: sendMpdCommand status took 6 milliseconds
May 05 13:28:25 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:25 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
May 05 13:28:25 volumio systemd[1]: Started Daily apt upgrade and clean activities.
May 05 13:28:29 volumio volumio[854]: info: Command Router : Notfying DB Updatetrue
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::Close All Modals sent
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:29 volumio volumio[854]: info: Command Router : Notfying DB Updatetrue
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::Close All Modals sent
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:29 volumio volumio[854]: info: Command Router : Notfying DB Updatetrue
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::Close All Modals sent
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 13:28:29 volumio volumio[854]: info: sendMpdCommand playlistinfo took 141 milliseconds
May 05 13:28:29 volumio volumio[854]: info: sendMpdCommand playlistinfo took 84 milliseconds
May 05 13:28:29 volumio volumio[854]: info: sendMpdCommand playlistinfo took 62 milliseconds
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::parseTrackInfo
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::parseTrackInfo
May 05 13:28:29 volumio volumio[854]: verbose: ControllerMpd::parseTrackInfo
May 05 13:28:29 volumio volumio[854]: info: ControllerMpd::pushState
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:28:29 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:29 volumio volumio[854]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15601,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Lucio Dalla - Angeli (Studio Version)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
May 05 13:28:29 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::syncState stateService play
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus play
May 05 13:28:29 volumio volumio[854]: info: Received an update from plugin. extracting info from payload
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:29 volumio volumio[854]: info: ControllerMpd::pushState
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:28:29 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:29 volumio volumio[854]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15601,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Lucio Dalla - Angeli (Studio Version)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
May 05 13:28:29 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::syncState stateService play
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus play
May 05 13:28:29 volumio volumio[854]: info: Received an update from plugin. extracting info from payload
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:29 volumio volumio[854]: info: ControllerMpd::pushState
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:28:29 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:29 volumio volumio[854]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15601,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Lucio Dalla - Angeli (Studio Version)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
May 05 13:28:29 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::syncState stateService play
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus play
May 05 13:28:29 volumio volumio[854]: info: Received an update from plugin. extracting info from payload
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:29 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:29 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:30 volumio volumio[854]: info: ------------------------------ 4919ms
May 05 13:28:30 volumio volumio[854]: info: ------------------------------ 4917ms
May 05 13:28:30 volumio volumio[854]: info: ------------------------------ 4916ms
May 05 13:28:30 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:30 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:30 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:30 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:30 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:30 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:30 volumio volumio[854]: Upnp client error: Error: This socket has been ended by the other party
May 05 13:28:30 volumio volumio[854]: Upnp client error: Error: This socket has been ended by the other party
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 05 13:28:30 volumio volumio[854]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 05 13:28:30 volumio volumio[854]: info: Adding plugin bluetooth to MyMusic Plugins
May 05 13:28:31 volumio volumio[854]: info: Adding plugin multiroom to MyMusic Plugins
May 05 13:28:31 volumio volumio[854]: info: Adding plugin metavolumio to MyMusic Plugins
May 05 13:28:31 volumio volumio[854]: info: Adding plugin cd_controller to MyMusic Plugins
May 05 13:28:31 volumio volumio[854]: info: Adding plugin smart_inputs to MyMusic Plugins
May 05 13:28:31 volumio volumio[854]: info: Adding plugin tidalconnect to MyMusic Plugins
May 05 13:28:31 volumio volumio[854]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 05 13:28:32 volumio volumio[854]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 05 13:28:32 volumio volumio[854]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 05 13:28:32 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:32 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:32 volumio volumio[854]: info: Starting MyVolumio Remote Streaming Endpoints
May 05 13:28:32 volumio volumio[854]: info: MyVolumio login type: Token
May 05 13:28:32 volumio volumio[854]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 05 13:28:32 volumio volumio[854]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 05 13:28:32 volumio volumio[854]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 05 13:28:32 volumio volumio[854]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 05 13:28:32 volumio volumio[854]: info: Streaming services startup
May 05 13:28:32 volumio volumio[854]: info: Starting Streaming Daemon
May 05 13:28:32 volumio sudo[1376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 05 13:28:32 volumio sudo[1376]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 05 13:28:32 volumio volumio[854]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
May 05 13:28:32 volumio systemd[1]: Stopping Volumio Streaming Daemon...
May 05 13:28:32 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM
May 05 13:28:32 volumio systemd[1]: volumio-streaming-daemon.service: Succeeded.
May 05 13:28:32 volumio systemd[1]: Stopped Volumio Streaming Daemon.
May 05 13:28:32 volumio systemd[1]: Started Volumio Streaming Daemon.
May 05 13:28:32 volumio sudo[1376]: pam_unix(sudo:session): session closed for user root
May 05 13:28:32 volumio volumio-streaming-daemon[1382]: ############################
May 05 13:28:32 volumio volumio-streaming-daemon[1382]: # Volumio Streaming Daemon #
May 05 13:28:32 volumio volumio-streaming-daemon[1382]: # Running on port 7777 #
May 05 13:28:32 volumio volumio-streaming-daemon[1382]: ############################
May 05 13:28:32 volumio volumio-streaming-daemon[1382]: Environment: production
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Lowshelf
May 05 13:28:32 volumio volumio[854]: freq: 185
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq2:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Peaking
May 05 13:28:32 volumio volumio[854]: freq: 1300
May 05 13:28:32 volumio volumio[854]: q: 0.4
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq3:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Highshelf
May 05 13:28:32 volumio volumio[854]: freq: 5500
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Lowshelf
May 05 13:28:32 volumio volumio[854]: freq: 185
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq2:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Peaking
May 05 13:28:32 volumio volumio[854]: freq: 1300
May 05 13:28:32 volumio volumio[854]: q: 0.4
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq3:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Highshelf
May 05 13:28:32 volumio volumio[854]: freq: 5500
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Lowshelf
May 05 13:28:32 volumio volumio[854]: freq: 185
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq2:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Peaking
May 05 13:28:32 volumio volumio[854]: freq: 1300
May 05 13:28:32 volumio volumio[854]: q: 0.4
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq3:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Highshelf
May 05 13:28:32 volumio volumio[854]: freq: 5500
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Lowshelf
May 05 13:28:32 volumio volumio[854]: freq: 185
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq2:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Peaking
May 05 13:28:32 volumio volumio[854]: freq: 1300
May 05 13:28:32 volumio volumio[854]: q: 0.4
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq3:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Highshelf
May 05 13:28:32 volumio volumio[854]: freq: 5500
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Lowshelf
May 05 13:28:32 volumio volumio[854]: freq: 185
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq2:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Peaking
May 05 13:28:32 volumio volumio[854]: freq: 1300
May 05 13:28:32 volumio volumio[854]: q: 0.4
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq3:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Highshelf
May 05 13:28:32 volumio volumio[854]: freq: 5500
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Lowshelf
May 05 13:28:32 volumio volumio[854]: freq: 185
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq2:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Peaking
May 05 13:28:32 volumio volumio[854]: freq: 1300
May 05 13:28:32 volumio volumio[854]: q: 0.4
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: eq3:
May 05 13:28:32 volumio volumio[854]: type: Biquad
May 05 13:28:32 volumio volumio[854]: parameters:
May 05 13:28:32 volumio volumio[854]: type: Highshelf
May 05 13:28:32 volumio volumio[854]: freq: 5500
May 05 13:28:32 volumio volumio[854]: q: 0.82
May 05 13:28:32 volumio volumio[854]: gain: 0
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:32 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:33 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:33 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:33 volumio volumio[854]: error: MyVolumio Custom Token format not valid, refreshing it
May 05 13:28:34 volumio volumio[854]: info: MyVolumio login type: Token
May 05 13:28:34 volumio volumio[854]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
May 05 13:28:34 volumio volumio[854]: info: MYVOLUMIO: Adding device
May 05 13:28:34 volumio volumio[854]: info: MYVOLUMIO: Evaluating Server
May 05 13:28:35 volumio volumio[854]: info: MyVolumio status changed
May 05 13:28:35 volumio volumio[854]: info: Streaming services startup
May 05 13:28:35 volumio volumio[854]: info: Re-Starting Streaming Daemon
May 05 13:28:35 volumio volumio[854]: info: Removing browser output: myVolumio user plan is not superstar
May 05 13:28:35 volumio volumio[854]: info: Removing audio output:
May 05 13:28:35 volumio volumio[854]: info: Stoppping Tunnel 1
May 05 13:28:35 volumio sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
May 05 13:28:35 volumio sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 05 13:28:37 volumio sudo[1403]: pam_unix(sudo:session): session closed for user root
May 05 13:28:37 volumio volumio-streaming-daemon[1382]: Restarting daemon
May 05 13:28:37 volumio volumio-streaming-daemon[1382]: Environment: production
May 05 13:28:37 volumio volumio[854]: info: Remote SSH Stopped
May 05 13:28:37 volumio volumio-streaming-daemon[1382]: Environment: production
May 05 13:28:37 volumio volumio[854]: info: Fetching Streaming Services browse cache
May 05 13:28:37 volumio volumio[854]: info: Setting Geolocation for MyVolumio to eu5
May 05 13:28:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:38 volumio volumio-streaming-daemon[1382]: Environment: production
May 05 13:28:38 volumio volumio[854]: info: Fetching Streaming Services browse cache
May 05 13:28:38 volumio volumio[854]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
May 05 13:28:38 volumio volumio[854]: info: Updating MyVolumio device info
May 05 13:28:38 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:40 volumio volumio[854]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
May 05 13:28:42 volumio volumio[854]: info: MYVOLUMIO: Adding device
May 05 13:28:42 volumio volumio[854]: info: MYVOLUMIO: Evaluating Server
May 05 13:28:42 volumio volumio[854]: info: MPD Database updated - AlbumList cache refreshed
May 05 13:28:42 volumio volumio[854]: info:
May 05 13:28:42 volumio volumio[854]: ---------------------------- MPD announces state update: database
May 05 13:28:42 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:42 volumio volumio[854]: info:
May 05 13:28:42 volumio volumio[854]: ---------------------------- MPD announces state update: update
May 05 13:28:42 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:28:42 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:42 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:28:42 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:42 volumio volumio[854]: info: MPD Database updated - AlbumList cache refreshed
May 05 13:28:42 volumio volumio[854]: info:
May 05 13:28:42 volumio volumio[854]: ---------------------------- MPD announces state update: database
May 05 13:28:42 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:42 volumio volumio[854]: info:
May 05 13:28:42 volumio volumio[854]: ---------------------------- MPD announces state update: update
May 05 13:28:42 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:28:42 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:42 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:28:42 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:42 volumio volumio[854]: info: MPD Database updated - AlbumList cache refreshed
May 05 13:28:42 volumio volumio[854]: info:
May 05 13:28:42 volumio volumio[854]: ---------------------------- MPD announces state update: database
May 05 13:28:42 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:42 volumio volumio[854]: info:
May 05 13:28:42 volumio volumio[854]: ---------------------------- MPD announces state update: update
May 05 13:28:42 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:28:42 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:42 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:28:42 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:28:43 volumio volumio[854]: Cannot compose Albumart path
May 05 13:28:43 volumio volumio[854]: info: sendMpdCommand status took 520 milliseconds
May 05 13:28:43 volumio volumio[854]: info: sendMpdCommand status took 518 milliseconds
May 05 13:28:43 volumio volumio[854]: info: sendMpdCommand status took 526 milliseconds
May 05 13:28:43 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:44 volumio volumio[854]: info: Command Router : Notfying DB Updatefalse
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::Close All Modals sent
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 13:28:44 volumio volumio[854]: info: Setting Geolocation for MyVolumio to eu5
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:44 volumio volumio[854]: Cannot compose Albumart path
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand status took 1855 milliseconds
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand status took 1854 milliseconds
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand status took 1854 milliseconds
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:44 volumio volumio[854]: info: Command Router : Notfying DB Updatefalse
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::Close All Modals sent
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 13:28:44 volumio volumio[854]: Cannot compose Albumart path
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand status took 2139 milliseconds
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand status took 2138 milliseconds
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand status took 2137 milliseconds
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand playlistinfo took 656 milliseconds
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand playlistinfo took 656 milliseconds
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand playlistinfo took 256 milliseconds
May 05 13:28:44 volumio volumio[854]: info: sendMpdCommand playlistinfo took 257 milliseconds
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:44 volumio volumio[854]: info: Command Router : Notfying DB Updatefalse
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::Close All Modals sent
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseState
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseTrackInfo
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseTrackInfo
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseTrackInfo
May 05 13:28:44 volumio volumio[854]: verbose: ControllerMpd::parseTrackInfo
May 05 13:28:44 volumio volumio[854]: info: ControllerMpd::pushState
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:28:44 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:44 volumio volumio[854]: verbose: STATE SERVICE {"status":"play","position":0,"seek":33349,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Lucio Dalla - Angeli (Studio Version)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
May 05 13:28:44 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:28:44 volumio volumio[854]: info: CoreStateMachine::syncState stateService play
May 05 13:28:44 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus play
May 05 13:28:44 volumio volumio[854]: info: Received an update from plugin. extracting info from payload
May 05 13:28:44 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:44 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:44 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:44 volumio volumio[854]: info: ControllerMpd::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:28:45 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:45 volumio volumio[854]: verbose: STATE SERVICE {"status":"play","position":0,"seek":33349,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Lucio Dalla - Angeli (Studio Version)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
May 05 13:28:45 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState stateService play
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus play
May 05 13:28:45 volumio volumio[854]: info: Received an update from plugin. extracting info from payload
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: ControllerMpd::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:28:45 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:45 volumio volumio[854]: verbose: STATE SERVICE {"status":"play","position":0,"seek":33475,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Lucio Dalla - Angeli (Studio Version)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
May 05 13:28:45 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState stateService play
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus play
May 05 13:28:45 volumio volumio[854]: info: Received an update from plugin. extracting info from payload
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: ControllerMpd::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:28:45 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:45 volumio volumio[854]: verbose: STATE SERVICE {"status":"play","position":0,"seek":33475,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Lucio Dalla - Angeli (Studio Version)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
May 05 13:28:45 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState stateService play
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus play
May 05 13:28:45 volumio volumio[854]: info: Received an update from plugin. extracting info from payload
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: ------------------------------ 2307ms
May 05 13:28:45 volumio volumio[854]: info: ------------------------------ 2307ms
May 05 13:28:45 volumio volumio[854]: info: ------------------------------ 2302ms
May 05 13:28:45 volumio volumio[854]: info: ------------------------------ 2302ms
May 05 13:28:45 volumio volumio[854]: info: sendMpdCommand playlistinfo took 128 milliseconds
May 05 13:28:45 volumio volumio[854]: info: sendMpdCommand playlistinfo took 129 milliseconds
May 05 13:28:45 volumio volumio[854]: verbose: ControllerMpd::parseTrackInfo
May 05 13:28:45 volumio volumio[854]: verbose: ControllerMpd::parseTrackInfo
May 05 13:28:45 volumio volumio[854]: info: ControllerMpd::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:28:45 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:45 volumio volumio[854]: verbose: STATE SERVICE {"status":"play","position":0,"seek":33475,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Lucio Dalla - Angeli (Studio Version)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
May 05 13:28:45 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState stateService play
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus play
May 05 13:28:45 volumio volumio[854]: info: Received an update from plugin. extracting info from payload
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: ControllerMpd::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:28:45 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:28:45 volumio volumio[854]: verbose: STATE SERVICE {"status":"play","position":0,"seek":33475,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Lucio Dalla - Angeli (Studio Version)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
May 05 13:28:45 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState stateService play
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus play
May 05 13:28:45 volumio volumio[854]: info: Received an update from plugin. extracting info from payload
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:28:45 volumio volumio[854]: info: ------------------------------ 2352ms
May 05 13:28:45 volumio volumio[854]: info: ------------------------------ 2352ms
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:28:45 volumio volumio[854]: info: Updating MyVolumio device info
May 05 13:28:45 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 13:28:45 volumio volumio[854]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
May 05 13:28:45 volumio volumio[854]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Lowshelf
May 05 13:28:46 volumio volumio[854]: freq: 185
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq2:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Peaking
May 05 13:28:46 volumio volumio[854]: freq: 1300
May 05 13:28:46 volumio volumio[854]: q: 0.4
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: eq3:
May 05 13:28:46 volumio volumio[854]: type: Biquad
May 05 13:28:46 volumio volumio[854]: parameters:
May 05 13:28:46 volumio volumio[854]: type: Highshelf
May 05 13:28:46 volumio volumio[854]: freq: 5500
May 05 13:28:46 volumio volumio[854]: q: 0.82
May 05 13:28:46 volumio volumio[854]: gain: 0
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:46 volumio volumio[854]: info: FusionDsp - {"Reload":{"result":"Ok"}}
May 05 13:28:53 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 05 13:28:53 volumio volumio[854]: info: CURURI: music-library/USB
May 05 13:28:54 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 05 13:28:54 volumio volumio[854]: info: CURURI: music-library/USB/KINGSTON
May 05 13:29:51 volumio volumio[854]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 05 13:29:51 volumio volumio[854]: info: CoreStateMachine::ClearQueue
May 05 13:29:51 volumio volumio[854]: info: CoreStateMachine::stop
May 05 13:29:51 volumio volumio[854]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 13:29:51 volumio volumio[854]: info: CoreStateMachine::stPlaybackTimer
May 05 13:29:51 volumio volumio[854]: info: CoreStateMachine::updateTrackBlock
May 05 13:29:51 volumio volumio[854]: info: CorePlayQueue::getTrackBlock
May 05 13:29:51 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:29:51 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:29:51 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:29:51 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:29:51 volumio volumio[854]: info: CoreStateMachine::serviceStop
May 05 13:29:51 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:29:51 volumio volumio[854]: info: CoreCommandRouter::serviceStop
May 05 13:29:51 volumio volumio[854]: info: ControllerMpd::stop
May 05 13:29:51 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand stop
May 05 13:29:51 volumio volumio[854]: info: CorePlayQueue::clearPlayQueue
May 05 13:29:51 volumio volumio[854]: info: CorePlayQueue::saveQueue
May 05 13:29:51 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:29:51 volumio volumio[854]: info: CoreCommandRouter::volumioPushQueue
May 05 13:29:51 volumio volumio[854]: info: CoreStateMachine::addQueueItems
May 05 13:29:51 volumio volumio[854]: info: CorePlayQueue::addQueueItems
May 05 13:29:51 volumio volumio[854]: info: Adding Item to queue: music-library/USB/KINGSTON/Lilith - Romantic Soul_1080p.mp4
May 05 13:29:51 volumio volumio[854]: info: Exploding uri music-library/USB/KINGSTON/Lilith - Romantic Soul_1080p.mp4 in service mpd
May 05 13:29:51 volumio volumio[854]: info: Adding Item to queue: music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 FINAŁ TOPU BUDKA ŁUKAWSKI STELKA NIEDŹWIECKI 03.05.2024.mp3
May 05 13:29:51 volumio volumio[854]: info: Exploding uri music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 FINAŁ TOPU BUDKA ŁUKAWSKI STELKA NIEDŹWIECKI 03.05.2024.mp3 in service mpd
May 05 13:29:51 volumio volumio[854]: info: Adding Item to queue: music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 MARCIN ŁUKAWSKI (12-15) 03.05.2024.mp3
May 05 13:29:51 volumio volumio[854]: info: Exploding uri music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 MARCIN ŁUKAWSKI (12-15) 03.05.2024.mp3 in service mpd
May 05 13:29:51 volumio volumio[854]: info: Adding Item to queue: music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 MAREK NIEDŹWIECKI (9-12) 03.05.2024.mp3
May 05 13:29:51 volumio volumio[854]: info: Exploding uri music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 MAREK NIEDŹWIECKI (9-12) 03.05.2024.mp3 in service mpd
May 05 13:29:51 volumio volumio[854]: info: Adding Item to queue: music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 OLA BUDKA (15-18) 03.05.2024.mp3
May 05 13:29:51 volumio volumio[854]: info: Exploding uri music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 OLA BUDKA (15-18) 03.05.2024.mp3 in service mpd
May 05 13:29:51 volumio volumio[854]: info: Adding Item to queue: music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 PIOTR STELMACH (18-20) 03.05.2024.mp3
May 05 13:29:51 volumio volumio[854]: info: Exploding uri music-library/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 PIOTR STELMACH (18-20) 03.05.2024.mp3 in service mpd
May 05 13:29:51 volumio volumio[854]: info: Adding Item to queue: music-library/USB/KINGSTON/KFMPURCHASE
May 05 13:29:51 volumio volumio[854]: info: Exploding uri music-library/USB/KINGSTON/KFMPURCHASE in service mpd
May 05 13:29:51 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:29:51 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:29:52 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:29:52 volumio volumio[854]: type: Biquad
May 05 13:29:52 volumio volumio[854]: parameters:
May 05 13:29:52 volumio volumio[854]: type: Lowshelf
May 05 13:29:52 volumio volumio[854]: freq: 185
May 05 13:29:52 volumio volumio[854]: q: 0.82
May 05 13:29:52 volumio volumio[854]: gain: 0
May 05 13:29:52 volumio volumio[854]: eq2:
May 05 13:29:52 volumio volumio[854]: type: Biquad
May 05 13:29:52 volumio volumio[854]: parameters:
May 05 13:29:52 volumio volumio[854]: type: Peaking
May 05 13:29:52 volumio volumio[854]: freq: 1300
May 05 13:29:52 volumio volumio[854]: q: 0.4
May 05 13:29:52 volumio volumio[854]: gain: 0
May 05 13:29:52 volumio volumio[854]: eq3:
May 05 13:29:52 volumio volumio[854]: type: Biquad
May 05 13:29:52 volumio volumio[854]: parameters:
May 05 13:29:52 volumio volumio[854]: type: Highshelf
May 05 13:29:52 volumio volumio[854]: freq: 5500
May 05 13:29:52 volumio volumio[854]: q: 0.82
May 05 13:29:52 volumio volumio[854]: gain: 0
May 05 13:29:52 volumio volumio[854]: info: FusionDsp - eq1:
May 05 13:29:52 volumio volumio[854]: type: Biquad
May 05 13:29:52 volumio volumio[854]: parameters:
May 05 13:29:52 volumio volumio[854]: type: Lowshelf
May 05 13:29:52 volumio volumio[854]: freq: 185
May 05 13:29:52 volumio volumio[854]: q: 0.82
May 05 13:29:52 volumio volumio[854]: gain: 0
May 05 13:29:52 volumio volumio[854]: eq2:
May 05 13:29:52 volumio volumio[854]: type: Biquad
May 05 13:29:52 volumio volumio[854]: parameters:
May 05 13:29:52 volumio volumio[854]: type: Peaking
May 05 13:29:52 volumio volumio[854]: freq: 1300
May 05 13:29:52 volumio volumio[854]: q: 0.4
May 05 13:29:52 volumio volumio[854]: gain: 0
May 05 13:29:52 volumio volumio[854]: eq3:
May 05 13:29:52 volumio volumio[854]: type: Biquad
May 05 13:29:52 volumio volumio[854]: parameters:
May 05 13:29:52 volumio volumio[854]: type: Highshelf
May 05 13:29:52 volumio volumio[854]: freq: 5500
May 05 13:29:52 volumio volumio[854]: q: 0.82
May 05 13:29:52 volumio volumio[854]: gain: 0
May 05 13:29:52 volumio volumio[854]: error: FusionDsp - WebSocket error: [object Object]
May 05 13:29:52 volumio volumio[854]: error: FusionDsp - WebSocket error: [object Object]
May 05 13:29:52 volumio volumio[854]: info: sendMpdCommand stop took 1232 milliseconds
May 05 13:29:52 volumio volumio[854]: info: CoreCommandRouter::servicePushState
May 05 13:29:52 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:29:52 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:29:52 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:29:52 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:29:52 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:29:52 volumio volumio[854]: verbose: STATE SERVICE {"status":"stop"}
May 05 13:29:52 volumio volumio[854]: verbose: CURRENT POSITION 0
May 05 13:29:52 volumio volumio[854]: info: CoreStateMachine::syncState stateService stop
May 05 13:29:52 volumio volumio[854]: info: CoreStateMachine::syncState currentStatus stop
May 05 13:29:52 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:29:52 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:29:52 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 13:29:52 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:29:52 volumio volumio[854]: info: No code
May 05 13:29:52 volumio volumio[854]: info: CoreStateMachine::pushState
May 05 13:29:52 volumio volumio[854]: info: CorePlayQueue::getTrack 0
May 05 13:29:52 volumio volumio[854]: info: CoreCommandRouter::volumioPushState
May 05 13:29:52 volumio volumio[854]: info:
May 05 13:29:52 volumio volumio[854]: ---------------------------- MPD announces state update: player
May 05 13:29:52 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:29:52 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:29:52 volumio volumio[854]: info:
May 05 13:29:52 volumio volumio[854]: ---------------------------- MPD announces state update: player
May 05 13:29:52 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:29:52 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:29:52 volumio volumio[854]: info:
May 05 13:29:52 volumio volumio[854]: ---------------------------- MPD announces state update: player
May 05 13:29:52 volumio volumio[854]: info: ALBUMART /albumart?cacheid=330&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLilith%20-%20Romantic%20Soul_1080p.mp4&metadata=false
May 05 13:29:52 volumio volumio[854]: info: URI /mnt/USB/KINGSTON/Lilith - Romantic Soul_1080p.mp4
May 05 13:29:52 volumio volumio[854]: info: ALBUMART /albumart?cacheid=330&web=RADIO%20357//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FRADIO%20357%20IV%20POLSKI%20TOP%20RADIA%20357%20FINA%C5%81%20TOPU%20BUDKA%20%C5%81UKAWSKI%20STELKA%20NIED%C5%B9WIECKI%2003.05.2024.mp3&metadata=false
May 05 13:29:52 volumio volumio[854]: info: URI /mnt/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 FINAŁ TOPU BUDKA ŁUKAWSKI STELKA NIEDŹWIECKI 03.05.2024.mp3
May 05 13:29:52 volumio volumio[854]: info: ALBUMART /albumart?cacheid=330&web=RADIO%20357//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FRADIO%20357%20IV%20POLSKI%20TOP%20RADIA%20357%20MARCIN%20%C5%81UKAWSKI%20(12-15)%2003.05.2024.mp3&metadata=false
May 05 13:29:52 volumio volumio[854]: info: URI /mnt/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 MARCIN ŁUKAWSKI (12-15) 03.05.2024.mp3
May 05 13:29:52 volumio volumio[854]: info: ALBUMART /albumart?cacheid=330&web=RADIO%20357//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FRADIO%20357%20IV%20POLSKI%20TOP%20RADIA%20357%20MAREK%20NIED%C5%B9WIECKI%20(9-12)%2003.05.2024.mp3&metadata=false
May 05 13:29:52 volumio volumio[854]: info: URI /mnt/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 MAREK NIEDŹWIECKI (9-12) 03.05.2024.mp3
May 05 13:29:52 volumio volumio[854]: info: ALBUMART /albumart?cacheid=330&web=RADIO%20357//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FRADIO%20357%20IV%20POLSKI%20TOP%20RADIA%20357%20OLA%20BUDKA%20(15-18)%2003.05.2024.mp3&metadata=false
May 05 13:29:52 volumio volumio[854]: info: URI /mnt/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 OLA BUDKA (15-18) 03.05.2024.mp3
May 05 13:29:52 volumio volumio[854]: info: ALBUMART /albumart?cacheid=330&web=RADIO%20357//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FRADIO%20357%20IV%20POLSKI%20TOP%20RADIA%20357%20PIOTR%20STELMACH%20(18-20)%2003.05.2024.mp3&metadata=false
May 05 13:29:52 volumio volumio[854]: info: URI /mnt/USB/KINGSTON/RADIO 357 IV POLSKI TOP RADIA 357 PIOTR STELMACH (18-20) 03.05.2024.mp3
May 05 13:29:52 volumio volumio[854]: info: ControllerMpd::getState
May 05 13:29:52 volumio volumio[854]: verbose: ControllerMpd::sendMpdCommand status
May 05 13:29:52 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:29:52 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:29:52 volumio volumio[854]: info: FusionDsp - If filter freq >samplerate/2 then disable it
May 05 13:29:52 volumio volumio[854]: info: ALBUMART /albumart?cacheid=330&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FKFMPURCHASE%2FBackup%20Set%202020-10-22%20191404%2FBackup%20Files%202020-10-22%20191404%2FBackup%20files%209.zip&metadata=false
May 05 13:29:52 volumio volumio[854]: info: URI /mnt/USB/KINGSTON/KFMPURCHASE/Backup Set 2020-10-22 191404/Backup Files 2020-10-22 191404/Backup files 9.zip
May 05 13:29:52 volumio volumio[854]: info: ALBUMART /albumart?cacheid=330&web=Bob%20Acri/Bob%20Acri/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FKFMPURCHASE%2FBackup%20Set%202020-10-22%20191404%2FBackup%20Files%202020-10-22%20191404%2FBackup%20files%209.zip&metadata=false
May 05 13:29:52 volumio volumio[854]: info: URI /mnt/USB/KINGSTON/KFMPURCHASE/Backup Set 2020-10-22 191404/Backup Files 2020-10-22 191404/Backup files 9.zip
May 05 13:29:52 volumio volumio[854]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 05 13:29:52 volumio volumio[854]: Error: Unable to resolve or reject the same promise twice
May 05 13:29:52 volumio volumio[854]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
May 05 13:29:52 volumio volumio[854]: at /volumio/app/plugins/music_service/mpd/index.js:2541:21
May 05 13:29:52 volumio volumio[854]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
May 05 13:29:52 volumio volumio[854]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
May 05 13:29:52 volumio volumio[854]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
May 05 13:29:52 volumio volumio[854]: at Socket.emit (events.js:315:20)
May 05 13:29:52 volumio volumio[854]: at addChunk (internal/streams/readable.js:309:12)
May 05 13:29:52 volumio volumio[854]: at readableAddChunk (internal/streams/readable.js:280:11)
May 05 13:29:52 volumio volumio[854]: at Socket.Readable.push (internal/streams/readable.js:223:10)
May 05 13:29:52 volumio volumio[854]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23)
May 05 13:29:52 volumio volumio[854]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 05 13:29:53 volumio sudo[1621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-05 13:28
May 05 13:29:53 volumio sudo[1621]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939"
VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463"
VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7"
VOLUMIO_BE_VERSION="85acf7bbbceb3e3dec447156a39a88033f921210"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 30 Sep 2022 10:43:40 AM CEST"
VOLUMIO_VERSION="3.378"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4bc817297375b72097a1fade15c6518b"