-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-01-19 14:22:47 CET. --
Jan 19 14:22:16 volumio systemd-timedated[1049]: Changed local time to Sun Jan 19 14:22:16 2025
Jan 19 14:22:16 volumio sudo[1047]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:16 volumio volumio-time-update[598]: volumio-time-update-util: System time updated successfully.
Jan 19 14:22:16 volumio systemd[1]: Started Volumio Time Update Utility.
Jan 19 14:22:16 volumio wireless.js[624]: trying...
Jan 19 14:22:16 volumio sudo[1052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 19 14:22:16 volumio sudo[1052]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:16 volumio sudo[1052]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:17 volumio wireless.js[624]: trying...
Jan 19 14:22:17 volumio sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 19 14:22:17 volumio sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:17 volumio sudo[1056]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:18 volumio dhcpcd[992]: wlan0: leased 192.168.1.4 for 3600 seconds
Jan 19 14:22:18 volumio avahi-daemon[615]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.4.
Jan 19 14:22:18 volumio dhcpcd[992]: wlan0: adding route to 192.168.1.0/24
Jan 19 14:22:18 volumio avahi-daemon[615]: New relevant interface wlan0.IPv4 for mDNS.
Jan 19 14:22:18 volumio dhcpcd[992]: wlan0: adding default route via 192.168.1.1
Jan 19 14:22:18 volumio avahi-daemon[615]: Registering new address record for 192.168.1.4 on wlan0.IPv4.
Jan 19 14:22:18 volumio wireless.js[624]: trying...
Jan 19 14:22:18 volumio sudo[1081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 19 14:22:18 volumio sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:18 volumio sudo[1081]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:18 volumio wireless.js[624]: Connected to: ----The Promised LAN
Jan 19 14:22:18 volumio wireless.js[624]: ----
Jan 19 14:22:18 volumio sudo[1084]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 19 14:22:18 volumio sudo[1084]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:18 volumio sudo[1084]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:18 volumio wireless.js[624]: ... joined AP, wlan0 IPv4 is 192.168.1.4, ipV6 is undefined
Jan 19 14:22:18 volumio wireless.js[624]: It's done! AP
Jan 19 14:22:18 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Jan 19 14:22:18 volumio systemd[1]: Started Wireless Services.
Jan 19 14:22:18 volumio systemd[1]: Started Volumio Backend Module.
Jan 19 14:22:18 volumio systemd[1]: Started Volumio Cpu Tweaker.
Jan 19 14:22:18 volumio systemd[1]: Reached target Multi-User System.
Jan 19 14:22:18 volumio systemd[1]: Reached target Graphical Interface.
Jan 19 14:22:18 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jan 19 14:22:18 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Jan 19 14:22:18 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Jan 19 14:22:18 volumio systemd[1]: Startup finished in 12.251s (kernel) + 21.497s (userspace) = 33.748s.
Jan 19 14:22:18 volumio volumio-cpu-tweak[1090]: Setting RT Priority for mpd
Jan 19 14:22:18 volumio volumio-cpu-tweak[1090]: Setting MPD Affinity
Jan 19 14:22:18 volumio volumio-cpu-tweak[1090]: pid 808's current affinity mask: f
Jan 19 14:22:18 volumio volumio-cpu-tweak[1090]: pid 808's new affinity mask: 3
Jan 19 14:22:18 volumio volumio-cpu-tweak[1090]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Jan 19 14:22:18 volumio volumio-cpu-tweak[1090]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Jan 19 14:22:18 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded.
Jan 19 14:22:20 volumio volumio[1089]: info: -------------------------------------------
Jan 19 14:22:20 volumio volumio[1089]: info: ----- Volumio3 ----
Jan 19 14:22:20 volumio volumio[1089]: info: -------------------------------------------
Jan 19 14:22:20 volumio volumio[1089]: info: ----- System startup ----
Jan 19 14:22:20 volumio ntpd[779]: Listen normally on 4 wlan0 192.168.1.4:123
Jan 19 14:22:20 volumio volumio[1089]: info: -------------------------------------------
Jan 19 14:22:20 volumio ntpd[779]: new interface(s) found: waking up resolver
Jan 19 14:22:20 volumio volumio[1089]: info: MYVOLUMIO Environment detected
Jan 19 14:22:20 volumio volumio[1089]: info: Plugin folders cleanup
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning into folder /volumio/app/plugins/
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning category audio_interface
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning category miscellanea
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning category music_service
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning category plugins.json
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning category system_controller
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning category user_interface
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning into folder /data/plugins/
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning category music_service
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning category system_controller
Jan 19 14:22:20 volumio volumio[1089]: info: Scanning category user_interface
Jan 19 14:22:20 volumio volumio[1089]: info: Plugin folders cleanup completed
Jan 19 14:22:20 volumio volumio[1089]: info: -------------------------------------------
Jan 19 14:22:20 volumio volumio[1089]: info: ----- Core plugins startup ----
Jan 19 14:22:20 volumio volumio[1089]: info: -------------------------------------------
Jan 19 14:22:20 volumio volumio[1089]: info: Loading plugins from folder /volumio/app/plugins/
Jan 19 14:22:20 volumio volumio[1089]: info: Adding plugin upnp to MyMusic Plugins
Jan 19 14:22:20 volumio volumio[1089]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jan 19 14:22:20 volumio volumio[1089]: info: Adding plugin upnp_browser to MyMusic Plugins
Jan 19 14:22:20 volumio volumio[1089]: info: Loading plugins from folder /data/plugins/
Jan 19 14:22:20 volumio volumio[1089]: info: Loading plugin "system"...
Jan 19 14:22:20 volumio volumio[1089]: info: Loading plugin "appearance"...
Jan 19 14:22:21 volumio volumio[1089]: info: Loading plugin "network"...
Jan 19 14:22:21 volumio volumio[1089]: info: Refreshing Cached IP Addresses
Jan 19 14:22:21 volumio sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 19 14:22:21 volumio sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:21 volumio sudo[1121]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:21 volumio sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 19 14:22:21 volumio sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:21 volumio sudo[1123]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:21 volumio volumio[1089]: info: Loading plugin "services"...
Jan 19 14:22:21 volumio volumio[1089]: info: Loading plugin "alsa_controller"...
Jan 19 14:22:21 volumio sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jan 19 14:22:21 volumio sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:21 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 19 14:22:21 volumio volumio[1089]: info: Loading plugin "wizard"...
Jan 19 14:22:21 volumio volumio[1089]: info: Loading plugin "networkfs"...
Jan 19 14:22:21 volumio volumio[1089]: info: Starting Udev Watcher for removable devices
Jan 19 14:22:21 volumio sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.2:/volume1/music /mnt/NAS/Synology
Jan 19 14:22:21 volumio sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:21 volumio volumio[1089]: info: Ignoring mount for partition: boot
Jan 19 14:22:21 volumio volumio[1089]: info: Ignoring mount for partition: volumio
Jan 19 14:22:21 volumio volumio[1089]: info: Ignoring mount for partition: volumio_data
Jan 19 14:22:22 volumio volumio[1089]: info: Mounting Device Elements
Jan 19 14:22:22 volumio sudo[1159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Elements -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Jan 19 14:22:22 volumio sudo[1159]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:23 volumio volumio-remote-updater[628]: [2025-01-19 14:22:23] [connect] Successful connection
Jan 19 14:22:23 volumio ntfs-3g[1162]: Version 2017.3.23AR.3 integrated FUSE 28
Jan 19 14:22:23 volumio ntfs-3g[1162]: Mounted /dev/sda1 (Read-Write, label "Elements", NTFS 3.1)
Jan 19 14:22:23 volumio ntfs-3g[1162]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
Jan 19 14:22:23 volumio ntfs-3g[1162]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096
Jan 19 14:22:23 volumio ntfs-3g[1162]: Global ownership and permissions enforced, configuration type 7
Jan 19 14:22:23 volumio sudo[1159]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:23 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 19 14:22:23 volumio volumio[1089]: info: Loading plugin "volumio_command_line_client"...
Jan 19 14:22:23 volumio volumio[1089]: info: Loading plugin "upnp"...
Jan 19 14:22:23 volumio volumio[1089]: info: [1737292943281] Starting Upmpd Daemon
Jan 19 14:22:23 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 19 14:22:23 volumio volumio[1089]: info: Loading plugin "my_music"...
Jan 19 14:22:23 volumio volumio[1089]: info: Loading plugin "mpd"...
Jan 19 14:22:23 volumio volumio[1089]: info: Loading plugin "upnp_browser"...
Jan 19 14:22:23 volumio volumio[1089]: info: Loading plugin "alarm-clock"...
Jan 19 14:22:23 volumio volumio[1089]: info: Loading plugin "airplay_emulation"...
Jan 19 14:22:23 volumio volumio[1089]: info: Starting Shairport Sync
Jan 19 14:22:23 volumio volumio[1089]: info: Loading plugin "last_100"...
Jan 19 14:22:23 volumio volumio[1089]: info: Loading plugin "webradio"...
Jan 19 14:22:24 volumio volumio[1089]: info: Loading plugin "i2s_dacs"...
Jan 19 14:22:24 volumio volumio[1089]: info: I2S DAC not set, start Auto-detection
Jan 19 14:22:24 volumio volumio[1089]: info: Loading plugin "volumiodiscovery"...
Jan 19 14:22:24 volumio volumio[1089]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jan 19 14:22:24 volumio volumio[1089]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 19 14:22:24 volumio node[1089]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jan 19 14:22:24 volumio volumio[1089]: *** WARNING *** For more information see
Jan 19 14:22:24 volumio volumio[1089]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jan 19 14:22:24 volumio volumio[1089]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 19 14:22:24 volumio volumio[1089]: *** WARNING *** For more information see
Jan 19 14:22:24 volumio node[1089]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 19 14:22:24 volumio node[1089]: *** WARNING *** For more information see
Jan 19 14:22:24 volumio node[1089]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jan 19 14:22:24 volumio node[1089]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 19 14:22:24 volumio node[1089]: *** WARNING *** For more information see
Jan 19 14:22:24 volumio volumio[1089]: info: Applying required configuration parameters for plugin volumiodiscovery
Jan 19 14:22:24 volumio volumio[1089]: info: Discovery: Started advertising with name: Volumio
Jan 19 14:22:24 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 19 14:22:24 volumio volumio[1089]: info: Loading plugin "spop"...
Jan 19 14:22:25 volumio volumio[1089]: info: Loading plugin "autostart"...
Jan 19 14:22:25 volumio volumio[1089]: info: Applying required configuration parameters for plugin autostart
Jan 19 14:22:25 volumio volumio[1089]: info: AutoStart - onVolumioStart - read config.json
Jan 19 14:22:25 volumio volumio[1089]: info: Plugin now_playing is not enabled
Jan 19 14:22:25 volumio volumio[1089]: info: Loading plugin "outputs"...
Jan 19 14:22:25 volumio volumio[1089]: info: Loading plugin "albumart"...
Jan 19 14:22:25 volumio volumio[1089]: info: Plugin example_plugin is not enabled
Jan 19 14:22:25 volumio volumio[1089]: info: Loading plugin "inputs"...
Jan 19 14:22:25 volumio volumio[1089]: info: Loading plugin "updater_comm"...
Jan 19 14:22:25 volumio volumio[1089]: info: Plugin mpdemulation is not enabled
Jan 19 14:22:25 volumio volumio[1089]: info: Loading plugin "rest_api"...
Jan 19 14:22:25 volumio volumio[1089]: info: Loading plugin "websocket"...
Jan 19 14:22:25 volumio volumio[1089]: info: Starting Socket.io Server version 2.3.0
Jan 19 14:22:25 volumio volumio[1089]: info: Plugin peppymeterbasic is not enabled
Jan 19 14:22:25 volumio volumio[1089]: info: Plugin peppyspectrum is not enabled
Jan 19 14:22:25 volumio volumio[1089]: info: Loading plugin "randomizer"...
Jan 19 14:22:25 volumio sudo[1132]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:25 volumio volumio[1089]: Forking 3 albumart workers
Jan 19 14:22:25 volumio volumio[1089]: info: Applying required configuration parameters for plugin randomizer
Jan 19 14:22:26 volumio volumio[1089]: info: Loading plugin "touch_display"...
Jan 19 14:22:26 volumio volumio[1089]: Starting albumart workers
Jan 19 14:22:26 volumio volumio[1089]: Starting albumart workers
Jan 19 14:22:26 volumio volumio[1089]: Starting albumart workers
Jan 19 14:22:26 volumio volumio[1089]: info: Applying required configuration parameters for plugin touch_display
Jan 19 14:22:26 volumio volumio[1089]: info: Loading i18n strings for locale en
Jan 19 14:22:26 volumio volumio[1089]: Updating browse sources language
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::initPlayerControls
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: Express server listening on port 3000
Jan 19 14:22:26 volumio volumio[1089]: [Metrics] WebUI: 7s 383.74ms
Jan 19 14:22:26 volumio volumio[1089]: info: CoreStateMachine::resetVolumioState
Jan 19 14:22:26 volumio volumio[1089]: info: CoreStateMachine::getcurrentVolume
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::volumioRetrievevolume
Jan 19 14:22:26 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 19 14:22:26 volumio volumio[1089]: info: Volumio Network Manager: Network status updated: 3
Jan 19 14:22:26 volumio volumio-remote-updater[628]: [2025-01-19 14:22:26] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737292943 101
Jan 19 14:22:26 volumio volumio[1089]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1
Jan 19 14:22:27 volumio volumio[1089]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Jan 19 14:22:27 volumio volumio[1089]: info: Reloading queue from file
Jan 19 14:22:27 volumio volumio[1089]: info: VolumeController:: Volume=86 Mute =false
Jan 19 14:22:27 volumio volumio[1089]: info: CoreStateMachine::pushState
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState
Jan 19 14:22:27 volumio volumio[1089]: info: CoreStateMachine::updateTrackBlock
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrackBlock
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioRetrievevolume
Jan 19 14:22:27 volumio volumio[1089]: info: CoreStateMachine::setRepeat false single undefined
Jan 19 14:22:27 volumio volumio[1089]: info: CoreStateMachine::pushState
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState
Jan 19 14:22:27 volumio volumio[1089]: info: CoreStateMachine::setRandom true
Jan 19 14:22:27 volumio volumio[1089]: info: CoreStateMachine::pushState
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState
Jan 19 14:22:27 volumio volumio[1089]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jan 19 14:22:27 volumio volumio[1089]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115
Jan 19 14:22:27 volumio volumio[1089]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jan 19 14:22:27 volumio volumio[1089]: info: Setting Device type: Raspberry PI
Jan 19 14:22:27 volumio volumio[1089]: info: Discovery: adding 78431a9e-8043-4ac5-b5e0-40632856946e
Jan 19 14:22:27 volumio volumio[1089]: info: Discovery: Found device Volumio
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:27 volumio volumio[1089]: info: VolumeController:: Volume=86 Mute =false
Jan 19 14:22:27 volumio volumio[1089]: info: CoreStateMachine::pushState
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState
Jan 19 14:22:27 volumio volumio[1089]: info: Discovery: this is already registered, 78431a9e-8043-4ac5-b5e0-40632856946e
Jan 19 14:22:27 volumio volumio[1089]: info: Discovery: Found device Volumio
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:27 volumio sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 19 14:22:27 volumio sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:27 volumio sudo[1234]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:27 volumio sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 19 14:22:27 volumio sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:27 volumio sudo[1236]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:27 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.1.6 from 192.168.1.49 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 19 14:22:27 volumio sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 19 14:22:27 volumio sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:27 volumio sudo[1240]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:27 volumio sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 19 14:22:27 volumio sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:27 volumio sudo[1242]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:27 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.1.6 from 192.168.1.49 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 19 14:22:27 volumio volumio[1089]: info: Received Get System Info
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 19 14:22:27 volumio volumio[1089]: info: Discovery: Getting this device information
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState
Jan 19 14:22:27 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:27 volumio volumio[1089]: info: Listing playlists
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 19 14:22:27 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 19 14:22:29 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Jan 19 14:22:29 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState
Jan 19 14:22:29 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jan 19 14:22:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 19 14:22:29 volumio volumio[1089]: info: Received Get System Info
Jan 19 14:22:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 19 14:22:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 19 14:22:29 volumio volumio[1089]: info: Discovery: Getting this device information
Jan 19 14:22:29 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState
Jan 19 14:22:29 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 19 14:22:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Jan 19 14:22:31 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 19 14:22:31 volumio volumio[1089]: info: Received Get System Info
Jan 19 14:22:31 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 19 14:22:31 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 19 14:22:31 volumio volumio[1089]: info: Discovery: Getting this device information
Jan 19 14:22:31 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState
Jan 19 14:22:31 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:31 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 19 14:22:31 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Jan 19 14:22:31 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Jan 19 14:22:33 volumio sudo[1263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 19 14:22:33 volumio sudo[1263]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:33 volumio sudo[1263]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:33 volumio sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 19 14:22:33 volumio sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:33 volumio sudo[1265]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:33 volumio sudo[1269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jan 19 14:22:33 volumio sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 19 14:22:33 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jan 19 14:22:33 volumio sudo[1269]: pam_unix(sudo:session): session closed for user root
Jan 19 14:22:33 volumio volumio[1089]: info: Upmpdcli Daemon Started
Jan 19 14:22:33 volumio volumio[1271]: Generating RSA private key, 4096 bit long modulus (2 primes)
Jan 19 14:22:34 volumio volumio[1271]: ...............++++
Jan 19 14:22:36 volumio volumio[1271]: .................++++
Jan 19 14:22:36 volumio volumio[1271]: e is 65537 (0x010001)
Jan 19 14:22:36 volumio volumio[1271]: writing RSA key
Jan 19 14:22:37 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 19 14:22:38 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue
Jan 19 14:22:38 volumio volumio[1089]: info: CoreStateMachine::getQueue
Jan 19 14:22:38 volumio volumio[1089]: info: CorePlayQueue::getQueue
Jan 19 14:22:45 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 19 14:22:45 volumio volumio[1089]: info: CURURI: albums://Various/A%20State%20Of%20Trance%20Classics%20Volume%2001
Jan 19 14:22:45 volumio volumio[1089]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'sendCommand' of undefined
Jan 19 14:22:45 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 19 14:22:45 volumio volumio[1089]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jan 19 14:22:45 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jan 19 14:22:45 volumio volumio[1089]: info: Received Get System Version
Jan 19 14:22:45 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 19 14:22:45 volumio volumio[1089]: info: Received Get System Info
Jan 19 14:22:45 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 19 14:22:45 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 19 14:22:45 volumio volumio[1089]: info: Discovery: Getting this device information
Jan 19 14:22:45 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState
Jan 19 14:22:45 volumio volumio[1089]: info: CorePlayQueue::getTrack 0
Jan 19 14:22:45 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 19 14:22:46 volumio systemd[1]: systemd-timedated.service: Succeeded.
Jan 19 14:22:47 volumio volumio[1089]: info: Preload queue cleared
Jan 19 14:22:47 volumio volumio[1089]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 19 14:22:47 volumio volumio[1089]: info: CoreStateMachine::ClearQueue
Jan 19 14:22:47 volumio volumio[1089]: info: CoreStateMachine::stop
Jan 19 14:22:47 volumio volumio[1089]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 14:22:47 volumio volumio[1089]: info: CorePlayQueue::clearPlayQueue
Jan 19 14:22:47 volumio volumio[1089]: info: CorePlayQueue::saveQueue
Jan 19 14:22:47 volumio volumio[1089]: info: CoreCommandRouter::volumioPushQueue
Jan 19 14:22:47 volumio volumio[1089]: info: CoreStateMachine::addQueueItems
Jan 19 14:22:47 volumio volumio[1089]: info: CorePlayQueue::addQueueItems
Jan 19 14:22:47 volumio volumio[1089]: info: Preload queue cleared
Jan 19 14:22:47 volumio volumio[1089]: info: Adding Item to queue: albums://Various/A%20State%20Of%20Trance%20Classics%20Volume%2001
Jan 19 14:22:47 volumio volumio[1089]: info: Exploding uri albums://Various/A%20State%20Of%20Trance%20Classics%20Volume%2001 in service mpd
Jan 19 14:22:47 volumio volumio[1089]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 19 14:22:47 volumio volumio[1089]: TypeError: Cannot read property 'sendCommand' of undefined
Jan 19 14:22:47 volumio volumio[1089]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2121:20)
Jan 19 14:22:47 volumio volumio[1089]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1378:16)
Jan 19 14:22:47 volumio volumio[1089]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Jan 19 14:22:47 volumio volumio[1089]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Jan 19 14:22:47 volumio volumio[1089]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30)
Jan 19 14:22:47 volumio volumio[1089]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25)
Jan 19 14:22:47 volumio volumio[1089]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:526:23)
Jan 19 14:22:47 volumio volumio[1089]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17)
Jan 19 14:22:47 volumio volumio[1089]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33)
Jan 19 14:22:47 volumio volumio[1089]: at Socket.emit (events.js:315:20)
Jan 19 14:22:47 volumio volumio[1089]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jan 19 14:22:47 volumio volumio[1089]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jan 19 14:22:47 volumio volumio[1089]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 19 14:22:47 volumio sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-19 14:21
Jan 19 14:22:47 volumio sudo[1340]: 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="f6610a1100d2380eef33bd3004af43153c786f96"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET"
VOLUMIO_VERSION="3.785"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"