-- Logs begin at Thu 2019-02-14 05:12:00 EST, end at Sat 2024-05-11 21:41:24 EDT. --
May 11 21:40:06 volumio ntpd[559]: Soliciting pool server 216.197.156.83
May 11 21:40:48 volumio volumio[597]: verbose: New Socket.io Connection to volumio.loc from 10.1.113.101 UA: Mozilla/5.0 (X11; Linux x86_64; rv:125.0) Gecko/20100101 Firefox/125.0 Total Clients: 5
May 11 21:40:49 volumio volumio[597]: info: CoreCommandRouter::volumioGetState
May 11 21:40:49 volumio volumio[597]: info: CorePlayQueue::getTrack 0
May 11 21:40:49 volumio volumio[597]: info: CoreCommandRouter::volumioGetQueue
May 11 21:40:49 volumio volumio[597]: info: CoreStateMachine::getQueue
May 11 21:40:49 volumio volumio[597]: info: CorePlayQueue::getQueue
May 11 21:40:49 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
May 11 21:40:49 volumio volumio[597]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object]
May 11 21:40:49 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction
May 11 21:40:49 volumio volumio[597]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs
May 11 21:40:49 volumio volumio[597]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object]
May 11 21:40:49 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection
May 11 21:40:51 volumio volumio[597]: info: CALLMETHOD: system_controller system enableSSH true
May 11 21:40:51 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: system , enableSSH
May 11 21:40:51 volumio sudo[1221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ssh.service
May 11 21:40:51 volumio sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 11 21:40:51 volumio systemd[1]: Starting OpenBSD Secure Shell server...
May 11 21:40:51 volumio sshd[1224]: Server listening on 0.0.0.0 port 22.
May 11 21:40:51 volumio sshd[1224]: Server listening on :: port 22.
May 11 21:40:51 volumio systemd[1]: Started OpenBSD Secure Shell server.
May 11 21:40:51 volumio sudo[1221]: pam_unix(sudo:session): session closed for user root
May 11 21:40:51 volumio sudo[1225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable ssh.service
May 11 21:40:51 volumio sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 11 21:40:52 volumio systemd[1]: Reloading.
May 11 21:40:53 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
May 11 21:40:53 volumio systemd[1]: serial-getty@ttyAMA0.service: Current command vanished from the unit file, execution of the command list won't be resumed.
May 11 21:40:53 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
May 11 21:40:53 volumio sudo[1225]: pam_unix(sudo:session): session closed for user root
May 11 21:40:53 volumio volumio[597]: error: Cannot enable SSH service: Error: Command failed: /usr/bin/sudo /bin/systemctl start ssh.service && /usr/bin/sudo /bin/systemctl enable ssh.service
May 11 21:40:53 volumio volumio[597]: Synchronizing state of ssh.service with SysV service script with /lib/systemd/systemd-sysv-install.
May 11 21:40:53 volumio volumio[597]: Executing: /lib/systemd/systemd-sysv-install enable ssh
May 11 21:40:53 volumio volumio[597]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5).
May 11 21:40:53 volumio volumio[597]: insserv: warning: current stop runlevel(s) (2 3 4 5) of script `ssh' overrides LSB defaults (empty).
May 11 21:40:53 volumio volumio[597]: update-rc.d: error: No space left on device
May 11 21:40:56 volumio sshd[1247]: Accepted password for volumio from 10.1.113.101 port 55458 ssh2
May 11 21:40:56 volumio sshd[1247]: pam_unix(sshd:session): session opened for user volumio by (uid=0)
May 11 21:40:56 volumio systemd[1]: Created slice User Slice of UID 1000.
May 11 21:40:56 volumio systemd[1]: Starting User Runtime Directory /run/user/1000...
May 11 21:40:56 volumio systemd-logind[378]: New session 1 of user volumio.
May 11 21:40:56 volumio systemd[1]: Started User Runtime Directory /run/user/1000.
May 11 21:40:56 volumio systemd[1]: Starting User Manager for UID 1000...
May 11 21:40:56 volumio systemd[1251]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0)
May 11 21:40:56 volumio ntpd[559]: Soliciting pool server 2607:5300:201:3100::32ae
May 11 21:40:57 volumio systemd[1251]: gpgconf: running /usr/bin/gpg-agent failed (exitcode=2): General error
May 11 21:40:57 volumio systemd[1251]: gpgconf: fatal error (exit status 1)
May 11 21:40:57 volumio systemd[1251]: Starting D-Bus User Message Bus Socket.
May 11 21:40:57 volumio systemd[1251]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
May 11 21:40:57 volumio systemd[1251]: Listening on GnuPG cryptographic agent and passphrase cache.
May 11 21:40:57 volumio systemd[1251]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
May 11 21:40:57 volumio systemd[1251]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
May 11 21:40:57 volumio systemd[1251]: Reached target Paths.
May 11 21:40:57 volumio systemd[1251]: Listening on GnuPG network certificate management daemon.
May 11 21:40:57 volumio systemd[1251]: Reached target Timers.
May 11 21:40:57 volumio systemd[1251]: Listening on Sound System.
May 11 21:40:57 volumio systemd[1251]: Listening on D-Bus User Message Bus Socket.
May 11 21:40:57 volumio systemd[1251]: Reached target Sockets.
May 11 21:40:57 volumio systemd[1251]: Reached target Basic System.
May 11 21:40:57 volumio systemd[1]: Started User Manager for UID 1000.
May 11 21:40:57 volumio systemd[1251]: Starting Music Player Daemon...
May 11 21:40:57 volumio systemd[1]: Started Session 1 of user volumio.
May 11 21:40:59 volumio mpd[1262]: exception: Default TCP listener setup failed, but this is okay because we have a $XDG_RUNTIME_DIR listener: Failed to bind to '[::]:6600'; Failed to bind socket: Address already in use
May 11 21:40:59 volumio mpd[1262]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 11 21:40:59 volumio mpd[1262]: output: No 'audio_output' defined in config file
May 11 21:40:59 volumio mpd[1262]: output: Successfully detected a sndio audio device
May 11 21:40:59 volumio systemd[1251]: Starting Sound Service...
May 11 21:40:59 volumio systemd[1251]: Started Music Player Daemon.
May 11 21:40:59 volumio systemd[1251]: Reached target Default.
May 11 21:40:59 volumio dbus-daemon[398]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.14' (uid=1000 pid=1274 comm="/usr/bin/pulseaudio --daemonize=no ")
May 11 21:40:59 volumio systemd[1]: rtkit-daemon.service: Failed to run 'start' task: No space left on device
May 11 21:40:59 volumio systemd[1]: rtkit-daemon.service: Failed with result 'resources'.
May 11 21:40:59 volumio systemd[1]: Failed to start RealtimeKit Scheduling Policy Service.
May 11 21:41:00 volumio ntpd[559]: Soliciting pool server 207.34.48.31
May 11 21:41:03 volumio ntpd[559]: Soliciting pool server 173.183.146.26
May 11 21:41:12 volumio ntpd[559]: Soliciting pool server 138.197.135.239
May 11 21:41:19 volumio sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 11 21:41:19 volumio sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 11 21:41:19 volumio sudo[1280]: pam_unix(sudo:session): session closed for user root
May 11 21:41:19 volumio sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 11 21:41:19 volumio sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 11 21:41:19 volumio sudo[1282]: pam_unix(sudo:session): session closed for user root
May 11 21:41:19 volumio volumio[597]: verbose: New Socket.io Connection to 10.1.151.210 from 10.1.113.101 UA: Mozilla/5.0 (X11; Linux x86_64; rv:125.0) Gecko/20100101 Firefox/125.0 Total Clients: 5
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::volumioGetVisibleSources
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::volumioGetState
May 11 21:41:19 volumio volumio[597]: info: CorePlayQueue::getTrack 0
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 11 21:41:19 volumio volumio[597]: info: Received Get System Info
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 11 21:41:19 volumio volumio[597]: info: Discovery: Getting this device information
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::volumioGetState
May 11 21:41:19 volumio volumio[597]: info: CorePlayQueue::getTrack 0
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::volumioGetState
May 11 21:41:19 volumio volumio[597]: info: CorePlayQueue::getTrack 0
May 11 21:41:19 volumio volumio[597]: info: Listing playlists
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 11 21:41:19 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 11 21:41:20 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 11 21:41:20 volumio volumio[597]: info: CoreCommandRouter::volumioGetState
May 11 21:41:20 volumio volumio[597]: info: CorePlayQueue::getTrack 0
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 11 21:41:21 volumio volumio[597]: info: Received Get System Info
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 11 21:41:21 volumio volumio[597]: info: Discovery: Getting this device information
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::volumioGetState
May 11 21:41:21 volumio volumio[597]: info: CorePlayQueue::getTrack 0
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 11 21:41:21 volumio volumio[597]: info: Received Get System Info
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 11 21:41:21 volumio volumio[597]: info: Discovery: Getting this device information
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::volumioGetState
May 11 21:41:21 volumio volumio[597]: info: CorePlayQueue::getTrack 0
May 11 21:41:21 volumio volumio[597]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 11 21:41:23 volumio volumio-remote-updater[395]: Test mode enabled
May 11 21:41:23 volumio volumio-remote-updater[395]: No alpha test mode
May 11 21:41:23 volumio volumio-remote-updater[395]: Test mode enabled
May 11 21:41:23 volumio volumio-remote-updater[395]: No alpha test mode
May 11 21:41:23 volumio volumio[597]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Improvements for Volumio logo on boot
\n- Fix kiosk start on boot
\n
\nNEW ADDITIONS
\n\n- Use 64bit kernel on CM4
\n- Add BBC radios
\n- Bump to kernel 6.1.77 on RPi
\n- Bump to init-v3
\n- Add USB and NVME boot capabilities to RPi
\n- Add install to NVME disk on supported RPi models
\n- New awesome plymouth on boot
\n- UNSTABLE ALPHA BUILD - DO NOT INSTALL
\n
\n","title":"Update v3.669","updateavailable":true}
May 11 21:41:23 volumio volumio[597]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 11 21:41:23 volumio volumio[597]: SyntaxError: /data/configuration/plugins.json: Unexpected end of JSON input
May 11 21:41:23 volumio volumio[597]: at JSON.parse ()
May 11 21:41:23 volumio volumio[597]: at Object.readFileSync (/volumio/node_modules/jsonfile/index.js:69:17)
May 11 21:41:23 volumio volumio[597]: at PluginManager.getAllPlugNames (/volumio/app/pluginmanager.js:568:21)
May 11 21:41:23 volumio volumio[597]: at PluginManager.getPluginsMatrix (/volumio/app/pluginmanager.js:592:26)
May 11 21:41:23 volumio volumio[597]: at PluginManager.listPluginsBrokenByNewVersion (/volumio/app/pluginmanager.js:1224:22)
May 11 21:41:23 volumio volumio[597]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:934:60)
May 11 21:41:23 volumio volumio[597]: at Socket.emit (events.js:315:20)
May 11 21:41:23 volumio volumio[597]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 11 21:41:23 volumio volumio[597]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 11 21:41:23 volumio volumio[597]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 11 21:41:23 volumio volumio-remote-updater[395]: Test mode enabled
May 11 21:41:23 volumio volumio-remote-updater[395]: No alpha test mode
May 11 21:41:24 volumio sudo[1335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-11 21:40
May 11 21:41:24 volumio sudo[1335]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d"
VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee"
VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623"
VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST"
VOLUMIO_VERSION="3.661"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"