Volumio2 and brutefir...

Discuss, contribute and orient Volumio development!

Ads helps Volumio remain Free and Open Source. Please consider donating to help us continue to serve you.

Volumio2 and brutefir...

Postby r.kfr » Mon Oct 16 2017 09:21

Then I start playing via airplay (but no sound):

Code: Select all
Oct 16 09:20:37 volumio volumio[16080]: info: CoreCommandRouter::volumioStop
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637216] CoreStateMachine::stop
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637217] CoreStateMachine::setConsumeUpdateService undefined
Oct 16 09:20:37 volumio volumio[16080]: UNSET VOLATILE
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637218] CoreStateMachine::setConsumeUpdateService undefined
Oct 16 09:20:37 volumio volumio[16080]: info: Airplay started streaming
Oct 16 09:20:37 volumio volumio[16080]: info: CoreCommandRouter::servicePushState
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637300] CoreStateMachine::syncState
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637301] CoreStateMachine::pushState
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637302] CoreStateMachine::getState
Oct 16 09:20:37 volumio volumio[16080]: info: CoreCommandRouter::volumioPushState
Oct 16 09:20:37 volumio volumio[16080]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637308] interfaceApi::pushState
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637310] InterfaceWebUI::pushState
Oct 16 09:20:37 volumio volumio[16080]: info: CoreCommandRouter::servicePushState
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637361] CoreStateMachine::syncState
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637362] CoreStateMachine::pushState
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637363] CoreStateMachine::getState
Oct 16 09:20:37 volumio volumio[16080]: info: CoreCommandRouter::volumioPushState
Oct 16 09:20:37 volumio volumio[16080]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637376] interfaceApi::pushState
Oct 16 09:20:37 volumio volumio[16080]: info: [1508145637384] InterfaceWebUI::pushState
Oct 16 09:20:37 volumio volumio[16080]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false}
Oct 16 09:20:37 volumio volumio[16080]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false}
Random avatar
r.kfr
Sunday DIYer
Sunday DIYer
 
Posts: 13
Joined: Fri Oct 13 2017 19:23

Ads helps Volumio remain Free and Open Source. Please consider donating to help us continue to serve you.


Volumio2 and brutefir...

Postby balbuze » Mon Oct 16 2017 16:53

I see brutefir is running... But you don't have to select the output....
The correct way :
disable the plugin
set the correct output in volumio and reboot
test with a track
enable the plugin
that't it ! never change by hand the output, the volume mixer etc...
If brutefir fails to start, go in advanced of the plugin and play with output value... Number of partition ( often>8) but it is harware dependent, I can't determine it automatically...
have a look in your ssh console, it gives good info about what happens...
User avatar
balbuze
Moderator
 
Posts: 1228
Joined: Thu May 08 2014 08:42
Location: Isère France


Volumio2 and brutefir...

Postby r.kfr » Tue Oct 17 2017 09:08

Somehow inconsistent. When I start the brute fir plugin now, I get:
Code: Select all
Oct 17 09:07:06 volumio volumio[2030]: info: Enabling plugin brutefir
Oct 17 09:07:06 volumio volumio[2030]: info: Loading plugin "brutefir"...
Oct 17 09:07:06 volumio volumio[2030]: info: Applying required configuration parameters for plugin brutefir
Oct 17 09:07:06 volumio volumio[2030]: info: PLUGIN START: brutefir
Oct 17 09:07:06 volumio sudo[2190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start brutefir.service
Oct 17 09:07:06 volumio sudo[2190]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 17 09:07:06 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:07:06 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:07:06 volumio sudo[2190]: pam_unix(sudo:session): session closed for user root
Oct 17 09:07:06 volumio volumio[2195]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:07:06 volumio volumio[2030]: info: Brutefir Daemon Started
Oct 17 09:07:06 volumio volumio[2195]: Internal resolution is 64 bit floating point.
Oct 17 09:07:06 volumio volumio[2195]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:07:06 volumio volumio[2195]: Loading 4 coefficient sets...finished.
Oct 17 09:07:06 volumio volumio[2195]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:07:06 volumio volumio[2195]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:07:06 volumio volumio[2195]: Timers for benchmarking may be unreliable.
Oct 17 09:07:06 volumio volumio[2195]: Filters in process 0: 0 2
Oct 17 09:07:06 volumio volumio[2195]: Filters in process 1: 1 3
Oct 17 09:07:06 volumio volumio[2195]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:07:06 volumio volumio[2195]: Failed to init output device.
Oct 17 09:07:06 volumio volumio[2195]: Failed to initialise digital audio interfaces.
Oct 17 09:07:06 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:07:06 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:07:07 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:07:07 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:07:07 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:07:07 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:07:07 volumio volumio[2201]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:07:07 volumio volumio[2201]: Internal resolution is 64 bit floating point.
Oct 17 09:07:07 volumio volumio[2201]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:07:07 volumio volumio[2201]: Loading 4 coefficient sets...finished.
Oct 17 09:07:07 volumio volumio[2201]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:07:07 volumio volumio[2201]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:07:07 volumio volumio[2201]: Timers for benchmarking may be unreliable.
Oct 17 09:07:07 volumio volumio[2201]: Filters in process 0: 0 2
Oct 17 09:07:07 volumio volumio[2201]: Filters in process 1: 1 3
Oct 17 09:07:07 volumio volumio[2201]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:07:07 volumio volumio[2201]: Failed to init output device.
Oct 17 09:07:07 volumio volumio[2201]: Failed to initialise digital audio interfaces.
Oct 17 09:07:07 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:07:07 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:07:07 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:07:07 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:07:07 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:07:07 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:07:07 volumio volumio[2205]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:07:07 volumio volumio[2205]: Internal resolution is 64 bit floating point.
Oct 17 09:07:07 volumio volumio[2205]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:07:07 volumio volumio[2205]: Loading 4 coefficient sets...finished.
Oct 17 09:07:07 volumio volumio[2030]: info: Connecting to daemon brutefir
Oct 17 09:07:07 volumio volumio[2205]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:07:07 volumio volumio[2030]: events.js:160
Oct 17 09:07:07 volumio volumio[2030]: throw er; // Unhandled 'error' event
Oct 17 09:07:07 volumio volumio[2030]: ^
Oct 17 09:07:07 volumio volumio[2030]: Error: connect ECONNREFUSED 127.0.0.1:3002
Oct 17 09:07:07 volumio volumio[2030]: at Object.exports._errnoException (util.js:1018:11)
Oct 17 09:07:07 volumio volumio[2030]: at exports._exceptionWithHostPort (util.js:1041:20)
Oct 17 09:07:07 volumio volumio[2030]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1086:14)
Oct 17 09:07:07 volumio volumio-remote-updater[648]: [2017-10-17 09:07:07] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Oct 17 09:07:07 volumio volumio-remote-updater[648]: [2017-10-17 09:07:07] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Oct 17 09:07:07 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:07:07 volumio systemd[1]: Unit volumio.service entered failed state.
Oct 17 09:07:07 volumio systemd[1]: Starting dynamicswap.service...
Oct 17 09:07:07 volumio systemd[1]: Started dynamicswap.service.
Oct 17 09:07:07 volumio volumio[2205]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:07:07 volumio volumio[2205]: Timers for benchmarking may be unreliable.
Oct 17 09:07:07 volumio volumio[2205]: Filters in process 0: 0 2
Oct 17 09:07:07 volumio volumio[2205]: Filters in process 1: 1 3
Oct 17 09:07:07 volumio volumio[2205]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:07:07 volumio volumio[2205]: Failed to init output device.
Oct 17 09:07:07 volumio volumio[2205]: Failed to initialise digital audio interfaces.
Oct 17 09:07:07 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:07:07 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:07:07 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Oct 17 09:07:07 volumio systemd[1]: Starting dynamicswap.service...
Oct 17 09:07:07 volumio systemd[1]: Started dynamicswap.service.
Oct 17 09:07:07 volumio systemd[1]: Stopping Volumio Backend Module...
Oct 17 09:07:07 volumio systemd[1]: Starting Volumio Backend Module...
Oct 17 09:07:07 volumio systemd[1]: Started Volumio Backend Module.
Oct 17 09:07:08 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:07:08 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:07:08 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:07:08 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:07:08 volumio volumio[2233]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:07:08 volumio volumio[2233]: Internal resolution is 64 bit floating point.
Oct 17 09:07:08 volumio volumio[2233]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:07:08 volumio volumio[2233]: Loading 4 coefficient sets...finished.
Oct 17 09:07:08 volumio volumio[2233]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:07:08 volumio volumio[2233]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:07:08 volumio volumio[2233]: Timers for benchmarking may be unreliable.
Oct 17 09:07:08 volumio volumio[2233]: Filters in process 0: 0 2
Oct 17 09:07:08 volumio volumio[2233]: Filters in process 1: 1 3
Oct 17 09:07:08 volumio volumio[2233]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:07:08 volumio volumio[2233]: Failed to init output device.
Oct 17 09:07:08 volumio volumio[2233]: Failed to initialise digital audio interfaces.
Oct 17 09:07:08 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:07:08 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:07:08 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:07:08 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:07:08 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:07:08 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:07:08 volumio volumio[2236]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:07:08 volumio volumio[2236]: Internal resolution is 64 bit floating point.
Oct 17 09:07:08 volumio volumio[2236]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:07:08 volumio volumio[2236]: Loading 4 coefficient sets...finished.
Oct 17 09:07:08 volumio volumio[2236]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:07:08 volumio volumio[2236]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:07:08 volumio volumio[2236]: Timers for benchmarking may be unreliable.
Oct 17 09:07:08 volumio volumio[2236]: Filters in process 0: 0 2
Oct 17 09:07:08 volumio volumio[2236]: Filters in process 1: 1 3
Oct 17 09:07:08 volumio volumio[2236]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:07:08 volumio volumio[2236]: Failed to init output device.
Oct 17 09:07:08 volumio volumio[2236]: Failed to initialise digital audio interfaces.
Oct 17 09:07:08 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:07:08 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:07:09 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:07:09 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:07:09 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:07:09 volumio systemd[1]: brutefir.service start request repeated too quickly, refusing to start.
Oct 17 09:07:09 volumio systemd[1]: Failed to start brutefir Daemon.
Oct 17 09:07:09 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:07:11 volumio volumio[2219]: info: -------------------------------------------
Oct 17 09:07:11 volumio volumio[2219]: info: -----            Volumio2              ----
Oct 17 09:07:11 volumio volumio[2219]: info: -------------------------------------------
Oct 17 09:07:11 volumio volumio[2219]: info: -----          System startup          ----
Oct 17 09:07:11 volumio volumio[2219]: info: -------------------------------------------
Oct 17 09:07:11 volumio volumio[2219]: info: Plugin folders cleanup
Oct 17 09:07:11 volumio volumio[2219]: info: Scanning into folder /volumio/app/plugins/
Oct 17 09:07:11 volumio volumio[2219]: info: Scanning category audio_interface
Oct 17 09:07:11 volumio volumio[2219]: info: Scanning category miscellanea
Oct 17 09:07:11 volumio volumio[2219]: info: Scanning category music_service
Oct 17 09:07:11 volumio volumio[2219]: info: Scanning category plugins.json
Oct 17 09:07:11 volumio volumio[2219]: info: Scanning category system_controller
Oct 17 09:07:11 volumio volumio[2219]: info: Scanning category user_interface
Oct 17 09:07:11 volumio volumio[2219]: info: Scanning into folder /data/plugins/
Oct 17 09:07:11 volumio volumio[2219]: info: Scanning category miscellanea
Oct 17 09:07:11 volumio volumio[2219]: info: Plugin folders cleanup completed
Oct 17 09:07:11 volumio volumio[2219]: info: Loading plugins from folder /volumio/app/plugins/
Oct 17 09:07:11 volumio volumio[2219]: info: Loading plugins from folder /data/plugins/
Oct 17 09:07:11 volumio volumio[2219]: info: Loading plugin "system"...
Oct 17 09:07:12 volumio volumio[2219]: info: Loading plugin "appearance"...
Oct 17 09:07:12 volumio volumio-remote-updater[648]: [2017-10-17 09:07:12] [connect] Successful connection
Oct 17 09:07:13 volumio volumio[2219]: info: Loading plugin "network"...
Oct 17 09:07:13 volumio volumio[2219]: info: Loading plugin "services"...
Oct 17 09:07:13 volumio volumio[2219]: info: Loading plugin "alsa_controller"...
Oct 17 09:07:13 volumio volumio[2219]: info: Loading plugin "wizard"...
Oct 17 09:07:13 volumio volumio[2219]: info: Loading plugin "volumio_command_line_client"...
Oct 17 09:07:13 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:13 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:13 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:13 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:13 volumio volumio[2219]: info: Loading plugin "upnp"...
Oct 17 09:07:13 volumio volumio[2219]: info: [1508231233612] Starting Upmpd Daemon
Oct 17 09:07:13 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 17 09:07:13 volumio volumio[2219]: info: Loading plugin "mpd"...
Oct 17 09:07:13 volumio volumio[2219]: info: Plugin upnp_browser is not enabled
Oct 17 09:07:13 volumio volumio[2219]: info: Loading plugin "networkfs"...
Oct 17 09:07:13 volumio volumio[2219]: info: Loading plugin "alarm-clock"...
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "airplay_emulation"...
Oct 17 09:07:14 volumio volumio[2219]: info: [1508231234073] Starting Shairport Sync
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "last_100"...
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "webradio"...
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "i2s_dacs"...
Oct 17 09:07:14 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "my_volumio"...
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "volumiodiscovery"...
Oct 17 09:07:14 volumio volumio[2219]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 17 09:07:14 volumio node[2219]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 17 09:07:14 volumio node[2219]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 17 09:07:14 volumio node[2219]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node>
Oct 17 09:07:14 volumio node[2219]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 17 09:07:14 volumio node[2219]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 17 09:07:14 volumio node[2219]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister>
Oct 17 09:07:14 volumio volumio[2219]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 17 09:07:14 volumio volumio[2219]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node>
Oct 17 09:07:14 volumio volumio[2219]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 17 09:07:14 volumio volumio[2219]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 17 09:07:14 volumio volumio[2219]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister>
Oct 17 09:07:14 volumio volumio[2219]: info: Applying required configuration parameters for plugin volumiodiscovery
Oct 17 09:07:14 volumio volumio[2219]: Discovery: StartAdv! undefined
Oct 17 09:07:14 volumio volumio[2219]: Discovery: Started advertising... Volumio - undefined
Oct 17 09:07:14 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "albumart"...
Oct 17 09:07:14 volumio volumio[2219]: info: Plugin example_plugin is not enabled
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "updater_comm"...
Oct 17 09:07:14 volumio volumio[2219]: info: Plugin mpdemulation is not enabled
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "rest_api"...
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "websocket"...
Oct 17 09:07:14 volumio volumio[2219]: info: Loading plugin "brutefir"...
Oct 17 09:07:15 volumio volumio[2219]: info: Applying required configuration parameters for plugin brutefir
Oct 17 09:07:15 volumio volumio[2219]: info: ___________ START PLUGINS ___________
Oct 17 09:07:15 volumio volumio[2219]: info: PLUGIN START: appearance
Oct 17 09:07:15 volumio volumio[2219]: info: PLUGIN START: wizard
Oct 17 09:07:15 volumio volumio[2219]: info: PLUGIN START: last_100
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 17 09:07:15 volumio volumio[2219]: info: [1508231235625] CoreMusicLibrary::Adding element Last_100
Oct 17 09:07:15 volumio volumio[2219]: info: PLUGIN START: webradio
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 17 09:07:15 volumio volumio[2219]: info: [1508231235640] CoreMusicLibrary::Adding element Webradio
Oct 17 09:07:15 volumio volumio[2219]: info: PLUGIN START: my_volumio
Oct 17 09:07:15 volumio volumio[2219]: info: PLUGIN START: brutefir
Oct 17 09:07:15 volumio volumio[2219]: info: Loading i18n strings for locale de
Oct 17 09:07:15 volumio volumio[2219]: Updating browse sources language
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::initPlayerControls
Oct 17 09:07:15 volumio sudo[2282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start brutefir.service
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Oct 17 09:07:15 volumio sudo[2282]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 17 09:07:15 volumio volumio[2219]: info: BOOT COMPLETED
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 17 09:07:15 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:07:15 volumio systemd[1]: brutefir.service start request repeated too quickly, refusing to start.
Oct 17 09:07:15 volumio systemd[1]: Failed to start brutefir Daemon.
Oct 17 09:07:15 volumio sudo[2282]: pam_unix(sudo:session): session closed for user root
Oct 17 09:07:15 volumio volumio[2219]: Express server listening on port 3000
Oct 17 09:07:15 volumio volumio[2219]: Volumio Calling Home
Oct 17 09:07:15 volumio volumio[2219]: info: [1508231235873] CoreStateMachine::resetVolumioState
Oct 17 09:07:15 volumio volumio[2219]: info: [1508231235875] CoreStateMachine::getcurrentVolume
Oct 17 09:07:15 volumio volumio[2219]: info: CoreCommandRouter::volumioRetrievevolume
Oct 17 09:07:15 volumio volumio[2219]: info: [1508231235896] CoreStateMachine::updateTrackBlock
Oct 17 09:07:15 volumio volumio[2219]: info: [1508231235898] CorePlayQueue::getTrackBlock
Oct 17 09:07:16 volumio volumio[2219]: { Error: Command failed: /usr/bin/aplay --device=plughw:2,0 /volumio/app/startup.wav
Oct 17 09:07:16 volumio volumio[2219]: aplay: main:722: audio open error: Device or resource busy
Oct 17 09:07:16 volumio volumio[2219]: at ChildProcess.exithandler (child_process.js:204:12)
Oct 17 09:07:16 volumio volumio[2219]: at emitTwo (events.js:106:13)
Oct 17 09:07:16 volumio volumio[2219]: at ChildProcess.emit (events.js:191:7)
Oct 17 09:07:16 volumio volumio[2219]: at maybeClose (internal/child_process.js:891:16)
Oct 17 09:07:16 volumio volumio[2219]: at Socket.<anonymous> (internal/child_process.js:342:11)
Oct 17 09:07:16 volumio volumio[2219]: at emitOne (events.js:96:13)
Oct 17 09:07:16 volumio volumio[2219]: at Socket.emit (events.js:188:7)
Oct 17 09:07:16 volumio volumio[2219]: at Pipe._handle.close [as _onclose] (net.js:497:12)
Oct 17 09:07:16 volumio volumio[2219]: killed: false,
Oct 17 09:07:16 volumio volumio[2219]: code: 1,
Oct 17 09:07:16 volumio volumio[2219]: signal: null,
Oct 17 09:07:16 volumio volumio[2219]: cmd: '/usr/bin/aplay --device=plughw:2,0 /volumio/app/startup.wav' }
Oct 17 09:07:16 volumio volumio[2219]: info: brutefir failed to start. Check your configuration Error: Command failed: /usr/bin/sudo /bin/systemctl start brutefir.service
Oct 17 09:07:16 volumio volumio[2219]: Job for brutefir.service failed. See 'systemctl status brutefir.service' and 'journalctl -xn' for details.
Oct 17 09:07:16 volumio volumio[2219]: info: MPD running with PID685 ,establishing connection
Oct 17 09:07:16 volumio volumio[2219]: info: Setting Device type: Raspberry PI
Oct 17 09:07:16 volumio volumio-remote-updater[648]: [2017-10-17 09:07:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1508231232 101
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236364] VolumeController:: Volume=undefined Mute =undefined
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236368] CoreStateMachine::pushState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236371] CoreStateMachine::getState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236373] CorePlayQueue::getTrack 0
Oct 17 09:07:16 volumio volumio[2219]: info: CoreCommandRouter::volumioPushState
Oct 17 09:07:16 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236383] interfaceApi::pushState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236384] InterfaceWebUI::pushState
Oct 17 09:07:16 volumio volumio[2219]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false}
Oct 17 09:07:16 volumio volumio[2219]: info: Reloading queue from file
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236574] CoreStateMachine::setRepeat true single undefined
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236575] CoreStateMachine::pushState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236576] CoreStateMachine::getState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236577] CorePlayQueue::getTrack 0
Oct 17 09:07:16 volumio volumio[2219]: info: CoreCommandRouter::volumioPushState
Oct 17 09:07:16 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236586] interfaceApi::pushState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236587] InterfaceWebUI::pushState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236593] CoreStateMachine::setRandom null
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236595] CoreStateMachine::pushState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236596] CoreStateMachine::getState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236597] CorePlayQueue::getTrack 0
Oct 17 09:07:16 volumio volumio[2219]: info: CoreCommandRouter::volumioPushState
Oct 17 09:07:16 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236601] interfaceApi::pushState
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236602] InterfaceWebUI::pushState
Oct 17 09:07:16 volumio volumio[2219]: info: Volumio called home
Oct 17 09:07:16 volumio volumio[2219]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 17 09:07:16 volumio volumio[2219]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 17 09:07:16 volumio sudo[2302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay
Oct 17 09:07:16 volumio sudo[2302]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 17 09:07:16 volumio systemd[1]: Stopping ShairportSync AirTunes receiver...
Oct 17 09:07:16 volumio volumio[2219]: Discovery: adding be445d32-e7e9-4932-aa24-295087799530
Oct 17 09:07:16 volumio volumio[2219]: info: mDNS: Found device Volumio
Oct 17 09:07:16 volumio systemd[1]: Starting ShairportSync AirTunes receiver...
Oct 17 09:07:16 volumio systemd[1]: Started ShairportSync AirTunes receiver.
Oct 17 09:07:16 volumio sudo[2302]: pam_unix(sudo:session): session closed for user root
Oct 17 09:07:16 volumio shairport-sync[2308]: Successful Startup
Oct 17 09:07:16 volumio volumio[2219]: info: [1508231236853] Shairport-Sync Started
Oct 17 09:07:17 volumio volumio[2219]: info: CoreCommandRouter::volumioGetState
Oct 17 09:07:17 volumio volumio[2219]: info: [1508231237167] CoreStateMachine::getState
Oct 17 09:07:17 volumio volumio[2219]: info: [1508231237168] CorePlayQueue::getTrack 0
Oct 17 09:07:17 volumio volumio[2219]: info:
Oct 17 09:07:17 volumio volumio[2219]: [1508231237169] ---------------------------- Client requests Volumio state
Oct 17 09:07:17 volumio volumio[2219]: info: [1508231237172] InterfaceWebUI::pushState
Oct 17 09:07:17 volumio volumio[2219]: info: [1508231237192] ------------------------------ 27ms
Oct 17 09:07:17 volumio volumio[2219]: info:
Oct 17 09:07:17 volumio volumio[2219]: [1508231237203] ---------------------------- Client requests Menu Items
Oct 17 09:07:17 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 17 09:07:17 volumio volumio[2219]: Plugin multiroom or method getMultiroom not found
Oct 17 09:07:17 volumio volumio[2219]: info: [1508231237234] Listing playlists
Oct 17 09:07:17 volumio volumio[2219]: info: [1508231237379] ------------------------------ 176ms
Oct 17 09:07:18 volumio volumio[2219]: info: CoreCommandRouter::volumioGetState
Oct 17 09:07:18 volumio volumio[2219]: info: [1508231238941] CoreStateMachine::getState
Oct 17 09:07:18 volumio volumio[2219]: info: [1508231238942] CorePlayQueue::getTrack 0
Oct 17 09:07:18 volumio volumio[2219]: info:
Oct 17 09:07:18 volumio volumio[2219]: [1508231238943] ---------------------------- Client requests Volumio state
Oct 17 09:07:18 volumio volumio[2219]: info: [1508231238944] InterfaceWebUI::pushState
Oct 17 09:07:18 volumio volumio[2219]: info: [1508231238975] ------------------------------ 35ms
Oct 17 09:07:23 volumio sudo[2331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Oct 17 09:07:23 volumio sudo[2331]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 17 09:07:23 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Oct 17 09:07:23 volumio sudo[2331]: pam_unix(sudo:session): session closed for user root
Oct 17 09:07:23 volumio volumio[2219]: info: Upmpdcli Daemon Started
Random avatar
r.kfr
Sunday DIYer
Sunday DIYer
 
Posts: 13
Joined: Fri Oct 13 2017 19:23


Volumio2 and brutefir...

Postby r.kfr » Tue Oct 17 2017 09:12

The above was enabling the plugin "while playing music".

Without music, it looks like this:

Code: Select all
Oct 17 09:09:22 volumio volumio[2219]: info: Enabling plugin brutefir
Oct 17 09:09:22 volumio volumio[2219]: info: Loading plugin "brutefir"...
Oct 17 09:09:22 volumio volumio[2219]: info: Applying required configuration parameters for plugin brutefir
Oct 17 09:09:22 volumio volumio[2219]: info: PLUGIN START: brutefir
Oct 17 09:09:22 volumio sudo[2503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start brutefir.service
Oct 17 09:09:22 volumio sudo[2503]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 17 09:09:22 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:09:22 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:09:22 volumio sudo[2503]: pam_unix(sudo:session): session closed for user root
Oct 17 09:09:22 volumio volumio[2508]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:09:22 volumio volumio[2219]: info: Brutefir Daemon Started
Oct 17 09:09:22 volumio volumio[2508]: Internal resolution is 64 bit floating point.
Oct 17 09:09:22 volumio volumio[2508]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:09:22 volumio volumio[2508]: Loading 4 coefficient sets...finished.
Oct 17 09:09:22 volumio volumio[2508]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:09:22 volumio volumio[2508]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:09:22 volumio volumio[2508]: Timers for benchmarking may be unreliable.
Oct 17 09:09:22 volumio volumio[2508]: Filters in process 0: 0 2
Oct 17 09:09:22 volumio volumio[2508]: Filters in process 1: 1 3
Oct 17 09:09:22 volumio volumio[2508]: Warning: not allowed to set realtime priority. Will run with default priority
Oct 17 09:09:22 volumio volumio[2508]: instead, which is less reliable (underflow may occur).
Oct 17 09:09:23 volumio volumio[2508]: Creating inverse inplace FFTW plan of size 4096 using wisdom...finished
Oct 17 09:09:23 volumio volumio[2508]: Fixed I/O-delay is 2048 samples
Oct 17 09:09:23 volumio volumio[2508]: Audio processing starts now
Oct 17 09:09:23 volumio volumio[2219]: info: Connecting to daemon brutefir
Oct 17 09:09:23 volumio volumio[2219]: Connected to brutefir
Oct 17 09:09:23 volumio volumio[2219]: myeq or preset =true
Oct 17 09:09:23 volumio volumio[2219]: raw values are "0,0,0,0,0,0,0,0,0,0,0"
Oct 17 09:09:23 volumio volumio[2219]: splitted coef values are ["0","0","0","0","0","0","0","0","0","0","0"]
Oct 17 09:09:23 volumio volumio[2219]: cmd sent to brutefir = lmc eq 0 mag 31/0, 63/0, 125/0, 250/0, 500/0, 1000/0, 2000/0, 4000/0, 8000/0, 16000/0
Oct 17 09:09:23 volumio volumio[2219]: info: Done.
Oct 17 09:09:23 volumio volumio[2219]: Received:
Oct 17 09:09:23 volumio volumio[2219]: Welcome to BruteFIR, type "help" for help.
Oct 17 09:09:23 volumio volumio[2219]: >
Oct 17 09:09:25 volumio volumio[2508]: ALSA I/O: Could not read audio: Broken pipe.
Oct 17 09:09:25 volumio volumio[2508]: I/O module failed to read (probably) due to buffer underflow on output, aborting.
Oct 17 09:09:25 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=5/NOTINSSTALLED
Oct 17 09:09:25 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:09:25 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:09:25 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:09:25 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:09:25 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:09:25 volumio volumio[2523]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:09:25 volumio volumio[2523]: Internal resolution is 64 bit floating point.
Oct 17 09:09:25 volumio volumio[2523]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:09:25 volumio volumio[2523]: Loading 4 coefficient sets...finished.
Oct 17 09:09:25 volumio volumio[2523]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:09:25 volumio volumio[2523]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:09:25 volumio volumio[2523]: Timers for benchmarking may be unreliable.
Oct 17 09:09:25 volumio volumio[2523]: Filters in process 0: 0 2
Oct 17 09:09:25 volumio volumio[2523]: Filters in process 1: 1 3
Oct 17 09:09:25 volumio volumio[2523]: Warning: not allowed to set realtime priority. Will run with default priority
Oct 17 09:09:25 volumio volumio[2523]: instead, which is less reliable (underflow may occur).
Oct 17 09:09:25 volumio volumio[2523]: Creating inverse inplace FFTW plan of size 4096 using wisdom...finished
Oct 17 09:09:25 volumio volumio[2523]: Fixed I/O-delay is 2048 samples
Oct 17 09:09:25 volumio volumio[2523]: Audio processing starts now



and then when I play music (seems like it is playing, but no sound coming out)

Code: Select all
Oct 17 09:11:35 volumio volumio[2219]: info: CoreCommandRouter::volumioStop
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495627] CoreStateMachine::stop
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495628] CoreStateMachine::setConsumeUpdateService undefined
Oct 17 09:11:35 volumio volumio[2219]: UNSET VOLATILE
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495631] CoreStateMachine::setConsumeUpdateService undefined
Oct 17 09:11:35 volumio volumio[2219]: info: Airplay started streaming
Oct 17 09:11:35 volumio volumio[2219]: info: CoreCommandRouter::servicePushState
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495681] CoreStateMachine::syncState
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495684] CoreStateMachine::pushState
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495687] CoreStateMachine::getState
Oct 17 09:11:35 volumio volumio[2219]: info: CoreCommandRouter::volumioPushState
Oct 17 09:11:35 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495704] interfaceApi::pushState
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495708] InterfaceWebUI::pushState
Oct 17 09:11:35 volumio volumio[2219]: info: CoreCommandRouter::servicePushState
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495756] CoreStateMachine::syncState
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495759] CoreStateMachine::pushState
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495762] CoreStateMachine::getState
Oct 17 09:11:35 volumio volumio[2219]: info: CoreCommandRouter::volumioPushState
Oct 17 09:11:35 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495767] interfaceApi::pushState
Oct 17 09:11:35 volumio volumio[2219]: info: [1508231495769] InterfaceWebUI::pushState
Oct 17 09:11:35 volumio volumio[2219]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false}
Oct 17 09:11:35 volumio volumio[2219]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false}
Oct 17 09:11:40 volumio volumio[2219]: info: CoreCommandRouter::servicePushState
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500278] CoreStateMachine::syncState
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500279] CoreStateMachine::pushState
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500280] CoreStateMachine::getState
Oct 17 09:11:40 volumio volumio[2219]: info: CoreCommandRouter::volumioPushState
Oct 17 09:11:40 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500284] interfaceApi::pushState
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500285] InterfaceWebUI::pushState
Oct 17 09:11:40 volumio volumio[2219]: info: CoreCommandRouter::servicePushState
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500326] CoreStateMachine::syncState
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500327] CoreStateMachine::pushState
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500328] CoreStateMachine::getState
Oct 17 09:11:40 volumio volumio[2219]: info: CoreCommandRouter::volumioPushState
Oct 17 09:11:40 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500339] interfaceApi::pushState
Oct 17 09:11:40 volumio volumio[2219]: info: [1508231500340] InterfaceWebUI::pushState
Oct 17 09:11:40 volumio volumio[2219]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false}
Oct 17 09:11:40 volumio volumio[2219]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false}
Oct 17 09:12:24 volumio systemd[1]: Starting Cleanup of Temporary Directories...
Oct 17 09:12:24 volumio systemd[1]: Started Cleanup of Temporary Directories.



The "brutefir entered failed state part" from the first code snippet in this post, I have seen lots of times when playing around. For example, choosing the "flat" preset in brutefir gives:


Code: Select all
Oct 17 09:14:38 volumio volumio[2219]: info: CoreCommandRouter::servicePushState
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678219] CoreStateMachine::syncState
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678223] CoreStateMachine::pushState
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678224] CoreStateMachine::getState
Oct 17 09:14:38 volumio volumio[2219]: info: CoreCommandRouter::volumioPushState
Oct 17 09:14:38 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678227] interfaceApi::pushState
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678228] InterfaceWebUI::pushState
Oct 17 09:14:38 volumio volumio[2219]: info: CoreCommandRouter::servicePushState
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678271] CoreStateMachine::syncState
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678272] CoreStateMachine::pushState
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678273] CoreStateMachine::getState
Oct 17 09:14:38 volumio volumio[2219]: info: CoreCommandRouter::volumioPushState
Oct 17 09:14:38 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678278] interfaceApi::pushState
Oct 17 09:14:38 volumio volumio[2219]: info: [1508231678280] InterfaceWebUI::pushState
Oct 17 09:14:38 volumio volumio[2219]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false}
Oct 17 09:14:38 volumio volumio[2219]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false}
Oct 17 09:14:59 volumio volumio[2219]: info: [{"prettyName":"Brutefir for Volumio 0.0.8","name":"brutefir","category":"miscellanea","version":"0.0.8","icon":"fa fa-cube","enabled":true,"active":true}]
Oct 17 09:15:01 volumio volumio[2219]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 17 09:15:05 volumio volumio[2219]: info: CALLMETHOD: miscellanea brutefir saveBrutefirconfigAccount1 [object Object]
Oct 17 09:15:05 volumio volumio[2219]: info: CoreCommandRouter::executeOnPlugin: brutefir , saveBrutefirconfigAccount1
Oct 17 09:15:05 volumio volumio[2219]: info: Configurations have been set
Oct 17 09:15:05 volumio volumio[2219]: Connected to brutefir
Oct 17 09:15:05 volumio volumio[2219]: myeq or preset =false
Oct 17 09:15:05 volumio volumio[2219]: raw values are "0,0,0,0,0,0,0,0,0,0"
Oct 17 09:15:05 volumio volumio[2219]: splitted coef values are ["0","0","0","0","0","0","0","0","0","0"]
Oct 17 09:15:05 volumio volumio[2219]: cmd sent to brutefir = lmc eq 0 mag 31/0, 63/0, 125/0, 250/0, 500/0, 1000/0, 2000/0, 4000/0, 8000/0, 16000/0
Oct 17 09:15:05 volumio volumio[2219]: Received:
Oct 17 09:15:05 volumio volumio[2219]: Welcome to BruteFIR, type "help" for help.
Oct 17 09:15:05 volumio volumio[2219]: >
Oct 17 09:15:22 volumio volumio[2523]: [33B blob data]
Oct 17 09:15:22 volumio volumio[2523]: ALSA I/O: Could not read audio: Broken pipe.
Oct 17 09:15:22 volumio volumio[2523]: I/O module failed to read (probably) due to buffer underflow on output, aborting.
Oct 17 09:15:22 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=5/NOTINSSTALLED
Oct 17 09:15:22 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:15:22 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:15:22 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:15:22 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:15:22 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:15:22 volumio volumio[2933]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:15:22 volumio volumio[2933]: Internal resolution is 64 bit floating point.
Oct 17 09:15:22 volumio volumio[2933]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:15:22 volumio volumio[2933]: Loading 4 coefficient sets...finished.
Oct 17 09:15:22 volumio volumio[2933]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:15:22 volumio volumio[2933]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:15:22 volumio volumio[2933]: Timers for benchmarking may be unreliable.
Oct 17 09:15:22 volumio volumio[2933]: Filters in process 0: 0 2
Oct 17 09:15:22 volumio volumio[2933]: Filters in process 1: 1 3
Oct 17 09:15:22 volumio volumio[2933]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:15:22 volumio volumio[2933]: Failed to init output device.
Oct 17 09:15:22 volumio volumio[2933]: Failed to initialise digital audio interfaces.
Oct 17 09:15:22 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:15:22 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:15:22 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:15:22 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:15:22 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:15:22 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:15:23 volumio volumio[2936]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:15:23 volumio volumio[2936]: Internal resolution is 64 bit floating point.
Oct 17 09:15:23 volumio volumio[2936]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:15:23 volumio volumio[2936]: Loading 4 coefficient sets...finished.
Oct 17 09:15:23 volumio volumio[2936]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:15:23 volumio volumio[2936]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:15:23 volumio volumio[2936]: Timers for benchmarking may be unreliable.
Oct 17 09:15:23 volumio volumio[2936]: Filters in process 0: 0 2
Oct 17 09:15:23 volumio volumio[2936]: Filters in process 1: 1 3
Oct 17 09:15:23 volumio volumio[2936]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:15:23 volumio volumio[2936]: Failed to init output device.
Oct 17 09:15:23 volumio volumio[2936]: Failed to initialise digital audio interfaces.
Oct 17 09:15:23 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:15:23 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:15:23 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:15:23 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:15:23 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:15:23 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:15:23 volumio volumio[2940]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:15:23 volumio volumio[2940]: Internal resolution is 64 bit floating point.
Oct 17 09:15:23 volumio volumio[2940]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:15:23 volumio volumio[2940]: Loading 4 coefficient sets...finished.
Oct 17 09:15:23 volumio volumio[2940]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:15:23 volumio volumio[2940]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:15:23 volumio volumio[2940]: Timers for benchmarking may be unreliable.
Oct 17 09:15:23 volumio volumio[2940]: Filters in process 0: 0 2
Oct 17 09:15:23 volumio volumio[2940]: Filters in process 1: 1 3
Oct 17 09:15:23 volumio volumio[2940]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:15:23 volumio volumio[2940]: Failed to init output device.
Oct 17 09:15:23 volumio volumio[2940]: Failed to initialise digital audio interfaces.
Oct 17 09:15:23 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:15:23 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:15:23 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:15:23 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:15:23 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:15:23 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:15:24 volumio volumio[2943]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:15:24 volumio volumio[2943]: Internal resolution is 64 bit floating point.
Oct 17 09:15:24 volumio volumio[2943]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:15:24 volumio volumio[2943]: Loading 4 coefficient sets...finished.
Oct 17 09:15:24 volumio volumio[2943]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:15:24 volumio volumio[2943]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:15:24 volumio volumio[2943]: Timers for benchmarking may be unreliable.
Oct 17 09:15:24 volumio volumio[2943]: Filters in process 0: 0 2
Oct 17 09:15:24 volumio volumio[2943]: Filters in process 1: 1 3
Oct 17 09:15:24 volumio volumio[2943]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:15:24 volumio volumio[2943]: Failed to init output device.
Oct 17 09:15:24 volumio volumio[2943]: Failed to initialise digital audio interfaces.
Oct 17 09:15:24 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:15:24 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:15:24 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:15:24 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:15:24 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:15:24 volumio systemd[1]: Started brutefir Daemon.
Oct 17 09:15:24 volumio volumio[2947]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 17 09:15:24 volumio volumio[2947]: Internal resolution is 64 bit floating point.
Oct 17 09:15:24 volumio volumio[2947]: Creating 4 FFTW plans of size 2048...finished.
Oct 17 09:15:24 volumio volumio[2947]: Loading 4 coefficient sets...finished.
Oct 17 09:15:24 volumio volumio[2947]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 17 09:15:24 volumio volumio[2947]: Warning: no support for clock cycle counter on this platform.
Oct 17 09:15:24 volumio volumio[2947]: Timers for benchmarking may be unreliable.
Oct 17 09:15:24 volumio volumio[2947]: Filters in process 0: 0 2
Oct 17 09:15:24 volumio volumio[2947]: Filters in process 1: 1 3
Oct 17 09:15:24 volumio volumio[2947]: ALSA I/O: Could not open audio output "hw:2": Device or resource busy.
Oct 17 09:15:24 volumio volumio[2947]: Failed to init output device.
Oct 17 09:15:24 volumio volumio[2947]: Failed to initialise digital audio interfaces.
Oct 17 09:15:24 volumio systemd[1]: brutefir.service: main process exited, code=exited, status=1/FAILURE
Oct 17 09:15:24 volumio systemd[1]: Unit brutefir.service entered failed state.
Oct 17 09:15:24 volumio systemd[1]: brutefir.service holdoff time over, scheduling restart.
Oct 17 09:15:24 volumio systemd[1]: Stopping brutefir Daemon...
Oct 17 09:15:24 volumio systemd[1]: Starting brutefir Daemon...
Oct 17 09:15:24 volumio systemd[1]: brutefir.service start request repeated too quickly, refusing to start.
Oct 17 09:15:24 volumio systemd[1]: Failed to start brutefir Daemon.
Oct 17 09:15:24 volumio systemd[1]: Unit brutefir.service entered failed state.
Random avatar
r.kfr
Sunday DIYer
Sunday DIYer
 
Posts: 13
Joined: Fri Oct 13 2017 19:23


Volumio2 and brutefir...

Postby balbuze » Tue Oct 17 2017 18:52

Hi,
I see several things :
buffer underrun : you should increase filter size and number of partition. A rpi2 is ok with 65535 or more and 8 partition. But depend on your hardware.

Other thing that cause me headache : device busy... this occurs in last version of volumio. I'm still trying to solve it...
need more investigation...
User avatar
balbuze
Moderator
 
Posts: 1228
Joined: Thu May 08 2014 08:42
Location: Isère France


Volumio2 and brutefir...

Postby balbuze » Tue Oct 17 2017 19:08

I see now a other problem...the output is not always properly set.
He best is to wait I fix all that ;)
User avatar
balbuze
Moderator
 
Posts: 1228
Joined: Thu May 08 2014 08:42
Location: Isère France


Volumio2 and brutefir...

Postby balbuze » Wed Oct 18 2017 19:59

I uploaded a new version that may +or not) solve some problems...
User avatar
balbuze
Moderator
 
Posts: 1228
Joined: Thu May 08 2014 08:42
Location: Isère France


Volumio2 and brutefir...

Postby r.kfr » Fri Oct 20 2017 12:26

Sigh...

Updated brute fir plugin and volume and things are strange. I now get sound through the plugin, but not for long (via airplay): Music plays for a couple of seconds and then stops.

Via ssh I see this

Code: Select all
Oct 20 12:22:19 volumio volumio[2853]: info: CoreCommandRouter::volumioStop
Oct 20 12:22:19 volumio volumio[2853]: info: [1508502139135] CoreStateMachine::stop
Oct 20 12:22:19 volumio volumio[2853]: info: [1508502139136] CoreStateMachine::setConsumeUpdateService undefined
Oct 20 12:22:19 volumio volumio[2853]: UNSET VOLATILE
Oct 20 12:22:19 volumio volumio[2853]: info: [1508502139137] CoreStateMachine::setConsumeUpdateService undefined
Oct 20 12:22:19 volumio volumio[2853]: info: Airplay started streaming
Oct 20 12:22:19 volumio volumio[2853]: info: CoreCommandRouter::volumioStop
Oct 20 12:22:19 volumio volumio[2853]: info: [1508502139141] CoreStateMachine::stop
Oct 20 12:22:19 volumio volumio[2853]: info: [1508502139142] CoreStateMachine::serviceStop
Oct 20 12:22:19 volumio volumio[2853]: info: CoreCommandRouter::serviceStop
Oct 20 12:22:19 volumio volumio[2853]: /volumio/app/index.js:346
Oct 20 12:22:19 volumio volumio[2853]: return thisPlugin.stop();
Oct 20 12:22:19 volumio volumio[2853]: ^
Oct 20 12:22:19 volumio volumio[2853]: TypeError: Cannot read property 'stop' of undefined
Oct 20 12:22:19 volumio volumio[2853]: at CoreCommandRouter.serviceStop (/volumio/app/index.js:346:19)
Oct 20 12:22:19 volumio volumio[2853]: at CoreStateMachine.serviceStop (/volumio/app/statemachine.js:1260:29)
Oct 20 12:22:19 volumio volumio[2853]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1226:15)
Oct 20 12:22:19 volumio volumio[2853]: at CoreCommandRouter.volumioStop (/volumio/app/index.js:100:27)
Oct 20 12:22:19 volumio volumio[2853]: at ShairportSyncReaderUDP.<anonymous> (/volumio/app/plugins/music_service/airplay_emulation/index.js:159:34)
Oct 20 12:22:19 volumio volumio[2853]: at emitOne (events.js:101:20)
Oct 20 12:22:19 volumio volumio[2853]: at ShairportSyncReaderUDP.emit (events.js:188:7)
Oct 20 12:22:19 volumio volumio[2853]: at ShairportSyncReaderUDP.useData (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-base.js:85:11)
Oct 20 12:22:19 volumio volumio[2853]: at Socket.ShairportSyncReaderUDP._source.on.msg (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-udp.js:21:9)
Oct 20 12:22:19 volumio volumio[2853]: at emitTwo (events.js:106:13)
Oct 20 12:22:19 volumio volumio[2853]: at Socket.emit (events.js:191:7)
Oct 20 12:22:19 volumio volumio-remote-updater[651]: [2017-10-20 12:22:19] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Oct 20 12:22:19 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Oct 20 12:22:19 volumio volumio-remote-updater[651]: [2017-10-20 12:22:19] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Oct 20 12:22:19 volumio systemd[1]: Unit volumio.service entered failed state.
Oct 20 12:22:19 volumio systemd[1]: Starting dynamicswap.service...
Oct 20 12:22:19 volumio systemd[1]: Started dynamicswap.service.
Oct 20 12:22:19 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Oct 20 12:22:19 volumio systemd[1]: Starting dynamicswap.service...
Oct 20 12:22:19 volumio systemd[1]: Started dynamicswap.service.
Oct 20 12:22:19 volumio systemd[1]: Stopping Volumio Backend Module...
Oct 20 12:22:19 volumio systemd[1]: Starting Volumio Backend Module...
Oct 20 12:22:19 volumio systemd[1]: Started Volumio Backend Module.
Oct 20 12:22:21 volumio volumio[3572]: info: -------------------------------------------
Oct 20 12:22:21 volumio volumio[3572]: info: -----            Volumio2              ----
Oct 20 12:22:21 volumio volumio[3572]: info: -------------------------------------------
Oct 20 12:22:21 volumio volumio[3572]: info: -----          System startup          ----
Oct 20 12:22:21 volumio volumio[3572]: info: -------------------------------------------
Oct 20 12:22:21 volumio volumio[3572]: info: Plugin folders cleanup
Oct 20 12:22:21 volumio volumio[3572]: info: Scanning into folder /volumio/app/plugins/
Oct 20 12:22:21 volumio volumio[3572]: info: Scanning category audio_interface
Oct 20 12:22:21 volumio volumio[3572]: info: Scanning category miscellanea
Oct 20 12:22:21 volumio volumio[3572]: info: Scanning category music_service
Oct 20 12:22:21 volumio volumio[3572]: info: Scanning category plugins.json
Oct 20 12:22:21 volumio volumio[3572]: info: Scanning category system_controller
Oct 20 12:22:21 volumio volumio[3572]: info: Scanning category user_interface
Oct 20 12:22:21 volumio volumio[3572]: info: Scanning into folder /data/plugins/
Oct 20 12:22:21 volumio volumio[3572]: info: Scanning category miscellanea
Oct 20 12:22:21 volumio volumio[3572]: info: Plugin folders cleanup completed
Oct 20 12:22:21 volumio volumio[3572]: info: Loading plugins from folder /volumio/app/plugins/
Oct 20 12:22:21 volumio volumio[3572]: info: Loading plugins from folder /data/plugins/
Oct 20 12:22:21 volumio volumio[3572]: info: Loading plugin "system"...
Oct 20 12:22:22 volumio volumio[3572]: info: Loading plugin "appearance"...
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "network"...
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "services"...
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "alsa_controller"...
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "wizard"...
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "volumio_command_line_client"...
Oct 20 12:22:23 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:23 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:23 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:23 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "upnp"...
Oct 20 12:22:23 volumio volumio[3572]: info: [1508502143553] Starting Upmpd Daemon
Oct 20 12:22:23 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "mpd"...
Oct 20 12:22:23 volumio volumio[3572]: info: Plugin upnp_browser is not enabled
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "networkfs"...
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "alarm-clock"...
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "airplay_emulation"...
Oct 20 12:22:23 volumio volumio[3572]: info: [1508502143958] Starting Shairport Sync
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "last_100"...
Oct 20 12:22:23 volumio volumio[3572]: info: Loading plugin "webradio"...
Oct 20 12:22:24 volumio volumio-remote-updater[651]: [2017-10-20 12:22:24] [connect] Successful connection
Oct 20 12:22:24 volumio volumio[3572]: info: Loading plugin "i2s_dacs"...
Oct 20 12:22:24 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 20 12:22:24 volumio volumio[3572]: info: Loading plugin "my_volumio"...
Oct 20 12:22:24 volumio volumio[3572]: info: Loading plugin "volumiodiscovery"...
Oct 20 12:22:24 volumio volumio[3572]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 20 12:22:24 volumio node[3572]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 20 12:22:24 volumio node[3572]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 12:22:24 volumio node[3572]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node>
Oct 20 12:22:24 volumio node[3572]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 20 12:22:24 volumio node[3572]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 12:22:24 volumio node[3572]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister>
Oct 20 12:22:24 volumio volumio[3572]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 12:22:24 volumio volumio[3572]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node>
Oct 20 12:22:24 volumio volumio[3572]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 20 12:22:24 volumio volumio[3572]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 12:22:24 volumio volumio[3572]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister>
Oct 20 12:22:24 volumio volumio[3572]: info: Applying required configuration parameters for plugin volumiodiscovery
Oct 20 12:22:24 volumio volumio[3572]: Discovery: StartAdv! undefined
Oct 20 12:22:24 volumio volumio[3572]: Discovery: Started advertising... Volumio - undefined
Oct 20 12:22:24 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 20 12:22:24 volumio volumio[3572]: info: Loading plugin "albumart"...
Oct 20 12:22:24 volumio volumio[3572]: info: Plugin example_plugin is not enabled
Oct 20 12:22:24 volumio volumio[3572]: info: Loading plugin "updater_comm"...
Oct 20 12:22:24 volumio volumio[3572]: info: Plugin mpdemulation is not enabled
Oct 20 12:22:24 volumio volumio[3572]: info: Loading plugin "rest_api"...
Oct 20 12:22:24 volumio volumio[3572]: info: Loading plugin "websocket"...
Oct 20 12:22:24 volumio volumio[3572]: info: Loading plugin "brutefir"...
Oct 20 12:22:25 volumio volumio[3572]: info: Applying required configuration parameters for plugin brutefir
Oct 20 12:22:25 volumio volumio[3572]: info: ___________ START PLUGINS ___________
Oct 20 12:22:25 volumio volumio[3572]: info: PLUGIN START: appearance
Oct 20 12:22:25 volumio volumio[3572]: info: PLUGIN START: wizard
Oct 20 12:22:25 volumio volumio[3572]: info: PLUGIN START: last_100
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 20 12:22:25 volumio volumio[3572]: info: [1508502145783] CoreMusicLibrary::Adding element Last_100
Oct 20 12:22:25 volumio volumio[3572]: info: PLUGIN START: webradio
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 20 12:22:25 volumio volumio[3572]: info: [1508502145800] CoreMusicLibrary::Adding element Webradio
Oct 20 12:22:25 volumio volumio[3572]: info: PLUGIN START: my_volumio
Oct 20 12:22:25 volumio volumio[3572]: info: PLUGIN START: brutefir
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:25 volumio volumio[3572]: info: Loading i18n strings for locale de
Oct 20 12:22:25 volumio volumio[3572]: Updating browse sources language
Oct 20 12:22:25 volumio sudo[3635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2
Oct 20 12:22:25 volumio sudo[3635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 20 12:22:25 volumio volumio[3572]: info: CoreCommandRouter::initPlayerControls
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:26 volumio sudo[3635]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:26 volumio volumio[3572]: info: BOOT COMPLETED
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 20 12:22:26 volumio volumio[3572]: Express server listening on port 3000
Oct 20 12:22:26 volumio volumio[3572]: Volumio Calling Home
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146154] CoreStateMachine::resetVolumioState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146156] CoreStateMachine::getcurrentVolume
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::volumioRetrievevolume
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146180] CoreStateMachine::updateTrackBlock
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146182] CorePlayQueue::getTrackBlock
Oct 20 12:22:26 volumio volumio[3572]: { Error: Command failed: /usr/bin/aplay --device=plughw:2,0 /volumio/app/startup.wav
Oct 20 12:22:26 volumio volumio[3572]: aplay: main:722: audio open error: Device or resource busy
Oct 20 12:22:26 volumio volumio[3572]: at ChildProcess.exithandler (child_process.js:204:12)
Oct 20 12:22:26 volumio volumio[3572]: at emitTwo (events.js:106:13)
Oct 20 12:22:26 volumio volumio[3572]: at ChildProcess.emit (events.js:191:7)
Oct 20 12:22:26 volumio volumio[3572]: at maybeClose (internal/child_process.js:891:16)
Oct 20 12:22:26 volumio volumio[3572]: at Socket.<anonymous> (internal/child_process.js:342:11)
Oct 20 12:22:26 volumio volumio[3572]: at emitOne (events.js:96:13)
Oct 20 12:22:26 volumio volumio[3572]: at Socket.emit (events.js:188:7)
Oct 20 12:22:26 volumio volumio[3572]: at Pipe._handle.close [as _onclose] (net.js:497:12)
Oct 20 12:22:26 volumio volumio[3572]: killed: false,
Oct 20 12:22:26 volumio volumio[3572]: code: 1,
Oct 20 12:22:26 volumio volumio[3572]: signal: null,
Oct 20 12:22:26 volumio volumio[3572]: cmd: '/usr/bin/aplay --device=plughw:2,0 /volumio/app/startup.wav' }
Oct 20 12:22:26 volumio volumio[3572]: info: snd_aloop loaded
Oct 20 12:22:26 volumio volumio[3572]: info: MPD running with PID3044 ,establishing connection
Oct 20 12:22:26 volumio volumio[3572]: info: Setting Device type: Raspberry PI
Oct 20 12:22:26 volumio volumio-remote-updater[651]: [2017-10-20 12:22:26] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1508502144 101
Oct 20 12:22:26 volumio volumio[3572]: hw:2
Oct 20 12:22:26 volumio volumio[3572]: /data/INTERNAL/brutefirfilters/
Oct 20 12:22:26 volumio volumio[3572]: File exists.
Oct 20 12:22:26 volumio volumio[3572]: File exists.
Oct 20 12:22:26 volumio volumio[3572]: info: Reloading queue from file
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146905] VolumeController:: Volume=undefined Mute =undefined
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146908] CoreStateMachine::pushState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146911] CoreStateMachine::getState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146913] CorePlayQueue::getTrack 0
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146921] interfaceApi::pushState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146923] InterfaceWebUI::pushState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146964] CoreStateMachine::setRepeat true single undefined
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146965] CoreStateMachine::pushState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146967] CoreStateMachine::getState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146968] CorePlayQueue::getTrack 0
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146975] interfaceApi::pushState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146977] InterfaceWebUI::pushState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146983] CoreStateMachine::setRandom null
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146984] CoreStateMachine::pushState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146985] CoreStateMachine::getState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146986] CorePlayQueue::getTrack 0
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:22:26 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146990] interfaceApi::pushState
Oct 20 12:22:26 volumio volumio[3572]: info: [1508502146992] InterfaceWebUI::pushState
Oct 20 12:22:27 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:22:27 volumio volumio[3572]: info: Volumio called home
Oct 20 12:22:27 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:22:27 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:22:27 volumio volumio[3572]: info: asound.conf file written
Oct 20 12:22:27 volumio sudo[3656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/asoundrc /etc/asound.conf
Oct 20 12:22:27 volumio sudo[3656]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:27 volumio sudo[3656]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:27 volumio sudo[3667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart brutefir.service
Oct 20 12:22:27 volumio sudo[3667]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:27 volumio sudo[3670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay
Oct 20 12:22:27 volumio systemd[1]: Stopping brutefir Daemon...
Oct 20 12:22:27 volumio sudo[3670]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:27 volumio volumio[3572]: Discovery: adding be445d32-e7e9-4932-aa24-295087799530
Oct 20 12:22:27 volumio volumio[3572]: info: mDNS: Found device Volumio
Oct 20 12:22:27 volumio systemd[1]: Starting brutefir Daemon...
Oct 20 12:22:27 volumio systemd[1]: Started brutefir Daemon.
Oct 20 12:22:27 volumio sudo[3667]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:27 volumio systemd[1]: Stopping ShairportSync AirTunes receiver...
Oct 20 12:22:27 volumio volumio[3679]: BruteFIR v1.0m (November 2013)                                (c) Anders Torger
Oct 20 12:22:27 volumio volumio[3679]: Internal resolution is 64 bit floating point.
Oct 20 12:22:27 volumio volumio[3679]: Creating 4 FFTW plans of size 8192...finished.
Oct 20 12:22:27 volumio systemd[1]: Starting ShairportSync AirTunes receiver...
Oct 20 12:22:27 volumio systemd[1]: Started ShairportSync AirTunes receiver.
Oct 20 12:22:27 volumio sudo[3670]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:27 volumio shairport-sync[3687]: Successful Startup
Oct 20 12:22:27 volumio sudo[3694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start brutefir.service
Oct 20 12:22:27 volumio volumio[3572]: info: [1508502147360] Shairport-Sync Started
Oct 20 12:22:27 volumio sudo[3694]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:27 volumio volumio[3679]: Loading 4 coefficient sets...finished.
Oct 20 12:22:27 volumio volumio[3679]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Oct 20 12:22:27 volumio volumio[3679]: Warning: no support for clock cycle counter on this platform.
Oct 20 12:22:27 volumio volumio[3679]: Timers for benchmarking may be unreliable.
Oct 20 12:22:27 volumio volumio[3679]: Filters in process 0: 0 2
Oct 20 12:22:27 volumio volumio[3679]: Filters in process 1: 1 3
Oct 20 12:22:27 volumio systemd[1]: Started brutefir Daemon.
Oct 20 12:22:27 volumio sudo[3694]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:27 volumio volumio[3572]: info: asound.conf file written
Oct 20 12:22:27 volumio sudo[3704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/asoundrc /etc/asound.conf
Oct 20 12:22:27 volumio sudo[3704]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:27 volumio volumio[3679]: Realtime priority 1 set for cli process (pid 3707)
Oct 20 12:22:27 volumio sudo[3704]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:27 volumio volumio[3572]: info: Brutefir Daemon Started
Oct 20 12:22:27 volumio volumio[3679]: Creating inverse inplace FFTW plan of size 16384 using wisdom...finished
Oct 20 12:22:27 volumio volumio[3679]: Realtime priority 3 set for input process (pid 3681)
Oct 20 12:22:27 volumio volumio[3679]: Realtime priority 4 set for filter process (pid 3705)
Oct 20 12:22:27 volumio volumio[3679]: Realtime priority 4 set for filter process (pid 3706)
Oct 20 12:22:27 volumio volumio[3679]: Realtime priority 3 set for output process (pid 3718)
Oct 20 12:22:27 volumio volumio[3679]: Fixed I/O-delay is 8192 samples
Oct 20 12:22:27 volumio volumio[3679]: Audio processing starts now
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::volumioGetState
Oct 20 12:22:29 volumio volumio[3572]: info: [1508502149049] CoreStateMachine::getState
Oct 20 12:22:29 volumio volumio[3572]: info: [1508502149050] CorePlayQueue::getTrack 0
Oct 20 12:22:29 volumio volumio[3572]: info:
Oct 20 12:22:29 volumio volumio[3572]: [1508502149052] ---------------------------- Client requests Volumio state
Oct 20 12:22:29 volumio volumio[3572]: info: [1508502149057] InterfaceWebUI::pushState
Oct 20 12:22:29 volumio volumio[3572]: info: [1508502149083] ------------------------------ 37ms
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 20 12:22:29 volumio volumio[3572]: info: Output device has changed, restarting MPD
Oct 20 12:22:29 volumio sudo[3725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 20 12:22:29 volumio volumio[3572]: info: Output device has changed, restarting Shairport Sync
Oct 20 12:22:29 volumio sudo[3725]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:29 volumio sudo[3725]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:29 volumio sudo[3728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 20 12:22:29 volumio sudo[3728]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 20 12:22:29 volumio systemd[1]: Stopping Music Player Daemon...
Oct 20 12:22:29 volumio systemd[1]: Starting Music Player Daemon...
Oct 20 12:22:29 volumio systemd[1]: Started Music Player Daemon.
Oct 20 12:22:29 volumio volumio[3572]: info: Setting mixer PCM for card
Oct 20 12:22:29 volumio sudo[3728]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 20 12:22:29 volumio volumio[3572]: info: Updating Volume Controller Parameters: Device: Loopback Name:  Mixer: PCM Max Vol: 100 Vol Curve; linear Vol Steps: 10
Oct 20 12:22:29 volumio volumio[3572]: info: Connecting to daemon
Oct 20 12:22:29 volumio volumio[3572]: myeq or preset =false
Oct 20 12:22:29 volumio volumio[3572]: cmd sent to brutefir = lmc eq 0 mag 31/0, 63/0, 125/0, 250/0, 500/0, 1000/0, 2000/0, 4000/0, 8000/0, 16000/0
Oct 20 12:22:29 volumio volumio[3572]: info: MPD Permissions set
Oct 20 12:22:29 volumio volumio[3572]: Received:
Oct 20 12:22:29 volumio volumio[3572]: Welcome to BruteFIR, type "help" for help.
Oct 20 12:22:29 volumio volumio[3572]: >
Oct 20 12:22:29 volumio sudo[3753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l
Oct 20 12:22:29 volumio sudo[3753]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:29 volumio sudo[3753]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:29 volumio volumio[3572]: info: No Overlays Loaded
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 20 12:22:29 volumio volumio[3572]: { device: '2',
Oct 20 12:22:29 volumio volumio[3572]: name: 'Allo DigiOne',
Oct 20 12:22:29 volumio volumio[3572]: mixer: '',
Oct 20 12:22:29 volumio volumio[3572]: mixertype: 'None',
Oct 20 12:22:29 volumio volumio[3572]: maxvolume: '100',
Oct 20 12:22:29 volumio volumio[3572]: volumecurve: 'linear',
Oct 20 12:22:29 volumio volumio[3572]: volumestart: 'disabled',
Oct 20 12:22:29 volumio volumio[3572]: volumesteps: '10' }
Oct 20 12:22:29 volumio volumio[3572]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 20 12:22:29 volumio volumio[3572]: info: Updating Volume Controller Parameters: Device: 2 Name: Allo DigiOne Mixer:  Max Vol: 100 Vol Curve; linear Vol Steps: 10
Oct 20 12:22:29 volumio sudo[3766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay
Oct 20 12:22:30 volumio sudo[3766]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:30 volumio systemd[1]: Stopping ShairportSync AirTunes receiver...
Oct 20 12:22:30 volumio systemd[1]: Starting ShairportSync AirTunes receiver...
Oct 20 12:22:30 volumio systemd[1]: Started ShairportSync AirTunes receiver.
Oct 20 12:22:30 volumio sudo[3766]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:30 volumio shairport-sync[3772]: Successful Startup
Oct 20 12:22:30 volumio volumio[3572]: info: [1508502150057] Shairport-Sync Started
Oct 20 12:22:30 volumio volumio[3572]: info:
Oct 20 12:22:30 volumio volumio[3572]: error: Upnp client error: Error: This socket has been ended by the other party
Oct 20 12:22:30 volumio volumio[3572]: info: Connecting to daemon brutefir
Oct 20 12:22:30 volumio volumio[3572]: myeq or preset =false
Oct 20 12:22:30 volumio volumio[3572]: cmd sent to brutefir = lmc eq 0 mag 31/0, 63/0, 125/0, 250/0, 500/0, 1000/0, 2000/0, 4000/0, 8000/0, 16000/0
Oct 20 12:22:30 volumio volumio[3572]: Received:
Oct 20 12:22:30 volumio volumio[3572]: Welcome to BruteFIR, type "help" for help.
Oct 20 12:22:30 volumio volumio[3572]: >
Oct 20 12:22:31 volumio volumio[3572]: info: CoreCommandRouter::volumioGetState
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151055] CoreStateMachine::getState
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151056] CorePlayQueue::getTrack 0
Oct 20 12:22:31 volumio volumio[3572]: info:
Oct 20 12:22:31 volumio volumio[3572]: [1508502151058] ---------------------------- Client requests Volumio state
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151065] InterfaceWebUI::pushState
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151096] ------------------------------ 43ms
Oct 20 12:22:31 volumio volumio[3572]: info:
Oct 20 12:22:31 volumio volumio[3572]: [1508502151133] ---------------------------- Client requests Menu Items
Oct 20 12:22:31 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 20 12:22:31 volumio volumio[3572]: Plugin multiroom or method getMultiroom not found
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151170] Listing playlists
Oct 20 12:22:31 volumio volumio[3572]: info: CoreCommandRouter::volumioGetQueue
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151176] CoreStateMachine::getQueue
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151178] CorePlayQueue::getQueue
Oct 20 12:22:31 volumio volumio[3572]: info:
Oct 20 12:22:31 volumio volumio[3572]: [1508502151180] ---------------------------- Client requests Volumio queue
Oct 20 12:22:31 volumio volumio[3572]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151194] InterfaceWebUI::pushQueue
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151198] ------------------------------ 24ms
Oct 20 12:22:31 volumio volumio[3572]: info: [1508502151243] ------------------------------ 110ms
Oct 20 12:22:33 volumio sudo[3789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Oct 20 12:22:33 volumio sudo[3789]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 20 12:22:33 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Oct 20 12:22:33 volumio sudo[3789]: pam_unix(sudo:session): session closed for user root
Oct 20 12:22:33 volumio volumio[3572]: info: Upmpdcli Daemon Started


Random avatar
r.kfr
Sunday DIYer
Sunday DIYer
 
Posts: 13
Joined: Fri Oct 13 2017 19:23


Volumio2 and brutefir...

Postby r.kfr » Fri Oct 20 2017 12:27

Internet radio is working better.

Code: Select all
Oct 20 12:24:22 volumio volumio[3572]: info:
Oct 20 12:24:22 volumio volumio[3572]: [1508502262605] ---------------------------- Client requests Volumio play
Oct 20 12:24:22 volumio volumio[3572]: info: CoreCommandRouter::volumioPlay
Oct 20 12:24:22 volumio volumio[3572]: UNSET VOLATILE
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262609] CoreStateMachine::play index undefined
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262611] CoreStateMachine::setConsumeUpdateService undefined
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262613] CorePlayQueue::getTrack 0
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262614] CoreStateMachine::startPlaybackTimer
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262616] CorePlayQueue::getTrack 0
Oct 20 12:24:22 volumio volumio[3572]: aaaaaaaaaaaaaaaaaaaaaaaaaaaaaaa[object Object]
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262618] ControllerWebradio::clearAddPlayTrack
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262620] ControllerMpd::sendMpdCommand stop
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262627] sending command...
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262629] ------------------------------ 24ms
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262634] parsing response...
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262635] ControllerMpd::sendMpdCommand clear
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262637] sending command...
Oct 20 12:24:22 volumio volumio[3572]: info:
Oct 20 12:24:22 volumio volumio[3572]: [1508502262640] ---------------------------- MPD announces system state update
Oct 20 12:24:22 volumio volumio[3572]: info: Mpd Status Update: playlist
Oct 20 12:24:22 volumio volumio[3572]: info:
Oct 20 12:24:22 volumio volumio[3572]: [1508502262643] ---------------------------- MPD announces state update
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262644] parsing response...
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262646] ControllerMpd::getState
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262647] ControllerMpd::sendMpdCommand status
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262648] ControllerMpd::sendMpdCommand load "https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3"
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262650] sending command...
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262652] sending command...
Oct 20 12:24:22 volumio volumio[3572]: info:
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262658] ------------------------------ 18ms
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262659] parsing response...
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262661] ControllerMpd::parseState
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262663] ControllerMpd::pushState
Oct 20 12:24:22 volumio volumio[3572]: info: CoreCommandRouter::servicePushState
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262665] CoreStateMachine::syncState
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262670] CorePlayQueue::getTrack 0
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262672] Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Oct 20 12:24:22 volumio volumio[3572]: info: [1508502262673] ------------------------------ 31ms
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263571] ControllerMpd::sendMpdCommand add "https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3"
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263572] sending command...
Oct 20 12:24:23 volumio volumio[3572]: info:
Oct 20 12:24:23 volumio volumio[3572]: [1508502263575] ---------------------------- MPD announces system state update
Oct 20 12:24:23 volumio volumio[3572]: info: Mpd Status Update: playlist
Oct 20 12:24:23 volumio volumio[3572]: info:
Oct 20 12:24:23 volumio volumio[3572]: [1508502263578] ---------------------------- MPD announces state update
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263580] parsing response...
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263581] ControllerMpd::getState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263582] ControllerMpd::sendMpdCommand status
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263583] CoreStateMachine::setConsumeUpdateService mpd
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263584] ControllerMpd::sendMpdCommand play
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263587] sending command...
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263600] sending command...
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263607] ------------------------------ 32ms
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263608] parsing response...
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263611] ControllerMpd::parseState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263612] ControllerMpd::pushState
Oct 20 12:24:23 volumio volumio[3572]: info: CoreCommandRouter::servicePushState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263615] CoreStateMachine::syncState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263622] CorePlayQueue::getTrack 0
Oct 20 12:24:23 volumio volumio[3572]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 20 12:24:23 volumio volumio[3572]: info: CURRENT POSITION 0
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263631] CoreStateMachine::syncState   stateService stop
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263632] CoreStateMachine::syncState   currentStatus stop
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263633] CoreStateMachine::pushState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263634] CoreStateMachine::getState
Oct 20 12:24:23 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:23 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263643] interfaceApi::pushState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263646] InterfaceWebUI::pushState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263675] No code
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263676] CoreStateMachine::pushState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263677] CoreStateMachine::getState
Oct 20 12:24:23 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:23 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263689] interfaceApi::pushState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263690] InterfaceWebUI::pushState
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263738] ------------------------------ 161ms
Oct 20 12:24:23 volumio volumio[3572]: info: [1508502263796] parsing response...
Oct 20 12:24:23 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:23 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:24 volumio volumio[3572]: info: Mpd Status Update: player
Oct 20 12:24:24 volumio volumio[3572]: info:
Oct 20 12:24:24 volumio volumio[3572]: [1508502264849] ---------------------------- MPD announces state update
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264855] ControllerMpd::getState
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264856] ControllerMpd::sendMpdCommand status
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264857] sending command...
Oct 20 12:24:24 volumio volumio[3572]: info:
Oct 20 12:24:24 volumio volumio[3572]: [1508502264870] ---------------------------- MPD announces system state update
Oct 20 12:24:24 volumio volumio[3572]: info: Mpd Status Update: playlist
Oct 20 12:24:24 volumio volumio[3572]: info:
Oct 20 12:24:24 volumio volumio[3572]: [1508502264872] ---------------------------- MPD announces state update
Oct 20 12:24:24 volumio volumio[3572]: info: Mpd Status Update: player
Oct 20 12:24:24 volumio volumio[3572]: info:
Oct 20 12:24:24 volumio volumio[3572]: [1508502264875] ---------------------------- MPD announces state update
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264876] ControllerMpd::getState
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264876] ControllerMpd::sendMpdCommand status
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264877] ControllerMpd::getState
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264878] ControllerMpd::sendMpdCommand status
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264878] parsing response...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264886] sending command...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264930] sending command...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264932] ControllerMpd::parseState
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264933] ControllerMpd::sendMpdCommand playlistinfo
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264934] sending command...
Oct 20 12:24:24 volumio volumio[3572]: info:
Oct 20 12:24:24 volumio volumio[3572]: [1508502264958] ---------------------------- MPD announces system state update
Oct 20 12:24:24 volumio volumio[3572]: info: Mpd Status Update: playlist
Oct 20 12:24:24 volumio volumio[3572]: info:
Oct 20 12:24:24 volumio volumio[3572]: [1508502264961] ---------------------------- MPD announces state update
Oct 20 12:24:24 volumio volumio[3572]: info: Mpd Status Update: player
Oct 20 12:24:24 volumio volumio[3572]: info:
Oct 20 12:24:24 volumio volumio[3572]: [1508502264962] ---------------------------- MPD announces state update
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264967] ControllerMpd::getState
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264970] ControllerMpd::sendMpdCommand status
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264974] ControllerMpd::getState
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264975] ControllerMpd::sendMpdCommand status
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264976] ------------------------------ 106ms
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264977] parsing response...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264978] parsing response...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264979] parsing response...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264980] sending command...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264981] sending command...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264982] ControllerMpd::parseState
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264982] ControllerMpd::sendMpdCommand playlistinfo
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264983] ControllerMpd::parseState
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264984] ControllerMpd::sendMpdCommand playlistinfo
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264984] ControllerMpd::parseTrackInfo
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264985] sending command...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264986] sending command...
Oct 20 12:24:24 volumio volumio[3572]: info: [1508502264987] ControllerMpd::pushState
Oct 20 12:24:24 volumio volumio[3572]: info: CoreCommandRouter::servicePushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502264989] CoreStateMachine::syncState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502264990] CorePlayQueue::getTrack 0
Oct 20 12:24:25 volumio volumio[3572]: info: STATE SERVICE {"status":"play","position":0,"seek":42,"duration":0,"samplerate":"48 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Lorde - Royals  ","artist":"1Live, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","trackType":"mp3"}
Oct 20 12:24:25 volumio volumio[3572]: info: CURRENT POSITION 0
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502264991] CoreStateMachine::syncState   stateService play
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502264992] CoreStateMachine::syncState   currentStatus stop
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502264993] CoreStateMachine::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502264994] CoreStateMachine::getState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502264997] interfaceApi::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502264998] InterfaceWebUI::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265019] ------------------------------ 172ms
Oct 20 12:24:25 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265030] ------------------------------ 72ms
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265031] parsing response...
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265035] parsing response...
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265038] parsing response...
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265039] parsing response...
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265041] ControllerMpd::parseState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265043] ControllerMpd::sendMpdCommand playlistinfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265044] ControllerMpd::parseState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265044] ControllerMpd::sendMpdCommand playlistinfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265045] ControllerMpd::parseTrackInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265046] ControllerMpd::parseTrackInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265047] sending command...
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265049] sending command...
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265050] ControllerMpd::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::servicePushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265052] CoreStateMachine::syncState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265052] CorePlayQueue::getTrack 0
Oct 20 12:24:25 volumio volumio[3572]: info: STATE SERVICE {"status":"play","position":0,"seek":160,"duration":0,"samplerate":"48 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Lorde - Royals  ","artist":"1Live, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","trackType":"mp3"}
Oct 20 12:24:25 volumio volumio[3572]: info: CURRENT POSITION 0
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265054] CoreStateMachine::syncState   stateService play
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265055] CoreStateMachine::syncState   currentStatus play
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265055] Received an update from plaugin. extracting info from payload
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265057] CoreStateMachine::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265058] CoreStateMachine::getState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265063] interfaceApi::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265064] InterfaceWebUI::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265082] CoreStateMachine::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265083] CoreStateMachine::getState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265086] interfaceApi::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265087] InterfaceWebUI::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265104] ControllerMpd::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::servicePushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265105] CoreStateMachine::syncState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265105] CorePlayQueue::getTrack 0
Oct 20 12:24:25 volumio volumio[3572]: info: STATE SERVICE {"status":"play","position":0,"seek":160,"duration":0,"samplerate":"48 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Lorde - Royals  ","artist":"1Live, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","trackType":"mp3"}
Oct 20 12:24:25 volumio volumio[3572]: info: CURRENT POSITION 0
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265107] CoreStateMachine::syncState   stateService play
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265108] CoreStateMachine::syncState   currentStatus play
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265108] Received an update from plaugin. extracting info from payload
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265109] CoreStateMachine::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265110] CoreStateMachine::getState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265114] interfaceApi::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265115] InterfaceWebUI::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265130] CoreStateMachine::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265131] CoreStateMachine::getState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265134] interfaceApi::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265135] InterfaceWebUI::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265160] ------------------------------ 288ms
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265164] ------------------------------ 290ms
Oct 20 12:24:25 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:25 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:25 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:25 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265243] parsing response...
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265244] parsing response...
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265244] ControllerMpd::parseTrackInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265245] ControllerMpd::parseTrackInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265246] ControllerMpd::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::servicePushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265247] CoreStateMachine::syncState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265248] CorePlayQueue::getTrack 0
Oct 20 12:24:25 volumio volumio[3572]: info: STATE SERVICE {"status":"play","position":0,"seek":498,"duration":0,"samplerate":"48 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Lorde - Royals  ","artist":"1Live, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","trackType":"mp3"}
Oct 20 12:24:25 volumio volumio[3572]: info: CURRENT POSITION 0
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265252] CoreStateMachine::syncState   stateService play
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265253] CoreStateMachine::syncState   currentStatus play
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265254] Received an update from plaugin. extracting info from payload
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265255] CoreStateMachine::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265255] CoreStateMachine::getState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265258] interfaceApi::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265260] InterfaceWebUI::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265280] CoreStateMachine::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265281] CoreStateMachine::getState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265283] interfaceApi::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265283] InterfaceWebUI::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265298] ControllerMpd::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::servicePushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265299] CoreStateMachine::syncState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265300] CorePlayQueue::getTrack 0
Oct 20 12:24:25 volumio volumio[3572]: info: STATE SERVICE {"status":"play","position":0,"seek":498,"duration":0,"samplerate":"48 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Lorde - Royals  ","artist":"1Live, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","trackType":"mp3"}
Oct 20 12:24:25 volumio volumio[3572]: info: CURRENT POSITION 0
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265303] CoreStateMachine::syncState   stateService play
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265303] CoreStateMachine::syncState   currentStatus play
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265304] Received an update from plaugin. extracting info from payload
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265305] CoreStateMachine::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265305] CoreStateMachine::getState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265307] interfaceApi::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265308] InterfaceWebUI::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265328] CoreStateMachine::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265329] CoreStateMachine::getState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::volumioPushState
Oct 20 12:24:25 volumio volumio[3572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265335] interfaceApi::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265335] InterfaceWebUI::pushState
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265356] ------------------------------ 397ms
Oct 20 12:24:25 volumio volumio[3572]: info: [1508502265359] ------------------------------ 397ms
Oct 20 12:24:25 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:25 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:25 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}
Oct 20 12:24:25 volumio volumio[3572]: info: Pushing Favourites {"service":"webradio","uri":"https://wdr-1live-live.sslcast.addradio.de/wdr/1live/live/mp3/128/stream.mp3","favourite":false}



Actually, I would like to start trying out using filters to correct for my room. I use REW and thought it would then be easy to get the filters I create there into brutefir - but I can't find (or don't understand) info on how this works! Can you guys give me a hint?

Cheers!
Random avatar
r.kfr
Sunday DIYer
Sunday DIYer
 
Posts: 13
Joined: Fri Oct 13 2017 19:23


Volumio2 and brutefir...

Postby balbuze » Fri Oct 20 2017 18:50

Hi,
to use your filters, have a look here (brand new and incomplete ;) ) https://github.com/balbuze/volumio-plug ... by-balbuze
User avatar
balbuze
Moderator
 
Posts: 1228
Joined: Thu May 08 2014 08:42
Location: Isère France

PreviousNext

Return to Development talks

Who is online

Users browsing this forum: No registered users and 0 guests