dual mono with alsa

Bjorn1 · March 16, 2020, 2:40pm

Hi,

So, this may not be a volumio problem at all, rather alsa. But, if we can provide a solution I think this thread could be a good resource for trobleshooting. I have gone through the forum and also searched a LOT on solutions for this. The challange is simple enough - can we get dual mono output from rapberry running volumio.
I found no plugins or built in functionality for this. (although it would be nice)

I found the asound.conf file (/etc/asound) and tried a bunch of different configurations to get this to work. example from hifiberry using dmix:

pcm.hifiberry {
type hw card 0
}

pcm.!default {
type plug
slave.pcm “dmixer”
ttable.0.0 1;
ttable.1.1 1;
ttable.0.1 0;
ttable.1.0 0;
}

pcm.dmixer {
type dmix
ipc_key 1024
slave {
pcm “hifiberry”
channels 2
}
}

ctl.dmixer {
type hw
card 0
}

This does not work as it is (even if I alter the ttable values - above example is just for mono on one channel) I also found out that people have had variating results using dmix. Using type route in alsa may be a better option (just guessing)

The original asound.conf (that came with volumio) is rather simple:
volumio@oa5:/etc$ cat asound.conf
pcm.softvolume {
type plug
slave.pcm “softvol”
}

pcm.softvol {
type softvol
slave {
pcm “plughw:Loopback,0”
}
control {
name “SoftMaster”
card Loopback
device 0
}

max_dB 0.0
min_dB -50.0
resolution 100
}
volumio@oa5:/etc$

So, any idea on how to merge theese files, or does anyone have a working example for dual mono out (using volumio)?
Or is there any other way to do it that I have missed?

for reference:
Raspberry Pi 3b
pi dac pro
volumio 2.714

Thanks!

Bjorn

balbuze · March 16, 2020, 2:53pm

Under the dust, I found this :
https://github.com/balbuze/volumio-plugins/tree/master/plugins/audio_interface/volstereo2mono
maybe worth to try…

Bjorn1 · March 16, 2020, 3:22pm

Wow,

I was sooooooooooooooo close

Thanks a lot!

Bjorn1 · March 16, 2020, 3:24pm

pcm.monoouts {
type route
slave.pcm “plughw:Loopback,0”
ttable {
0.0 0.7 # in-channel 0, out-channel 0, 70% volume
1.0 0.7 # in-channel 1, out-channel 0, 70% volume
0.1 0.7 # in-channel 0, out-channel 1, 70% volume
1.1 0.7 # in-channel 0, out-channel 1, 70% volume
}
}

pcm.monoout {
type plug
slave.pcm “pcm.monoouts”
}

I guess “type route” is the way to go as well…

Bjorn1 · April 21, 2020, 2:18pm

So, this does not work since the last update?

I reimaged with the latest version 2.2729 - but the plugin wont install. Nor does asound.conf exist anymore?

balbuze · April 21, 2020, 2:30pm

Nothing has been changed in the plugin…
Have changed the default password? If yes, it prevents from installing plugin…

Bjorn1 · April 21, 2020, 2:49pm

ahh, thanks!

Bjorn1 · April 22, 2020, 8:15pm

Ok, seems there is some issue anyway. I read through the 48 (!) pages of brutefir forum thread in attempt to get some hints, and I did. I tried the usual recommendations as “disable everything - reboot” - “enable brutefir - reboot” - “enable other plugin (volstereo2mono in my case) - reboot”

I gor it to work one time, not sure why. I have been fiddling with the asound.conf file from time to time but i suspect that had nothing to do with it. Probably more of a coincidence. Not sure if this is a brutefir och volstereo2mono issue. But hey, here´s a sudo journalctl -f

Apr 22 20:05:25 oa5 sudo[1900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:05:26 oa5 sudo[1900]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:05:26 oa5 sudo[1900]: pam_unix(sudo:session): session closed for user root
Apr 22 20:05:26 oa5 volumio[1062]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 22 20:05:26 oa5 volumio[1062]: info: CoreCommandRouter::volumioGetState
Apr 22 20:05:26 oa5 volumio[1062]: info: CoreStateMachine::getState
Apr 22 20:05:26 oa5 volumio[1062]: info: CorePlayQueue::getTrack 0
Apr 22 20:05:26 oa5 sudo[1909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:05:26 oa5 sudo[1909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:05:26 oa5 sudo[1909]: pam_unix(sudo:session): session closed for user root
Apr 22 20:05:26 oa5 volumio[1062]: info: CoreCommandRouter::volumioGetState
Apr 22 20:05:26 oa5 volumio[1062]: info: CoreStateMachine::getState
Apr 22 20:05:26 oa5 volumio[1062]: info: CorePlayQueue::getTrack 0
Apr 22 20:05:26 oa5 sudo[1918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:05:26 oa5 sudo[1918]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:05:26 oa5 sudo[1918]: pam_unix(sudo:session): session closed for user root
Apr 22 20:05:37 oa5 volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 22 20:05:41 oa5 volumio[1062]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 22 20:05:44 oa5 volumio[1062]: info: CALLMETHOD: audio_interface volstereo2mono savevolstereo2mono [object Object]
Apr 22 20:05:44 oa5 volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volstereo2mono , savevolstereo2mono
Apr 22 20:05:44 oa5 volumio[1062]: info: asound.conf file written
Apr 22 20:05:44 oa5 sudo[1945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volstereo2mono.service
Apr 22 20:05:44 oa5 sudo[1945]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:05:44 oa5 sudo[1948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/asoundrc /etc/asound.conf
Apr 22 20:05:44 oa5 systemd[1]: Starting alsaloop for volstereo2mono…
Apr 22 20:05:44 oa5 systemd[1]: Started alsaloop for volstereo2mono.
Apr 22 20:05:44 oa5 sudo[1945]: pam_unix(sudo:session): session closed for user root
Apr 22 20:05:44 oa5 sudo[1948]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:05:44 oa5 sudo[1948]: pam_unix(sudo:session): session closed for user root
Apr 22 20:05:44 oa5 volumio[1953]: playback monoout open error: Device or resource busy
Apr 22 20:05:44 oa5 volumio[1953]: Loopback initialization failure.
Apr 22 20:05:44 oa5 systemd[1]: volstereo2mono.service: main process exited, code=exited, status=1/FAILURE
Apr 22 20:05:44 oa5 systemd[1]: Unit volstereo2mono.service entered failed state.
Apr 22 20:05:44 oa5 volumio[1062]: /usr/sbin/alsactl: set_control:1461: Cannot write control ‘2:0:0:Max Overclock PLL:0’ : Device or resource busy
Apr 22 20:05:44 oa5 volumio[1062]: /usr/sbin/alsactl: set_control:1461: Cannot write control ‘2:0:0:Max Overclock DSP:0’ : Device or resource busy
Apr 22 20:05:44 oa5 volumio[1062]: /usr/sbin/alsactl: set_control:1461: Cannot write control ‘2:0:0:Max Overclock DAC:0’ : Device or resource busy
Apr 22 20:05:45 oa5 systemd[1]: volstereo2mono.service holdoff time over, scheduling restart.
Apr 22 20:05:45 oa5 systemd[1]: Stopping alsaloop for volstereo2mono…
Apr 22 20:05:45 oa5 systemd[1]: Starting alsaloop for volstereo2mono…
Apr 22 20:05:45 oa5 systemd[1]: Started alsaloop for volstereo2mono.
Apr 22 20:05:45 oa5 volumio[1966]: playback monoout open error: Device or resource busy
Apr 22 20:05:45 oa5 volumio[1966]: Loopback initialization failure.
Apr 22 20:05:45 oa5 systemd[1]: volstereo2mono.service: main process exited, code=exited, status=1/FAILURE
Apr 22 20:05:45 oa5 systemd[1]: Unit volstereo2mono.service entered failed state.
Apr 22 20:05:45 oa5 systemd[1]: volstereo2mono.service holdoff time over, scheduling restart.
Apr 22 20:05:45 oa5 systemd[1]: Stopping alsaloop for volstereo2mono…
Apr 22 20:05:45 oa5 systemd[1]: Starting alsaloop for volstereo2mono…
Apr 22 20:05:45 oa5 systemd[1]: Started alsaloop for volstereo2mono.
Apr 22 20:05:45 oa5 volumio[1968]: playback monoout open error: Device or resource busy
Apr 22 20:05:45 oa5 volumio[1968]: Loopback initialization failure.
Apr 22 20:05:45 oa5 systemd[1]: volstereo2mono.service: main process exited, code=exited, status=1/FAILURE
Apr 22 20:05:45 oa5 systemd[1]: Unit volstereo2mono.service entered failed state.
Apr 22 20:05:45 oa5 systemd[1]: volstereo2mono.service holdoff time over, scheduling restart.
Apr 22 20:05:45 oa5 systemd[1]: Stopping alsaloop for volstereo2mono…
Apr 22 20:05:45 oa5 systemd[1]: Starting alsaloop for volstereo2mono…
Apr 22 20:05:45 oa5 systemd[1]: Started alsaloop for volstereo2mono.
Apr 22 20:05:45 oa5 volumio[1970]: playback monoout open error: Device or resource busy
Apr 22 20:05:45 oa5 volumio[1970]: Loopback initialization failure.
Apr 22 20:05:45 oa5 systemd[1]: volstereo2mono.service: main process exited, code=exited, status=1/FAILURE
Apr 22 20:05:45 oa5 systemd[1]: Unit volstereo2mono.service entered failed state.
Apr 22 20:05:45 oa5 systemd[1]: volstereo2mono.service holdoff time over, scheduling restart.
Apr 22 20:05:45 oa5 systemd[1]: Stopping alsaloop for volstereo2mono…
Apr 22 20:05:45 oa5 systemd[1]: Starting alsaloop for volstereo2mono…
Apr 22 20:05:45 oa5 systemd[1]: Started alsaloop for volstereo2mono.
Apr 22 20:05:45 oa5 volumio[1972]: playback monoout open error: Device or resource busy
Apr 22 20:05:45 oa5 volumio[1972]: Loopback initialization failure.
Apr 22 20:05:45 oa5 systemd[1]: volstereo2mono.service: main process exited, code=exited, status=1/FAILURE
Apr 22 20:05:45 oa5 systemd[1]: Unit volstereo2mono.service entered failed state.
Apr 22 20:05:46 oa5 systemd[1]: volstereo2mono.service holdoff time over, scheduling restart.
Apr 22 20:05:46 oa5 systemd[1]: Stopping alsaloop for volstereo2mono…
Apr 22 20:05:46 oa5 systemd[1]: Starting alsaloop for volstereo2mono…
Apr 22 20:05:46 oa5 systemd[1]: volstereo2mono.service start request repeated too quickly, refusing to start.
Apr 22 20:05:46 oa5 systemd[1]: Failed to start alsaloop for volstereo2mono.
Apr 22 20:05:46 oa5 systemd[1]: Unit volstereo2mono.service entered failed state.

Bjorn1 · April 22, 2020, 8:27pm

I realize I´m pasting too much info here, but I´ll get the hang of it

This is from a clean start, without brutefir or volstereo2mono initilized. Then, enabling brutefir - seem ok…

volumio@oa5:/$ sudo journalctl -f
– Logs begin at Wed 2020-04-22 20:21:45 UTC. –
Apr 22 20:23:41 oa5 systemd[1288]: Starting Basic System.
Apr 22 20:23:41 oa5 systemd[1288]: Reached target Basic System.
Apr 22 20:23:41 oa5 systemd[1288]: Starting Default.
Apr 22 20:23:41 oa5 systemd[1288]: Reached target Default.
Apr 22 20:23:41 oa5 systemd[1288]: Startup finished in 32ms.
Apr 22 20:23:41 oa5 systemd[1]: Started User Manager for UID 1000.
Apr 22 20:23:41 oa5 sshd[1283]: lastlog_openseek: Couldn’t stat /var/log/lastlog: No such file or directory
Apr 22 20:23:41 oa5 sshd[1283]: lastlog_openseek: Couldn’t stat /var/log/lastlog: No such file or directory
Apr 22 20:23:58 oa5 sudo[1301]: volumio : TTY=pts/0 ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -f
Apr 22 20:23:58 oa5 sudo[1301]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Apr 22 20:24:13 oa5 volumio[1060]: info: CoreCommandRouter::volumioGetState
Apr 22 20:24:13 oa5 volumio[1060]: info: CoreStateMachine::getState
Apr 22 20:24:13 oa5 volumio[1060]: info: CorePlayQueue::getTrack 0
Apr 22 20:24:13 oa5 sudo[1323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:13 oa5 sudo[1323]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:13 oa5 sudo[1323]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:15 oa5 sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 22 20:24:15 oa5 sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:15 oa5 sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:15 oa5 sudo[1332]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:15 oa5 sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:15 oa5 sudo[1334]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreCommandRouter::volumioGetState
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreStateMachine::getState
Apr 22 20:24:15 oa5 volumio[1060]: info: CorePlayQueue::getTrack 0
Apr 22 20:24:15 oa5 sudo[1350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 22 20:24:15 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 22 20:24:15 oa5 sudo[1350]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:15 oa5 sudo[1352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:15 oa5 sudo[1350]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:15 oa5 sudo[1352]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:15 oa5 volumio[1060]: info: Listing playlists
Apr 22 20:24:15 oa5 sudo[1352]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:17 oa5 volumio[1060]: info: CoreCommandRouter::volumioGetQueue
Apr 22 20:24:17 oa5 volumio[1060]: info: CoreStateMachine::getQueue
Apr 22 20:24:17 oa5 volumio[1060]: info: CorePlayQueue::getQueue
Apr 22 20:24:23 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 22 20:24:26 oa5 volumio[1060]: info: Enabling plugin brutefir
Apr 22 20:24:26 oa5 volumio[1060]: info: Loading plugin “brutefir”…
Apr 22 20:24:27 oa5 volumio[1060]: info: Applying required configuration parameters for plugin brutefir
Apr 22 20:24:27 oa5 volumio[1060]: info: PLUGIN START: brutefir
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:27 oa5 sudo[1381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2
Apr 22 20:24:27 oa5 sudo[1381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:27 oa5 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Apr 22 20:24:27 oa5 volumio[1060]: info: Done.
Apr 22 20:24:27 oa5 sudo[1381]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:27 oa5 volumio[1060]: info: snd_aloop loaded
Apr 22 20:24:27 oa5 volumio[1060]: AAAAAAAAAAAAAAAAAAAAAAAAAA-> 2 <-AAAAAAAAAAAAA
Apr 22 20:24:27 oa5 volumio[1060]: AAAAAAAAAAAAAAAAAAAAAAAAAA-> S16_LE S24_LE S32_LE <-AAAAAAAAAAAAA
Apr 22 20:24:27 oa5 volumio[1060]: AAAAAAAAAAAAAAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA
Apr 22 20:24:27 oa5 volumio[1060]: info: Auto set output format : -------> S32_LE
Apr 22 20:24:27 oa5 volumio[1060]: info: no delay needed
Apr 22 20:24:27 oa5 volumio[1060]: S16_LE
Apr 22 20:24:27 oa5 sudo[1396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart brutefir.service
Apr 22 20:24:27 oa5 sudo[1396]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:27 oa5 systemd[1]: Starting brutefir Daemon…
Apr 22 20:24:27 oa5 systemd[1]: Started brutefir Daemon.
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreCommandRouter::volumioGetState
Apr 22 20:24:27 oa5 volumio[1060]: info: CoreStateMachine::getState
Apr 22 20:24:27 oa5 volumio[1060]: info: CorePlayQueue::getTrack 0
Apr 22 20:24:27 oa5 sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:27 oa5 volumio[1401]: BruteFIR v1.0m (November 2013) © Anders Torger
Apr 22 20:24:27 oa5 sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:27 oa5 volumio[1401]: Internal resolution is 64 bit floating point.
Apr 22 20:24:27 oa5 sudo[1404]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:27 oa5 volumio[1401]: Creating 4 FFTW plans of size 16384…finished.
Apr 22 20:24:27 oa5 sudo[1396]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:28 oa5 volumio[1401]: Loading 16 coefficient sets…finished.
Apr 22 20:24:28 oa5 volumio[1401]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Apr 22 20:24:28 oa5 volumio[1401]: Warning: no support for clock cycle counter on this platform.
Apr 22 20:24:28 oa5 volumio[1401]: Timers for benchmarking may be unreliable.
Apr 22 20:24:28 oa5 volumio[1401]: Filters in process 0: 0 2
Apr 22 20:24:28 oa5 volumio[1401]: Filters in process 1: 1 3
Apr 22 20:24:28 oa5 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Apr 22 20:24:28 oa5 volumio[1060]: info: Starting brutefir
Apr 22 20:24:28 oa5 sudo[1419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start brutefir.service
Apr 22 20:24:28 oa5 sudo[1419]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:28 oa5 systemd[1]: Started brutefir Daemon.
Apr 22 20:24:28 oa5 sudo[1419]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:28 oa5 volumio[1060]: info: Brutefir Daemon Started
Apr 22 20:24:28 oa5 volumio[1401]: Realtime priority 1 set for cli process (pid 1417)
Apr 22 20:24:28 oa5 volumio[1401]: Realtime priority 3 set for input process (pid 1402)
Apr 22 20:24:28 oa5 volumio[1401]: Realtime priority 4 set for filter process (pid 1416)
Apr 22 20:24:28 oa5 volumio[1401]: Realtime priority 4 set for filter process (pid 1415)
Apr 22 20:24:28 oa5 volumio[1401]: Realtime priority 3 set for output process (pid 1427)
Apr 22 20:24:28 oa5 volumio[1401]: Fixed I/O-delay is 16384 samples
Apr 22 20:24:28 oa5 volumio[1401]: Audio processing starts now
Apr 22 20:24:29 oa5 volumio[1060]: info: VolumeController::SetAlsaVolumemute
Apr 22 20:24:29 oa5 volumio[1060]: info: CoreStateMachine::pushState
Apr 22 20:24:29 oa5 volumio[1060]: info: CoreStateMachine::getState
Apr 22 20:24:29 oa5 volumio[1060]: info: CorePlayQueue::getTrack 0
Apr 22 20:24:29 oa5 volumio[1060]: info: CoreCommandRouter::volumioPushState
Apr 22 20:24:29 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 22 20:24:29 oa5 sudo[1431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:29 oa5 volumio[1060]: info: VolumeController::SetAlsaVolumeunmute
Apr 22 20:24:29 oa5 sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:29 oa5 sudo[1431]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:29 oa5 volumio[1060]: info: CoreStateMachine::pushState
Apr 22 20:24:29 oa5 volumio[1060]: info: CoreStateMachine::getState
Apr 22 20:24:29 oa5 volumio[1060]: info: CorePlayQueue::getTrack 0
Apr 22 20:24:29 oa5 volumio[1060]: info: CoreCommandRouter::volumioPushState
Apr 22 20:24:29 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 22 20:24:29 oa5 sudo[1441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:29 oa5 sudo[1441]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:29 oa5 sudo[1441]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:32 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC
Apr 22 20:24:32 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 22 20:24:32 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Apr 22 20:24:32 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 22 20:24:32 oa5 volumio[1060]: info: Output device has changed, restarting MPD
Apr 22 20:24:32 oa5 sudo[1450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 22 20:24:32 oa5 volumio[1060]: info: Output device has changed, restarting Shairport Sync
Apr 22 20:24:32 oa5 sudo[1450]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:32 oa5 sudo[1450]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:32 oa5 sudo[1453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 22 20:24:32 oa5 sudo[1453]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:32 oa5 systemd[1]: Stopping Music Player Daemon…
Apr 22 20:24:32 oa5 volumio[1060]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 22 20:24:32 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 22 20:24:32 oa5 volumio[1060]: info: Device Loopback does not have any Mixer Control Available, setting a softvol device
Apr 22 20:24:33 oa5 systemd[1]: Starting Music Player Daemon…
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Apr 22 20:24:33 oa5 volumio[1060]: info: Updating Volume Controller Parameters: Device: Loopback Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreStateMachine::pushState
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreStateMachine::getState
Apr 22 20:24:33 oa5 volumio[1060]: info: CorePlayQueue::getTrack 0
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::volumioPushState
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 22 20:24:33 oa5 sudo[1477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:33 oa5 volumio[1060]: info: MPD Permissions set
Apr 22 20:24:33 oa5 sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:33 oa5 sudo[1477]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:33 oa5 sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l
Apr 22 20:24:33 oa5 sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:33 oa5 sudo[1484]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:33 oa5 volumio[1060]: info: No Overlays Loaded
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 22 20:24:33 oa5 volumio[1060]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 22 20:24:33 oa5 volumio[1060]: info: Starting Shairport Sync
Apr 22 20:24:33 oa5 sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 22 20:24:33 oa5 sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:33 oa5 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver…
Apr 22 20:24:33 oa5 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver…
Apr 22 20:24:33 oa5 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 22 20:24:33 oa5 sudo[1503]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:33 oa5 sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service
Apr 22 20:24:33 oa5 sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:33 oa5 volumio[1060]: info: Shairport-Sync Started
Apr 22 20:24:33 oa5 systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Apr 22 20:24:33 oa5 systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway.
Apr 22 20:24:33 oa5 systemd[1]: Starting Spotify Daemon…
Apr 22 20:24:33 oa5 systemd[1]: Started Spotify Daemon.
Apr 22 20:24:33 oa5 sudo[1512]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:33 oa5 systemd[1]: Started Music Player Daemon.
Apr 22 20:24:33 oa5 sudo[1453]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:33 oa5 volumio[1060]: info: SpopD Daemon Started
Apr 22 20:24:33 oa5 volumio[1060]: info:
Apr 22 20:24:33 oa5 volumio[1531]: 2020-04-22 20:24:33 [SPTF] 20:24:33.886 I [ap:1752] Connecting to AP ap.spotify.com:4070
Apr 22 20:24:33 oa5 volumio[1531]: 2020-04-22 20:24:33 [SPTF] 20:24:33.961 I [ap:1226] Connected to AP: 35.190.243.13:4070
Apr 22 20:24:34 oa5 volumio[1531]: 2020-04-22 20:24:34 [SPTF] 20:24:34.525 I [offline-mgr:2082] Storage has been cleaned
Apr 22 20:24:35 oa5 volumio[1531]: 2020-04-22 20:24:35 [SPTF] 20:24:35.517 I [offline-mgr:2030] 0 files are locked. 0 images are locked
Apr 22 20:24:35 oa5 volumio[1531]: 2020-04-22 20:24:35 [SPTF] 20:24:35.519 I [offline-mgr:2056] 0 files unlocked. 0 images unlocked
Apr 22 20:24:35 oa5 volumio[1060]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Apr 22 20:24:35 oa5 volumio[1060]: info: CoreStateMachine::getcurrentVolume
Apr 22 20:24:35 oa5 volumio[1060]: info: CoreCommandRouter::volumioRetrievevolume
Apr 22 20:24:35 oa5 volumio[1060]: info: CoreStateMachine::pushState
Apr 22 20:24:35 oa5 volumio[1060]: info: CoreStateMachine::getState
Apr 22 20:24:35 oa5 volumio[1060]: info: CorePlayQueue::getTrack 0
Apr 22 20:24:35 oa5 volumio[1060]: info: CoreCommandRouter::volumioPushState
Apr 22 20:24:35 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 22 20:24:35 oa5 sudo[1547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:35 oa5 sudo[1547]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:35 oa5 sudo[1547]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:38 oa5 volumio[1060]: info: Connecting to daemon
Apr 22 20:24:38 oa5 volumio[1060]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 22 20:24:38 oa5 volumio[1060]: info: [1587587078638] CoreMusicLibrary::Adding element Spotify
Apr 22 20:24:38 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 22 20:24:38 oa5 volumio[1060]: info: FIRST BRANCH
Apr 22 20:24:38 oa5 volumio[1060]: info: An error occurred while listing Spotify featured playlists WebapiError: Unauthorized
Apr 22 20:24:38 oa5 volumio[1060]: info: An error occurred while listing Spotify new albums WebapiError: Unauthorized
Apr 22 20:24:38 oa5 volumio[1060]: info: An error occurred while listing Spotify categories WebapiError: Unauthorized
Apr 22 20:24:38 oa5 volumio[1060]: info: New Spotify access token = BQCA1CZVvQ6hvleL53uhx990prqTuERsZEKAjjK26vH0kwyHgdKtZY4qP967ftL-2SFg-PEA51Di90JdhPJ5UPCGCELHjstNzWOhHi0ma2x-7dHn8xit8VU2krwnq7eDJb1FWMytuIRUG9p4DzZ-XhEuKmU8DwKd5ZHjRy8gilTaJchKXVu8u3x6r4o
Apr 22 20:24:38 oa5 volumio[1060]: info: Spotify credentials grant success - running version from March 24, 2019
Apr 22 20:24:39 oa5 volumio[1060]: { device: ‘1’,
Apr 22 20:24:39 oa5 volumio[1060]: name: ‘IQaudIO Pi-DigiAMP+’,
Apr 22 20:24:39 oa5 volumio[1060]: mixer: ‘Analogue’,
Apr 22 20:24:39 oa5 volumio[1060]: mixertype: ‘Hardware’,
Apr 22 20:24:39 oa5 volumio[1060]: maxvolume: ‘100’,
Apr 22 20:24:39 oa5 volumio[1060]: volumecurve: ‘logarithmic’,
Apr 22 20:24:39 oa5 volumio[1060]: volumestart: ‘disabled’,
Apr 22 20:24:39 oa5 volumio[1060]: volumesteps: ‘10’,
Apr 22 20:24:39 oa5 volumio[1060]: softvolumenumber: ‘undefined’ }
Apr 22 20:24:39 oa5 volumio[1060]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Apr 22 20:24:39 oa5 volumio[1060]: info: Updating Volume Controller Parameters: Device: 1 Name: IQaudIO Pi-DigiAMP+ Mixer: Analogue Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10
Apr 22 20:24:39 oa5 volumio[1060]: info: VolumeController:: Volume=100 Mute =false
Apr 22 20:24:39 oa5 volumio[1060]: info: CoreStateMachine::pushState
Apr 22 20:24:39 oa5 volumio[1060]: info: CoreStateMachine::getState
Apr 22 20:24:39 oa5 volumio[1060]: info: CorePlayQueue::getTrack 0
Apr 22 20:24:39 oa5 volumio[1060]: info: CoreCommandRouter::volumioPushState
Apr 22 20:24:39 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 22 20:24:39 oa5 sudo[1558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:24:39 oa5 sudo[1558]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:24:39 oa5 sudo[1558]: pam_unix(sudo:session): session closed for user root
Apr 22 20:24:44 oa5 volumio[1060]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam

Bjorn1 · April 22, 2020, 8:35pm

here we have a “save” from the GUI. (see - already less text )

Apr 22 20:31:14 oa5 volumio[1061]: info: CALLMETHOD: audio_interface brutefir saveBrutefirconfigAccount2 [object Object]
Apr 22 20:31:14 oa5 volumio[1061]: info: CoreCommandRouter::executeOnPlugin: brutefir , saveBrutefirconfigAccount2
Apr 22 20:31:16 oa5 volumio[1061]: info: -------->filter txt text
Apr 22 20:31:16 oa5 volumio[1061]: false + false
Apr 22 20:31:16 oa5 volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 22 20:31:16 oa5 volumio[1061]: info: no delay needed
Apr 22 20:31:16 oa5 volumio[1061]: S16_LE
Apr 22 20:31:16 oa5 volumio[1061]: info: Number of channels detected : ----------->2
Apr 22 20:31:16 oa5 volumio[1061]: info: HW sample rate : 44100 48000 88200 96000 176400 192000
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available HW sample rate :,44100,48000,88200,96000,176400,192000
Apr 22 20:31:16 oa5 volumio[1061]: info: result formats ,HW-Detected-S16_LE,HW-Detected-S24_LE,HW-Detected-S32_LE, Factory_S16_LE, Factory_S24_LE, Factory_S24_3LE, Factory_S24_4LE, Factory_S32_LE,
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters for DRC :None,HP60bw18r96.txt,LP80bw42r96.txt,demo-left-soft-44.1kHz-HK5.pcm,demo-right-soft-44.1kHz-HK5.pcm
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :None
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :HP60bw18r96.txt
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :LP80bw42r96.txt
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :demo-left-soft-44.1kHz-HK5.pcm
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :demo-right-soft-44.1kHz-HK5.pcm
Apr 22 20:31:16 oa5 volumio[1061]: [ ‘demo-impulse-left.wav’, ‘demo-impulse-right.wav’ ]
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available curves :HK5.txt,HK8.txt,bk.txt,qa2.txt
Apr 22 20:31:16 oa5 volumio[1061]: [ ‘HK5.txt’, ‘HK8.txt’, ‘bk.txt’, ‘qa2.txt’ ]
Apr 22 20:31:16 oa5 volumio[1061]: info: CoreCommandRouter::Reload Ui
Apr 22 20:31:16 oa5 sudo[1574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart brutefir.service
Apr 22 20:31:16 oa5 sudo[1574]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:31:16 oa5 systemd[1]: Stopping brutefir Daemon…
Apr 22 20:31:16 oa5 systemd[1]: Starting brutefir Daemon…
Apr 22 20:31:16 oa5 systemd[1]: Started brutefir Daemon.
Apr 22 20:31:16 oa5 sudo[1574]: pam_unix(sudo:session): session closed for user root
Apr 22 20:31:16 oa5 volumio[1579]: BruteFIR v1.0m (November 2013) © Anders Torger
Apr 22 20:31:16 oa5 volumio[1579]: Internal resolution is 64 bit floating point.
Apr 22 20:31:16 oa5 volumio[1579]: Creating 4 FFTW plans of size 16384…finished.
Apr 22 20:31:16 oa5 sudo[1585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 22 20:31:16 oa5 sudo[1585]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:31:16 oa5 sudo[1587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:31:16 oa5 sudo[1585]: pam_unix(sudo:session): session closed for user root
Apr 22 20:31:16 oa5 sudo[1587]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:31:16 oa5 sudo[1587]: pam_unix(sudo:session): session closed for user root
Apr 22 20:31:16 oa5 volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 22 20:31:16 oa5 volumio[1061]: info: Number of channels detected : ----------->2
Apr 22 20:31:16 oa5 volumio[1061]: info: HW sample rate : 44100 48000 88200 96000 176400 192000
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available HW sample rate :,44100,48000,88200,96000,176400,192000
Apr 22 20:31:16 oa5 volumio[1061]: info: result formats ,HW-Detected-S16_LE,HW-Detected-S24_LE,HW-Detected-S32_LE, Factory_S16_LE, Factory_S24_LE, Factory_S24_3LE, Factory_S24_4LE, Factory_S32_LE,
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters for DRC :None,HP60bw18r96.txt,LP80bw42r96.txt,demo-left-soft-44.1kHz-HK5.pcm,demo-right-soft-44.1kHz-HK5.pcm
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :None
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :HP60bw18r96.txt
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :LP80bw42r96.txt
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :demo-left-soft-44.1kHz-HK5.pcm
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available filters UI :demo-right-soft-44.1kHz-HK5.pcm
Apr 22 20:31:16 oa5 volumio[1061]: [ ‘demo-impulse-left.wav’, ‘demo-impulse-right.wav’ ]
Apr 22 20:31:16 oa5 volumio[1061]: info: list of available curves :HK5.txt,HK8.txt,bk.txt,qa2.txt
Apr 22 20:31:16 oa5 volumio[1061]: [ ‘HK5.txt’, ‘HK8.txt’, ‘bk.txt’, ‘qa2.txt’ ]
Apr 22 20:31:17 oa5 volumio[1579]: Loading 16 coefficient sets…finished.
Apr 22 20:31:17 oa5 volumio[1579]: Realtime priorities are min = 2, usermax = 1, mid = 3 and max = 4.
Apr 22 20:31:17 oa5 volumio[1579]: Warning: no support for clock cycle counter on this platform.
Apr 22 20:31:17 oa5 volumio[1579]: Timers for benchmarking may be unreliable.
Apr 22 20:31:17 oa5 volumio[1579]: Filters in process 0: 0 2
Apr 22 20:31:17 oa5 volumio[1579]: Filters in process 1: 1 3
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreCommandRouter::volumioGetState
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreStateMachine::getState
Apr 22 20:31:17 oa5 volumio[1061]: info: CorePlayQueue::getTrack 0
Apr 22 20:31:17 oa5 sudo[1603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 22 20:31:17 oa5 sudo[1605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:31:17 oa5 sudo[1603]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:31:17 oa5 sudo[1605]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:31:17 oa5 sudo[1603]: pam_unix(sudo:session): session closed for user root
Apr 22 20:31:17 oa5 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Apr 22 20:31:17 oa5 sudo[1605]: pam_unix(sudo:session): session closed for user root
Apr 22 20:31:17 oa5 volumio[1579]: Realtime priority 1 set for cli process (pid 1626)
Apr 22 20:31:17 oa5 volumio[1579]: Realtime priority 3 set for input process (pid 1582)
Apr 22 20:31:17 oa5 volumio[1579]: Realtime priority 4 set for filter process (pid 1624)
Apr 22 20:31:17 oa5 volumio[1579]: Realtime priority 4 set for filter process (pid 1625)
Apr 22 20:31:17 oa5 volumio[1579]: Realtime priority 3 set for output process (pid 1627)
Apr 22 20:31:17 oa5 volumio[1579]: Fixed I/O-delay is 16384 samples
Apr 22 20:31:17 oa5 volumio[1579]: Audio processing starts now
Apr 22 20:31:17 oa5 volumio[1061]: info: VolumeController::SetAlsaVolumemute
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreStateMachine::pushState
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreStateMachine::getState
Apr 22 20:31:17 oa5 volumio[1061]: info: CorePlayQueue::getTrack 0
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreCommandRouter::volumioPushState
Apr 22 20:31:17 oa5 volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 22 20:31:18 oa5 sudo[1631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:31:18 oa5 sudo[1631]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:31:18 oa5 volumio[1061]: info: VolumeController::SetAlsaVolumeunmute
Apr 22 20:31:18 oa5 sudo[1631]: pam_unix(sudo:session): session closed for user root
Apr 22 20:31:18 oa5 volumio[1061]: info: CoreStateMachine::pushState
Apr 22 20:31:18 oa5 volumio[1061]: info: CoreStateMachine::getState
Apr 22 20:31:18 oa5 volumio[1061]: info: CorePlayQueue::getTrack 0
Apr 22 20:31:18 oa5 volumio[1061]: info: CoreCommandRouter::volumioPushState
Apr 22 20:31:18 oa5 volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 22 20:31:18 oa5 sudo[1641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:31:18 oa5 sudo[1641]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:31:18 oa5 sudo[1641]: pam_unix(sudo:session): session closed for user root

Bjorn1 · April 22, 2020, 8:43pm

I guess this is from enabling the plugin volstereo2mono… (NOT enabling mono - just enabling the plugin)

(did a reboot in between)

Apr 22 20:39:53 oa5 volumio[1051]: { device: ‘1’,
Apr 22 20:39:53 oa5 volumio[1051]: name: ‘IQaudIO Pi-DigiAMP+’,
Apr 22 20:39:53 oa5 volumio[1051]: mixer: ‘Analogue’,
Apr 22 20:39:53 oa5 volumio[1051]: mixertype: ‘Hardware’,
Apr 22 20:39:53 oa5 volumio[1051]: maxvolume: ‘100’,
Apr 22 20:39:53 oa5 volumio[1051]: volumecurve: ‘logarithmic’,
Apr 22 20:39:53 oa5 volumio[1051]: volumestart: ‘disabled’,
Apr 22 20:39:53 oa5 volumio[1051]: volumesteps: ‘10’,
Apr 22 20:39:53 oa5 volumio[1051]: softvolumenumber: ‘undefined’ }
Apr 22 20:39:53 oa5 volumio[1051]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Apr 22 20:39:53 oa5 volumio[1051]: info: Updating Volume Controller Parameters: Device: 1 Name: IQaudIO Pi-DigiAMP+ Mixer: Analogue Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10
Apr 22 20:39:53 oa5 sudo[1963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volstereo2mono.service
Apr 22 20:39:53 oa5 sudo[1963]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:39:53 oa5 systemd[1]: Starting alsaloop for volstereo2mono…
Apr 22 20:39:53 oa5 systemd[1]: Started alsaloop for volstereo2mono.
Apr 22 20:39:53 oa5 sudo[1963]: pam_unix(sudo:session): session closed for user root
Apr 22 20:39:53 oa5 volumio[1051]: info: VolumeController:: Volume=100 Mute =false
Apr 22 20:39:53 oa5 volumio[1051]: info: CoreStateMachine::pushState
Apr 22 20:39:53 oa5 volumio[1051]: info: CoreStateMachine::getState
Apr 22 20:39:53 oa5 volumio[1051]: info: CorePlayQueue::getTrack 0
Apr 22 20:39:53 oa5 volumio[1051]: info: CoreCommandRouter::volumioPushState
Apr 22 20:39:53 oa5 volumio[1051]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 22 20:39:53 oa5 volumio[1051]: info: Alsaloop bridge ok
Apr 22 20:39:53 oa5 sudo[1974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 22 20:39:53 oa5 sudo[1974]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 22 20:39:53 oa5 sudo[1974]: pam_unix(sudo:session): session closed for user root
Apr 22 20:39:58 oa5 volumio[1051]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam

Bjorn1 · April 22, 2020, 8:46pm

and this time it worked, of course…

Bjorn1 · April 22, 2020, 9:12pm

ok, but after a restart we are seeing the problem again. Mono i obviously not working (using my testfile)

If I just set the volstereo2mono to “off” - we see the same pattern as before:

Apr 22 21:09:50 oa5 volumio[2320]: playback monoout open error: Device or resource busy
Apr 22 21:09:50 oa5 volumio[2320]: Loopback initialization failure.
Apr 22 21:09:50 oa5 systemd[1]: volstereo2mono.service: main process exited, code=exited, status=1/FAILURE
Apr 22 21:09:50 oa5 systemd[1]: Unit volstereo2mono.service entered failed state.
Apr 22 21:09:50 oa5 systemd[1]: volstereo2mono.service holdoff time over, scheduling restart.
Apr 22 21:09:50 oa5 systemd[1]: Stopping alsaloop for volstereo2mono…
Apr 22 21:09:50 oa5 systemd[1]: Starting alsaloop for volstereo2mono…
Apr 22 21:09:50 oa5 systemd[1]: Started alsaloop for volstereo2mono.
Apr 22 21:09:50 oa5 volumio[2322]: playback monoout open error: Device or resource busy
Apr 22 21:09:50 oa5 volumio[2322]: Loopback initialization failure.
Apr 22 21:09:50 oa5 systemd[1]: volstereo2mono.service: main process exited, code=exited, status=1/FAILURE
Apr 22 21:09:50 oa5 systemd[1]: Unit volstereo2mono.service entered failed state.
Apr 22 21:09:51 oa5 systemd[1]: volstereo2mono.service holdoff time over, scheduling restart.
Apr 22 21:09:51 oa5 systemd[1]: Stopping alsaloop for volstereo2mono…
Apr 22 21:09:51 oa5 systemd[1]: Starting alsaloop for volstereo2mono…
Apr 22 21:09:51 oa5 systemd[1]: volstereo2mono.service start request repeated too quickly, refusing to start.
Apr 22 21:09:51 oa5 systemd[1]: Failed to start alsaloop for volstereo2mono.
Apr 22 21:09:51 oa5 systemd[1]: Unit volstereo2mono.service entered failed state.

Bjorn1 · April 23, 2020, 10:27pm

I tested to enable and disable plugins to spot any different behaviour. Kind of “semilucky” with that. I now CAN get the volstereo2mono to work by doing the following:

Disable volstereo2mono
reboot
enable volstereo2mono

works!

After a reboot, the plugin wont start due to “device busy”. So, disable the plugin, reboot, enable and it works again.

Following the sequences with journalctl, I suspect some delay for the start of the volstereo2mono might help. Google is not my friend today, and I have found no resources to where this could be set (delay fort the plugin).

Any ideas?

//Björn

Bjorn1 · April 23, 2020, 11:21pm

I guess it could be here somewhere:

/data/plugins/audio_interface/volstereo2mono/index.js

Bjorn1 · April 27, 2020, 7:31pm

Any ideas om how to delay the start of a plugin?