-- Logs begin at Thu 2019-02-14 02:12:00 PST, end at Wed 2024-02-21 13:30:42 PST. --
Feb 21 13:29:02 volumio ntpd[824]: Soliciting pool server 65.100.46.166
Feb 21 13:29:02 volumio kernel: cp15barrier_handler: 605 callbacks suppressed
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97e10
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7eb1cc8
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7eb1d68
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7eb1cc8
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7eb1d68
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7eb1cc8
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7eb1d68
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b273c4
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b274f8
Feb 21 13:29:02 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b41ae0
Feb 21 13:29:08 volumio kernel: cp15barrier_handler: 891 callbacks suppressed
Feb 21 13:29:08 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97e10
Feb 21 13:29:08 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97d70
Feb 21 13:29:08 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:29:08 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:29:08 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:29:08 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3d70
Feb 21 13:29:08 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:29:08 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:29:08 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:29:08 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:29:11 volumio dbus-daemon[646]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Feb 21 13:29:11 volumio sudo[3601]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:11 volumio volumio[3189]: Failed to set time zone: Connection timed out
Feb 21 13:29:11 volumio volumio[3189]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 13:29:11 volumio volumio[3189]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'America/Los_Angeles'
Feb 21 13:29:11 volumio volumio[3189]: Failed to set time zone: Connection timed out
Feb 21 13:29:11 volumio volumio[3189]: at checkExecSyncError (child_process.js:616:11)
Feb 21 13:29:11 volumio volumio[3189]: at execSync (child_process.js:652:15)
Feb 21 13:29:11 volumio volumio[3189]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1556:9)
Feb 21 13:29:11 volumio volumio[3189]: at listOnTimeout (internal/timers.js:554:17)
Feb 21 13:29:11 volumio volumio[3189]: at processTimers (internal/timers.js:497:7) {
Feb 21 13:29:11 volumio volumio[3189]: status: 1,
Feb 21 13:29:11 volumio volumio[3189]: signal: null,
Feb 21 13:29:11 volumio volumio[3189]: output: [ null, '', 'Failed to set time zone: Connection timed out\n' ],
Feb 21 13:29:11 volumio volumio[3189]: pid: 3600,
Feb 21 13:29:11 volumio volumio[3189]: stdout: '',
Feb 21 13:29:11 volumio volumio[3189]: stderr: 'Failed to set time zone: Connection timed out\n'
Feb 21 13:29:11 volumio volumio[3189]: }
Feb 21 13:29:11 volumio volumio[3189]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 13:29:11 volumio sudo[3614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-02-21 13:28
Feb 21 13:29:12 volumio sudo[3614]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:12 volumio sudo[3614]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:14 volumio kernel: cp15barrier_handler: 369768 callbacks suppressed
Feb 21 13:29:14 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fe10
Feb 21 13:29:14 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fd70
Feb 21 13:29:14 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fe10
Feb 21 13:29:14 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b00104
Feb 21 13:29:14 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fd70
Feb 21 13:29:14 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fe10
Feb 21 13:29:14 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b001a0
Feb 21 13:29:14 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b00104
Feb 21 13:29:14 volumio kernel: "node" (3606) uses deprecated CP15 Barrier instruction at 0xf7cafe10
Feb 21 13:29:14 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fd70
Feb 21 13:29:19 volumio kernel: cp15barrier_handler: 3672 callbacks suppressed
Feb 21 13:29:19 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fe10
Feb 21 13:29:19 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fd70
Feb 21 13:29:19 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fe10
Feb 21 13:29:19 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b00104
Feb 21 13:29:19 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fd70
Feb 21 13:29:19 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fe10
Feb 21 13:29:19 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b001a0
Feb 21 13:29:19 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b00104
Feb 21 13:29:19 volumio kernel: "node" (3606) uses deprecated CP15 Barrier instruction at 0xf7cafe10
Feb 21 13:29:19 volumio kernel: "curl" (3619) uses deprecated CP15 Barrier instruction at 0xf7b7fd70
Feb 21 13:29:19 volumio volumio-remote-updater[636]: [2024-02-21 13:29:19] [info] asio async_read_at_least error: system:104 (Connection reset by peer)
Feb 21 13:29:19 volumio volumio-remote-updater[636]: [2024-02-21 13:29:19] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error)
Feb 21 13:29:19 volumio volumio-remote-updater[636]: [2024-02-21 13:29:19] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006]
Feb 21 13:29:19 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:29:19 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Feb 21 13:29:19 volumio systemd[1]: Started dynamicswap service.
Feb 21 13:29:19 volumio systemd[1]: dynamicswap.service: Succeeded.
Feb 21 13:29:19 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Feb 21 13:29:19 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 7.
Feb 21 13:29:19 volumio systemd[1]: Stopped Volumio Backend Module.
Feb 21 13:29:19 volumio systemd[1]: Started Volumio Backend Module.
Feb 21 13:29:19 volumio systemd[1]: Started dynamicswap service.
Feb 21 13:29:19 volumio systemd[1]: dynamicswap.service: Succeeded.
Feb 21 13:29:22 volumio volumio[3627]: info: -------------------------------------------
Feb 21 13:29:22 volumio volumio[3627]: info: ----- Volumio3 ----
Feb 21 13:29:22 volumio volumio[3627]: info: -------------------------------------------
Feb 21 13:29:22 volumio volumio[3627]: info: ----- System startup ----
Feb 21 13:29:22 volumio volumio[3627]: info: -------------------------------------------
Feb 21 13:29:23 volumio volumio[3627]: info: MYVOLUMIO Environment detected
Feb 21 13:29:23 volumio volumio[3627]: info: Plugin folders cleanup
Feb 21 13:29:23 volumio volumio[3627]: info: Scanning into folder /volumio/app/plugins/
Feb 21 13:29:23 volumio volumio[3627]: info: Scanning category audio_interface
Feb 21 13:29:23 volumio volumio[3627]: info: Scanning category miscellanea
Feb 21 13:29:23 volumio volumio[3627]: info: Scanning category music_service
Feb 21 13:29:23 volumio volumio[3627]: info: Scanning category plugins.json
Feb 21 13:29:23 volumio volumio[3627]: info: Scanning category system_controller
Feb 21 13:29:23 volumio volumio[3627]: info: Scanning category user_interface
Feb 21 13:29:23 volumio volumio[3627]: info: Scanning into folder /data/plugins/
Feb 21 13:29:23 volumio volumio[3627]: info: Plugin folders cleanup completed
Feb 21 13:29:23 volumio volumio[3627]: info: -------------------------------------------
Feb 21 13:29:23 volumio volumio[3627]: info: ----- Core plugins startup ----
Feb 21 13:29:23 volumio volumio[3627]: info: -------------------------------------------
Feb 21 13:29:23 volumio volumio[3627]: info: Loading plugins from folder /volumio/app/plugins/
Feb 21 13:29:23 volumio volumio[3627]: info: Adding plugin upnp to MyMusic Plugins
Feb 21 13:29:23 volumio volumio[3627]: info: Adding plugin airplay_emulation to MyMusic Plugins
Feb 21 13:29:23 volumio volumio[3627]: info: Adding plugin upnp_browser to MyMusic Plugins
Feb 21 13:29:23 volumio volumio[3627]: info: Loading plugins from folder /data/plugins/
Feb 21 13:29:23 volumio volumio[3627]: info: Loading plugin "system"...
Feb 21 13:29:23 volumio volumio[3627]: info: Loading plugin "appearance"...
Feb 21 13:29:24 volumio kernel: cp15barrier_handler: 3350771 callbacks suppressed
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf765d400
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf765d420
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf7659eb4
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xa4dbb4
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xa8fdd0
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x8b1c40
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x8b1c54
Feb 21 13:29:24 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xace794
Feb 21 13:29:24 volumio volumio-remote-updater[636]: [2024-02-21 13:29:24] [connect] Successful connection
Feb 21 13:29:24 volumio volumio[3627]: info: Loading plugin "network"...
Feb 21 13:29:24 volumio volumio[3627]: info: Refreshing Cached IP Addresses
Feb 21 13:29:24 volumio sudo[3655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 21 13:29:24 volumio sudo[3655]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:24 volumio sudo[3655]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:24 volumio volumio[3627]: info: Loading plugin "services"...
Feb 21 13:29:24 volumio sudo[3657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 21 13:29:24 volumio sudo[3657]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:24 volumio volumio[3627]: info: Loading plugin "alsa_controller"...
Feb 21 13:29:24 volumio sudo[3657]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:24 volumio sudo[3660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Feb 21 13:29:24 volumio sudo[3660]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:24 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:24 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:24 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 13:29:24 volumio volumio[3627]: info: Loading plugin "wizard"...
Feb 21 13:29:24 volumio volumio[3627]: info: Loading plugin "networkfs"...
Feb 21 13:29:24 volumio volumio[3627]: info: Starting Udev Watcher for removable devices
Feb 21 13:29:25 volumio volumio[3627]: info: Ignoring mount for partition: BOOT_EMMC
Feb 21 13:29:25 volumio volumio[3627]: info: Ignoring mount for partition: ROOTFS_EMMC
Feb 21 13:29:25 volumio volumio[3627]: info: Mounting Device BOOT
Feb 21 13:29:25 volumio volumio[3627]: /bin/mkdir: cannot create directory ‘/mnt/USB/BOOT’: Permission denied
Feb 21 13:29:25 volumio volumio[3627]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/BOOT"
Feb 21 13:29:25 volumio volumio[3627]: /bin/mkdir: cannot create directory ‘/mnt/USB/BOOT’: Permission denied
Feb 21 13:29:25 volumio sudo[3679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/BOOT -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 21 13:29:25 volumio sudo[3679]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:25 volumio sudo[3679]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:25 volumio volumio[3627]: mount: /mnt/USB/BOOT: mount point does not exist.
Feb 21 13:29:25 volumio volumio[3627]: error: Failed to mount BOOT: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/BOOT" -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 21 13:29:25 volumio volumio[3627]: mount: /mnt/USB/BOOT: mount point does not exist.
Feb 21 13:29:25 volumio volumio[3627]: info: Mounting Device ROOTFS
Feb 21 13:29:25 volumio volumio[3627]: /bin/mkdir: cannot create directory ‘/mnt/USB/ROOTFS’: Permission denied
Feb 21 13:29:25 volumio volumio[3627]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/ROOTFS"
Feb 21 13:29:25 volumio volumio[3627]: /bin/mkdir: cannot create directory ‘/mnt/USB/ROOTFS’: Permission denied
Feb 21 13:29:25 volumio sudo[3687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/ROOTFS -o noatime
Feb 21 13:29:25 volumio sudo[3687]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:25 volumio sudo[3687]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:25 volumio volumio[3627]: mount: /mnt/USB/ROOTFS: mount point does not exist.
Feb 21 13:29:25 volumio volumio[3627]: error: Failed to mount ROOTFS: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/ROOTFS" -o noatime
Feb 21 13:29:25 volumio volumio[3627]: mount: /mnt/USB/ROOTFS: mount point does not exist.
Feb 21 13:29:25 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 21 13:29:25 volumio volumio[3627]: info: Loading plugin "volumio_command_line_client"...
Feb 21 13:29:25 volumio volumio[3627]: info: Loading plugin "upnp"...
Feb 21 13:29:25 volumio volumio[3627]: info: [1708550965283] Starting Upmpd Daemon
Feb 21 13:29:25 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 21 13:29:25 volumio volumio[3627]: info: Loading plugin "my_music"...
Feb 21 13:29:25 volumio volumio[3627]: info: Loading plugin "mpd"...
Feb 21 13:29:25 volumio volumio[3627]: info: Loading plugin "upnp_browser"...
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "alarm-clock"...
Feb 21 13:29:26 volumio sudo[3660]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "airplay_emulation"...
Feb 21 13:29:26 volumio volumio[3627]: info: Starting Shairport Sync
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "last_100"...
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "webradio"...
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "i2s_dacs"...
Feb 21 13:29:26 volumio volumio[3627]: info: I2S DAC not set, start Auto-detection
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "volumiodiscovery"...
Feb 21 13:29:26 volumio volumio[3627]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 21 13:29:26 volumio volumio[3627]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 13:29:26 volumio node[3627]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 21 13:29:26 volumio volumio[3627]: *** WARNING *** For more information see
Feb 21 13:29:26 volumio volumio[3627]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 21 13:29:26 volumio volumio[3627]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 13:29:26 volumio volumio[3627]: *** WARNING *** For more information see
Feb 21 13:29:26 volumio node[3627]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 13:29:26 volumio node[3627]: *** WARNING *** For more information see
Feb 21 13:29:26 volumio node[3627]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 21 13:29:26 volumio node[3627]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 13:29:26 volumio node[3627]: *** WARNING *** For more information see
Feb 21 13:29:26 volumio volumio[3627]: info: Applying required configuration parameters for plugin volumiodiscovery
Feb 21 13:29:26 volumio volumio[3627]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/volumiodiscovery/config.json'
Feb 21 13:29:26 volumio volumio[3627]: info: Discovery: Started advertising with name: Volumio
Feb 21 13:29:26 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "outputs"...
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "albumart"...
Feb 21 13:29:26 volumio volumio[3627]: info: Plugin example_plugin is not enabled
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "inputs"...
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "updater_comm"...
Feb 21 13:29:26 volumio volumio[3627]: info: Plugin mpdemulation is not enabled
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "rest_api"...
Feb 21 13:29:26 volumio volumio[3627]: info: Loading plugin "websocket"...
Feb 21 13:29:26 volumio volumio[3627]: info: Loading i18n strings for locale ca
Feb 21 13:29:26 volumio volumio[3627]: Updating browse sources language
Feb 21 13:29:26 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 13:29:27 volumio volumio[3627]: Forking 3 albumart workers
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::initPlayerControls
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: Express server listening on port 3000
Feb 21 13:29:27 volumio volumio[3627]: [Metrics] WebUI: 6s 18.98ms
Feb 21 13:29:27 volumio volumio[3627]: info: CoreStateMachine::resetVolumioState
Feb 21 13:29:27 volumio volumio[3627]: info: CoreStateMachine::getcurrentVolume
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::volumioRetrievevolume
Feb 21 13:29:27 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:29:27 volumio volumio[3627]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/audio_interface/alsa_controller/config.json'
Feb 21 13:29:27 volumio volumio[3627]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Feb 21 13:29:27 volumio volumio[3627]: info: Completed loading Core Plugins
Feb 21 13:29:27 volumio volumio[3627]: info: Preparing to generate the ALSA configuration file
Feb 21 13:29:27 volumio volumio[3627]: info: Cannot read play queue from file
Feb 21 13:29:27 volumio volumio[3627]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 1
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 2
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 3
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 4
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 5
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 6
Feb 21 13:29:28 volumio volumio-remote-updater[636]: [2024-02-21 13:29:28] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1708550964 101
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 7
Feb 21 13:29:28 volumio volumio[3627]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Home directory not accessible: Permission denied
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 8
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 9
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 10
Feb 21 13:29:28 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 11
Feb 21 13:29:28 volumio volumio[3627]: info: VolumeController:: Volume=undefined Mute =false
Feb 21 13:29:28 volumio volumio[3627]: info: CoreStateMachine::pushState
Feb 21 13:29:28 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::volumioPushState
Feb 21 13:29:28 volumio volumio[3627]: info: CoreStateMachine::updateTrackBlock
Feb 21 13:29:28 volumio volumio[3627]: info: CorePlayQueue::getTrackBlock
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::volumioRetrievevolume
Feb 21 13:29:28 volumio volumio[3627]: info: CoreStateMachine::setRepeat null single undefined
Feb 21 13:29:28 volumio volumio[3627]: info: CoreStateMachine::pushState
Feb 21 13:29:28 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::volumioPushState
Feb 21 13:29:28 volumio volumio[3627]: info: CoreStateMachine::setRandom null
Feb 21 13:29:28 volumio volumio[3627]: info: CoreStateMachine::pushState
Feb 21 13:29:28 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::volumioPushState
Feb 21 13:29:28 volumio volumio[3627]: Starting albumart workers
Feb 21 13:29:28 volumio volumio[3627]: Starting albumart workers
Feb 21 13:29:28 volumio volumio[3627]: error: Cannot write /etc/asound.conf: Error: EACCES: permission denied, open '/home/volumio/.asoundrc'
Feb 21 13:29:28 volumio volumio[3627]: info: Output device has changed, restarting MPD
Feb 21 13:29:28 volumio volumio[3627]: info: Output device has changed, restarting Shairport Sync
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:29:28 volumio sudo[3738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 21 13:29:28 volumio sudo[3738]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:28 volumio sudo[3739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 21 13:29:28 volumio sudo[3739]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:28 volumio sudo[3738]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:28 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:28 volumio volumio[3627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 13:29:28 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:28 volumio volumio[3627]: info: ___________ START PLUGINS ___________
Feb 21 13:29:28 volumio volumio[3627]: info: ControllerMpd::onStart: Initializing MPD
Feb 21 13:29:28 volumio volumio[3627]: info: Creating MPD Configuration file
Feb 21 13:29:28 volumio volumio[3627]: Starting albumart workers
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 13:29:28 volumio volumio[3627]: info: [1708550968902] CoreMusicLibrary::Adding element Media Servers
Feb 21 13:29:28 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 13:29:28 volumio systemd[1]: Listening on mpd.socket.
Feb 21 13:29:28 volumio sudo[3747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 21 13:29:28 volumio sudo[3747]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:28 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:29:28 volumio sudo[3749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 21 13:29:28 volumio sudo[3749]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:28 volumio sudo[3747]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:28 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Feb 21 13:29:28 volumio systemd[1]: mpd.service: Succeeded.
Feb 21 13:29:28 volumio systemd[1]: Stopped Music Player Daemon.
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:29:29 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:29:29 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:29 volumio volumio[3627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 13:29:29 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:29 volumio volumio[3627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 13:29:29 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 13:29:29 volumio volumio[3627]: info: [1708550969156] CoreMusicLibrary::Adding element Last_100
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 13:29:29 volumio volumio[3627]: info: [1708550969163] CoreMusicLibrary::Adding element Webradio
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 13:29:29 volumio volumio[3627]: info: Volumio Calling Home
Feb 21 13:29:29 volumio kernel: cp15barrier_handler: 6775281 callbacks suppressed
Feb 21 13:29:29 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0x8aa898
Feb 21 13:29:29 volumio kernel: "node" (3705) uses deprecated CP15 Barrier instruction at 0xf77242c8
Feb 21 13:29:29 volumio kernel: "node" (3705) uses deprecated CP15 Barrier instruction at 0xf772409c
Feb 21 13:29:29 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0xa83244
Feb 21 13:29:29 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0x8aa898
Feb 21 13:29:29 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0xa4dbb4
Feb 21 13:29:29 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf765a2c8
Feb 21 13:29:29 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf765a09c
Feb 21 13:29:29 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0xa83244
Feb 21 13:29:29 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xb03da8
Feb 21 13:29:29 volumio volumio[3627]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Home directory not accessible: Permission denied
Feb 21 13:29:29 volumio volumio[3627]: info: MPD Permissions set
Feb 21 13:29:29 volumio volumio[3627]: info: MPD Permissions set
Feb 21 13:29:29 volumio volumio[3627]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12
Feb 21 13:29:29 volumio volumio[3627]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/plugins.json'
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:29:29 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 13:29:30 volumio volumio[3627]: info: VolumeController:: Volume=undefined Mute =false
Feb 21 13:29:30 volumio volumio[3627]: info: CoreStateMachine::pushState
Feb 21 13:29:30 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::volumioPushState
Feb 21 13:29:30 volumio volumio[3627]: info: Discovery: adding ff119fd5-935a-4faf-a8f6-14279294ef83
Feb 21 13:29:30 volumio volumio[3627]: info: Discovery: Found device Volumio
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::volumioGetState
Feb 21 13:29:30 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:29:30 volumio volumio[3627]: info: Discovery: this is already registered, ff119fd5-935a-4faf-a8f6-14279294ef83
Feb 21 13:29:30 volumio volumio[3627]: info: Discovery: Found device Volumio
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::volumioGetState
Feb 21 13:29:30 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:29:30 volumio volumio[3627]: info: Starting Shairport Sync
Feb 21 13:29:30 volumio volumio[3627]: info: Starting Shairport Sync
Feb 21 13:29:30 volumio volumio[3627]: info: Starting Shairport Sync
Feb 21 13:29:30 volumio sudo[3806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 13:29:30 volumio sudo[3806]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:30 volumio sudo[3808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 13:29:30 volumio sudo[3808]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:30 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 21 13:29:30 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 21 13:29:30 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 21 13:29:30 volumio sudo[3812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 13:29:30 volumio sudo[3812]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:30 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 21 13:29:30 volumio sudo[3808]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:30 volumio sudo[3806]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:30 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 21 13:29:30 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Feb 21 13:29:30 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 21 13:29:30 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 21 13:29:30 volumio volumio[3627]: info: Shairport-Sync Started
Feb 21 13:29:30 volumio volumio[3627]: Error adding Membership: Error: addMembership EINVAL
Feb 21 13:29:30 volumio volumio[3627]: info: Shairport-Sync Started
Feb 21 13:29:30 volumio volumio[3627]: info: CoreCommandRouter::volumioGetState
Feb 21 13:29:30 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:29:30 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 21 13:29:30 volumio sudo[3812]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:30 volumio volumio[3627]: info: Shairport-Sync Started
Feb 21 13:29:30 volumio volumio[3627]: info: Volumio called home
Feb 21 13:29:31 volumio mpd[3753]: Feb 21 13:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:29:31 volumio mpd[3753]: Feb 21 13:29 : exception: Database corrupted
Feb 21 13:29:31 volumio mpd[3753]: Feb 21 13:29 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:29:31 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:29:31 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:29:31 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:29:31 volumio sudo[3739]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:31 volumio sudo[3749]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:31 volumio volumio[3627]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service
Feb 21 13:29:31 volumio volumio[3627]: Job for mpd.service failed because the control process exited with error code.
Feb 21 13:29:31 volumio volumio[3627]: See "systemctl status mpd.service" and "journalctl -xe" for details.
Feb 21 13:29:31 volumio volumio[3627]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service
Feb 21 13:29:31 volumio volumio[3627]: Job for mpd.service failed because the control process exited with error code.
Feb 21 13:29:31 volumio volumio[3627]: See "systemctl status mpd.service" and "journalctl -xe" for details.
Feb 21 13:29:31 volumio volumio[3627]: info: Completed starting Core Plugins
Feb 21 13:29:31 volumio volumio[3627]: info: -------------------------------------------
Feb 21 13:29:31 volumio volumio[3627]: info: ----- MyVolumio plugins startup ----
Feb 21 13:29:31 volumio volumio[3627]: info: -------------------------------------------
Feb 21 13:29:31 volumio volumio[3627]: info: [MyVolumio PluginManager] Fetching plans data....
Feb 21 13:29:31 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:29:32 volumio volumio[3627]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/plugins.json'
Feb 21 13:29:32 volumio mpd[3819]: Feb 21 13:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:29:32 volumio mpd[3819]: Feb 21 13:29 : exception: Database corrupted
Feb 21 13:29:32 volumio mpd[3819]: Feb 21 13:29 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:29:32 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:29:32 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:29:32 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:29:32 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:29:33 volumio mpd[3821]: Feb 21 13:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:29:33 volumio mpd[3821]: Feb 21 13:29 : exception: Database corrupted
Feb 21 13:29:33 volumio mpd[3821]: Feb 21 13:29 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:29:33 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:29:33 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:29:33 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:29:33 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:29:34 volumio kernel: cp15barrier_handler: 1099008 callbacks suppressed
Feb 21 13:29:34 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97e10
Feb 21 13:29:34 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97d70
Feb 21 13:29:34 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:29:34 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:29:34 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:29:34 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3d70
Feb 21 13:29:34 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:29:34 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:29:34 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:29:34 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:29:35 volumio sudo[3862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 21 13:29:35 volumio sudo[3862]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:35 volumio mpd[3822]: Feb 21 13:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:29:35 volumio mpd[3822]: Feb 21 13:29 : exception: Database corrupted
Feb 21 13:29:35 volumio mpd[3822]: Feb 21 13:29 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:29:35 volumio sudo[3862]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:35 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:29:35 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:29:35 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:29:35 volumio systemd[1]: mpd.service: Start request repeated too quickly.
Feb 21 13:29:35 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:29:35 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:29:35 volumio systemd[1]: mpd.socket: Failed with result 'service-start-limit-hit'.
Feb 21 13:29:35 volumio volumio[3627]: error: MPD error: Error: read ECONNRESET
Feb 21 13:29:35 volumio sudo[3867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Feb 21 13:29:35 volumio sudo[3867]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:35 volumio volumio[3627]: error: MPD error: Error: read ECONNRESET
Feb 21 13:29:35 volumio sudo[3865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 21 13:29:35 volumio sudo[3865]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:35 volumio sudo[3865]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:35 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Feb 21 13:29:35 volumio sudo[3867]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:35 volumio volumio[3627]: info: Upmpdcli Daemon Started
Feb 21 13:29:35 volumio volumio[3627]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Feb 21 13:29:38 volumio kernel: usb 1-1: USB disconnect, device number 2
Feb 21 13:29:38 volumio kernel: usb 1-1.1: USB disconnect, device number 4
Feb 21 13:29:38 volumio thd[645]: Error reading device '/dev/input/event2'
Feb 21 13:29:39 volumio thd[645]: Error reading device '/dev/input/event3'
Feb 21 13:29:39 volumio kernel: usb 1-1.2: USB disconnect, device number 5
Feb 21 13:29:39 volumio thd[645]: Error reading device '/dev/input/event4'
Feb 21 13:29:39 volumio thd[645]: Error reading device '/dev/input/event5'
Feb 21 13:29:39 volumio kernel: cp15barrier_handler: 390532 callbacks suppressed
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0x49f5f4
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0x49f614
Feb 21 13:29:39 volumio kernel: usb 1-1.6: USB disconnect, device number 6
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0xf7dc21a0
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0xf7dc21a0
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0xf7dc21a0
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0xf7dc21a0
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0xf7dc21a0
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0xf7dc21a0
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0xf7dc21a0
Feb 21 13:29:39 volumio kernel: "systemd-udevd" (389) uses deprecated CP15 Barrier instruction at 0xf7dc21a0
Feb 21 13:29:39 volumio thd[645]: Error reading device '/dev/input/event6'
Feb 21 13:29:39 volumio thd[645]: Error reading device '/dev/input/event7'
Feb 21 13:29:39 volumio volumio[3627]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Feb 21 13:29:39 volumio thd[645]: Error reading device '/dev/input/event8'
Feb 21 13:29:39 volumio thd[645]: Error reading device '/dev/input/event9'
Feb 21 13:29:39 volumio thd[645]: Error reading device '/dev/input/event10'
Feb 21 13:29:40 volumio volumio[3627]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket
Feb 21 13:29:40 volumio volumio[3627]: error: connect ECONNREFUSED /run/mpd/socket {"errno":-111,"code":"ECONNREFUSED","syscall":"connect","address":"/run/mpd/socket"}
Feb 21 13:29:40 volumio volumio[3627]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket
Feb 21 13:29:40 volumio volumio[3627]: error: connect ECONNREFUSED /run/mpd/socket {"errno":-111,"code":"ECONNREFUSED","syscall":"connect","address":"/run/mpd/socket"}
Feb 21 13:29:40 volumio kernel: usb 1-1: new full-speed USB device number 7 using xhci-hcd
Feb 21 13:29:41 volumio kernel: usb 1-1: New USB device found, idVendor=0a12, idProduct=1004, bcdDevice=36.05
Feb 21 13:29:41 volumio kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Feb 21 13:29:41 volumio kernel: usb 1-1: Product: FiiO BTA30
Feb 21 13:29:41 volumio kernel: usb 1-1: Manufacturer: FiiO
Feb 21 13:29:41 volumio kernel: usb 1-1: SerialNumber: ABCDEF0123456789
Feb 21 13:29:41 volumio kernel: usbcore: registered new interface driver snd-usb-audio
Feb 21 13:29:41 volumio systemd-udevd[3873]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99.
Feb 21 13:29:41 volumio volumio[3627]: info:
Feb 21 13:29:41 volumio volumio[3627]: ---------------------------- USB Audio Device Attached
Feb 21 13:29:41 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Feb 21 13:29:44 volumio kernel: cp15barrier_handler: 56112 callbacks suppressed
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf76cee10
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf773fe7c
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf77416c8
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf76ced70
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf76cee10
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:44 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x8477d4
Feb 21 13:29:44 volumio volumio[3627]: verbose: New Socket.io Connection to 192.168.60.190 from 192.168.60.3 UA: Mozilla/5.0 (Windows NT 10.0; WOW64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.6332.209 Safari/537.36 Total Clients: 13
Feb 21 13:29:44 volumio volumio[3627]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 21 13:29:44 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 13:29:45 volumio volumio[3627]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 21 13:29:48 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:48 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 21 13:29:48 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:48 volumio volumio[3627]: info: Setting mixer ACODEC for card P230-Q200
Feb 21 13:29:48 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 21 13:29:48 volumio volumio[3627]: info: Updating Volume Controller Parameters: Device: 0 Name: P230-Q200 Mixer: ACODEC Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Feb 21 13:29:48 volumio volumio[3627]: info: Disabling external Volume Control
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 21 13:29:48 volumio volumio[3627]: info: Preparing to generate the ALSA configuration file
Feb 21 13:29:48 volumio volumio[3627]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Home directory not accessible: Permission denied
Feb 21 13:29:48 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 21 13:29:48 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 21 13:29:48 volumio volumio[3627]: error: Cannot write /etc/asound.conf: Error: EACCES: permission denied, open '/home/volumio/.asoundrc'
Feb 21 13:29:48 volumio volumio[3627]: info: Output device has changed, restarting MPD
Feb 21 13:29:48 volumio volumio[3627]: info: Output device has changed, restarting Shairport Sync
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:29:48 volumio sudo[3895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 21 13:29:48 volumio sudo[3895]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:48 volumio sudo[3895]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:48 volumio sudo[3897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 21 13:29:48 volumio sudo[3897]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:48 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:48 volumio volumio[3627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 13:29:48 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:29:48 volumio volumio[3627]: info: VolumeController:: Volume=undefined Mute =false
Feb 21 13:29:48 volumio volumio[3627]: info: CoreStateMachine::pushState
Feb 21 13:29:48 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:29:48 volumio volumio[3627]: info: CoreCommandRouter::volumioPushState
Feb 21 13:29:48 volumio systemd[1]: Listening on mpd.socket.
Feb 21 13:29:48 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:29:49 volumio volumio[3627]: info: MPD Permissions set
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 21 13:29:49 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:29:49 volumio volumio[3627]: info: Starting Shairport Sync
Feb 21 13:29:49 volumio sudo[3912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 13:29:49 volumio sudo[3912]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:49 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 21 13:29:49 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 21 13:29:49 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 21 13:29:49 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 21 13:29:49 volumio sudo[3912]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:49 volumio volumio[3627]: info: Shairport-Sync Started
Feb 21 13:29:49 volumio volumio[3627]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/audio_interface/alsa_controller/config.json'
Feb 21 13:29:49 volumio kernel: cp15barrier_handler: 413775 callbacks suppressed
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf76cee10
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf773fe7c
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0xf77416c8
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x536584
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x536590
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x535e18
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x535e30
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:49 volumio kernel: "node" (3627) uses deprecated CP15 Barrier instruction at 0x50324c
Feb 21 13:29:50 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Feb 21 13:29:50 volumio volumio[3627]: info: Loading i18n strings for locale zh
Feb 21 13:29:50 volumio volumio[3627]: Updating browse sources language
Feb 21 13:29:50 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 13:29:50 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Feb 21 13:29:50 volumio volumio[3627]: info: Setting timezone to America/Los_Angeles
Feb 21 13:29:50 volumio sudo[3918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Feb 21 13:29:50 volumio sudo[3918]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:50 volumio sudo[3918]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:50 volumio sudo[3922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Los_Angeles /etc/localtime
Feb 21 13:29:50 volumio sudo[3922]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:50 volumio sudo[3922]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:50 volumio sudo[3925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Feb 21 13:29:50 volumio sudo[3925]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:50 volumio sudo[3925]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:50 volumio sudo[3928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Los_Angeles
Feb 21 13:29:50 volumio sudo[3928]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:29:50 volumio dbus-daemon[646]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.73' (uid=0 pid=3929 comm="/usr/bin/timedatectl set-timezone America/Los_Ange" label="kernel")
Feb 21 13:29:50 volumio systemd[1]: systemd-timedated.service: Failed to run 'start' task: No space left on device
Feb 21 13:29:50 volumio systemd[1]: systemd-timedated.service: Failed with result 'resources'.
Feb 21 13:29:50 volumio systemd[1]: Failed to start Time & Date Service.
Feb 21 13:29:50 volumio mpd[3904]: Feb 21 13:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:29:50 volumio mpd[3904]: Feb 21 13:29 : exception: Database corrupted
Feb 21 13:29:50 volumio mpd[3904]: Feb 21 13:29 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:29:50 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:29:50 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:29:50 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:29:50 volumio sudo[3897]: pam_unix(sudo:session): session closed for user root
Feb 21 13:29:54 volumio kernel: cp15barrier_handler: 104761 callbacks suppressed
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0xf784be10
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0xf78bce7c
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0xf78be6c8
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0x536584
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0x536590
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0x535e18
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0x535e30
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:29:54 volumio kernel: "node" (3700) uses deprecated CP15 Barrier instruction at 0x50324c
Feb 21 13:29:57 volumio ntpd[824]: Soliciting pool server 71.162.136.44
Feb 21 13:30:00 volumio kernel: cp15barrier_handler: 868 callbacks suppressed
Feb 21 13:30:00 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97e10
Feb 21 13:30:00 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97d70
Feb 21 13:30:00 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:00 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:00 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:00 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3d70
Feb 21 13:30:00 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:00 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:00 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:00 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:04 volumio ntpd[824]: Soliciting pool server 5.161.184.148
Feb 21 13:30:05 volumio ntpd[824]: Soliciting pool server 2620:b0:2000:102::2:123
Feb 21 13:30:05 volumio kernel: cp15barrier_handler: 656493 callbacks suppressed
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3d70
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78c7c68
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:05 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:08 volumio ntpd[824]: Soliciting pool server 66.205.249.28
Feb 21 13:30:10 volumio kernel: cp15barrier_handler: 730 callbacks suppressed
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0xf77d2e10
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0xf7843e7c
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0xf78456c8
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0x536584
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0x536590
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0x535e18
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0x535e30
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0x870f4c
Feb 21 13:30:10 volumio kernel: "node" (3699) uses deprecated CP15 Barrier instruction at 0x50324c
Feb 21 13:30:15 volumio dbus-daemon[646]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Feb 21 13:30:15 volumio sudo[3928]: pam_unix(sudo:session): session closed for user root
Feb 21 13:30:15 volumio volumio[3627]: Failed to set time zone: Connection timed out
Feb 21 13:30:15 volumio volumio[3627]: info: Could not set timezone, retrying
Feb 21 13:30:15 volumio volumio[3627]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/miscellanea/appearance/config.json'
Feb 21 13:30:15 volumio volumio[3627]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/system/config.json'
Feb 21 13:30:15 volumio volumio[3627]: error: MyVolumio Plugin failed to start in a timely fashion
Feb 21 13:30:15 volumio volumio[3627]: info: BOOT COMPLETED
Feb 21 13:30:15 volumio volumio[3627]: [Metrics] CommandRouter: 53s 291.04ms
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::volumiosetStartupVolume
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::Close All Modals sent
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::Close All Modals sent
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Feb 21 13:30:15 volumio volumio[3627]: info: CoreStateMachine::getcurrentVolume
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::volumioRetrievevolume
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 21 13:30:15 volumio volumio[3627]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Home directory not accessible: Permission denied
Feb 21 13:30:15 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:30:15 volumio volumio[3627]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Feb 21 13:30:15 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:30:15 volumio volumio[3627]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card
Feb 21 13:30:15 volumio volumio[3627]: aplay: main:828: audio open error: No such device
Feb 21 13:30:15 volumio volumio[3627]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service
Feb 21 13:30:15 volumio volumio[3627]: Job for mpd.service failed because the control process exited with error code.
Feb 21 13:30:15 volumio volumio[3627]: See "systemctl status mpd.service" and "journalctl -xe" for details.
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Feb 21 13:30:15 volumio sudo[3939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Feb 21 13:30:15 volumio sudo[3939]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:30:15 volumio volumio[3627]: info: VolumeController:: Volume=undefined Mute =false
Feb 21 13:30:15 volumio volumio[3627]: info: CoreStateMachine::pushState
Feb 21 13:30:15 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::volumioPushState
Feb 21 13:30:15 volumio volumio[3627]: info: CoreStateMachine::updateTrackBlock
Feb 21 13:30:15 volumio volumio[3627]: info: CorePlayQueue::getTrackBlock
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::volumioRetrievevolume
Feb 21 13:30:15 volumio kernel: cp15barrier_handler: 4170691 callbacks suppressed
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b58400
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b58420
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b58ec8
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b58ee8
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b33d80
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b54eb4
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b54eb4
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b32a0c
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b58400
Feb 21 13:30:15 volumio kernel: "(mpd)" (3936) uses deprecated CP15 Barrier instruction at 0xf7b58420
Feb 21 13:30:15 volumio volumio[3627]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Home directory not accessible: Permission denied
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 21 13:30:15 volumio volumio[3627]: info: VolumeController:: Volume=undefined Mute =false
Feb 21 13:30:15 volumio volumio[3627]: info: CoreStateMachine::pushState
Feb 21 13:30:15 volumio volumio[3627]: info: CorePlayQueue::getTrack 0
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::volumioPushState
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
Feb 21 13:30:15 volumio volumio[3627]: info: System name has changed, restarting Shairport Sync
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:30:15 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:30:15 volumio volumio[3627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 13:30:15 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:30:15 volumio volumio[3627]: info: Discovery: Restarting Advertising due to device name change
Feb 21 13:30:15 volumio volumio[3627]: error: Failed to set hostname: Error: EACCES: permission denied, open '/etc/hostname'
Feb 21 13:30:15 volumio sudo[3948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Feb 21 13:30:15 volumio sudo[3948]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:30:15 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices
Feb 21 13:30:15 volumio systemd[1]: upmpdcli.service: Main process exited, code=killed, status=15/TERM
Feb 21 13:30:15 volumio systemd[1]: upmpdcli.service: Succeeded.
Feb 21 13:30:15 volumio sudo[3948]: pam_unix(sudo:session): session closed for user root
Feb 21 13:30:16 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:30:16 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 21 13:30:16 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 13:30:16 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 21 13:30:16 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Feb 21 13:30:16 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 21 13:30:16 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:30:16 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:30:16 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 21 13:30:16 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:30:16 volumio volumio[3627]: info: Setting mixer ACODEC for card P230-Q200
Feb 21 13:30:16 volumio volumio[3627]: Home directory not accessible: Permission denied
Feb 21 13:30:16 volumio volumio[3627]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 21 13:30:16 volumio volumio[3627]: info: Updating Volume Controller Parameters: Device: 0 Name: P230-Q200 Mixer: ACODEC Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Feb 21 13:30:16 volumio volumio[3627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Feb 21 13:30:16 volumio volumio[3627]: info: Disabling external Volume Control
Feb 21 13:30:16 volumio volumio[3627]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 21 13:30:16 volumio volumio[3627]: info: Preparing to generate the ALSA configuration file
Feb 21 13:30:16 volumio volumio[3627]: info: Starting Shairport Sync
Feb 21 13:30:16 volumio sudo[3962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 13:30:16 volumio sudo[3962]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:30:16 volumio sudo[3964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Los_Angeles
Feb 21 13:30:16 volumio sudo[3964]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 13:30:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 21 13:30:16 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 21 13:30:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 21 13:30:16 volumio dbus-daemon[646]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.74' (uid=0 pid=3966 comm="/usr/bin/timedatectl set-timezone America/Los_Ange" label="kernel")
Feb 21 13:30:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 21 13:30:16 volumio sudo[3962]: pam_unix(sudo:session): session closed for user root
Feb 21 13:30:16 volumio systemd[1]: systemd-timedated.service: Failed to run 'start' task: No space left on device
Feb 21 13:30:16 volumio systemd[1]: systemd-timedated.service: Failed with result 'resources'.
Feb 21 13:30:16 volumio systemd[1]: Failed to start Time & Date Service.
Feb 21 13:30:17 volumio mpd[3936]: Feb 21 13:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:30:17 volumio mpd[3936]: Feb 21 13:30 : exception: Database corrupted
Feb 21 13:30:17 volumio sudo[3939]: pam_unix(sudo:session): session closed for user root
Feb 21 13:30:17 volumio mpd[3936]: Feb 21 13:30 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:30:17 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:30:17 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:30:17 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:30:17 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:30:18 volumio mpd[3972]: Feb 21 13:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:30:18 volumio mpd[3972]: Feb 21 13:30 : exception: Database corrupted
Feb 21 13:30:18 volumio mpd[3972]: Feb 21 13:30 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:30:18 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:30:18 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:30:18 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:30:18 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:30:19 volumio mpd[3973]: Feb 21 13:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:30:19 volumio mpd[3973]: Feb 21 13:30 : exception: Database corrupted
Feb 21 13:30:19 volumio mpd[3973]: Feb 21 13:30 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:30:19 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:30:19 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:30:19 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:30:19 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:30:21 volumio kernel: cp15barrier_handler: 519426 callbacks suppressed
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf40fac18
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf40fada8
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf40fadd0
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf408df64
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf408dfd8
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf3fd8654
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf3fd8678
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf4101a50
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf4101a98
Feb 21 13:30:21 volumio kernel: "mpd" (3974) uses deprecated CP15 Barrier instruction at 0xf40feef8
Feb 21 13:30:21 volumio mpd[3974]: Feb 21 13:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:30:21 volumio mpd[3974]: Feb 21 13:30 : exception: Database corrupted
Feb 21 13:30:21 volumio mpd[3974]: Feb 21 13:30 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:30:21 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:30:21 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:30:21 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:30:21 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 13:30:22 volumio mpd[3975]: Feb 21 13:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 13:30:22 volumio mpd[3975]: Feb 21 13:30 : exception: Database corrupted
Feb 21 13:30:22 volumio mpd[3975]: Feb 21 13:30 : exception: Failed to open database plugin; Can't open db file "/var/lib/mpd/tag_cache" for reading/writing: Permission denied
Feb 21 13:30:22 volumio systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 13:30:22 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:30:22 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:30:22 volumio systemd[1]: mpd.service: Start request repeated too quickly.
Feb 21 13:30:22 volumio systemd[1]: mpd.service: Failed with result 'exit-code'.
Feb 21 13:30:22 volumio systemd[1]: Failed to start Music Player Daemon.
Feb 21 13:30:22 volumio systemd[1]: mpd.socket: Failed with result 'service-start-limit-hit'.
Feb 21 13:30:26 volumio kernel: cp15barrier_handler: 463390 callbacks suppressed
Feb 21 13:30:26 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97e10
Feb 21 13:30:26 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97d70
Feb 21 13:30:26 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:26 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:26 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:26 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3d70
Feb 21 13:30:26 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:26 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:26 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:26 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:32 volumio kernel: cp15barrier_handler: 313 callbacks suppressed
Feb 21 13:30:32 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97e10
Feb 21 13:30:32 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97d70
Feb 21 13:30:32 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:32 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:32 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:32 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3d70
Feb 21 13:30:32 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:32 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:32 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:32 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:38 volumio kernel: cp15barrier_handler: 5253 callbacks suppressed
Feb 21 13:30:38 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97e10
Feb 21 13:30:38 volumio kernel: "ntpd" (824) uses deprecated CP15 Barrier instruction at 0xf7b97d70
Feb 21 13:30:38 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:38 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:38 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:38 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3d70
Feb 21 13:30:38 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf7cf3e10
Feb 21 13:30:38 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:38 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561ec
Feb 21 13:30:38 volumio kernel: "systemd-journal" (363) uses deprecated CP15 Barrier instruction at 0xf78561cc
Feb 21 13:30:41 volumio dbus-daemon[646]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Feb 21 13:30:41 volumio sudo[3964]: pam_unix(sudo:session): session closed for user root
Feb 21 13:30:41 volumio volumio[3627]: Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Feb 21 13:30:41 volumio volumio[3627]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 13:30:41 volumio volumio[3627]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'America/Los_Angeles'
Feb 21 13:30:41 volumio volumio[3627]: Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Feb 21 13:30:41 volumio volumio[3627]: at checkExecSyncError (child_process.js:616:11)
Feb 21 13:30:41 volumio volumio[3627]: at execSync (child_process.js:652:15)
Feb 21 13:30:41 volumio volumio[3627]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1556:9)
Feb 21 13:30:41 volumio volumio[3627]: at listOnTimeout (internal/timers.js:554:17)
Feb 21 13:30:41 volumio volumio[3627]: at processTimers (internal/timers.js:497:7) {
Feb 21 13:30:41 volumio volumio[3627]: status: 1,
Feb 21 13:30:41 volumio volumio[3627]: signal: null,
Feb 21 13:30:41 volumio volumio[3627]: output: [
Feb 21 13:30:41 volumio volumio[3627]: null,
Feb 21 13:30:41 volumio volumio[3627]: '',
Feb 21 13:30:41 volumio volumio[3627]: "Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)\n"
Feb 21 13:30:41 volumio volumio[3627]: ],
Feb 21 13:30:41 volumio volumio[3627]: pid: 3963,
Feb 21 13:30:41 volumio volumio[3627]: stdout: '',
Feb 21 13:30:41 volumio volumio[3627]: stderr: "Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)\n"
Feb 21 13:30:41 volumio volumio[3627]: }
Feb 21 13:30:41 volumio volumio[3627]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 13:30:42 volumio sudo[4026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-02-21 13:29
Feb 21 13:30:42 volumio sudo[4026]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"