-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Tue 2024-05-07 16:15:36 CEST. --
May 07 16:14:00 volumio-c4 systemd[1]: Starting Daily apt download activities...
May 07 16:14:00 volumio-c4 volumio[4642]: info: Loading plugin "alarm-clock"...
May 07 16:14:01 volumio-c4 volumio[4642]: info: Loading plugin "airplay_emulation"...
May 07 16:14:01 volumio-c4 volumio[4642]: info: Starting Shairport Sync
May 07 16:14:01 volumio-c4 volumio[4642]: info: Loading plugin "last_100"...
May 07 16:14:01 volumio-c4 volumio[4642]: info: Loading plugin "webradio"...
May 07 16:14:01 volumio-c4 volumio[4642]: info: Loading plugin "i2s_dacs"...
May 07 16:14:01 volumio-c4 volumio[4642]: info: I2S DAC not set, start Auto-detection
May 07 16:14:01 volumio-c4 volumio[4642]: info: Loading plugin "volumiodiscovery"...
May 07 16:14:01 volumio-c4 volumio[4642]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 07 16:14:01 volumio-c4 volumio[4642]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 07 16:14:01 volumio-c4 volumio[4642]: *** WARNING *** For more information see 
May 07 16:14:01 volumio-c4 volumio[4642]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 07 16:14:01 volumio-c4 node[4642]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 07 16:14:01 volumio-c4 volumio[4642]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 07 16:14:01 volumio-c4 volumio[4642]: *** WARNING *** For more information see 
May 07 16:14:01 volumio-c4 node[4642]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 07 16:14:01 volumio-c4 node[4642]: *** WARNING *** For more information see 
May 07 16:14:01 volumio-c4 node[4642]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 07 16:14:01 volumio-c4 node[4642]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 07 16:14:01 volumio-c4 node[4642]: *** WARNING *** For more information see 
May 07 16:14:01 volumio-c4 volumio[4642]: info: Applying required configuration parameters for plugin volumiodiscovery
May 07 16:14:01 volumio-c4 volumio[4642]: info: Discovery: Started advertising with name: Volumio-C4
May 07 16:14:01 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 07 16:14:01 volumio-c4 volumio[4642]: info: Loading plugin "gpio-buttons"...
May 07 16:14:01 volumio-c4 volumio-remote-updater[3708]: [2024-05-07 16:14:01] [connect] Successful connection
May 07 16:14:03 volumio-c4 sudo[4813]: pam_unix(sudo:session): session closed for user root
May 07 16:14:03 volumio-c4 volumio[4642]: info: GPIO-Buttons initialized
May 07 16:14:03 volumio-c4 volumio[4642]: info: Loading plugin "outputs"...
May 07 16:14:03 volumio-c4 volumio[4642]: info: Loading plugin "albumart"...
May 07 16:14:04 volumio-c4 volumio[4642]: info: Plugin example_plugin is not enabled
May 07 16:14:04 volumio-c4 volumio[4642]: info: Loading plugin "inputs"...
May 07 16:14:04 volumio-c4 volumio[4642]: info: Loading plugin "updater_comm"...
May 07 16:14:04 volumio-c4 systemd[1]: apt-daily.service: Succeeded.
May 07 16:14:04 volumio-c4 systemd[1]: Started Daily apt download activities.
May 07 16:14:04 volumio-c4 systemd[1]: Starting Daily apt upgrade and clean activities...
May 07 16:14:04 volumio-c4 volumio[4642]: info: Plugin mpdemulation is not enabled
May 07 16:14:04 volumio-c4 volumio[4642]: info: Loading plugin "rest_api"...
May 07 16:14:04 volumio-c4 volumio[4642]: info: Loading plugin "websocket"...
May 07 16:14:04 volumio-c4 volumio[4642]: info: Loading plugin "gpio_control"...
May 07 16:14:04 volumio-c4 volumio[4642]: Forking 3 albumart workers
May 07 16:14:05 volumio-c4 volumio[4642]: Starting albumart workers
May 07 16:14:05 volumio-c4 volumio[4642]: Starting albumart workers
May 07 16:14:05 volumio-c4 volumio[4642]: Starting albumart workers
May 07 16:14:05 volumio-c4 kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 16:14:05 volumio-c4 kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 16:14:05 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 07 16:14:05 volumio-c4 sudo[4823]: pam_unix(sudo:session): session closed for user root
May 07 16:14:05 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 07 16:14:05 volumio-c4 sudo[4825]: pam_unix(sudo:session): session closed for user root
May 07 16:14:05 volumio-c4 systemd[1]: apt-daily-upgrade.service: Succeeded.
May 07 16:14:05 volumio-c4 systemd[1]: Started Daily apt upgrade and clean activities.
May 07 16:14:06 volumio-c4 volumio[4642]: error: !!!! WARNING !!!!
May 07 16:14:06 volumio-c4 volumio[4642]: error: The plugin system_hardware/gpio_control failed to load, setting it to stopped. Error: TypeError: Cannot read property '0' of null
May 07 16:14:06 volumio-c4 volumio[4642]: error: Stack trace: TypeError: Cannot read property '0' of null
May 07 16:14:06 volumio-c4 volumio[4642]:     at GPIOControl.getPiBoardInfo (/data/plugins/system_hardware/gpio_control/index.js:511:12)
May 07 16:14:06 volumio-c4 volumio[4642]:     at new GPIOControl (/data/plugins/system_hardware/gpio_control/index.js:35:22)
May 07 16:14:06 volumio-c4 volumio[4642]:     at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:24)
May 07 16:14:06 volumio-c4 volumio[4642]:     at /volumio/app/pluginmanager.js:338:34
May 07 16:14:06 volumio-c4 volumio[4642]:     at Array.forEach ()
May 07 16:14:06 volumio-c4 volumio[4642]:     at HashMap. (/volumio/app/pluginmanager.js:337:20)
May 07 16:14:06 volumio-c4 volumio[4642]:     at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
May 07 16:14:06 volumio-c4 volumio[4642]:     at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
May 07 16:14:06 volumio-c4 volumio[4642]:     at PluginManager.loadCorePlugins (/volumio/app/pluginmanager.js:335:18)
May 07 16:14:06 volumio-c4 volumio[4642]:     at PluginManager.startPlugins (/volumio/app/pluginmanager.js:102:26)
May 07 16:14:06 volumio-c4 volumio[4642]:     at new CoreCommandRouter (/volumio/app/index.js:48:42)
May 07 16:14:06 volumio-c4 volumio[4642]:     at Object. (/volumio/index.js:51:21)
May 07 16:14:06 volumio-c4 volumio[4642]:     at Module._compile (internal/modules/cjs/loader.js:1114:14)
May 07 16:14:06 volumio-c4 volumio[4642]:     at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10)
May 07 16:14:06 volumio-c4 volumio[4642]:     at Module.load (internal/modules/cjs/loader.js:979:32)
May 07 16:14:06 volumio-c4 volumio[4642]:     at Function.Module._load (internal/modules/cjs/loader.js:819:12)
May 07 16:14:06 volumio-c4 volumio[4642]: error: !!!! WARNING !!!!
May 07 16:14:06 volumio-c4 volumio[4642]: info: Loading plugin "ir_controller"...
May 07 16:14:06 volumio-c4 volumio[4642]: info: Applying required configuration parameters for plugin ir_controller
May 07 16:14:06 volumio-c4 volumio[4642]: info: Loading plugin "rotaryencoder2"...
May 07 16:14:07 volumio-c4 systemd[1]: systemd-fsckd.service: Succeeded.
May 07 16:14:07 volumio-c4 sh[3450]: timed out
May 07 16:14:07 volumio-c4 dhcpcd[3607]: timed out
May 07 16:14:07 volumio-c4 sh[3450]: dhcpcd exited
May 07 16:14:07 volumio-c4 dhcpcd[3607]: dhcpcd exited
May 07 16:14:07 volumio-c4 sh[3450]: ifup: failed to bring up eth0
May 07 16:14:07 volumio-c4 systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
May 07 16:14:07 volumio-c4 systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
May 07 16:14:07 volumio-c4 volumio[4642]: info: Loading plugin "Systeminfo"...
May 07 16:14:08 volumio-c4 volumio[4642]: info: Loading i18n strings for locale de
May 07 16:14:08 volumio-c4 volumio[4642]: Updating browse sources language
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::initPlayerControls
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: Express server listening on port 3000
May 07 16:14:08 volumio-c4 volumio[4642]:  [Metrics]  WebUI:  13s 221.11ms 
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreStateMachine::resetVolumioState
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreStateMachine::getcurrentVolume
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioRetrievevolume
May 07 16:14:08 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:08 volumio-c4 volumio[4642]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
May 07 16:14:08 volumio-c4 volumio[4642]: info: Completed loading Core Plugins
May 07 16:14:08 volumio-c4 volumio[4642]: info: Preparing to generate the ALSA configuration file
May 07 16:14:09 volumio-c4 volumio[4642]: info: Cannot mount NAS NAS6A9DE8 at system boot, trial number 1 ,retrying in 5 seconds
May 07 16:14:09 volumio-c4 volumio[4642]: info: Cannot mount NAS NAS6A5781 at system boot, trial number 1 ,retrying in 5 seconds
May 07 16:14:09 volumio-c4 volumio[4642]: info: Cannot mount NAS NASD7FEFD at system boot, trial number 1 ,retrying in 5 seconds
May 07 16:14:09 volumio-c4 volumio[4642]: Unable to parse:
May 07 16:14:09 volumio-c4 volumio[4642]:  Simple mixer control 'Audio hdmi-out mute',0
May 07 16:14:09 volumio-c4 volumio[4642]:   Capabilities: pswitch pswitch-joined
May 07 16:14:09 volumio-c4 volumio[4642]:   Playback channels: Mono
May 07 16:14:09 volumio-c4 volumio[4642]:   Mono: Playback [off]
May 07 16:14:09 volumio-c4 volumio[4642]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
May 07 16:14:09 volumio-c4 volumio[4642]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1
May 07 16:14:09 volumio-c4 volumio[4642]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2
May 07 16:14:09 volumio-c4 volumio[4642]: info: Reloading queue from file
May 07 16:14:09 volumio-c4 volumio[4642]: Unable to parse:
May 07 16:14:09 volumio-c4 volumio[4642]:  Simple mixer control 'Audio hdmi-out mute',0
May 07 16:14:09 volumio-c4 volumio[4642]:   Capabilities: pswitch pswitch-joined
May 07 16:14:09 volumio-c4 volumio[4642]:   Playback channels: Mono
May 07 16:14:09 volumio-c4 volumio[4642]:   Mono: Playback [off]
May 07 16:14:09 volumio-c4 volumio[4642]: info: VolumeController:: Volume=undefined Mute =false
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreStateMachine::pushState
May 07 16:14:09 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioPushState
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreStateMachine::updateTrackBlock
May 07 16:14:09 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrackBlock
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioRetrievevolume
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreStateMachine::setRepeat null single undefined
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreStateMachine::pushState
May 07 16:14:09 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioPushState
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreStateMachine::setRandom false
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreStateMachine::pushState
May 07 16:14:09 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioPushState
May 07 16:14:09 volumio-c4 volumio[4642]: Unable to parse:
May 07 16:14:09 volumio-c4 volumio[4642]:  Simple mixer control 'Audio hdmi-out mute',0
May 07 16:14:09 volumio-c4 volumio[4642]:   Capabilities: pswitch pswitch-joined
May 07 16:14:09 volumio-c4 volumio[4642]:   Playback channels: Mono
May 07 16:14:09 volumio-c4 volumio[4642]:   Mono: Playback [off]
May 07 16:14:09 volumio-c4 volumio[4642]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
May 07 16:14:09 volumio-c4 volumio[4642]: info: Asound.conf file written
May 07 16:14:09 volumio-c4 sudo[5108]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
May 07 16:14:09 volumio-c4 sudo[5108]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:09 volumio-c4 sudo[5108]: pam_unix(sudo:session): session closed for user root
May 07 16:14:09 volumio-c4 kernel: out of value, fixed it
May 07 16:14:09 volumio-c4 kernel: id=0 set inskew=0
May 07 16:14:09 volumio-c4 kernel: Fine tdm clk setting range (0~2000000), 11289593
May 07 16:14:09 volumio-c4 kernel: out of value, fixed it
May 07 16:14:09 volumio-c4 kernel: id=0 set inskew=0
May 07 16:14:09 volumio-c4 volumio[4642]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted
May 07 16:14:09 volumio-c4 volumio[4642]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted
May 07 16:14:09 volumio-c4 volumio[4642]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted
May 07 16:14:09 volumio-c4 volumio[4642]: info: Output device has changed, restarting MPD
May 07 16:14:09 volumio-c4 sudo[5113]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 07 16:14:09 volumio-c4 sudo[5113]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:09 volumio-c4 volumio[4642]: info: Output device has changed, restarting Shairport Sync
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:09 volumio-c4 sudo[5113]: pam_unix(sudo:session): session closed for user root
May 07 16:14:09 volumio-c4 sudo[5115]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 07 16:14:09 volumio-c4 sudo[5115]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:09 volumio-c4 systemd[1]: Listening on mpd.socket.
May 07 16:14:09 volumio-c4 systemd[1]: Starting Music Player Daemon...
May 07 16:14:09 volumio-c4 volumio[4642]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 07 16:14:09 volumio-c4 volumio[4642]: info: ___________ START PLUGINS ___________
May 07 16:14:09 volumio-c4 volumio[4642]: info: ControllerMpd::onStart: Initializing MPD
May 07 16:14:09 volumio-c4 volumio[4642]: info: Creating MPD Configuration file
May 07 16:14:09 volumio-c4 sudo[5138]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 07 16:14:09 volumio-c4 sudo[5138]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 16:14:09 volumio-c4 volumio[4642]: info: [1715091249596] CoreMusicLibrary::Adding element Medienserver
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 16:14:09 volumio-c4 sudo[5138]: pam_unix(sudo:session): session closed for user root
May 07 16:14:09 volumio-c4 sudo[5140]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 07 16:14:09 volumio-c4 sudo[5140]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:09 volumio-c4 volumio[4642]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:09 volumio-c4 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
May 07 16:14:09 volumio-c4 systemd[1]: mpd.service: Succeeded.
May 07 16:14:09 volumio-c4 systemd[1]: Stopped Music Player Daemon.
May 07 16:14:09 volumio-c4 systemd[1]: Starting Music Player Daemon...
May 07 16:14:09 volumio-c4 volumio[4642]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 16:14:09 volumio-c4 volumio[4642]: info: [1715091249701] CoreMusicLibrary::Adding element Last_100
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 16:14:09 volumio-c4 volumio[4642]: info: [1715091249705] CoreMusicLibrary::Adding element Webradio
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 07 16:14:09 volumio-c4 volumio[4642]: info: GPIO-Buttons: Reading config and creating triggers...
May 07 16:14:09 volumio-c4 volumio[4642]: info: Loading i18n strings for locale de
May 07 16:14:09 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 07 16:14:09 volumio-c4 volumio[4642]: info: Volumio Calling Home
May 07 16:14:09 volumio-c4 volumio[4642]: info: GPIO-Buttons started
May 07 16:14:10 volumio-c4 sudo[5175]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/hardware.conf /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc
May 07 16:14:10 volumio-c4 sudo[5175]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:10 volumio-c4 sudo[5175]: pam_unix(sudo:session): session closed for user root
May 07 16:14:10 volumio-c4 volumio[4642]: info: Discovery: adding 2e0b9267-1ece-444b-95a9-53d51900c65f
May 07 16:14:10 volumio-c4 volumio[4642]: info: Discovery: Found device Volumio-C4
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:14:10 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:10 volumio-c4 volumio[4642]: Unable to parse:
May 07 16:14:10 volumio-c4 volumio[4642]:  Simple mixer control 'Audio hdmi-out mute',0
May 07 16:14:10 volumio-c4 volumio[4642]:   Capabilities: pswitch pswitch-joined
May 07 16:14:10 volumio-c4 volumio[4642]:   Playback channels: Mono
May 07 16:14:10 volumio-c4 volumio[4642]:   Mono: Playback [off]
May 07 16:14:10 volumio-c4 volumio[4642]: info: VolumeController:: Volume=undefined Mute =false
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreStateMachine::pushState
May 07 16:14:10 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioPushState
May 07 16:14:10 volumio-c4 sudo[5178]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 07 16:14:10 volumio-c4 sudo[5178]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:10 volumio-c4 sudo[5178]: pam_unix(sudo:session): session closed for user root
May 07 16:14:10 volumio-c4 sudo[5180]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 07 16:14:10 volumio-c4 sudo[5180]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:10 volumio-c4 sudo[5180]: pam_unix(sudo:session): session closed for user root
May 07 16:14:10 volumio-c4 volumio[4642]: info: ir_controller: File permissions successfully set on /etc/lirc/*.
May 07 16:14:10 volumio-c4 volumio[4642]: info: MPD Permissions set
May 07 16:14:10 volumio-c4 volumio[4642]: info: MPD Permissions set
May 07 16:14:10 volumio-c4 volumio[4642]: info: Volumio called home
May 07 16:14:10 volumio-c4 volumio[4642]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3
May 07 16:14:10 volumio-c4 volumio[4642]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:10 volumio-c4 volumio[4642]: info: Starting Shairport Sync
May 07 16:14:10 volumio-c4 sudo[5196]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 07 16:14:10 volumio-c4 sudo[5196]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:10 volumio-c4 volumio[4642]: info: Starting Shairport Sync
May 07 16:14:10 volumio-c4 volumio[4642]: info: Starting Shairport Sync
May 07 16:14:10 volumio-c4 sudo[5198]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 07 16:14:10 volumio-c4 sudo[5198]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:10 volumio-c4 systemd[1]: Started UPnP Renderer front-end to MPD.
May 07 16:14:10 volumio-c4 sudo[5196]: pam_unix(sudo:session): session closed for user root
May 07 16:14:10 volumio-c4 sudo[5201]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 07 16:14:10 volumio-c4 sudo[5201]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:10 volumio-c4 sudo[5213]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 07 16:14:10 volumio-c4 sudo[5213]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:10 volumio-c4 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 07 16:14:10 volumio-c4 systemd[1]: shairport-sync.service: Succeeded.
May 07 16:14:10 volumio-c4 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 07 16:14:10 volumio-c4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 07 16:14:10 volumio-c4 sudo[5201]: pam_unix(sudo:session): session closed for user root
May 07 16:14:10 volumio-c4 sudo[5198]: pam_unix(sudo:session): session closed for user root
May 07 16:14:10 volumio-c4 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 07 16:14:10 volumio-c4 volumio[4642]: info: ir_controller: LIRC correctly updated.
May 07 16:14:10 volumio-c4 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
May 07 16:14:10 volumio-c4 systemd[1]: shairport-sync.service: Succeeded.
May 07 16:14:10 volumio-c4 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 07 16:14:10 volumio-c4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 07 16:14:10 volumio-c4 sudo[5213]: pam_unix(sudo:session): session closed for user root
May 07 16:14:10 volumio-c4 volumio[4642]: info: Upmpdcli Daemon Started
May 07 16:14:10 volumio-c4 volumio[4642]: info: Shairport-Sync Started
May 07 16:14:10 volumio-c4 volumio[4642]: Error adding Membership: Error: addMembership EINVAL
May 07 16:14:10 volumio-c4 volumio[4642]: info: Shairport-Sync Started
May 07 16:14:10 volumio-c4 volumio[4642]: info: Shairport-Sync Started
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:14:10 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:10 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:14:10 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:11 volumio-c4 sudo[5266]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service
May 07 16:14:11 volumio-c4 sudo[5266]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:11 volumio-c4 systemd[1]: Starting lircd(8) initialization helper tool...
May 07 16:14:12 volumio-c4 kernel: Registered IR keymap rc-empty
May 07 16:14:12 volumio-c4 kernel: input: meson-ir as /devices/platform/ff808040.meson-ir/rc/rc0/input1
May 07 16:14:12 volumio-c4 kernel: rc rc0: meson-ir as /devices/platform/ff808040.meson-ir/rc/rc0
May 07 16:14:12 volumio-c4 kernel: meson-ir ff808040.meson-ir: AO_RTI_PIN_MUX : 0x50150011
May 07 16:14:12 volumio-c4 kernel: meson-ir ff808040.meson-ir: receiver initialized
May 07 16:14:12 volumio-c4 lircd-setup[5268]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead.
May 07 16:14:12 volumio-c4 lircd-setup[5268]:   parser = configparser.SafeConfigParser()
May 07 16:14:12 volumio-c4 kernel: lirc_dev: IR Remote Control driver registered, major 499
May 07 16:14:12 volumio-c4 kernel: rc rc0: lirc_dev: driver ir-lirc-codec (meson-ir) registered at minor = 0
May 07 16:14:12 volumio-c4 kernel: IR LIRC bridge handler initialized
May 07 16:14:12 volumio-c4 systemd[1]: lircd-setup.service: Succeeded.
May 07 16:14:12 volumio-c4 systemd[1]: Started lircd(8) initialization helper tool.
May 07 16:14:12 volumio-c4 systemd[1]: Starting Flexible IR remote input/output application support...
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Info: lircd:  Opening log, level: Info
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Version: lircd 0.10.1
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: System info: Linux volumio-c4 4.9.241+ #15 SMP PREEMPT Thu Feb 10 11:27:37 CET 2022 aarch64 GNU/Linux
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Info: Initial device: /dev/lirc0
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Info: Initial device: /dev/lirc0
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Info: [lirc] protocol is enabled
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: driver: default
May 07 16:14:12 volumio-c4 lircd[5304]: lircd-0.10.1[5304]: Info: lircd:  Opening log, level: Info
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: output: /var/run/lirc/lircd
May 07 16:14:12 volumio-c4 lircd[5304]: lircd-0.10.1[5304]: Notice: Using systemd fd
May 07 16:14:12 volumio-c4 lircd[5304]: lircd-0.10.1[5304]: Warning: Running as root
May 07 16:14:12 volumio-c4 lircd[5304]: lircd-0.10.1[5304]: Info: Using remote: odroid.
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: nodaemon: 1
May 07 16:14:12 volumio-c4 lircd[5304]: lircd-0.10.1[5304]: Notice: lircd(default) ready, using /var/run/lirc/lircd
May 07 16:14:12 volumio-c4 systemd[1]: Started Flexible IR remote input/output application support.
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: logfile: syslog
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: immediate-init: 0
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: permission: 666
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: driver-options:
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: pidfile: /var/run/lirc/lircd.pid
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: listen: 0
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: connect: (null)
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: userelease: 0
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: effective_user: (null)
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: release_suffix: _EVUP
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: allow_simulate: 0
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: repeat_max: 600
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: configfile: /etc/lirc/lircd.conf
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Options: dynamic_codes: (null)
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Current driver: default
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Driver API version: 3
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Driver  version: 0.10.0
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Driver  info: See file:///usr/share/doc/lirc/plugindocs/default.html
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Info: lircd:  Opening log, level: Info
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: Using systemd fd
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Warning: Running as root
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Info: Using remote: odroid.
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: lircd(default) ready, using /var/run/lirc/lircd
May 07 16:14:12 volumio-c4 sudo[5266]: pam_unix(sudo:session): session closed for user root
May 07 16:14:12 volumio-c4 volumio[4642]: info: ir_controller: systemctl restart lircd.service succeeded.
May 07 16:14:12 volumio-c4 systemd-udevd[5212]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 07 16:14:12 volumio-c4 sudo[5331]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service
May 07 16:14:12 volumio-c4 sudo[5331]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:12 volumio-c4 systemd[1]: Started Handle events from IR remotes decoded by lircd(8).
May 07 16:14:12 volumio-c4 sudo[5331]: pam_unix(sudo:session): session closed for user root
May 07 16:14:12 volumio-c4 volumio[4642]: info: ir_controller: systemctl restart irexec.service succeeded.
May 07 16:14:12 volumio-c4 lircd[5304]: lircd-0.10.1[5304]: Notice: accepted new client on /var/run/lirc/lircd
May 07 16:14:12 volumio-c4 lircd[5304]: lircd-0.10.1[5304]: Info: [lirc] protocol is enabled
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Notice: accepted new client on /var/run/lirc/lircd
May 07 16:14:12 volumio-c4 lircd-0.10.1[5304]: Info: [lirc] protocol is enabled
May 07 16:14:12 volumio-c4 mpd[5152]: May 07 16:14 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 07 16:14:12 volumio-c4 systemd[1]: Started Music Player Daemon.
May 07 16:14:12 volumio-c4 volumio[4642]: Upnp client error: Error: This socket has been ended by the other party
May 07 16:14:12 volumio-c4 sudo[5115]: pam_unix(sudo:session): session closed for user root
May 07 16:14:12 volumio-c4 sudo[5140]: pam_unix(sudo:session): session closed for user root
May 07 16:14:12 volumio-c4 volumio[4642]: info: Completed starting Core Plugins
May 07 16:14:12 volumio-c4 volumio[4642]: info: -------------------------------------------
May 07 16:14:12 volumio-c4 volumio[4642]: info: -----    MyVolumio plugins startup     ----
May 07 16:14:12 volumio-c4 volumio[4642]: info: -------------------------------------------
May 07 16:14:12 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Fetching plans data....
May 07 16:14:12 volumio-c4 volumio[4642]: error: MPD error: The expression evaluated to a falsy value:
May 07 16:14:12 volumio-c4 volumio[4642]:   assert.ok(self.idling)
May 07 16:14:12 volumio-c4 volumio[4642]: error: The expression evaluated to a falsy value:
May 07 16:14:12 volumio-c4 volumio[4642]:   assert.ok(self.idling)
May 07 16:14:12 volumio-c4 volumio[4642]: info: MPD running with PID5152
May 07 16:14:12 volumio-c4 volumio[4642]:  ,establishing connection
May 07 16:14:12 volumio-c4 volumio[4642]: error: updateQueue error: null
May 07 16:14:12 volumio-c4 volumio[4642]: error: updateQueue error: null
May 07 16:14:14 volumio-c4 sudo[5359]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/Multimedia/QNAP-Musik /mnt/NAS/NAS6A9DE8
May 07 16:14:14 volumio-c4 sudo[5359]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:14 volumio-c4 sudo[5361]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.52/Multimedia/QNAP-Musik /mnt/NAS/NAS6A5781
May 07 16:14:14 volumio-c4 sudo[5361]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:14 volumio-c4 sudo[5367]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.25/Multimedia/Musik /mnt/NAS/NASD7FEFD
May 07 16:14:14 volumio-c4 sudo[5367]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:14 volumio-c4 sudo[5359]: pam_unix(sudo:session): session closed for user root
May 07 16:14:14 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -95
May 07 16:14:14 volumio-c4 volumio[4642]: info: Cannot mount NAS NAS6A9DE8 at system boot, trial number 2 ,retrying in 5 seconds
May 07 16:14:14 volumio-c4 volumio[5203]: Generating RSA private key, 4096 bit long modulus (2 primes)
May 07 16:14:15 volumio-c4 volumio[5203]: .....++++
May 07 16:14:16 volumio-c4 volumio-remote-updater[3708]: [2024-05-07 16:14:16] [connect] Successful connection
May 07 16:14:16 volumio-c4 volumio-remote-updater[3708]: [2024-05-07 16:14:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1715091256 101
May 07 16:14:16 volumio-c4 volumio[4642]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 5
May 07 16:14:17 volumio-c4 volumio[5203]: ..................................................++++
May 07 16:14:17 volumio-c4 volumio[5203]: e is 65537 (0x010001)
May 07 16:14:17 volumio-c4 volumio[5203]: writing RSA key
May 07 16:14:19 volumio-c4 sudo[5420]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/Multimedia/QNAP-Musik /mnt/NAS/NAS6A9DE8
May 07 16:14:19 volumio-c4 sudo[5420]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:19 volumio-c4 sudo[5420]: pam_unix(sudo:session): session closed for user root
May 07 16:14:19 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -95
May 07 16:14:19 volumio-c4 volumio[4642]: info: Cannot mount NAS NAS6A9DE8 at system boot, trial number 3 ,retrying in 5 seconds
May 07 16:14:20 volumio-c4 kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 16:14:20 volumio-c4 kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 16:14:20 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 07 16:14:20 volumio-c4 sudo[5361]: pam_unix(sudo:session): session closed for user root
May 07 16:14:20 volumio-c4 sudo[5367]: pam_unix(sudo:session): session closed for user root
May 07 16:14:20 volumio-c4 volumio[4642]: info: Cannot mount NAS NAS6A5781 at system boot, trial number 2 ,retrying in 5 seconds
May 07 16:14:20 volumio-c4 volumio[4642]: info: Cannot mount NAS NASD7FEFD at system boot, trial number 2 ,retrying in 5 seconds
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 07 16:14:21 volumio-c4 volumio[4642]: info: Adding plugin bluetooth to MyMusic Plugins
May 07 16:14:21 volumio-c4 volumio[4642]: info: Adding plugin multiroom to MyMusic Plugins
May 07 16:14:21 volumio-c4 volumio[4642]: info: Adding plugin metavolumio to MyMusic Plugins
May 07 16:14:21 volumio-c4 volumio[4642]: info: Adding plugin cd_controller to MyMusic Plugins
May 07 16:14:21 volumio-c4 volumio[4642]: info: Adding plugin smart_inputs to MyMusic Plugins
May 07 16:14:21 volumio-c4 volumio[4642]: info: Adding plugin tidalconnect to MyMusic Plugins
May 07 16:14:21 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 07 16:14:22 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 07 16:14:22 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 07 16:14:22 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:22 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:22 volumio-c4 volumio[4642]: info: Starting MyVolumio Remote Streaming Endpoints
May 07 16:14:22 volumio-c4 volumio[4642]: info: MyVolumio login type: Token
May 07 16:14:22 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 07 16:14:22 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 07 16:14:23 volumio-c4 volumio[4642]: info: Starting Streaming Service Transparent Proxy
May 07 16:14:23 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 07 16:14:23 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 07 16:14:23 volumio-c4 volumio[4642]: info: Streaming services startup
May 07 16:14:23 volumio-c4 volumio[4642]: info: Starting Streaming Daemon
May 07 16:14:23 volumio-c4 sudo[5436]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 07 16:14:23 volumio-c4 sudo[5436]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:23 volumio-c4 sudo[5436]: pam_unix(sudo:session): session closed for user root
May 07 16:14:23 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
May 07 16:14:23 volumio-c4 volumio[4642]: error: Cannot start Volumio Streaming Daemon
May 07 16:14:23 volumio-c4 volumio[4642]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 07 16:14:23 volumio-c4 volumio[4642]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 07 16:14:23 volumio-c4 volumio[4642]: error: MyVolumio Custom Token format not valid, refreshing it
May 07 16:14:24 volumio-c4 volumio[4642]: STREAMING PROXY: Starting server on port 3245
May 07 16:14:24 volumio-c4 volumio[4642]: Node JS runtime: 14
May 07 16:14:24 volumio-c4 sudo[5444]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/Multimedia/QNAP-Musik /mnt/NAS/NAS6A9DE8
May 07 16:14:24 volumio-c4 sudo[5444]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:24 volumio-c4 sudo[5444]: pam_unix(sudo:session): session closed for user root
May 07 16:14:24 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -95
May 07 16:14:24 volumio-c4 volumio[4642]: info: Cannot mount NAS NAS6A9DE8 at system boot, trial number 4 ,retrying in 5 seconds
May 07 16:14:24 volumio-c4 volumio[4642]: info: MyVolumio login type: Token
May 07 16:14:24 volumio-c4 volumio[4642]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
May 07 16:14:25 volumio-c4 sudo[5453]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.52/Multimedia/QNAP-Musik /mnt/NAS/NAS6A5781
May 07 16:14:25 volumio-c4 sudo[5453]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:25 volumio-c4 sudo[5457]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.25/Multimedia/Musik /mnt/NAS/NASD7FEFD
May 07 16:14:25 volumio-c4 sudo[5457]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:25 volumio-c4 volumio[4642]: info: MyVolumio token set successfully
May 07 16:14:25 volumio-c4 volumio[4642]: info: MYVOLUMIO: Adding device
May 07 16:14:25 volumio-c4 volumio[4642]: info: MYVOLUMIO: Evaluating Server
May 07 16:14:26 volumio-c4 volumio[4642]: info: MyVolumio Plan changed: premium
May 07 16:14:26 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
May 07 16:14:26 volumio-c4 volumio[4642]: info: Removing browser output: myVolumio user plan is not superstar
May 07 16:14:26 volumio-c4 volumio[4642]: info: Removing audio output:
May 07 16:14:26 volumio-c4 volumio[4642]: info: MYVOLUMIO: Adding device
May 07 16:14:26 volumio-c4 volumio[4642]: info: MYVOLUMIO: Evaluating Server
May 07 16:14:26 volumio-c4 volumio[4642]: info: Remote config written successfully
May 07 16:14:26 volumio-c4 volumio[4642]: info: Starting Tunnel 1
May 07 16:14:26 volumio-c4 volumio[4642]: info: Starting Tunnel Connection Checker
May 07 16:14:26 volumio-c4 volumio[4642]: info: Completed starting MyVolumio Plugin
May 07 16:14:26 volumio-c4 volumio[4642]: info: MYVolumio Device enabled
May 07 16:14:26 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
May 07 16:14:26 volumio-c4 volumio[4642]: info: MyVolumio status changed
May 07 16:14:26 volumio-c4 volumio[4642]: info: Streaming services startup
May 07 16:14:26 volumio-c4 volumio[4642]: info: Starting Streaming Daemon
May 07 16:14:26 volumio-c4 sudo[5505]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 07 16:14:26 volumio-c4 sudo[5505]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:26 volumio-c4 volumio[4642]: info: Setting Geolocation for MyVolumio to eu7
May 07 16:14:26 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:26 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:26 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:26 volumio-c4 sudo[5505]: pam_unix(sudo:session): session closed for user root
May 07 16:14:26 volumio-c4 volumio[4642]: error: Cannot start Volumio Streaming Daemon
May 07 16:14:26 volumio-c4 volumio[4642]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 07 16:14:26 volumio-c4 volumio[4642]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 07 16:14:26 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
May 07 16:14:26 volumio-c4 volumio[4642]: error: [MyVolumio PluginManager] Cache data is invalid!
May 07 16:14:26 volumio-c4 kernel: fb: mem_free_work, free memory: addr:800000
May 07 16:14:27 volumio-c4 volumio[4642]: info: Setting Geolocation for MyVolumio to eu6
May 07 16:14:27 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:27 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:27 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:27 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
May 07 16:14:27 volumio-c4 volumio[4642]: info: [1715091267595] Starting BluetoothController
May 07 16:14:27 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
May 07 16:14:29 volumio-c4 sudo[5509]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
May 07 16:14:29 volumio-c4 sudo[5509]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 sudo[5509]: pam_unix(sudo:session): session closed for user root
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: MultiRoom plugin initialized
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: STOPPING SNAPCLIENT
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: Snap server stop
May 07 16:14:29 volumio-c4 sudo[5525]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
May 07 16:14:29 volumio-c4 sudo[5525]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: STOPPING volumioStreaming
May 07 16:14:29 volumio-c4 sudo[5528]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
May 07 16:14:29 volumio-c4 sudo[5528]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 sudo[5525]: pam_unix(sudo:session): session closed for user root
May 07 16:14:29 volumio-c4 sudo[5531]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
May 07 16:14:29 volumio-c4 sudo[5531]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 sudo[5528]: pam_unix(sudo:session): session closed for user root
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
May 07 16:14:29 volumio-c4 sudo[5531]: pam_unix(sudo:session): session closed for user root
May 07 16:14:29 volumio-c4 sudo[5535]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
May 07 16:14:29 volumio-c4 sudo[5535]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 sudo[5535]: pam_unix(sudo:session): session closed for user root
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
May 07 16:14:29 volumio-c4 volumio[4642]: info: Preparing to generate the ALSA configuration file
May 07 16:14:29 volumio-c4 volumio[4642]: info: Updating MyVolumio device info
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:29 volumio-c4 volumio[4642]: info: Updating MyVolumio device info
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
May 07 16:14:29 volumio-c4 volumio[4642]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
May 07 16:14:29 volumio-c4 volumio[4642]: info: Reading ALSA contributions from plugins.
May 07 16:14:29 volumio-c4 volumio[4642]: info: Successfully Added MyVolumio device
May 07 16:14:29 volumio-c4 sudo[5538]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/Multimedia/QNAP-Musik /mnt/NAS/NAS6A9DE8
May 07 16:14:29 volumio-c4 sudo[5538]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: Removed streaming files
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: volumioStreaming STOPPED
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: SNAPSERVER STOPPED
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: SNAPCLIENT STOPPED
May 07 16:14:29 volumio-c4 sudo[5538]: pam_unix(sudo:session): session closed for user root
May 07 16:14:29 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -95
May 07 16:14:29 volumio-c4 volumio[4642]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
May 07 16:14:29 volumio-c4 volumio[4642]: info: Asound.conf file written
May 07 16:14:29 volumio-c4 sudo[5546]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
May 07 16:14:29 volumio-c4 sudo[5546]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 sudo[5546]: pam_unix(sudo:session): session closed for user root
May 07 16:14:29 volumio-c4 kernel: out of value, fixed it
May 07 16:14:29 volumio-c4 kernel: id=0 set inskew=0
May 07 16:14:29 volumio-c4 kernel: Fine tdm clk setting range (0~2000000), 11289593
May 07 16:14:29 volumio-c4 kernel: out of value, fixed it
May 07 16:14:29 volumio-c4 kernel: id=0 set inskew=0
May 07 16:14:29 volumio-c4 volumio[4642]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted
May 07 16:14:29 volumio-c4 volumio[4642]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted
May 07 16:14:29 volumio-c4 volumio[4642]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted
May 07 16:14:29 volumio-c4 volumio[4642]: info: Output device has changed, restarting MPD
May 07 16:14:29 volumio-c4 sudo[5551]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 07 16:14:29 volumio-c4 sudo[5551]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 sudo[5551]: pam_unix(sudo:session): session closed for user root
May 07 16:14:29 volumio-c4 volumio[4642]: info: Output device has changed, restarting Shairport Sync
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:29 volumio-c4 sudo[5554]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 07 16:14:29 volumio-c4 sudo[5554]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 systemd[1]: Stopping Music Player Daemon...
May 07 16:14:29 volumio-c4 volumio[4642]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output for this device
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output
May 07 16:14:29 volumio-c4 sudo[5562]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio-C4
May 07 16:14:29 volumio-c4 sudo[5562]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding audio output:
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding audio output:
May 07 16:14:29 volumio-c4 kernel: aml_spdif_open
May 07 16:14:29 volumio-c4 kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0
May 07 16:14:29 volumio-c4 kernel: spdif_a keep clk continuous
May 07 16:14:29 volumio-c4 kernel: aml_spdif_close
May 07 16:14:29 volumio-c4 kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0
May 07 16:14:29 volumio-c4 volumio[4642]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding METAVOLUMIO REST API Endpoints
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding Manifest REST API Endpoints
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
May 07 16:14:29 volumio-c4 volumio[4642]: info: Preparing CD Folders
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding CD REST API Endpoints
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
May 07 16:14:29 volumio-c4 volumio[4642]: info: Starting UDEV Watcher for CD
May 07 16:14:29 volumio-c4 volumio[4642]: info: Detecting CD presence with UDEV
May 07 16:14:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
May 07 16:14:29 volumio-c4 kernel: aml_spdif_open
May 07 16:14:29 volumio-c4 kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0
May 07 16:14:29 volumio-c4 kernel: spdif_a keep clk continuous
May 07 16:14:29 volumio-c4 kernel: aml_spdif_close
May 07 16:14:29 volumio-c4 kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0
May 07 16:14:29 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding inputs REST Endpoints
May 07 16:14:29 volumio-c4 volumio[4642]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
May 07 16:14:29 volumio-c4 volumio[4642]: info: Scanning Audio Inputs
May 07 16:14:29 volumio-c4 kernel: Bluetooth: Core ver 2.22
May 07 16:14:29 volumio-c4 kernel: Bluetooth: Starting self testing
May 07 16:14:29 volumio-c4 kernel: Bluetooth: ECDH test passed in 13421 usecs
May 07 16:14:29 volumio-c4 kernel: Bluetooth: SMP test passed in 26 usecs
May 07 16:14:29 volumio-c4 kernel: Bluetooth: Finished self testing
May 07 16:14:29 volumio-c4 kernel: NET: Registered protocol family 31
May 07 16:14:29 volumio-c4 kernel: Bluetooth: HCI device and connection manager initialized
May 07 16:14:30 volumio-c4 kernel: Bluetooth: HCI socket layer initialized
May 07 16:14:30 volumio-c4 kernel: Bluetooth: L2CAP socket layer initialized
May 07 16:14:30 volumio-c4 kernel: Bluetooth: SCO socket layer initialized
May 07 16:14:29 volumio-c4 sudo[5562]: pam_unix(sudo:session): session closed for user root
May 07 16:14:30 volumio-c4 volumio[4642]: info: Checking against Known Cards name
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 16:14:30 volumio-c4 volumio[4642]: info: [1715091270005] CoreMusicLibrary::Adding element ODROID-DAC
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 16:14:30 volumio-c4 volumio[4642]: Cannot find translation for source ODROID-DAC
May 07 16:14:30 volumio-c4 volumio[4642]: info: Checking against Known Cards name
May 07 16:14:30 volumio-c4 volumio[4642]: info: Adding Server instance for streaming
May 07 16:14:30 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
May 07 16:14:30 volumio-c4 volumio[4642]: error: Hi Res Audio Failed Login: Missing Login Data
May 07 16:14:30 volumio-c4 volumio[4642]: info: Adding HIGHRESAUDIO REST API Endpoints
May 07 16:14:30 volumio-c4 volumio[4642]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
May 07 16:14:30 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
May 07 16:14:30 volumio-c4 volumio[4642]: info: Refreshing TIDAL token
May 07 16:14:30 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
May 07 16:14:30 volumio-c4 volumio[4642]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
May 07 16:14:30 volumio-c4 sudo[5579]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
May 07 16:14:30 volumio-c4 sudo[5579]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:30 volumio-c4 volumio[4642]: info: Stopping AccessToken refresher cron for QOBUZ
May 07 16:14:30 volumio-c4 sudo[5579]: pam_unix(sudo:session): session closed for user root
May 07 16:14:30 volumio-c4 volumio[4642]: info: AccessToken refresher cron started for QOBUZ
May 07 16:14:30 volumio-c4 systemd[1]: mpd.service: Succeeded.
May 07 16:14:30 volumio-c4 volumio[4642]: info: Adding QOBUZ REST API Endpoints
May 07 16:14:30 volumio-c4 systemd[1]: Stopped Music Player Daemon.
May 07 16:14:30 volumio-c4 volumio[4642]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
May 07 16:14:30 volumio-c4 systemd[1]: Starting Music Player Daemon...
May 07 16:14:30 volumio-c4 volumio[4642]: info: Successfully Updated MyVolumio device
May 07 16:14:30 volumio-c4 volumio[4642]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Volumio-C4'
May 07 16:14:30 volumio-c4 volumio[4642]: Can't get device info: No such device
May 07 16:14:30 volumio-c4 volumio[4642]: info: MPD Permissions set
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:30 volumio-c4 volumio[4642]: info: Starting Shairport Sync
May 07 16:14:30 volumio-c4 sudo[5606]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 07 16:14:30 volumio-c4 sudo[5606]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:30 volumio-c4 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 07 16:14:30 volumio-c4 systemd[1]: shairport-sync.service: Succeeded.
May 07 16:14:30 volumio-c4 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 07 16:14:30 volumio-c4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 07 16:14:30 volumio-c4 sudo[5606]: pam_unix(sudo:session): session closed for user root
May 07 16:14:30 volumio-c4 volumio[4642]: info: Shairport-Sync Started
May 07 16:14:30 volumio-c4 volumio[4642]: info: Successfully Updated MyVolumio device
May 07 16:14:30 volumio-c4 volumio[4642]: info: Access Token successfully retrieved
May 07 16:14:30 volumio-c4 volumio[4642]: info: Successfully retrieved User Session From TIDAL
May 07 16:14:30 volumio-c4 volumio[4642]: info: Successfully retrieved User Subscription From TIDAL
May 07 16:14:30 volumio-c4 volumio[4642]: info: Adding TIDAL to Browse Sources
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 16:14:30 volumio-c4 volumio[4642]: info: [1715091270846] CoreMusicLibrary::Adding element TIDAL
May 07 16:14:30 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 16:14:30 volumio-c4 volumio[4642]: Cannot find translation for source ODROID-DAC
May 07 16:14:30 volumio-c4 volumio[4642]: Cannot find translation for source TIDAL
May 07 16:14:30 volumio-c4 volumio[4642]: info: Stopping AccessToken refresher cron
May 07 16:14:30 volumio-c4 volumio[4642]: info: AccessToken refresher cron started
May 07 16:14:30 volumio-c4 volumio[4642]: info: Adding TIDAL REST API Endpoints
May 07 16:14:30 volumio-c4 volumio[4642]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
May 07 16:14:31 volumio-c4 sudo[5633]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
May 07 16:14:31 volumio-c4 sudo[5633]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:31 volumio-c4 systemd[1]: Started MyVolumio SSH Tunnel.
May 07 16:14:31 volumio-c4 sudo[5633]: pam_unix(sudo:session): session closed for user root
May 07 16:14:31 volumio-c4 volumio[4642]: info: Remote SSH Started
May 07 16:14:31 volumio-c4 mpd[5582]: May 07 16:14 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 07 16:14:31 volumio-c4 kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 16:14:31 volumio-c4 sudo[5453]: pam_unix(sudo:session): session closed for user root
May 07 16:14:31 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 07 16:14:31 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 07 16:14:31 volumio-c4 sudo[5457]: pam_unix(sudo:session): session closed for user root
May 07 16:14:31 volumio-c4 autossh[5653]: port set to 0, monitoring disabled
May 07 16:14:31 volumio-c4 autossh[5653]: starting ssh (count 1)
May 07 16:14:31 volumio-c4 autossh[5653]: ssh child pid is 5662
May 07 16:14:31 volumio-c4 volumio[4642]: info: Cannot mount NAS NASD7FEFD at system boot, trial number 3 ,retrying in 5 seconds
May 07 16:14:31 volumio-c4 volumio[4642]: info: Cannot mount NAS NAS6A5781 at system boot, trial number 3 ,retrying in 5 seconds
May 07 16:14:31 volumio-c4 volumiossh-tunnel[5635]: Warning: Permanently added '[eu6.myvolumio.org]:2222,[207.154.233.230]:2222' (RSA) to the list of known hosts.
May 07 16:14:31 volumio-c4 systemd[1]: Started Music Player Daemon.
May 07 16:14:31 volumio-c4 sudo[5554]: pam_unix(sudo:session): session closed for user root
May 07 16:14:31 volumio-c4 volumio[4642]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6
May 07 16:14:31 volumio-c4 volumio[4642]: error: updateQueue error: null
May 07 16:14:31 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:14:31 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:32 volumio-c4 sudo[5673]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
May 07 16:14:32 volumio-c4 sudo[5673]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:32 volumio-c4 systemd[1]: Started Volumio Bluetooth Module.
May 07 16:14:32 volumio-c4 sudo[5673]: pam_unix(sudo:session): session closed for user root
May 07 16:14:32 volumio-c4 sudo[5689]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
May 07 16:14:32 volumio-c4 sudo[5689]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:32 volumio-c4 volumio[4642]: info: Volumio BT Module successfully started
May 07 16:14:32 volumio-c4 volumiobt[5675]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
May 07 16:14:32 volumio-c4 sudo[5689]: pam_unix(sudo:session): session closed for user root
May 07 16:14:33 volumio-c4 volumio[4642]: info: TidalConnect service stoped!
May 07 16:14:33 volumio-c4 volumio[4642]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
May 07 16:14:33 volumio-c4 volumio[4642]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
May 07 16:14:33 volumio-c4 sudo[5709]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
May 07 16:14:33 volumio-c4 sudo[5709]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:33 volumio-c4 systemd[1]: Started Volumio Tidal Connect Service.
May 07 16:14:33 volumio-c4 sudo[5709]: pam_unix(sudo:session): session closed for user root
May 07 16:14:33 volumio-c4 volumio[4642]: info: Executing endpoint tc_getconfig
May 07 16:14:33 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
May 07 16:14:33 volumio-c4 vtcs[5711]: STARTING TidalConnect services, version: 1.3.0.19
May 07 16:14:33 volumio-c4 vtcs[5711]: STARTED TidalConnect services.
May 07 16:14:33 volumio-c4 volumio[4642]: info: Executing endpoint tc_connect
May 07 16:14:33 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
May 07 16:14:33 volumio-c4 volumio[4642]: info: Connecting to TidalConnect
May 07 16:14:33 volumio-c4 volumio[4642]: info: CoreCommandRouter::servicePushState
May 07 16:14:33 volumio-c4 volumio[4642]: info: CoreStateMachine::pushState
May 07 16:14:33 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:33 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioPushState
May 07 16:14:33 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output update for this device
May 07 16:14:33 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output
May 07 16:14:33 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:33 volumio-c4 volumio[4642]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
May 07 16:14:33 volumio-c4 volumio[4642]: info: CoreCommandRouter::servicePushState
May 07 16:14:33 volumio-c4 volumio[4642]: info: CoreStateMachine::pushState
May 07 16:14:33 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:33 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioPushState
May 07 16:14:33 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output update for this device
May 07 16:14:33 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output
May 07 16:14:33 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:33 volumio-c4 volumio[4642]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
May 07 16:14:33 volumio-c4 sudo[5751]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
May 07 16:14:33 volumio-c4 sudo[5751]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:33 volumio-c4 volumiobt[5675]: pulseaudio: no process found
May 07 16:14:33 volumio-c4 sudo[5751]: pam_unix(sudo:session): session closed for user root
May 07 16:14:34 volumio-c4 dbus-daemon[3830]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.15' (uid=1000 pid=5756 comm="/usr/bin/pulseaudio --high-priority=true " label="kernel")
May 07 16:14:34 volumio-c4 systemd[1]: Starting RealtimeKit Scheduling Policy Service...
May 07 16:14:34 volumio-c4 volumio[4642]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 07 16:14:34 volumio-c4 dbus-daemon[3830]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
May 07 16:14:34 volumio-c4 systemd[1]: Started RealtimeKit Scheduling Policy Service.
May 07 16:14:34 volumio-c4 rtkit-daemon[5757]: Successfully called chroot.
May 07 16:14:34 volumio-c4 rtkit-daemon[5757]: Successfully dropped privileges.
May 07 16:14:34 volumio-c4 rtkit-daemon[5757]: Successfully limited resources.
May 07 16:14:34 volumio-c4 rtkit-daemon[5757]: Running.
May 07 16:14:34 volumio-c4 rtkit-daemon[5757]: Watchdog thread running.
May 07 16:14:34 volumio-c4 rtkit-daemon[5757]: Canary thread running.
May 07 16:14:34 volumio-c4 dbus-daemon[3830]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.16' (uid=0 pid=5757 comm="/usr/lib/rtkit/rtkit-daemon " label="kernel")
May 07 16:14:34 volumio-c4 systemd[1]: Starting Authorization Manager...
May 07 16:14:34 volumio-c4 volumio[4642]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 07 16:14:34 volumio-c4 polkitd[5779]: started daemon version 0.105 using authority implementation `local' version `0.105'
May 07 16:14:34 volumio-c4 dbus-daemon[3830]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
May 07 16:14:34 volumio-c4 systemd[1]: Started Authorization Manager.
May 07 16:14:34 volumio-c4 dbus-daemon[3830]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.36' (uid=1000 pid=5756 comm="/usr/bin/pulseaudio --high-priority=true " label="kernel")
May 07 16:14:34 volumio-c4 systemd[1]: Starting Bluetooth service...
May 07 16:14:34 volumio-c4 volumio[4642]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 07 16:14:34 volumio-c4 pulseaudio[5756]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
May 07 16:14:34 volumio-c4 pulseaudio[5756]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
May 07 16:14:34 volumio-c4 volumiobt[5675]: Applying permissions
May 07 16:14:34 volumio-c4 volumiobt[5675]: Setting BT discoverable and pairable
May 07 16:14:34 volumio-c4 bluetoothd[5804]: Bluetooth daemon 5.50
May 07 16:14:34 volumio-c4 bluetoothd[5804]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
May 07 16:14:34 volumio-c4 dbus-daemon[3830]: [system] Successfully activated service 'org.bluez'
May 07 16:14:34 volumio-c4 systemd[1]: Started Bluetooth service.
May 07 16:14:34 volumio-c4 bluetoothd[5804]: Starting SDP server
May 07 16:14:34 volumio-c4 bluetoothd[5804]: Excluding (cli) sap
May 07 16:14:34 volumio-c4 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
May 07 16:14:34 volumio-c4 kernel: Bluetooth: BNEP filters: protocol multicast
May 07 16:14:34 volumio-c4 kernel: Bluetooth: BNEP socket layer initialized
May 07 16:14:34 volumio-c4 bluetoothd[5804]: Bluetooth management interface 1.14 initialized
May 07 16:14:34 volumio-c4 dbus-daemon[3830]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.38' (uid=0 pid=5804 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap " label="kernel")
May 07 16:14:34 volumio-c4 volumiobt[5675]: [bluetooth]# -e power on
May 07 16:14:34 volumio-c4 volumiobt[5675]: Invalid command in menu main: -e
May 07 16:14:34 volumio-c4 volumiobt[5675]: 
May 07 16:14:34 volumio-c4 volumiobt[5675]: Use "help" for a list of available commands in a menu.
May 07 16:14:34 volumio-c4 volumiobt[5675]: Use "menu " if you want to enter any submenu.
May 07 16:14:34 volumio-c4 volumiobt[5675]: Use "back" if you want to return to menu main.
May 07 16:14:34 volumio-c4 volumiobt[5675]: [bluetooth]# agent on
May 07 16:14:34 volumio-c4 volumiobt[5675]: Failed to register agent object
May 07 16:14:34 volumio-c4 volumiobt[5675]: [bluetooth]# discoverable on
May 07 16:14:34 volumio-c4 volumiobt[5675]: No default controller available
May 07 16:14:34 volumio-c4 volumiobt[5675]: [bluetooth]# pairable on
May 07 16:14:34 volumio-c4 volumiobt[5675]: No default controller available
May 07 16:14:34 volumio-c4 volumiobt[5675]: [bluetooth]# agent NoInputNoOutput
May 07 16:14:34 volumio-c4 volumiobt[5675]: Failed to register agent object
May 07 16:14:34 volumio-c4 volumiobt[5675]: [bluetooth]# default-agent
May 07 16:14:34 volumio-c4 volumiobt[5675]: No agent is registered
May 07 16:14:34 volumio-c4 volumiobt[5675]: [bluetooth]# quit
May 07 16:14:34 volumio-c4 pulseaudio[5756]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files
May 07 16:14:34 volumio-c4 volumiobt[5675]: [59B blob data]
May 07 16:14:34 volumio-c4 systemd[1]: Starting Hostname Service...
May 07 16:14:34 volumio-c4 volumio[4642]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 07 16:14:34 volumio-c4 dbus-daemon[3830]: [system] Successfully activated service 'org.freedesktop.hostname1'
May 07 16:14:34 volumio-c4 systemd[1]: Started Hostname Service.
May 07 16:14:34 volumio-c4 volumio[4642]: info: MRS: Getting audio outputs on start
May 07 16:14:34 volumio-c4 volumio[4642]: info: MRS: Requesting all other devices output
May 07 16:14:36 volumio-c4 volumio[4642]: info: TidalConnect service started!
May 07 16:14:36 volumio-c4 volumio[4642]: info: BOOT COMPLETED
May 07 16:14:36 volumio-c4 volumio[4642]:  [Metrics]  CommandRouter:  39s 642.67ms 
May 07 16:14:36 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumiosetStartupVolume
May 07 16:14:36 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:36 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:36 volumio-c4 volumio[4642]: info: CoreCommandRouter::Close All Modals sent
May 07 16:14:36 volumio-c4 volumio[4642]: info: CoreCommandRouter::Close All Modals sent
May 07 16:14:36 volumio-c4 kernel: aml_spdif_open
May 07 16:14:36 volumio-c4 kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0
May 07 16:14:36 volumio-c4 kernel: set normal 512 fs /4 fs
May 07 16:14:36 volumio-c4 kernel:          set spdifout clk:5644800, mpll:22579200
May 07 16:14:36 volumio-c4 kernel:          get spdifout clk:5644797, mpll:22579186
May 07 16:14:36 volumio-c4 kernel: aml_dai_set_spdif_fmt , fmt 0x4010
May 07 16:14:36 volumio-c4 kernel: set normal 512 fs /4 fs
May 07 16:14:36 volumio-c4 kernel:          set spdifout clk:5644800, mpll:22579200
May 07 16:14:36 volumio-c4 kernel:          get spdifout clk:5644797, mpll:22579186
May 07 16:14:36 volumio-c4 kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0
May 07 16:14:36 volumio-c4 kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1
May 07 16:14:36 volumio-c4 kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0
May 07 16:14:36 volumio-c4 kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1
May 07 16:14:36 volumio-c4 kernel: asoc-aml-card odroid_hdmi: S/PDIF Playback enable
May 07 16:14:36 volumio-c4 sudo[5848]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.25/Multimedia/Musik /mnt/NAS/NASD7FEFD
May 07 16:14:36 volumio-c4 sudo[5848]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:36 volumio-c4 sudo[5851]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.52/Multimedia/QNAP-Musik /mnt/NAS/NAS6A5781
May 07 16:14:36 volumio-c4 sudo[5851]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:37 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 07 16:14:37 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 07 16:14:37 volumio-c4 volumio[4642]: xcb_connection_has_error() returned true
May 07 16:14:37 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 07 16:14:37 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 07 16:14:37 volumio-c4 volumio[4642]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7
May 07 16:14:37 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:14:37 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:14:39 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 07 16:14:39 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 16:14:39 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 07 16:14:39 volumio-c4 volumio-remote-updater[3708]: No test mode
May 07 16:14:39 volumio-c4 volumio-remote-updater[3708]: No alpha test mode
May 07 16:14:39 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
May 07 16:14:39 volumio-c4 volumio[4642]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nFix for mpd crashing with wrongly formatted cue files
\nFix for missing metadata with CD playback
\nFix for metadata on Classic and Contemporary UI
\nVarious fixes for TIDAL Connect
\nFix japanese and thai characters on HDMI display
\nFix for keyboard opening on select on mobile
\n
\nNEW ADDITIONS
\n\nBump MPD to 0.23.15-3
\nBump to init-v3
\nAdd filtering to QOBUZ New releases
\nImprovements for reducing boot time
\nNew boot animation
\n\n","title":"Update v3.666","updateavailable":true}
May 07 16:14:40 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 07 16:14:41 volumio-c4 kernel: asoc-aml-card odroid_hdmi: S/PDIF Playback disable
May 07 16:14:41 volumio-c4 kernel: audio_ddr_mngr: delay:[0us]; FRDDR_STATUS2: [0xcf64ad50] [0xcf64add0]
May 07 16:14:41 volumio-c4 kernel: spdif_a keep clk continuous
May 07 16:14:41 volumio-c4 kernel: aml_spdif_close
May 07 16:14:41 volumio-c4 kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0
May 07 16:14:42 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:42 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 16:14:42 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
May 07 16:14:42 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 07 16:14:42 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
May 07 16:14:42 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetBrowseSources
May 07 16:14:42 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 07 16:14:42 volumio-c4 kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 16:14:42 volumio-c4 sudo[5848]: pam_unix(sudo:session): session closed for user root
May 07 16:14:42 volumio-c4 sudo[5851]: pam_unix(sudo:session): session closed for user root
May 07 16:14:42 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 07 16:14:42 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 07 16:14:42 volumio-c4 volumio[4642]: info: Cannot mount NAS NASD7FEFD at system boot, trial number 4 ,retrying in 5 seconds
May 07 16:14:42 volumio-c4 volumio[4642]: info: Cannot mount NAS NAS6A5781 at system boot, trial number 4 ,retrying in 5 seconds
May 07 16:14:47 volumio-c4 sudo[5909]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.25/Multimedia/Musik /mnt/NAS/NASD7FEFD
May 07 16:14:47 volumio-c4 sudo[5909]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:47 volumio-c4 sudo[5912]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.52/Multimedia/QNAP-Musik /mnt/NAS/NAS6A5781
May 07 16:14:47 volumio-c4 sudo[5912]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:14:53 volumio-c4 kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 16:14:53 volumio-c4 kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 16:14:53 volumio-c4 sudo[5909]: pam_unix(sudo:session): session closed for user root
May 07 16:14:53 volumio-c4 sudo[5912]: pam_unix(sudo:session): session closed for user root
May 07 16:14:53 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 07 16:14:53 volumio-c4 kernel: CIFS VFS: cifs_mount failed w/return code = -113
May 07 16:14:53 volumio-c4 volumio[4642]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
May 07 16:14:53 volumio-c4 volumio[4642]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
May 07 16:15:04 volumio-c4 systemd[1]: systemd-hostnamed.service: Succeeded.
May 07 16:15:06 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 07 16:15:06 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 07 16:15:06 volumio-c4 volumio[4642]: info: Discovery: Getting this device information
May 07 16:15:06 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:06 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:06 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 07 16:15:06 volumio-c4 volumio[4642]: verbose: New Socket.io Connection to 192.168.178.45 from 192.168.178.54 UA: okhttp/4.9.2 Total Clients: 8
May 07 16:15:06 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:06 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:06 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 07 16:15:06 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 07 16:15:11 volumio-c4 sudo[5930]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 07 16:15:11 volumio-c4 sudo[5930]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:15:11 volumio-c4 sudo[5930]: pam_unix(sudo:session): session closed for user root
May 07 16:15:11 volumio-c4 sudo[5932]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 07 16:15:11 volumio-c4 sudo[5932]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 16:15:11 volumio-c4 sudo[5932]: pam_unix(sudo:session): session closed for user root
May 07 16:15:11 volumio-c4 volumio[4642]: verbose: New Socket.io Connection to 192.168.178.45 from 192.168.178.54 UA: okhttp/4.9.2 Total Clients: 9
May 07 16:15:11 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 07 16:15:11 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 07 16:15:11 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetVisibleSources
May 07 16:15:11 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 16:15:11 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:11 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:11 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 07 16:15:12 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 07 16:15:12 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 07 16:15:12 volumio-c4 volumio[4642]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
May 07 16:15:12 volumio-c4 volumio[4642]: info: Received Get System Info
May 07 16:15:12 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 07 16:15:12 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 07 16:15:12 volumio-c4 volumio[4642]: info: Discovery: Getting this device information
May 07 16:15:12 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:12 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:12 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 07 16:15:12 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:12 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:12 volumio-c4 volumio[4642]: info: Listing playlists
May 07 16:15:12 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 07 16:15:12 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 07 16:15:13 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:13 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:13 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 07 16:15:13 volumio-c4 volumio[4642]: info: Received Get System Info
May 07 16:15:13 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 07 16:15:13 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 07 16:15:13 volumio-c4 volumio[4642]: info: Discovery: Getting this device information
May 07 16:15:13 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:13 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:13 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 07 16:15:13 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 07 16:15:14 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioPlay
May 07 16:15:14 volumio-c4 volumio[4642]: info: CoreStateMachine::play index undefined
May 07 16:15:14 volumio-c4 volumio[4642]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 16:15:14 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:14 volumio-c4 volumio[4642]: info: CoreStateMachine::startPlaybackTimer
May 07 16:15:14 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:14 volumio-c4 volumio[4642]: verbose: ControllerMpd::clearAddPlayTracks USB/Maxtor-500G/HDD-Musik/Bee Gees - Big Chance CD1 (2000) FLAC/01 - Bee Gees - Spicks & specks.flac
May 07 16:15:14 volumio-c4 volumio[4642]: verbose: ControllerMpd::sendMpdCommand stop
May 07 16:15:14 volumio-c4 volumio[4642]: info: sendMpdCommand stop took 3 milliseconds
May 07 16:15:14 volumio-c4 volumio[4642]: verbose: ControllerMpd::sendMpdCommand clear
May 07 16:15:14 volumio-c4 volumio[4642]: info:
May 07 16:15:14 volumio-c4 volumio[4642]: ---------------------------- MPD announces system playlist update
May 07 16:15:14 volumio-c4 volumio[4642]: info: Ignoring MPD Status Update
May 07 16:15:14 volumio-c4 volumio[4642]: info: sendMpdCommand clear took 4 milliseconds
May 07 16:15:14 volumio-c4 volumio[4642]: verbose: ControllerMpd::sendMpdCommand add "USB/Maxtor-500G/HDD-Musik/Bee Gees - Big Chance CD1 (2000) FLAC/01 - Bee Gees - Spicks & specks.flac"
May 07 16:15:14 volumio-c4 volumio[4642]: error: updateQueue error: null
May 07 16:15:14 volumio-c4 volumio[4642]: info:
May 07 16:15:14 volumio-c4 volumio[4642]: ---------------------------- MPD announces system playlist update
May 07 16:15:14 volumio-c4 volumio[4642]: info: Ignoring MPD Status Update
May 07 16:15:14 volumio-c4 volumio[4642]: info: ------------------------------ 7ms
May 07 16:15:14 volumio-c4 volumio[4642]: info: sendMpdCommand add "USB/Maxtor-500G/HDD-Musik/Bee Gees - Big Chance CD1 (2000) FLAC/01 - Bee Gees - Spicks & specks.flac" took 4 milliseconds
May 07 16:15:14 volumio-c4 volumio[4642]: verbose: ControllerMpd::sendMpdCommand play
May 07 16:15:14 volumio-c4 volumio[4642]: info: ------------------------------ 6ms
May 07 16:15:14 volumio-c4 volumio[4642]: info: sendMpdCommand play took 3 milliseconds
May 07 16:15:15 volumio-c4 volumio[4642]: info:
May 07 16:15:15 volumio-c4 volumio[4642]: ---------------------------- MPD announces state update: player
May 07 16:15:15 volumio-c4 volumio[4642]: info: ControllerMpd::getState
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: ControllerMpd::sendMpdCommand status
May 07 16:15:15 volumio-c4 kernel: aml_spdif_open
May 07 16:15:15 volumio-c4 kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0
May 07 16:15:15 volumio-c4 kernel: set normal 512 fs /4 fs
May 07 16:15:15 volumio-c4 kernel:          set spdifout clk:5644800, mpll:22579200
May 07 16:15:15 volumio-c4 kernel:          get spdifout clk:5644797, mpll:22579186
May 07 16:15:15 volumio-c4 kernel: aml_dai_set_spdif_fmt , fmt 0x4010
May 07 16:15:15 volumio-c4 kernel: set normal 512 fs /4 fs
May 07 16:15:15 volumio-c4 kernel:          set spdifout clk:5644800, mpll:22579200
May 07 16:15:15 volumio-c4 kernel:          get spdifout clk:5644797, mpll:22579186
May 07 16:15:15 volumio-c4 kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0
May 07 16:15:15 volumio-c4 kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1
May 07 16:15:15 volumio-c4 kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0
May 07 16:15:15 volumio-c4 kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1
May 07 16:15:15 volumio-c4 volumio[4642]: info:
May 07 16:15:15 volumio-c4 volumio[4642]: ---------------------------- MPD announces state update: player
May 07 16:15:15 volumio-c4 volumio[4642]: info: sendMpdCommand status took 19 milliseconds
May 07 16:15:15 volumio-c4 volumio[4642]: info: ControllerMpd::getState
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: ControllerMpd::sendMpdCommand status
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: ControllerMpd::parseState
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 16:15:15 volumio-c4 volumio[4642]: info: sendMpdCommand status took 4 milliseconds
May 07 16:15:15 volumio-c4 volumio[4642]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: ControllerMpd::parseState
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: ControllerMpd::parseTrackInfo
May 07 16:15:15 volumio-c4 volumio[4642]: info: ControllerMpd::pushState
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreCommandRouter::servicePushState
May 07 16:15:15 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":173,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Spicks & specks","artist":"Bee Gees","album":"Big Chance - CD 1","uri":"USB/Maxtor-500G/HDD-Musik/Bee Gees - Big Chance CD1 (2000) FLAC/01 - Bee Gees - Spicks & specks.flac","trackType":"flac"}
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: CURRENT POSITION 0
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreStateMachine::syncState   stateService play
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreStateMachine::syncState   currentStatus stop
May 07 16:15:15 volumio-c4 volumio[4642]: info: ------------------------------ 38ms
May 07 16:15:15 volumio-c4 volumio[4642]: info: sendMpdCommand playlistinfo took 8 milliseconds
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: ControllerMpd::parseTrackInfo
May 07 16:15:15 volumio-c4 volumio[4642]: info: ControllerMpd::pushState
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreCommandRouter::servicePushState
May 07 16:15:15 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":173,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"340 Kbps","isStreaming":false,"title":"Spicks & specks","artist":"Bee Gees","album":"Big Chance - CD 1","uri":"USB/Maxtor-500G/HDD-Musik/Bee Gees - Big Chance CD1 (2000) FLAC/01 - Bee Gees - Spicks & specks.flac","trackType":"flac"}
May 07 16:15:15 volumio-c4 volumio[4642]: verbose: CURRENT POSITION 0
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreStateMachine::syncState   stateService play
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreStateMachine::syncState   currentStatus play
May 07 16:15:15 volumio-c4 volumio[4642]: info: Received an update from plugin. extracting info from payload
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreStateMachine::pushState
May 07 16:15:15 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioPushState
May 07 16:15:15 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output update for this device
May 07 16:15:15 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreStateMachine::pushState
May 07 16:15:15 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioPushState
May 07 16:15:15 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output update for this device
May 07 16:15:15 volumio-c4 volumio[4642]: info: MRS: Pushing multiroomSync output
May 07 16:15:15 volumio-c4 volumio[4642]: info: ------------------------------ 66ms
May 07 16:15:15 volumio-c4 kernel: asoc-aml-card odroid_hdmi: S/PDIF Playback enable
May 07 16:15:15 volumio-c4 volumio[4642]: info: Executing endpoint metavolumio
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 07 16:15:15 volumio-c4 volumio[4642]: info: Executing endpoint metavolumio
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 07 16:15:15 volumio-c4 volumio[4642]: info: Executing endpoint metavolumio
May 07 16:15:15 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 07 16:15:16 volumio-c4 volumio[4642]: info: Received Get System Info
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 07 16:15:16 volumio-c4 volumio[4642]: info: Discovery: Getting this device information
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:16 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetQueue
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreStateMachine::getQueue
May 07 16:15:16 volumio-c4 volumio[4642]: info: CorePlayQueue::getQueue
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 07 16:15:16 volumio-c4 volumio[4642]: info: Received Get System Info
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 07 16:15:16 volumio-c4 volumio[4642]: info: Discovery: Getting this device information
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:16 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:16 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 07 16:15:17 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 07 16:15:17 volumio-c4 volumio[4642]: info: Received Get System Info
May 07 16:15:17 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 07 16:15:17 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 07 16:15:17 volumio-c4 volumio[4642]: info: Discovery: Getting this device information
May 07 16:15:17 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:17 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:17 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 07 16:15:20 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 07 16:15:20 volumio-c4 volumio[4642]: info: Preload queue cleared
May 07 16:15:22 volumio-c4 volumio[4642]: error: Failed request for metavolumio API
May 07 16:15:25 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 07 16:15:25 volumio-c4 volumio[4642]: info: Preload queue cleared
May 07 16:15:27 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 07 16:15:27 volumio-c4 volumio[4642]: info: Preload queue cleared
May 07 16:15:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 07 16:15:29 volumio-c4 volumio[4642]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 07 16:15:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 07 16:15:29 volumio-c4 volumio[4642]: info: Received Get System Version
May 07 16:15:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 07 16:15:29 volumio-c4 volumio[4642]: info: Received Get System Info
May 07 16:15:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 07 16:15:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 07 16:15:29 volumio-c4 volumio[4642]: info: Discovery: Getting this device information
May 07 16:15:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::volumioGetState
May 07 16:15:29 volumio-c4 volumio[4642]: info: CorePlayQueue::getTrack 0
May 07 16:15:29 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 07 16:15:35 volumio-c4 volumio[4642]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 07 16:15:35 volumio-c4 volumio[4642]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 07 16:15:35 volumio-c4 volumio[4642]: TypeError: Cannot read property 'length' of undefined
May 07 16:15:35 volumio-c4 volumio[4642]:     at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
May 07 16:15:35 volumio-c4 volumio[4642]:     at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
May 07 16:15:35 volumio-c4 volumio[4642]:     at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
May 07 16:15:35 volumio-c4 volumio[4642]:     at Parser.emit (events.js:400:28)
May 07 16:15:35 volumio-c4 volumio[4642]:     at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
May 07 16:15:35 volumio-c4 volumio[4642]:     at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
May 07 16:15:35 volumio-c4 volumio[4642]:     at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
May 07 16:15:35 volumio-c4 volumio[4642]:     at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
May 07 16:15:35 volumio-c4 volumio[4642]:     at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
May 07 16:15:35 volumio-c4 volumio[4642]:     at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
May 07 16:15:35 volumio-c4 volumio[4642]:     at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
May 07 16:15:35 volumio-c4 volumio[4642]:     at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
May 07 16:15:35 volumio-c4 volumio[4642]:     at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
May 07 16:15:35 volumio-c4 volumio[4642]:     at IncomingMessage.emit (events.js:412:35)
May 07 16:15:35 volumio-c4 volumio[4642]:     at endReadableNT (internal/streams/readable.js:1333:12)
May 07 16:15:35 volumio-c4 volumio[4642]:     at processTicksAndRejections (internal/process/task_queues.js:82:21)
May 07 16:15:35 volumio-c4 volumio[4642]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 07 16:15:36 volumio-c4 sudo[5953]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-07 16:14
May 07 16:15:36 volumio-c4 sudo[5953]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 24 Feb 2024 09:20:08 PM CET"
VOLUMIO_VERSION="3.629"
VOLUMIO_HARDWARE="odroidc4"
VOLUMIO_DEVICENAME="Odroid-C4"
VOLUMIO_HASH="f83d9bf37d1b991751b7e7a6d9294016"