-- Logs begin at Sun 2024-03-31 10:36:10 MSK, end at Mon 2024-04-01 21:01:29 MSK. --
Apr 01 21:00:00 volumio volumio[16183]: info: CoreStateMachine::setRepeat null single undefined
Apr 01 21:00:00 volumio volumio[16183]: info: CoreStateMachine::pushState
Apr 01 21:00:00 volumio volumio[16183]: info: CorePlayQueue::getTrack 0
Apr 01 21:00:00 volumio volumio[16183]: info: CoreCommandRouter::volumioPushState
Apr 01 21:00:00 volumio volumio[16183]: info: CoreStateMachine::setRandom null
Apr 01 21:00:00 volumio volumio[16183]: info: CoreStateMachine::pushState
Apr 01 21:00:00 volumio volumio[16183]: info: CorePlayQueue::getTrack 0
Apr 01 21:00:00 volumio volumio[16183]: info: CoreCommandRouter::volumioPushState
Apr 01 21:00:00 volumio volumio[16183]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:00:00 volumio volumio[16183]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com
Apr 01 21:00:00 volumio volumio[16183]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
Apr 01 21:00:00 volumio volumio[16183]: errno: -3007,
Apr 01 21:00:00 volumio volumio[16183]: code: 'ENOTFOUND',
Apr 01 21:00:00 volumio volumio[16183]: syscall: 'getaddrinfo',
Apr 01 21:00:00 volumio volumio[16183]: hostname: 'ws.audioscrobbler.com'
Apr 01 21:00:00 volumio volumio[16183]: }
Apr 01 21:00:00 volumio volumio[16183]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:00:01 volumio sudo[16370]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:01 volumio sudo[16400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-01 20:59
Apr 01 21:00:01 volumio sudo[16400]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:01 volumio sudo[16400]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:01 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 01 21:00:01 volumio sudo[16332]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:01 volumio sudo[16321]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:01 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 01 21:00:01 volumio systemd[1]: Started dynamicswap service.
Apr 01 21:00:01 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 01 21:00:01 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 01 21:00:01 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 21.
Apr 01 21:00:01 volumio systemd[1]: Started dynamicswap service.
Apr 01 21:00:01 volumio systemd[1]: Stopped Volumio Backend Module.
Apr 01 21:00:01 volumio systemd[1]: Started Volumio Backend Module.
Apr 01 21:00:02 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 01 21:00:02 volumio mpd[16335]: Apr 01 21:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 01 21:00:02 volumio systemd[1]: Started Music Player Daemon.
Apr 01 21:00:02 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Apr 01 21:00:02 volumio volumio[16429]: cset: --> shielding system active with
Apr 01 21:00:02 volumio volumio[16429]: cset: "system" cpuset of CPUSPEC(0-2) with 88 tasks running
Apr 01 21:00:02 volumio volumio[16429]: cset: "user" cpuset of CPUSPEC(3) with 3 tasks running
Apr 01 21:00:02 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Apr 01 21:00:04 volumio volumio[16416]: info: -------------------------------------------
Apr 01 21:00:04 volumio volumio[16416]: info: ----- Volumio3 ----
Apr 01 21:00:04 volumio volumio[16416]: info: -------------------------------------------
Apr 01 21:00:04 volumio volumio[16416]: info: ----- System startup ----
Apr 01 21:00:04 volumio volumio[16416]: info: -------------------------------------------
Apr 01 21:00:05 volumio volumio-remote-updater[7589]: [2024-04-01 21:00:05] [connect] Successful connection
Apr 01 21:00:05 volumio volumio[16416]: info: MYVOLUMIO Environment detected
Apr 01 21:00:05 volumio volumio[16416]: info: Plugin folders cleanup
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning into folder /volumio/app/plugins/
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning category audio_interface
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning category miscellanea
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning category music_service
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning category plugins.json
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning category system_controller
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning category user_interface
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning into folder /data/plugins/
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning category music_service
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning category system_hardware
Apr 01 21:00:05 volumio volumio[16416]: info: Scanning category user_interface
Apr 01 21:00:05 volumio volumio[16416]: info: Plugin folders cleanup completed
Apr 01 21:00:05 volumio volumio[16416]: info: -------------------------------------------
Apr 01 21:00:05 volumio volumio[16416]: info: ----- Core plugins startup ----
Apr 01 21:00:05 volumio volumio[16416]: info: -------------------------------------------
Apr 01 21:00:05 volumio volumio[16416]: info: Loading plugins from folder /volumio/app/plugins/
Apr 01 21:00:05 volumio volumio[16416]: info: Adding plugin upnp to MyMusic Plugins
Apr 01 21:00:05 volumio volumio[16416]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 01 21:00:05 volumio volumio[16416]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 01 21:00:05 volumio volumio[16416]: info: Loading plugins from folder /data/plugins/
Apr 01 21:00:05 volumio volumio[16416]: info: Loading plugin "system"...
Apr 01 21:00:05 volumio volumio[16416]: info: Loading plugin "appearance"...
Apr 01 21:00:07 volumio volumio[16416]: info: Loading plugin "network"...
Apr 01 21:00:07 volumio volumio[16416]: info: Refreshing Cached IP Addresses
Apr 01 21:00:07 volumio sudo[16460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 01 21:00:07 volumio sudo[16460]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:07 volumio volumio[16416]: info: Loading plugin "services"...
Apr 01 21:00:07 volumio sudo[16462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 01 21:00:07 volumio sudo[16462]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:07 volumio volumio[16416]: info: Loading plugin "alsa_controller"...
Apr 01 21:00:07 volumio sudo[16460]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:07 volumio sudo[16465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 01 21:00:07 volumio sudo[16465]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:07 volumio sudo[16462]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:07 volumio sudo[16465]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:07 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 01 21:00:07 volumio volumio[16416]: info: Loading plugin "wizard"...
Apr 01 21:00:07 volumio volumio[16416]: info: Loading plugin "networkfs"...
Apr 01 21:00:07 volumio volumio[16416]: info: Starting Udev Watcher for removable devices
Apr 01 21:00:07 volumio volumio[16416]: info: Ignoring mount for partition: boot
Apr 01 21:00:07 volumio volumio[16416]: info: Ignoring mount for partition: volumio
Apr 01 21:00:07 volumio volumio[16416]: info: Ignoring mount for partition: volumio_data
Apr 01 21:00:07 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 01 21:00:07 volumio volumio[16416]: info: Loading plugin "volumio_command_line_client"...
Apr 01 21:00:07 volumio volumio[16416]: info: Plugin upnp is not enabled
Apr 01 21:00:07 volumio volumio[16416]: info: Loading plugin "my_music"...
Apr 01 21:00:07 volumio volumio[16416]: info: Loading plugin "mpd"...
Apr 01 21:00:08 volumio volumio[16416]: info: Loading plugin "upnp_browser"...
Apr 01 21:00:08 volumio volumio[16416]: info: Loading plugin "alarm-clock"...
Apr 01 21:00:08 volumio volumio[16416]: info: Loading plugin "airplay_emulation"...
Apr 01 21:00:08 volumio volumio[16416]: info: Starting Shairport Sync
Apr 01 21:00:08 volumio volumio[16416]: info: Loading plugin "last_100"...
Apr 01 21:00:08 volumio volumio[16416]: info: Loading plugin "webradio"...
Apr 01 21:00:09 volumio volumio[16416]: info: Loading plugin "i2s_dacs"...
Apr 01 21:00:09 volumio volumio[16416]: info: I2S DAC not set, start Auto-detection
Apr 01 21:00:09 volumio volumio[16416]: info: Loading plugin "volumiodiscovery"...
Apr 01 21:00:09 volumio volumio[16416]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:09 volumio node[16416]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:09 volumio node[16416]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:09 volumio volumio[16416]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:09 volumio volumio[16416]: *** WARNING *** For more information see
Apr 01 21:00:09 volumio volumio[16416]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:09 volumio volumio[16416]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:09 volumio node[16416]: *** WARNING *** For more information see
Apr 01 21:00:09 volumio volumio[16416]: *** WARNING *** For more information see
Apr 01 21:00:09 volumio node[16416]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:09 volumio node[16416]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:09 volumio node[16416]: *** WARNING *** For more information see
Apr 01 21:00:09 volumio volumio[16416]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 01 21:00:09 volumio volumio[16416]: info: Discovery: Started advertising with name: VOLUMIO
Apr 01 21:00:09 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 01 21:00:09 volumio volumio[16416]: info: Loading plugin "bandcamp"...
Apr 01 21:00:10 volumio volumio[16416]: info: Loading plugin "calmradio"...
Apr 01 21:00:11 volumio volumio[16416]: info: Loading plugin "mixcloud"...
Apr 01 21:00:12 volumio volumio[16416]: info: Loading plugin "soundcloud"...
Apr 01 21:00:12 volumio volumio[16416]: info: Loading plugin "spop"...
Apr 01 21:00:13 volumio volumio[16416]: info: Loading plugin "youtube2"...
Apr 01 21:00:15 volumio volumio[16416]: info: Loading plugin "outputs"...
Apr 01 21:00:15 volumio volumio[16416]: info: Loading plugin "albumart"...
Apr 01 21:00:15 volumio volumio[16416]: info: Plugin example_plugin is not enabled
Apr 01 21:00:15 volumio volumio[16416]: info: Loading plugin "inputs"...
Apr 01 21:00:15 volumio volumio[16416]: info: Loading plugin "updater_comm"...
Apr 01 21:00:15 volumio volumio[16416]: info: Plugin mpdemulation is not enabled
Apr 01 21:00:15 volumio volumio[16416]: info: Loading plugin "rest_api"...
Apr 01 21:00:15 volumio volumio[16416]: info: Loading plugin "websocket"...
Apr 01 21:00:15 volumio volumio[16416]: info: Loading plugin "RoonBridge"...
Apr 01 21:00:15 volumio volumio[16416]: info: Applying required configuration parameters for plugin RoonBridge
Apr 01 21:00:16 volumio volumio[16416]: info: Loading plugin "motherearthradio"...
Apr 01 21:00:16 volumio volumio[16416]: Forking 3 albumart workers
Apr 01 21:00:16 volumio volumio[16416]: info: Applying required configuration parameters for plugin motherearthradio
Apr 01 21:00:16 volumio volumio[16416]: info: [1711994416605] [MotherEarth] API delay: 5
Apr 01 21:00:16 volumio volumio[16416]: info: Loading plugin "music_services_shield"...
Apr 01 21:00:17 volumio volumio[16416]: info: Applying required configuration parameters for plugin music_services_shield
Apr 01 21:00:17 volumio volumio[16416]: info: Loading plugin "lastfm"...
Apr 01 21:00:17 volumio volumio[16416]: Starting albumart workers
Apr 01 21:00:18 volumio volumio[16416]: Starting albumart workers
Apr 01 21:00:18 volumio volumio[16416]: Starting albumart workers
Apr 01 21:00:18 volumio volumio[16416]: info: Loading i18n strings for locale en
Apr 01 21:00:18 volumio volumio[16416]: Updating browse sources language
Apr 01 21:00:18 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:18 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:00:18 volumio volumio[16416]: info: CoreCommandRouter::initPlayerControls
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: Express server listening on port 3000
Apr 01 21:00:19 volumio volumio[16416]: [Metrics] WebUI: 15s 90.92ms
Apr 01 21:00:19 volumio volumio[16416]: info: CoreStateMachine::resetVolumioState
Apr 01 21:00:19 volumio volumio[16416]: info: CoreStateMachine::getcurrentVolume
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::volumioRetrievevolume
Apr 01 21:00:19 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:00:19 volumio volumio[16416]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 01 21:00:19 volumio volumio[16416]: info: Completed loading Core Plugins
Apr 01 21:00:19 volumio volumio[16416]: info: Preparing to generate the ALSA configuration file
Apr 01 21:00:19 volumio volumio[16416]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 01 21:00:19 volumio volumio[16416]: wlan0 Interface doesn't support scanning.
Apr 01 21:00:19 volumio volumio[16416]: info: Cannot use regular scanning, forcing with ap-force
Apr 01 21:00:19 volumio sudo[16525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 01 21:00:19 volumio sudo[16525]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:19 volumio sudo[16525]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:19 volumio volumio[16416]: command failed: No such device (-19)
Apr 01 21:00:19 volumio volumio[16416]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 01 21:00:19 volumio volumio[16416]: command failed: No such device (-19)
Apr 01 21:00:19 volumio volumio[16416]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 01 21:00:19 volumio volumio[16416]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0
Apr 01 21:00:19 volumio volumio[16416]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1
Apr 01 21:00:19 volumio volumio[16416]: info: Reloading queue from file
Apr 01 21:00:20 volumio volumio[16416]: info: VolumeController:: Volume=undefined Mute =false
Apr 01 21:00:20 volumio volumio[16416]: info: CoreStateMachine::pushState
Apr 01 21:00:20 volumio volumio[16416]: info: CorePlayQueue::getTrack 0
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioPushState
Apr 01 21:00:20 volumio volumio[16416]: info: CoreStateMachine::updateTrackBlock
Apr 01 21:00:20 volumio volumio[16416]: info: CorePlayQueue::getTrackBlock
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioRetrievevolume
Apr 01 21:00:20 volumio volumio[16416]: info: Asound.conf file unchanged, so no further update is needed
Apr 01 21:00:20 volumio volumio[16416]: info: Output device has changed, restarting MPD
Apr 01 21:00:20 volumio sudo[16552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 01 21:00:20 volumio sudo[16552]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:20 volumio volumio[16416]: info: Output device has changed, restarting Shairport Sync
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:00:20 volumio sudo[16552]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:20 volumio sudo[16554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 01 21:00:20 volumio sudo[16554]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:20 volumio systemd[1]: musicservicesshield.service: Succeeded.
Apr 01 21:00:20 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Apr 01 21:00:20 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Apr 01 21:00:20 volumio systemd[1]: Stopping Music Player Daemon...
Apr 01 21:00:20 volumio systemd[1]: mpd.service: Succeeded.
Apr 01 21:00:20 volumio systemd[1]: Stopped Music Player Daemon.
Apr 01 21:00:20 volumio volumio[16416]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:00:20 volumio volumio[16416]: info: ___________ START PLUGINS ___________
Apr 01 21:00:20 volumio volumio[16416]: info: ControllerMpd::onStart: Initializing MPD
Apr 01 21:00:20 volumio volumio[16416]: info: Creating MPD Configuration file
Apr 01 21:00:20 volumio systemd[1]: Starting Music Player Daemon...
Apr 01 21:00:20 volumio sudo[16562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 01 21:00:20 volumio sudo[16562]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:20 volumio sudo[16562]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:20 volumio volumio[16416]: info: [1711994420406] CoreMusicLibrary::Adding element Media Servers
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:20 volumio sudo[16565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 01 21:00:20 volumio sudo[16565]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:20 volumio volumio-remote-updater[7589]: [2024-04-01 21:00:20] [connect] Successful connection
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:00:20 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 01 21:00:20 volumio systemd[1]: mpd.service: Succeeded.
Apr 01 21:00:20 volumio systemd[1]: Stopped Music Player Daemon.
Apr 01 21:00:20 volumio systemd[1]: Starting Music Player Daemon...
Apr 01 21:00:20 volumio volumio[16416]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:00:20 volumio volumio[16416]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:20 volumio volumio[16416]: info: [1711994420693] CoreMusicLibrary::Adding element Last_100
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:20 volumio volumio[16416]: info: [1711994420699] CoreMusicLibrary::Adding element Webradio
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:20 volumio volumio[16416]: info: [1711994420730] CoreMusicLibrary::Adding element Bandcamp Discover
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:20 volumio volumio[16416]: info: Adding Calm Radio to Browse Sources
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:20 volumio volumio[16416]: info: [1711994420741] CoreMusicLibrary::Adding element Calm Radio
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Calm Radio
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:20 volumio volumio[16416]: info: [1711994420760] CoreMusicLibrary::Adding element Mixcloud
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Calm Radio
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Mixcloud
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:20 volumio volumio[16416]: info: [1711994420777] CoreMusicLibrary::Adding element SoundCloud
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Calm Radio
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Mixcloud
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source SoundCloud
Apr 01 21:00:20 volumio volumio[16416]: info: Creating Spotify config file
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:20 volumio volumio[16416]: info: [1711994420822] CoreMusicLibrary::Adding element YouTube2
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Calm Radio
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Mixcloud
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source SoundCloud
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source YouTube2
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:20 volumio volumio[16416]: info: [1711994420874] CoreMusicLibrary::Adding element Mother Earth Radio
Apr 01 21:00:20 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Calm Radio
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Mixcloud
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source SoundCloud
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source YouTube2
Apr 01 21:00:20 volumio volumio[16416]: Cannot find translation for source Mother Earth Radio
Apr 01 21:00:20 volumio sudo[16575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Apr 01 21:00:20 volumio sudo[16575]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:20 volumio sudo[16575]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:21 volumio volumio[16416]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:21 volumio volumio[16416]: info: [1711994421285] CoreMusicLibrary::Adding element LastFM
Apr 01 21:00:21 volumio volumio[16416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:21 volumio volumio[16416]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:21 volumio volumio[16416]: Cannot find translation for source Calm Radio
Apr 01 21:00:21 volumio volumio[16416]: Cannot find translation for source Mixcloud
Apr 01 21:00:21 volumio volumio[16416]: Cannot find translation for source SoundCloud
Apr 01 21:00:21 volumio volumio[16416]: Cannot find translation for source YouTube2
Apr 01 21:00:21 volumio volumio[16416]: Cannot find translation for source Mother Earth Radio
Apr 01 21:00:21 volumio volumio[16416]: Cannot find translation for source LastFM
Apr 01 21:00:21 volumio volumio[16416]: info: [LastFM] scrobbler initiated!
Apr 01 21:00:21 volumio volumio[16416]: info: [LastFM] extended logging: false
Apr 01 21:00:21 volumio volumio[16416]: info: [LastFM] try scrobble stream/radio plays: true
Apr 01 21:00:21 volumio volumio[16416]: info: [LastFM] Left init routine
Apr 01 21:00:21 volumio volumio[16416]: info: [LastFM] Socket already connected: false
Apr 01 21:00:21 volumio volumio[16416]: info: Volumio Calling Home
Apr 01 21:00:21 volumio sudo[16603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Apr 01 21:00:21 volumio sudo[16603]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:21 volumio volumio[16416]: info: CoreStateMachine::setRepeat null single undefined
Apr 01 21:00:21 volumio volumio[16416]: info: CoreStateMachine::pushState
Apr 01 21:00:21 volumio volumio[16416]: info: CorePlayQueue::getTrack 0
Apr 01 21:00:21 volumio volumio[16416]: info: CoreCommandRouter::volumioPushState
Apr 01 21:00:21 volumio volumio[16416]: info: CoreStateMachine::setRandom null
Apr 01 21:00:21 volumio volumio[16416]: info: CoreStateMachine::pushState
Apr 01 21:00:21 volumio volumio[16416]: info: CorePlayQueue::getTrack 0
Apr 01 21:00:21 volumio volumio[16416]: info: CoreCommandRouter::volumioPushState
Apr 01 21:00:21 volumio volumio[16416]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:00:21 volumio volumio[16416]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com
Apr 01 21:00:21 volumio volumio[16416]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
Apr 01 21:00:21 volumio volumio[16416]: errno: -3007,
Apr 01 21:00:21 volumio volumio[16416]: code: 'ENOTFOUND',
Apr 01 21:00:21 volumio volumio[16416]: syscall: 'getaddrinfo',
Apr 01 21:00:21 volumio volumio[16416]: hostname: 'ws.audioscrobbler.com'
Apr 01 21:00:21 volumio volumio[16416]: }
Apr 01 21:00:21 volumio volumio[16416]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:00:22 volumio sudo[16603]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:23 volumio sudo[16632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-01 20:59
Apr 01 21:00:23 volumio sudo[16632]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:23 volumio sudo[16632]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:23 volumio volumio-remote-updater[7589]: [2024-04-01 21:00:23] [info] asio async_read_at_least error: system:104 (Connection reset by peer)
Apr 01 21:00:23 volumio volumio-remote-updater[7589]: [2024-04-01 21:00:23] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error)
Apr 01 21:00:23 volumio volumio-remote-updater[7589]: [2024-04-01 21:00:23] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 01 21:00:23 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 01 21:00:23 volumio sudo[16565]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:23 volumio sudo[16554]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:23 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 01 21:00:23 volumio systemd[1]: Started dynamicswap service.
Apr 01 21:00:23 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 01 21:00:23 volumio mpd[16570]: Apr 01 21:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 01 21:00:23 volumio systemd[1]: Started Music Player Daemon.
Apr 01 21:00:23 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Apr 01 21:00:23 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 01 21:00:23 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 22.
Apr 01 21:00:23 volumio systemd[1]: Stopped Volumio Backend Module.
Apr 01 21:00:23 volumio systemd[1]: Started Volumio Backend Module.
Apr 01 21:00:23 volumio systemd[1]: Started dynamicswap service.
Apr 01 21:00:23 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 01 21:00:24 volumio volumio[16647]: cset: --> shielding system active with
Apr 01 21:00:24 volumio volumio[16647]: cset: "system" cpuset of CPUSPEC(0-2) with 85 tasks running
Apr 01 21:00:24 volumio volumio[16647]: cset: "user" cpuset of CPUSPEC(3) with 3 tasks running
Apr 01 21:00:24 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Apr 01 21:00:26 volumio volumio[16650]: info: -------------------------------------------
Apr 01 21:00:26 volumio volumio[16650]: info: ----- Volumio3 ----
Apr 01 21:00:26 volumio volumio[16650]: info: -------------------------------------------
Apr 01 21:00:26 volumio volumio[16650]: info: ----- System startup ----
Apr 01 21:00:26 volumio volumio[16650]: info: -------------------------------------------
Apr 01 21:00:27 volumio volumio[16650]: info: MYVOLUMIO Environment detected
Apr 01 21:00:27 volumio volumio[16650]: info: Plugin folders cleanup
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning into folder /volumio/app/plugins/
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning category audio_interface
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning category miscellanea
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning category music_service
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning category plugins.json
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning category system_controller
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning category user_interface
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning into folder /data/plugins/
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning category music_service
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning category system_hardware
Apr 01 21:00:27 volumio volumio[16650]: info: Scanning category user_interface
Apr 01 21:00:27 volumio volumio[16650]: info: Plugin folders cleanup completed
Apr 01 21:00:27 volumio volumio[16650]: info: -------------------------------------------
Apr 01 21:00:27 volumio volumio[16650]: info: ----- Core plugins startup ----
Apr 01 21:00:27 volumio volumio[16650]: info: -------------------------------------------
Apr 01 21:00:27 volumio volumio[16650]: info: Loading plugins from folder /volumio/app/plugins/
Apr 01 21:00:27 volumio volumio[16650]: info: Adding plugin upnp to MyMusic Plugins
Apr 01 21:00:27 volumio volumio[16650]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 01 21:00:27 volumio volumio[16650]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 01 21:00:27 volumio volumio[16650]: info: Loading plugins from folder /data/plugins/
Apr 01 21:00:27 volumio volumio[16650]: info: Loading plugin "system"...
Apr 01 21:00:27 volumio volumio[16650]: info: Loading plugin "appearance"...
Apr 01 21:00:28 volumio volumio[16650]: info: Loading plugin "network"...
Apr 01 21:00:29 volumio volumio[16650]: info: Refreshing Cached IP Addresses
Apr 01 21:00:29 volumio sudo[16729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 01 21:00:29 volumio sudo[16729]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:29 volumio volumio[16650]: info: Loading plugin "services"...
Apr 01 21:00:29 volumio sudo[16729]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:29 volumio volumio[16650]: info: Loading plugin "alsa_controller"...
Apr 01 21:00:29 volumio sudo[16731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 01 21:00:29 volumio sudo[16731]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:29 volumio sudo[16734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 01 21:00:29 volumio sudo[16734]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:29 volumio sudo[16731]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:29 volumio sudo[16734]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:29 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 01 21:00:29 volumio volumio[16650]: info: Loading plugin "wizard"...
Apr 01 21:00:29 volumio volumio[16650]: info: Loading plugin "networkfs"...
Apr 01 21:00:29 volumio volumio[16650]: info: Starting Udev Watcher for removable devices
Apr 01 21:00:29 volumio volumio[16650]: info: Ignoring mount for partition: boot
Apr 01 21:00:29 volumio volumio[16650]: info: Ignoring mount for partition: volumio
Apr 01 21:00:29 volumio volumio[16650]: info: Ignoring mount for partition: volumio_data
Apr 01 21:00:29 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 01 21:00:29 volumio volumio[16650]: info: Loading plugin "volumio_command_line_client"...
Apr 01 21:00:29 volumio volumio[16650]: info: Plugin upnp is not enabled
Apr 01 21:00:29 volumio volumio[16650]: info: Loading plugin "my_music"...
Apr 01 21:00:29 volumio volumio[16650]: info: Loading plugin "mpd"...
Apr 01 21:00:29 volumio volumio[16650]: info: Loading plugin "upnp_browser"...
Apr 01 21:00:30 volumio volumio[16650]: info: Loading plugin "alarm-clock"...
Apr 01 21:00:30 volumio volumio[16650]: info: Loading plugin "airplay_emulation"...
Apr 01 21:00:30 volumio volumio[16650]: info: Starting Shairport Sync
Apr 01 21:00:30 volumio volumio[16650]: info: Loading plugin "last_100"...
Apr 01 21:00:30 volumio volumio[16650]: info: Loading plugin "webradio"...
Apr 01 21:00:30 volumio volumio[16650]: info: Loading plugin "i2s_dacs"...
Apr 01 21:00:30 volumio volumio[16650]: info: I2S DAC not set, start Auto-detection
Apr 01 21:00:30 volumio volumio[16650]: info: Loading plugin "volumiodiscovery"...
Apr 01 21:00:30 volumio volumio[16650]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:30 volumio volumio[16650]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:30 volumio node[16650]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:30 volumio volumio[16650]: *** WARNING *** For more information see
Apr 01 21:00:30 volumio volumio[16650]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:30 volumio volumio[16650]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:30 volumio volumio[16650]: *** WARNING *** For more information see
Apr 01 21:00:30 volumio node[16650]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:30 volumio node[16650]: *** WARNING *** For more information see
Apr 01 21:00:30 volumio node[16650]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:30 volumio node[16650]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:30 volumio node[16650]: *** WARNING *** For more information see
Apr 01 21:00:30 volumio volumio[16650]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 01 21:00:30 volumio volumio[16650]: info: Discovery: Started advertising with name: VOLUMIO
Apr 01 21:00:30 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 01 21:00:30 volumio volumio[16650]: info: Loading plugin "bandcamp"...
Apr 01 21:00:32 volumio volumio[16650]: info: Loading plugin "calmradio"...
Apr 01 21:00:33 volumio volumio[16650]: info: Loading plugin "mixcloud"...
Apr 01 21:00:33 volumio volumio-remote-updater[7589]: [2024-04-01 21:00:33] [connect] Successful connection
Apr 01 21:00:33 volumio volumio[16650]: info: Loading plugin "soundcloud"...
Apr 01 21:00:34 volumio volumio[16650]: info: Loading plugin "spop"...
Apr 01 21:00:35 volumio volumio[16650]: info: Loading plugin "youtube2"...
Apr 01 21:00:37 volumio volumio[16650]: info: Loading plugin "outputs"...
Apr 01 21:00:37 volumio volumio[16650]: info: Loading plugin "albumart"...
Apr 01 21:00:37 volumio volumio[16650]: info: Plugin example_plugin is not enabled
Apr 01 21:00:37 volumio volumio[16650]: info: Loading plugin "inputs"...
Apr 01 21:00:37 volumio volumio[16650]: info: Loading plugin "updater_comm"...
Apr 01 21:00:37 volumio volumio[16650]: info: Plugin mpdemulation is not enabled
Apr 01 21:00:37 volumio volumio[16650]: info: Loading plugin "rest_api"...
Apr 01 21:00:37 volumio volumio[16650]: info: Loading plugin "websocket"...
Apr 01 21:00:37 volumio volumio[16650]: info: Loading plugin "RoonBridge"...
Apr 01 21:00:37 volumio volumio[16650]: info: Applying required configuration parameters for plugin RoonBridge
Apr 01 21:00:37 volumio volumio[16650]: Forking 3 albumart workers
Apr 01 21:00:37 volumio volumio[16650]: info: Loading plugin "motherearthradio"...
Apr 01 21:00:38 volumio volumio[16650]: info: Applying required configuration parameters for plugin motherearthradio
Apr 01 21:00:38 volumio volumio[16650]: info: [1711994438427] [MotherEarth] API delay: 5
Apr 01 21:00:38 volumio volumio[16650]: info: Loading plugin "music_services_shield"...
Apr 01 21:00:39 volumio volumio[16650]: info: Applying required configuration parameters for plugin music_services_shield
Apr 01 21:00:39 volumio volumio[16650]: info: Loading plugin "lastfm"...
Apr 01 21:00:39 volumio volumio[16650]: Starting albumart workers
Apr 01 21:00:39 volumio volumio[16650]: Starting albumart workers
Apr 01 21:00:40 volumio volumio[16650]: Starting albumart workers
Apr 01 21:00:40 volumio volumio[16650]: info: Loading i18n strings for locale en
Apr 01 21:00:40 volumio volumio[16650]: Updating browse sources language
Apr 01 21:00:40 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::initPlayerControls
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: Express server listening on port 3000
Apr 01 21:00:41 volumio volumio[16650]: [Metrics] WebUI: 15s 482.32ms
Apr 01 21:00:41 volumio volumio[16650]: info: CoreStateMachine::resetVolumioState
Apr 01 21:00:41 volumio volumio[16650]: info: CoreStateMachine::getcurrentVolume
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::volumioRetrievevolume
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:00:41 volumio volumio[16650]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 01 21:00:41 volumio volumio[16650]: info: Completed loading Core Plugins
Apr 01 21:00:41 volumio volumio[16650]: info: Preparing to generate the ALSA configuration file
Apr 01 21:00:41 volumio volumio[16650]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 01 21:00:41 volumio volumio[16650]: wlan0 Interface doesn't support scanning.
Apr 01 21:00:41 volumio volumio[16650]: info: Cannot use regular scanning, forcing with ap-force
Apr 01 21:00:41 volumio sudo[16813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 01 21:00:41 volumio sudo[16813]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:41 volumio sudo[16813]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:41 volumio volumio[16650]: command failed: No such device (-19)
Apr 01 21:00:41 volumio volumio[16650]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 01 21:00:41 volumio volumio[16650]: command failed: No such device (-19)
Apr 01 21:00:41 volumio volumio[16650]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 01 21:00:41 volumio volumio[16650]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0
Apr 01 21:00:41 volumio volumio[16650]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1
Apr 01 21:00:41 volumio volumio[16650]: info: Reloading queue from file
Apr 01 21:00:41 volumio volumio[16650]: info: VolumeController:: Volume=undefined Mute =false
Apr 01 21:00:41 volumio volumio[16650]: info: CoreStateMachine::pushState
Apr 01 21:00:41 volumio volumio[16650]: info: CorePlayQueue::getTrack 0
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::volumioPushState
Apr 01 21:00:41 volumio volumio[16650]: info: CoreStateMachine::updateTrackBlock
Apr 01 21:00:41 volumio volumio[16650]: info: CorePlayQueue::getTrackBlock
Apr 01 21:00:41 volumio volumio[16650]: info: CoreCommandRouter::volumioRetrievevolume
Apr 01 21:00:41 volumio volumio[16650]: info: Asound.conf file unchanged, so no further update is needed
Apr 01 21:00:41 volumio volumio[16650]: info: Output device has changed, restarting MPD
Apr 01 21:00:42 volumio sudo[16824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 01 21:00:42 volumio sudo[16824]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:42 volumio volumio[16650]: info: Output device has changed, restarting Shairport Sync
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:00:42 volumio sudo[16824]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:42 volumio sudo[16827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 01 21:00:42 volumio sudo[16827]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:42 volumio systemd[1]: musicservicesshield.service: Succeeded.
Apr 01 21:00:42 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Apr 01 21:00:42 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Apr 01 21:00:42 volumio systemd[1]: Stopping Music Player Daemon...
Apr 01 21:00:42 volumio volumio[16650]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:00:42 volumio volumio[16650]: info: ___________ START PLUGINS ___________
Apr 01 21:00:42 volumio volumio[16650]: info: ControllerMpd::onStart: Initializing MPD
Apr 01 21:00:42 volumio volumio[16650]: info: Creating MPD Configuration file
Apr 01 21:00:42 volumio systemd[1]: mpd.service: Succeeded.
Apr 01 21:00:42 volumio systemd[1]: Stopped Music Player Daemon.
Apr 01 21:00:42 volumio systemd[1]: Starting Music Player Daemon...
Apr 01 21:00:42 volumio sudo[16834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 01 21:00:42 volumio sudo[16834]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:42 volumio volumio[16650]: info: [1711994442270] CoreMusicLibrary::Adding element Media Servers
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:42 volumio sudo[16834]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:00:42 volumio sudo[16837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 01 21:00:42 volumio sudo[16837]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:42 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 01 21:00:42 volumio systemd[1]: mpd.service: Succeeded.
Apr 01 21:00:42 volumio systemd[1]: Stopped Music Player Daemon.
Apr 01 21:00:42 volumio volumio[16650]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:00:42 volumio systemd[1]: Starting Music Player Daemon...
Apr 01 21:00:42 volumio volumio[16650]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:42 volumio volumio[16650]: info: [1711994442538] CoreMusicLibrary::Adding element Last_100
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:42 volumio volumio[16650]: info: [1711994442544] CoreMusicLibrary::Adding element Webradio
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:42 volumio volumio[16650]: info: [1711994442574] CoreMusicLibrary::Adding element Bandcamp Discover
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:42 volumio volumio[16650]: info: Adding Calm Radio to Browse Sources
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:42 volumio volumio[16650]: info: [1711994442583] CoreMusicLibrary::Adding element Calm Radio
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Calm Radio
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:42 volumio volumio[16650]: info: [1711994442600] CoreMusicLibrary::Adding element Mixcloud
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Calm Radio
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Mixcloud
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:42 volumio volumio[16650]: info: [1711994442617] CoreMusicLibrary::Adding element SoundCloud
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Calm Radio
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Mixcloud
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source SoundCloud
Apr 01 21:00:42 volumio volumio[16650]: info: Creating Spotify config file
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:42 volumio volumio[16650]: info: [1711994442660] CoreMusicLibrary::Adding element YouTube2
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Calm Radio
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Mixcloud
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source SoundCloud
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source YouTube2
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:42 volumio volumio[16650]: info: [1711994442711] CoreMusicLibrary::Adding element Mother Earth Radio
Apr 01 21:00:42 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Calm Radio
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Mixcloud
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source SoundCloud
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source YouTube2
Apr 01 21:00:42 volumio volumio[16650]: Cannot find translation for source Mother Earth Radio
Apr 01 21:00:42 volumio sudo[16847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Apr 01 21:00:42 volumio sudo[16847]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:42 volumio sudo[16847]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:43 volumio volumio[16650]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:00:43 volumio volumio[16650]: info: [1711994443085] CoreMusicLibrary::Adding element LastFM
Apr 01 21:00:43 volumio volumio[16650]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:00:43 volumio volumio[16650]: Cannot find translation for source Bandcamp Discover
Apr 01 21:00:43 volumio volumio[16650]: Cannot find translation for source Calm Radio
Apr 01 21:00:43 volumio volumio[16650]: Cannot find translation for source Mixcloud
Apr 01 21:00:43 volumio volumio[16650]: Cannot find translation for source SoundCloud
Apr 01 21:00:43 volumio volumio[16650]: Cannot find translation for source YouTube2
Apr 01 21:00:43 volumio volumio[16650]: Cannot find translation for source Mother Earth Radio
Apr 01 21:00:43 volumio volumio[16650]: Cannot find translation for source LastFM
Apr 01 21:00:43 volumio volumio[16650]: info: [LastFM] scrobbler initiated!
Apr 01 21:00:43 volumio volumio[16650]: info: [LastFM] extended logging: false
Apr 01 21:00:43 volumio volumio[16650]: info: [LastFM] try scrobble stream/radio plays: true
Apr 01 21:00:43 volumio volumio[16650]: info: [LastFM] Left init routine
Apr 01 21:00:43 volumio volumio[16650]: info: [LastFM] Socket already connected: false
Apr 01 21:00:43 volumio volumio[16650]: info: Volumio Calling Home
Apr 01 21:00:43 volumio sudo[16875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Apr 01 21:00:43 volumio sudo[16875]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:43 volumio volumio[16650]: info: CoreStateMachine::setRepeat null single undefined
Apr 01 21:00:43 volumio volumio[16650]: info: CoreStateMachine::pushState
Apr 01 21:00:43 volumio volumio[16650]: info: CorePlayQueue::getTrack 0
Apr 01 21:00:43 volumio volumio[16650]: info: CoreCommandRouter::volumioPushState
Apr 01 21:00:43 volumio volumio[16650]: info: CoreStateMachine::setRandom null
Apr 01 21:00:43 volumio volumio[16650]: info: CoreStateMachine::pushState
Apr 01 21:00:43 volumio volumio[16650]: info: CorePlayQueue::getTrack 0
Apr 01 21:00:43 volumio volumio[16650]: info: CoreCommandRouter::volumioPushState
Apr 01 21:00:43 volumio volumio[16650]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:00:43 volumio volumio[16650]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com
Apr 01 21:00:43 volumio volumio[16650]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
Apr 01 21:00:43 volumio volumio[16650]: errno: -3007,
Apr 01 21:00:43 volumio volumio[16650]: code: 'ENOTFOUND',
Apr 01 21:00:43 volumio volumio[16650]: syscall: 'getaddrinfo',
Apr 01 21:00:43 volumio volumio[16650]: hostname: 'ws.audioscrobbler.com'
Apr 01 21:00:43 volumio volumio[16650]: }
Apr 01 21:00:43 volumio volumio[16650]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:00:44 volumio sudo[16875]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:44 volumio sudo[16904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-01 20:59
Apr 01 21:00:44 volumio sudo[16904]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:44 volumio sudo[16904]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:45 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 01 21:00:45 volumio sudo[16827]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:45 volumio sudo[16837]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:45 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 01 21:00:45 volumio systemd[1]: Started dynamicswap service.
Apr 01 21:00:45 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 01 21:00:45 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 01 21:00:45 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 23.
Apr 01 21:00:45 volumio systemd[1]: Stopped Volumio Backend Module.
Apr 01 21:00:45 volumio systemd[1]: Started Volumio Backend Module.
Apr 01 21:00:45 volumio systemd[1]: Started dynamicswap service.
Apr 01 21:00:45 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 01 21:00:45 volumio mpd[16842]: Apr 01 21:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 01 21:00:45 volumio systemd[1]: Started Music Player Daemon.
Apr 01 21:00:46 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Apr 01 21:00:46 volumio volumio[16933]: cset: --> shielding system active with
Apr 01 21:00:46 volumio volumio[16933]: cset: "system" cpuset of CPUSPEC(0-2) with 88 tasks running
Apr 01 21:00:46 volumio volumio[16933]: cset: "user" cpuset of CPUSPEC(3) with 3 tasks running
Apr 01 21:00:46 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Apr 01 21:00:48 volumio volumio[16918]: info: -------------------------------------------
Apr 01 21:00:48 volumio volumio[16918]: info: ----- Volumio3 ----
Apr 01 21:00:48 volumio volumio[16918]: info: -------------------------------------------
Apr 01 21:00:48 volumio volumio[16918]: info: ----- System startup ----
Apr 01 21:00:48 volumio volumio[16918]: info: -------------------------------------------
Apr 01 21:00:48 volumio volumio-remote-updater[7589]: [2024-04-01 21:00:48] [connect] Successful connection
Apr 01 21:00:49 volumio volumio[16918]: info: MYVOLUMIO Environment detected
Apr 01 21:00:49 volumio volumio[16918]: info: Plugin folders cleanup
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning into folder /volumio/app/plugins/
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning category audio_interface
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning category miscellanea
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning category music_service
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning category plugins.json
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning category system_controller
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning category user_interface
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning into folder /data/plugins/
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning category music_service
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning category system_hardware
Apr 01 21:00:49 volumio volumio[16918]: info: Scanning category user_interface
Apr 01 21:00:49 volumio volumio[16918]: info: Plugin folders cleanup completed
Apr 01 21:00:49 volumio volumio[16918]: info: -------------------------------------------
Apr 01 21:00:49 volumio volumio[16918]: info: ----- Core plugins startup ----
Apr 01 21:00:49 volumio volumio[16918]: info: -------------------------------------------
Apr 01 21:00:49 volumio volumio[16918]: info: Loading plugins from folder /volumio/app/plugins/
Apr 01 21:00:49 volumio volumio[16918]: info: Adding plugin upnp to MyMusic Plugins
Apr 01 21:00:49 volumio volumio[16918]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 01 21:00:49 volumio volumio[16918]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 01 21:00:49 volumio volumio[16918]: info: Loading plugins from folder /data/plugins/
Apr 01 21:00:49 volumio volumio[16918]: info: Loading plugin "system"...
Apr 01 21:00:49 volumio volumio[16918]: info: Loading plugin "appearance"...
Apr 01 21:00:50 volumio ntpd[13838]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Apr 01 21:00:50 volumio volumio[16918]: info: Loading plugin "network"...
Apr 01 21:00:50 volumio volumio[16918]: info: Refreshing Cached IP Addresses
Apr 01 21:00:50 volumio sudo[16962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 01 21:00:50 volumio sudo[16962]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:50 volumio sudo[16962]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:50 volumio sudo[16964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 01 21:00:50 volumio volumio[16918]: info: Loading plugin "services"...
Apr 01 21:00:50 volumio sudo[16964]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:51 volumio volumio[16918]: info: Loading plugin "alsa_controller"...
Apr 01 21:00:51 volumio sudo[16964]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:51 volumio sudo[16968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 01 21:00:51 volumio sudo[16968]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:00:51 volumio sudo[16968]: pam_unix(sudo:session): session closed for user root
Apr 01 21:00:51 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 01 21:00:51 volumio volumio[16918]: info: Loading plugin "wizard"...
Apr 01 21:00:51 volumio volumio[16918]: info: Loading plugin "networkfs"...
Apr 01 21:00:51 volumio volumio[16918]: info: Starting Udev Watcher for removable devices
Apr 01 21:00:51 volumio volumio[16918]: info: Ignoring mount for partition: boot
Apr 01 21:00:51 volumio volumio[16918]: info: Ignoring mount for partition: volumio
Apr 01 21:00:51 volumio volumio[16918]: info: Ignoring mount for partition: volumio_data
Apr 01 21:00:51 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 01 21:00:51 volumio volumio[16918]: info: Loading plugin "volumio_command_line_client"...
Apr 01 21:00:51 volumio volumio[16918]: info: Plugin upnp is not enabled
Apr 01 21:00:51 volumio volumio[16918]: info: Loading plugin "my_music"...
Apr 01 21:00:51 volumio volumio[16918]: info: Loading plugin "mpd"...
Apr 01 21:00:51 volumio volumio[16918]: info: Loading plugin "upnp_browser"...
Apr 01 21:00:52 volumio volumio[16918]: info: Loading plugin "alarm-clock"...
Apr 01 21:00:52 volumio volumio[16918]: info: Loading plugin "airplay_emulation"...
Apr 01 21:00:52 volumio volumio[16918]: info: Starting Shairport Sync
Apr 01 21:00:52 volumio volumio[16918]: info: Loading plugin "last_100"...
Apr 01 21:00:52 volumio volumio[16918]: info: Loading plugin "webradio"...
Apr 01 21:00:52 volumio volumio[16918]: info: Loading plugin "i2s_dacs"...
Apr 01 21:00:52 volumio volumio[16918]: info: I2S DAC not set, start Auto-detection
Apr 01 21:00:52 volumio volumio[16918]: info: Loading plugin "volumiodiscovery"...
Apr 01 21:00:52 volumio volumio[16918]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:52 volumio node[16918]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:52 volumio node[16918]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:52 volumio volumio[16918]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:52 volumio volumio[16918]: *** WARNING *** For more information see
Apr 01 21:00:52 volumio volumio[16918]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:52 volumio volumio[16918]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:52 volumio volumio[16918]: *** WARNING *** For more information see
Apr 01 21:00:52 volumio node[16918]: *** WARNING *** For more information see
Apr 01 21:00:52 volumio node[16918]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:00:52 volumio node[16918]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:00:52 volumio node[16918]: *** WARNING *** For more information see
Apr 01 21:00:52 volumio volumio[16918]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 01 21:00:52 volumio volumio[16918]: info: Discovery: Started advertising with name: VOLUMIO
Apr 01 21:00:52 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 01 21:00:52 volumio volumio[16918]: info: Loading plugin "bandcamp"...
Apr 01 21:00:53 volumio ntpd[13838]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Apr 01 21:00:53 volumio ntpd[13838]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Apr 01 21:00:54 volumio volumio[16918]: info: Loading plugin "calmradio"...
Apr 01 21:00:54 volumio ntpd[13838]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Apr 01 21:00:55 volumio volumio[16918]: info: Loading plugin "mixcloud"...
Apr 01 21:00:55 volumio volumio[16918]: info: Loading plugin "soundcloud"...
Apr 01 21:00:56 volumio volumio[16918]: info: Loading plugin "spop"...
Apr 01 21:00:57 volumio volumio[16918]: info: Loading plugin "youtube2"...
Apr 01 21:00:59 volumio volumio[16918]: info: Loading plugin "outputs"...
Apr 01 21:00:59 volumio volumio[16918]: info: Loading plugin "albumart"...
Apr 01 21:00:59 volumio volumio[16918]: info: Plugin example_plugin is not enabled
Apr 01 21:00:59 volumio volumio[16918]: info: Loading plugin "inputs"...
Apr 01 21:00:59 volumio volumio[16918]: info: Loading plugin "updater_comm"...
Apr 01 21:00:59 volumio volumio[16918]: info: Plugin mpdemulation is not enabled
Apr 01 21:00:59 volumio volumio[16918]: info: Loading plugin "rest_api"...
Apr 01 21:00:59 volumio volumio[16918]: info: Loading plugin "websocket"...
Apr 01 21:00:59 volumio volumio[16918]: info: Loading plugin "RoonBridge"...
Apr 01 21:00:59 volumio volumio[16918]: Forking 3 albumart workers
Apr 01 21:00:59 volumio volumio[16918]: info: Applying required configuration parameters for plugin RoonBridge
Apr 01 21:00:59 volumio volumio[16918]: info: Loading plugin "motherearthradio"...
Apr 01 21:01:00 volumio volumio[16918]: info: Applying required configuration parameters for plugin motherearthradio
Apr 01 21:01:00 volumio volumio[16918]: info: [1711994460755] [MotherEarth] API delay: 5
Apr 01 21:01:00 volumio volumio[16918]: info: Loading plugin "music_services_shield"...
Apr 01 21:01:01 volumio volumio[16918]: Starting albumart workers
Apr 01 21:01:01 volumio volumio[16918]: Starting albumart workers
Apr 01 21:01:01 volumio volumio[16918]: info: Applying required configuration parameters for plugin music_services_shield
Apr 01 21:01:01 volumio volumio[16918]: info: Loading plugin "lastfm"...
Apr 01 21:01:02 volumio volumio[16918]: Starting albumart workers
Apr 01 21:01:02 volumio volumio[16918]: info: Loading i18n strings for locale en
Apr 01 21:01:02 volumio volumio[16918]: Updating browse sources language
Apr 01 21:01:02 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::initPlayerControls
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: Express server listening on port 3000
Apr 01 21:01:03 volumio volumio[16918]: [Metrics] WebUI: 15s 728.49ms
Apr 01 21:01:03 volumio volumio[16918]: info: CoreStateMachine::resetVolumioState
Apr 01 21:01:03 volumio volumio[16918]: info: CoreStateMachine::getcurrentVolume
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::volumioRetrievevolume
Apr 01 21:01:03 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:01:03 volumio volumio[16918]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 01 21:01:03 volumio volumio[16918]: info: Completed loading Core Plugins
Apr 01 21:01:03 volumio volumio[16918]: info: Preparing to generate the ALSA configuration file
Apr 01 21:01:03 volumio volumio-remote-updater[7589]: [2024-04-01 21:01:03] [connect] Successful connection
Apr 01 21:01:03 volumio volumio[16918]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 01 21:01:03 volumio volumio[16918]: wlan0 Interface doesn't support scanning.
Apr 01 21:01:03 volumio volumio[16918]: info: Cannot use regular scanning, forcing with ap-force
Apr 01 21:01:03 volumio sudo[17047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 01 21:01:03 volumio sudo[17047]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:03 volumio sudo[17047]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:03 volumio volumio[16918]: command failed: No such device (-19)
Apr 01 21:01:03 volumio volumio[16918]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 01 21:01:03 volumio volumio[16918]: command failed: No such device (-19)
Apr 01 21:01:03 volumio volumio[16918]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 01 21:01:03 volumio volumio[16918]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0
Apr 01 21:01:03 volumio volumio[16918]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1
Apr 01 21:01:03 volumio volumio-remote-updater[7589]: [2024-04-01 21:01:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1711994463 101
Apr 01 21:01:03 volumio volumio[16918]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
Apr 01 21:01:04 volumio volumio[16918]: info: Reloading queue from file
Apr 01 21:01:04 volumio volumio[16918]: info: VolumeController:: Volume=undefined Mute =false
Apr 01 21:01:04 volumio volumio[16918]: info: CoreStateMachine::pushState
Apr 01 21:01:04 volumio volumio[16918]: info: CorePlayQueue::getTrack 0
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioPushState
Apr 01 21:01:04 volumio volumio[16918]: info: CoreStateMachine::updateTrackBlock
Apr 01 21:01:04 volumio volumio[16918]: info: CorePlayQueue::getTrackBlock
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioRetrievevolume
Apr 01 21:01:04 volumio volumio[16918]: info: Asound.conf file unchanged, so no further update is needed
Apr 01 21:01:04 volumio volumio[16918]: info: Output device has changed, restarting MPD
Apr 01 21:01:04 volumio sudo[17060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 01 21:01:04 volumio sudo[17060]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:04 volumio volumio[16918]: info: Output device has changed, restarting Shairport Sync
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:01:04 volumio sudo[17060]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:04 volumio sudo[17063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 01 21:01:04 volumio sudo[17063]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:04 volumio systemd[1]: musicservicesshield.service: Succeeded.
Apr 01 21:01:04 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Apr 01 21:01:04 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Apr 01 21:01:04 volumio systemd[1]: Stopping Music Player Daemon...
Apr 01 21:01:04 volumio systemd[1]: mpd.service: Succeeded.
Apr 01 21:01:04 volumio volumio[16918]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:01:04 volumio systemd[1]: Stopped Music Player Daemon.
Apr 01 21:01:04 volumio volumio[16918]: info: ___________ START PLUGINS ___________
Apr 01 21:01:04 volumio volumio[16918]: info: ControllerMpd::onStart: Initializing MPD
Apr 01 21:01:04 volumio volumio[16918]: info: Creating MPD Configuration file
Apr 01 21:01:04 volumio systemd[1]: Starting Music Player Daemon...
Apr 01 21:01:04 volumio sudo[17070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 01 21:01:04 volumio sudo[17070]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:01:04 volumio sudo[17070]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:04 volumio volumio[16918]: info: [1711994464428] CoreMusicLibrary::Adding element Media Servers
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:01:04 volumio sudo[17073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 01 21:01:04 volumio sudo[17073]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:04 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 01 21:01:04 volumio systemd[1]: mpd.service: Succeeded.
Apr 01 21:01:04 volumio systemd[1]: Stopped Music Player Daemon.
Apr 01 21:01:04 volumio systemd[1]: Starting Music Player Daemon...
Apr 01 21:01:04 volumio volumio[16918]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:01:04 volumio volumio[16918]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:04 volumio volumio[16918]: info: [1711994464707] CoreMusicLibrary::Adding element Last_100
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:04 volumio volumio[16918]: info: [1711994464714] CoreMusicLibrary::Adding element Webradio
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:04 volumio volumio[16918]: info: [1711994464751] CoreMusicLibrary::Adding element Bandcamp Discover
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:04 volumio volumio[16918]: info: Adding Calm Radio to Browse Sources
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:04 volumio volumio[16918]: info: [1711994464762] CoreMusicLibrary::Adding element Calm Radio
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Calm Radio
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:04 volumio volumio[16918]: info: [1711994464789] CoreMusicLibrary::Adding element Mixcloud
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Calm Radio
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Mixcloud
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:04 volumio volumio[16918]: info: [1711994464814] CoreMusicLibrary::Adding element SoundCloud
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Calm Radio
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Mixcloud
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source SoundCloud
Apr 01 21:01:04 volumio volumio[16918]: info: Creating Spotify config file
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:04 volumio volumio[16918]: info: [1711994464869] CoreMusicLibrary::Adding element YouTube2
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Calm Radio
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Mixcloud
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source SoundCloud
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source YouTube2
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:04 volumio volumio[16918]: info: [1711994464923] CoreMusicLibrary::Adding element Mother Earth Radio
Apr 01 21:01:04 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Calm Radio
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Mixcloud
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source SoundCloud
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source YouTube2
Apr 01 21:01:04 volumio volumio[16918]: Cannot find translation for source Mother Earth Radio
Apr 01 21:01:04 volumio sudo[17083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Apr 01 21:01:04 volumio sudo[17083]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:04 volumio sudo[17083]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:05 volumio volumio[16918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:05 volumio volumio[16918]: info: [1711994465374] CoreMusicLibrary::Adding element LastFM
Apr 01 21:01:05 volumio volumio[16918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:05 volumio volumio[16918]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:05 volumio volumio[16918]: Cannot find translation for source Calm Radio
Apr 01 21:01:05 volumio volumio[16918]: Cannot find translation for source Mixcloud
Apr 01 21:01:05 volumio volumio[16918]: Cannot find translation for source SoundCloud
Apr 01 21:01:05 volumio volumio[16918]: Cannot find translation for source YouTube2
Apr 01 21:01:05 volumio volumio[16918]: Cannot find translation for source Mother Earth Radio
Apr 01 21:01:05 volumio volumio[16918]: Cannot find translation for source LastFM
Apr 01 21:01:05 volumio volumio[16918]: info: [LastFM] scrobbler initiated!
Apr 01 21:01:05 volumio volumio[16918]: info: [LastFM] extended logging: false
Apr 01 21:01:05 volumio volumio[16918]: info: [LastFM] try scrobble stream/radio plays: true
Apr 01 21:01:05 volumio volumio[16918]: info: [LastFM] Left init routine
Apr 01 21:01:05 volumio volumio[16918]: info: [LastFM] Socket already connected: false
Apr 01 21:01:05 volumio volumio[16918]: info: Volumio Calling Home
Apr 01 21:01:05 volumio sudo[17111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Apr 01 21:01:05 volumio sudo[17111]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:05 volumio volumio[16918]: info: CoreStateMachine::setRepeat null single undefined
Apr 01 21:01:05 volumio volumio[16918]: info: CoreStateMachine::pushState
Apr 01 21:01:05 volumio volumio[16918]: info: CorePlayQueue::getTrack 0
Apr 01 21:01:05 volumio volumio[16918]: info: CoreCommandRouter::volumioPushState
Apr 01 21:01:05 volumio volumio[16918]: info: CoreStateMachine::setRandom null
Apr 01 21:01:05 volumio volumio[16918]: info: CoreStateMachine::pushState
Apr 01 21:01:05 volumio volumio[16918]: info: CorePlayQueue::getTrack 0
Apr 01 21:01:05 volumio volumio[16918]: info: CoreCommandRouter::volumioPushState
Apr 01 21:01:05 volumio volumio[16918]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:01:05 volumio volumio[16918]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com
Apr 01 21:01:05 volumio volumio[16918]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
Apr 01 21:01:05 volumio volumio[16918]: errno: -3007,
Apr 01 21:01:05 volumio volumio[16918]: code: 'ENOTFOUND',
Apr 01 21:01:05 volumio volumio[16918]: syscall: 'getaddrinfo',
Apr 01 21:01:05 volumio volumio[16918]: hostname: 'ws.audioscrobbler.com'
Apr 01 21:01:05 volumio volumio[16918]: }
Apr 01 21:01:05 volumio volumio[16918]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:01:06 volumio sudo[17111]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:07 volumio sudo[17140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-01 21:00
Apr 01 21:01:07 volumio sudo[17140]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:07 volumio sudo[17140]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:07 volumio volumio-remote-updater[7589]: [2024-04-01 21:01:07] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 01 21:01:07 volumio volumio-remote-updater[7589]: [2024-04-01 21:01:07] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 01 21:01:07 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 01 21:01:07 volumio sudo[17063]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:07 volumio sudo[17073]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:07 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 01 21:01:07 volumio systemd[1]: Started dynamicswap service.
Apr 01 21:01:07 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 01 21:01:07 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 01 21:01:07 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 24.
Apr 01 21:01:07 volumio mpd[17078]: Apr 01 21:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 01 21:01:07 volumio systemd[1]: Started dynamicswap service.
Apr 01 21:01:07 volumio systemd[1]: Stopped Volumio Backend Module.
Apr 01 21:01:07 volumio systemd[1]: Started Volumio Backend Module.
Apr 01 21:01:07 volumio systemd[1]: Started Music Player Daemon.
Apr 01 21:01:07 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Apr 01 21:01:07 volumio systemd[1]: dynamicswap.service: Succeeded.
Apr 01 21:01:08 volumio volumio[17162]: cset: --> shielding system active with
Apr 01 21:01:08 volumio volumio[17162]: cset: "system" cpuset of CPUSPEC(0-2) with 87 tasks running
Apr 01 21:01:08 volumio volumio[17162]: cset: "user" cpuset of CPUSPEC(3) with 3 tasks running
Apr 01 21:01:08 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Apr 01 21:01:10 volumio volumio[17156]: info: -------------------------------------------
Apr 01 21:01:10 volumio volumio[17156]: info: ----- Volumio3 ----
Apr 01 21:01:10 volumio volumio[17156]: info: -------------------------------------------
Apr 01 21:01:10 volumio volumio[17156]: info: ----- System startup ----
Apr 01 21:01:10 volumio volumio[17156]: info: -------------------------------------------
Apr 01 21:01:11 volumio volumio[17156]: info: MYVOLUMIO Environment detected
Apr 01 21:01:11 volumio volumio[17156]: info: Plugin folders cleanup
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning into folder /volumio/app/plugins/
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning category audio_interface
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning category miscellanea
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning category music_service
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning category plugins.json
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning category system_controller
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning category user_interface
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning into folder /data/plugins/
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning category music_service
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning category system_hardware
Apr 01 21:01:11 volumio volumio[17156]: info: Scanning category user_interface
Apr 01 21:01:11 volumio volumio[17156]: info: Plugin folders cleanup completed
Apr 01 21:01:11 volumio volumio[17156]: info: -------------------------------------------
Apr 01 21:01:11 volumio volumio[17156]: info: ----- Core plugins startup ----
Apr 01 21:01:11 volumio volumio[17156]: info: -------------------------------------------
Apr 01 21:01:11 volumio volumio[17156]: info: Loading plugins from folder /volumio/app/plugins/
Apr 01 21:01:11 volumio volumio[17156]: info: Adding plugin upnp to MyMusic Plugins
Apr 01 21:01:11 volumio volumio[17156]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 01 21:01:11 volumio volumio[17156]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 01 21:01:11 volumio volumio[17156]: info: Loading plugins from folder /data/plugins/
Apr 01 21:01:11 volumio volumio[17156]: info: Loading plugin "system"...
Apr 01 21:01:11 volumio volumio[17156]: info: Loading plugin "appearance"...
Apr 01 21:01:12 volumio volumio-remote-updater[7589]: [2024-04-01 21:01:12] [connect] Successful connection
Apr 01 21:01:12 volumio volumio[17156]: info: Loading plugin "network"...
Apr 01 21:01:12 volumio volumio[17156]: info: Refreshing Cached IP Addresses
Apr 01 21:01:12 volumio volumio[17156]: info: Loading plugin "services"...
Apr 01 21:01:12 volumio sudo[17199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 01 21:01:12 volumio sudo[17197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 01 21:01:12 volumio volumio[17156]: info: Loading plugin "alsa_controller"...
Apr 01 21:01:12 volumio sudo[17197]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:12 volumio sudo[17199]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:12 volumio sudo[17197]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:12 volumio sudo[17203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 01 21:01:12 volumio sudo[17203]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:12 volumio sudo[17199]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:13 volumio sudo[17203]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:13 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 01 21:01:13 volumio volumio[17156]: info: Loading plugin "wizard"...
Apr 01 21:01:13 volumio volumio[17156]: info: Loading plugin "networkfs"...
Apr 01 21:01:13 volumio volumio[17156]: info: Starting Udev Watcher for removable devices
Apr 01 21:01:13 volumio volumio[17156]: info: Ignoring mount for partition: boot
Apr 01 21:01:13 volumio volumio[17156]: info: Ignoring mount for partition: volumio
Apr 01 21:01:13 volumio volumio[17156]: info: Ignoring mount for partition: volumio_data
Apr 01 21:01:13 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 01 21:01:13 volumio volumio[17156]: info: Loading plugin "volumio_command_line_client"...
Apr 01 21:01:13 volumio volumio[17156]: info: Plugin upnp is not enabled
Apr 01 21:01:13 volumio volumio[17156]: info: Loading plugin "my_music"...
Apr 01 21:01:13 volumio volumio[17156]: info: Loading plugin "mpd"...
Apr 01 21:01:13 volumio volumio[17156]: info: Loading plugin "upnp_browser"...
Apr 01 21:01:14 volumio volumio[17156]: info: Loading plugin "alarm-clock"...
Apr 01 21:01:14 volumio volumio[17156]: info: Loading plugin "airplay_emulation"...
Apr 01 21:01:14 volumio volumio[17156]: info: Starting Shairport Sync
Apr 01 21:01:14 volumio volumio[17156]: info: Loading plugin "last_100"...
Apr 01 21:01:14 volumio volumio[17156]: info: Loading plugin "webradio"...
Apr 01 21:01:14 volumio volumio[17156]: info: Loading plugin "i2s_dacs"...
Apr 01 21:01:14 volumio volumio[17156]: info: I2S DAC not set, start Auto-detection
Apr 01 21:01:14 volumio volumio[17156]: info: Loading plugin "volumiodiscovery"...
Apr 01 21:01:14 volumio volumio[17156]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:01:14 volumio volumio[17156]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:01:14 volumio node[17156]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:01:14 volumio volumio[17156]: *** WARNING *** For more information see
Apr 01 21:01:14 volumio volumio[17156]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:01:14 volumio volumio[17156]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:01:14 volumio volumio[17156]: *** WARNING *** For more information see
Apr 01 21:01:14 volumio node[17156]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:01:14 volumio node[17156]: *** WARNING *** For more information see
Apr 01 21:01:14 volumio node[17156]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 01 21:01:14 volumio node[17156]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 01 21:01:14 volumio node[17156]: *** WARNING *** For more information see
Apr 01 21:01:14 volumio volumio[17156]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 01 21:01:14 volumio volumio[17156]: info: Discovery: Started advertising with name: VOLUMIO
Apr 01 21:01:14 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 01 21:01:14 volumio volumio[17156]: info: Loading plugin "bandcamp"...
Apr 01 21:01:15 volumio volumio[17156]: info: Loading plugin "calmradio"...
Apr 01 21:01:16 volumio volumio[17156]: info: Loading plugin "mixcloud"...
Apr 01 21:01:17 volumio volumio[17156]: info: Loading plugin "soundcloud"...
Apr 01 21:01:18 volumio volumio[17156]: info: Loading plugin "spop"...
Apr 01 21:01:19 volumio volumio[17156]: info: Loading plugin "youtube2"...
Apr 01 21:01:20 volumio volumio[17156]: info: Loading plugin "outputs"...
Apr 01 21:01:20 volumio volumio[17156]: info: Loading plugin "albumart"...
Apr 01 21:01:20 volumio volumio[17156]: info: Plugin example_plugin is not enabled
Apr 01 21:01:20 volumio volumio[17156]: info: Loading plugin "inputs"...
Apr 01 21:01:20 volumio volumio[17156]: info: Loading plugin "updater_comm"...
Apr 01 21:01:21 volumio volumio[17156]: info: Plugin mpdemulation is not enabled
Apr 01 21:01:21 volumio volumio[17156]: info: Loading plugin "rest_api"...
Apr 01 21:01:21 volumio volumio[17156]: info: Loading plugin "websocket"...
Apr 01 21:01:21 volumio volumio[17156]: info: Loading plugin "RoonBridge"...
Apr 01 21:01:21 volumio volumio[17156]: Forking 3 albumart workers
Apr 01 21:01:21 volumio volumio[17156]: info: Applying required configuration parameters for plugin RoonBridge
Apr 01 21:01:21 volumio volumio[17156]: info: Loading plugin "motherearthradio"...
Apr 01 21:01:22 volumio volumio[17156]: info: Applying required configuration parameters for plugin motherearthradio
Apr 01 21:01:22 volumio volumio[17156]: info: [1711994482230] [MotherEarth] API delay: 5
Apr 01 21:01:22 volumio volumio[17156]: info: Loading plugin "music_services_shield"...
Apr 01 21:01:22 volumio volumio[17156]: info: Applying required configuration parameters for plugin music_services_shield
Apr 01 21:01:22 volumio volumio[17156]: info: Loading plugin "lastfm"...
Apr 01 21:01:23 volumio volumio[17156]: Starting albumart workers
Apr 01 21:01:23 volumio volumio[17156]: Starting albumart workers
Apr 01 21:01:23 volumio volumio[17156]: info: Loading i18n strings for locale en
Apr 01 21:01:23 volumio volumio[17156]: Updating browse sources language
Apr 01 21:01:23 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:24 volumio volumio[17156]: Starting albumart workers
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::initPlayerControls
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:01:24 volumio volumio[17156]: Express server listening on port 3000
Apr 01 21:01:24 volumio volumio[17156]: [Metrics] WebUI: 14s 808.14ms
Apr 01 21:01:24 volumio volumio[17156]: info: CoreStateMachine::resetVolumioState
Apr 01 21:01:24 volumio volumio[17156]: info: CoreStateMachine::getcurrentVolume
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::volumioRetrievevolume
Apr 01 21:01:24 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:01:24 volumio volumio[17156]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 01 21:01:24 volumio volumio[17156]: info: Completed loading Core Plugins
Apr 01 21:01:24 volumio volumio[17156]: info: Preparing to generate the ALSA configuration file
Apr 01 21:01:25 volumio volumio-remote-updater[7589]: [2024-04-01 21:01:25] [connect] Successful connection
Apr 01 21:01:25 volumio volumio[17156]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 01 21:01:25 volumio volumio[17156]: wlan0 Interface doesn't support scanning.
Apr 01 21:01:25 volumio volumio[17156]: info: Cannot use regular scanning, forcing with ap-force
Apr 01 21:01:25 volumio sudo[17264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 01 21:01:25 volumio sudo[17264]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:25 volumio sudo[17264]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:25 volumio volumio[17156]: command failed: No such device (-19)
Apr 01 21:01:25 volumio volumio[17156]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 01 21:01:25 volumio volumio[17156]: command failed: No such device (-19)
Apr 01 21:01:25 volumio volumio[17156]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 01 21:01:25 volumio volumio[17156]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0
Apr 01 21:01:25 volumio volumio[17156]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1
Apr 01 21:01:25 volumio volumio-remote-updater[7589]: [2024-04-01 21:01:25] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1711994485 101
Apr 01 21:01:25 volumio volumio[17156]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
Apr 01 21:01:25 volumio volumio[17156]: info: Reloading queue from file
Apr 01 21:01:25 volumio volumio[17156]: info: VolumeController:: Volume=undefined Mute =false
Apr 01 21:01:25 volumio volumio[17156]: info: CoreStateMachine::pushState
Apr 01 21:01:25 volumio volumio[17156]: info: CorePlayQueue::getTrack 0
Apr 01 21:01:25 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 01 21:01:25 volumio volumio[17156]: info: CoreCommandRouter::volumioPushState
Apr 01 21:01:25 volumio volumio[17156]: info: CoreStateMachine::updateTrackBlock
Apr 01 21:01:25 volumio volumio[17156]: info: CorePlayQueue::getTrackBlock
Apr 01 21:01:25 volumio volumio[17156]: info: CoreCommandRouter::volumioRetrievevolume
Apr 01 21:01:25 volumio volumio[17156]: info: Asound.conf file unchanged, so no further update is needed
Apr 01 21:01:25 volumio volumio[17156]: info: Output device has changed, restarting MPD
Apr 01 21:01:25 volumio sudo[17291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 01 21:01:25 volumio sudo[17291]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:25 volumio volumio[17156]: info: Output device has changed, restarting Shairport Sync
Apr 01 21:01:25 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:25 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:01:25 volumio sudo[17291]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:25 volumio sudo[17294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 01 21:01:25 volumio sudo[17294]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:25 volumio systemd[1]: musicservicesshield.service: Succeeded.
Apr 01 21:01:25 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Apr 01 21:01:25 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Apr 01 21:01:25 volumio systemd[1]: Stopping Music Player Daemon...
Apr 01 21:01:25 volumio volumio[17156]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:01:25 volumio volumio[17156]: info: ___________ START PLUGINS ___________
Apr 01 21:01:25 volumio systemd[1]: mpd.service: Succeeded.
Apr 01 21:01:25 volumio volumio[17156]: info: ControllerMpd::onStart: Initializing MPD
Apr 01 21:01:25 volumio volumio[17156]: info: Creating MPD Configuration file
Apr 01 21:01:25 volumio systemd[1]: Stopped Music Player Daemon.
Apr 01 21:01:26 volumio systemd[1]: Starting Music Player Daemon...
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:26 volumio volumio[17156]: info: [1711994486097] CoreMusicLibrary::Adding element Media Servers
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:26 volumio sudo[17305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 01 21:01:26 volumio sudo[17305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:26 volumio sudo[17305]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:01:26 volumio sudo[17310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 01 21:01:26 volumio sudo[17310]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:26 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 01 21:01:26 volumio systemd[1]: mpd.service: Succeeded.
Apr 01 21:01:26 volumio systemd[1]: Stopped Music Player Daemon.
Apr 01 21:01:26 volumio volumio[17156]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 01 21:01:26 volumio systemd[1]: Starting Music Player Daemon...
Apr 01 21:01:26 volumio volumio[17156]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:26 volumio volumio[17156]: info: [1711994486500] CoreMusicLibrary::Adding element Last_100
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:26 volumio volumio[17156]: info: [1711994486508] CoreMusicLibrary::Adding element Webradio
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:26 volumio volumio[17156]: info: [1711994486544] CoreMusicLibrary::Adding element Bandcamp Discover
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:26 volumio volumio[17156]: info: Adding Calm Radio to Browse Sources
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:26 volumio volumio[17156]: info: [1711994486557] CoreMusicLibrary::Adding element Calm Radio
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Calm Radio
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:26 volumio volumio[17156]: info: [1711994486583] CoreMusicLibrary::Adding element Mixcloud
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Calm Radio
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Mixcloud
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:26 volumio volumio[17156]: info: [1711994486606] CoreMusicLibrary::Adding element SoundCloud
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Calm Radio
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Mixcloud
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source SoundCloud
Apr 01 21:01:26 volumio volumio[17156]: info: Creating Spotify config file
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:26 volumio volumio[17156]: info: [1711994486660] CoreMusicLibrary::Adding element YouTube2
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Calm Radio
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Mixcloud
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source SoundCloud
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source YouTube2
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:26 volumio volumio[17156]: info: [1711994486723] CoreMusicLibrary::Adding element Mother Earth Radio
Apr 01 21:01:26 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Calm Radio
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Mixcloud
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source SoundCloud
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source YouTube2
Apr 01 21:01:26 volumio volumio[17156]: Cannot find translation for source Mother Earth Radio
Apr 01 21:01:26 volumio sudo[17352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Apr 01 21:01:26 volumio sudo[17352]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:26 volumio sudo[17352]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:27 volumio volumio[17156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 01 21:01:27 volumio volumio[17156]: info: [1711994487133] CoreMusicLibrary::Adding element LastFM
Apr 01 21:01:27 volumio volumio[17156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 01 21:01:27 volumio volumio[17156]: Cannot find translation for source Bandcamp Discover
Apr 01 21:01:27 volumio volumio[17156]: Cannot find translation for source Calm Radio
Apr 01 21:01:27 volumio volumio[17156]: Cannot find translation for source Mixcloud
Apr 01 21:01:27 volumio volumio[17156]: Cannot find translation for source SoundCloud
Apr 01 21:01:27 volumio volumio[17156]: Cannot find translation for source YouTube2
Apr 01 21:01:27 volumio volumio[17156]: Cannot find translation for source Mother Earth Radio
Apr 01 21:01:27 volumio volumio[17156]: Cannot find translation for source LastFM
Apr 01 21:01:27 volumio volumio[17156]: info: [LastFM] scrobbler initiated!
Apr 01 21:01:27 volumio volumio[17156]: info: [LastFM] extended logging: false
Apr 01 21:01:27 volumio volumio[17156]: info: [LastFM] try scrobble stream/radio plays: true
Apr 01 21:01:27 volumio volumio[17156]: info: [LastFM] Left init routine
Apr 01 21:01:27 volumio volumio[17156]: info: [LastFM] Socket already connected: false
Apr 01 21:01:27 volumio volumio[17156]: info: Volumio Calling Home
Apr 01 21:01:27 volumio sudo[17380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Apr 01 21:01:27 volumio sudo[17380]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 01 21:01:27 volumio volumio[17156]: info: CoreStateMachine::setRepeat null single undefined
Apr 01 21:01:27 volumio volumio[17156]: info: CoreStateMachine::pushState
Apr 01 21:01:27 volumio volumio[17156]: info: CorePlayQueue::getTrack 0
Apr 01 21:01:27 volumio volumio[17156]: info: CoreCommandRouter::volumioPushState
Apr 01 21:01:27 volumio volumio[17156]: info: CoreStateMachine::setRandom null
Apr 01 21:01:27 volumio volumio[17156]: info: CoreStateMachine::pushState
Apr 01 21:01:27 volumio volumio[17156]: info: CorePlayQueue::getTrack 0
Apr 01 21:01:27 volumio volumio[17156]: info: CoreCommandRouter::volumioPushState
Apr 01 21:01:27 volumio volumio[17156]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:01:27 volumio volumio[17156]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com
Apr 01 21:01:27 volumio volumio[17156]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
Apr 01 21:01:27 volumio volumio[17156]: errno: -3007,
Apr 01 21:01:27 volumio volumio[17156]: code: 'ENOTFOUND',
Apr 01 21:01:27 volumio volumio[17156]: syscall: 'getaddrinfo',
Apr 01 21:01:27 volumio volumio[17156]: hostname: 'ws.audioscrobbler.com'
Apr 01 21:01:27 volumio volumio[17156]: }
Apr 01 21:01:27 volumio volumio[17156]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 01 21:01:28 volumio sudo[17380]: pam_unix(sudo:session): session closed for user root
Apr 01 21:01:28 volumio ntpd[13838]: ntpd exiting on signal 15 (Terminated)
Apr 01 21:01:28 volumio systemd[1]: Stopping Network Time Service...
Apr 01 21:01:28 volumio systemd[1]: ntp.service: Succeeded.
Apr 01 21:01:28 volumio systemd[1]: Stopped Network Time Service.
Apr 01 21:01:28 volumio systemd[1]: Starting Network Time Service...
Apr 01 21:01:28 volumio systemd[1]: ntp.service: Control process exited, code=killed, status=15/TERM
Apr 01 21:01:29 volumio systemd[1]: ntp.service: Succeeded.
Apr 01 21:01:29 volumio systemd[1]: Stopped Network Time Service.
Apr 01 21:01:29 volumio systemd[1]: Starting Network Time Service...
Apr 01 21:01:29 volumio ntpd[17475]: ntpd 4.2.8p12@1.3728-o (1): Starting
Apr 01 21:01:29 volumio ntpd[17475]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Apr 01 21:01:29 volumio ntpd[17481]: proto: precision = 2.333 usec (-19)
Apr 01 21:01:29 volumio ntpd[17481]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Apr 01 21:01:29 volumio ntpd[17481]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Apr 01 21:01:29 volumio ntpd[17481]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 461 days ago
Apr 01 21:01:29 volumio systemd[1]: Started Network Time Service.
Apr 01 21:01:29 volumio ntpd[17481]: Listen and drop on 0 v6wildcard [::]:123
Apr 01 21:01:29 volumio ntpd[17481]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Apr 01 21:01:29 volumio ntpd[17481]: Listen normally on 2 lo 127.0.0.1:123
Apr 01 21:01:29 volumio ntpd[17481]: Listen normally on 3 eth0 192.168.88.22:123
Apr 01 21:01:29 volumio ntpd[17481]: Listening on routing socket on fd #20 for interface updates
Apr 01 21:01:29 volumio ntpd[17481]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 01 21:01:29 volumio ntpd[17481]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 01 21:01:29 volumio sudo[17484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-01 21:00
Apr 01 21:01:29 volumio sudo[17484]: 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:44:32 PM CET"
VOLUMIO_VERSION="3.629"
VOLUMIO_HARDWARE="nanopineo3-armbian"
VOLUMIO_DEVICENAME="NanoPi Neo3"
VOLUMIO_HASH="a46168a52783b80bcf164f007350514b"