-- Logs begin at Thu 2019-02-14 17:12:00 +07, end at Thu 2024-09-26 08:54:05 +07. --
Sep 26 08:53:00 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 26 08:53:00 sanvuon volumio[923]: info: Received Get System Info
Sep 26 08:53:00 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 26 08:53:00 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 26 08:53:00 sanvuon volumio[923]: info: Discovery: Getting this device information
Sep 26 08:53:00 sanvuon volumio[923]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:00 sanvuon volumio[923]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:00 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 26 08:53:00 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:02 sanvuon volumio[923]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:02 sanvuon volumio[923]: info: Listing playlists
Sep 26 08:53:02 sanvuon volumio[923]: info: Listing playlists
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 26 08:53:02 sanvuon volumio[923]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 26 08:53:03 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:53:03 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 26 08:53:06 sanvuon volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Sep 26 08:53:06 sanvuon volumio[923]: verbose: ControllerMpd::sendMpdCommand update
Sep 26 08:53:06 sanvuon volumio[923]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:53:06 sanvuon volumio[923]: TypeError: Cannot read property 'then' of undefined
Sep 26 08:53:06 sanvuon volumio[923]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
Sep 26 08:53:06 sanvuon volumio[923]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1898:15)
Sep 26 08:53:06 sanvuon volumio[923]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Sep 26 08:53:06 sanvuon volumio[923]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26)
Sep 26 08:53:06 sanvuon volumio[923]: at Socket.emit (events.js:315:20)
Sep 26 08:53:06 sanvuon volumio[923]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Sep 26 08:53:06 sanvuon volumio[923]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Sep 26 08:53:06 sanvuon volumio[923]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:53:07 sanvuon sudo[1069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-26 08:52
Sep 26 08:53:07 sanvuon sudo[1069]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:07 sanvuon sudo[1069]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:08 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:08] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 26 08:53:08 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:08] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 26 08:53:08 sanvuon systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 26 08:53:08 sanvuon systemd[1]: media-Unisstant.mount: Succeeded.
Sep 26 08:53:08 sanvuon systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 26 08:53:08 sanvuon systemd[1]: Started dynamicswap service.
Sep 26 08:53:08 sanvuon systemd[1]: dynamicswap.service: Succeeded.
Sep 26 08:53:08 sanvuon systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 26 08:53:08 sanvuon systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Sep 26 08:53:08 sanvuon systemd[1]: Started dynamicswap service.
Sep 26 08:53:08 sanvuon systemd[1]: Stopped Volumio Backend Module.
Sep 26 08:53:08 sanvuon systemd[1]: Started Volumio Backend Module.
Sep 26 08:53:08 sanvuon systemd[1]: dynamicswap.service: Succeeded.
Sep 26 08:53:09 sanvuon volumio[1085]: info: -------------------------------------------
Sep 26 08:53:09 sanvuon volumio[1085]: info: ----- Volumio3 ----
Sep 26 08:53:09 sanvuon volumio[1085]: info: -------------------------------------------
Sep 26 08:53:09 sanvuon volumio[1085]: info: ----- System startup ----
Sep 26 08:53:09 sanvuon volumio[1085]: info: -------------------------------------------
Sep 26 08:53:10 sanvuon volumio[1085]: info: MYVOLUMIO Environment detected
Sep 26 08:53:10 sanvuon volumio[1085]: info: Plugin folders cleanup
Sep 26 08:53:10 sanvuon volumio[1085]: info: Scanning into folder /volumio/app/plugins/
Sep 26 08:53:10 sanvuon volumio[1085]: info: Scanning category audio_interface
Sep 26 08:53:10 sanvuon volumio[1085]: info: Scanning category miscellanea
Sep 26 08:53:10 sanvuon volumio[1085]: info: Scanning category music_service
Sep 26 08:53:10 sanvuon volumio[1085]: info: Scanning category plugins.json
Sep 26 08:53:10 sanvuon volumio[1085]: info: Scanning category system_controller
Sep 26 08:53:10 sanvuon volumio[1085]: info: Scanning category user_interface
Sep 26 08:53:10 sanvuon volumio[1085]: info: Scanning into folder /data/plugins/
Sep 26 08:53:10 sanvuon volumio[1085]: info: Scanning category music_service
Sep 26 08:53:10 sanvuon volumio[1085]: info: Plugin folders cleanup completed
Sep 26 08:53:10 sanvuon volumio[1085]: info: -------------------------------------------
Sep 26 08:53:10 sanvuon volumio[1085]: info: ----- Core plugins startup ----
Sep 26 08:53:10 sanvuon volumio[1085]: info: -------------------------------------------
Sep 26 08:53:10 sanvuon volumio[1085]: info: Loading plugins from folder /volumio/app/plugins/
Sep 26 08:53:10 sanvuon volumio[1085]: info: Adding plugin upnp to MyMusic Plugins
Sep 26 08:53:10 sanvuon volumio[1085]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 26 08:53:10 sanvuon volumio[1085]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 26 08:53:10 sanvuon volumio[1085]: info: Loading plugins from folder /data/plugins/
Sep 26 08:53:10 sanvuon volumio[1085]: info: Loading plugin "system"...
Sep 26 08:53:10 sanvuon volumio[1085]: info: Loading plugin "appearance"...
Sep 26 08:53:10 sanvuon wpa_supplicant[802]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="EliteHouses"
Sep 26 08:53:10 sanvuon wpa_supplicant[802]: wlan0: Trying to associate with SSID 'EliteHouses'
Sep 26 08:53:10 sanvuon volumio[1085]: info: Loading plugin "network"...
Sep 26 08:53:10 sanvuon volumio[1085]: info: Refreshing Cached IP Addresses
Sep 26 08:53:10 sanvuon sudo[1111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 26 08:53:10 sanvuon sudo[1111]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:10 sanvuon sudo[1111]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:10 sanvuon sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 26 08:53:10 sanvuon volumio[1085]: info: Loading plugin "services"...
Sep 26 08:53:10 sanvuon sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:10 sanvuon volumio[1085]: info: Loading plugin "alsa_controller"...
Sep 26 08:53:10 sanvuon sudo[1113]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:10 sanvuon sudo[1116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 26 08:53:10 sanvuon sudo[1116]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:10 sanvuon sudo[1116]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:10 sanvuon kernel: ieee80211 phy0: brcmf_cfg80211_scan: Connecting: status (3)
Sep 26 08:53:10 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 26 08:53:10 sanvuon volumio[1085]: info: Loading plugin "wizard"...
Sep 26 08:53:10 sanvuon volumio[1085]: info: Loading plugin "networkfs"...
Sep 26 08:53:10 sanvuon volumio[1085]: info: Starting Udev Watcher for removable devices
Sep 26 08:53:10 sanvuon volumio[1085]: info: Ignoring mount for partition: boot
Sep 26 08:53:10 sanvuon volumio[1085]: info: Ignoring mount for partition: volumio
Sep 26 08:53:10 sanvuon volumio[1085]: info: Ignoring mount for partition: volumio_data
Sep 26 08:53:10 sanvuon volumio[1085]: info: Mounting Device Unisstant
Sep 26 08:53:10 sanvuon sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Unisstant -o noatime
Sep 26 08:53:10 sanvuon sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:11 sanvuon sudo[1125]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:11 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "volumio_command_line_client"...
Sep 26 08:53:11 sanvuon volumio[1085]: info: Plugin upnp is not enabled
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "my_music"...
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "mpd"...
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "upnp_browser"...
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "alarm-clock"...
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "airplay_emulation"...
Sep 26 08:53:11 sanvuon volumio[1085]: info: Starting Shairport Sync
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "last_100"...
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "webradio"...
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "i2s_dacs"...
Sep 26 08:53:11 sanvuon volumio[1085]: info: I2S DAC not set, start Auto-detection
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "volumiodiscovery"...
Sep 26 08:53:11 sanvuon volumio[1085]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:11 sanvuon volumio[1085]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:11 sanvuon node[1085]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:11 sanvuon volumio[1085]: *** WARNING *** For more information see
Sep 26 08:53:11 sanvuon volumio[1085]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:11 sanvuon volumio[1085]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:11 sanvuon volumio[1085]: *** WARNING *** For more information see
Sep 26 08:53:11 sanvuon node[1085]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:11 sanvuon node[1085]: *** WARNING *** For more information see
Sep 26 08:53:11 sanvuon node[1085]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:11 sanvuon node[1085]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:11 sanvuon node[1085]: *** WARNING *** For more information see
Sep 26 08:53:11 sanvuon volumio[1085]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 26 08:53:11 sanvuon volumio[1085]: info: Discovery: Started advertising with name: SanVuon
Sep 26 08:53:11 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 26 08:53:11 sanvuon volumio[1085]: info: Loading plugin "youtube2"...
Sep 26 08:53:11 sanvuon wpa_supplicant[802]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16
Sep 26 08:53:11 sanvuon wpa_supplicant[802]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="EliteHouses" auth_failures=3 duration=46 reason=CONN_FAILED
Sep 26 08:53:12 sanvuon volumio[1085]: info: Loading plugin "outputs"...
Sep 26 08:53:12 sanvuon volumio[1085]: info: Loading plugin "albumart"...
Sep 26 08:53:12 sanvuon volumio[1085]: info: Plugin example_plugin is not enabled
Sep 26 08:53:12 sanvuon volumio[1085]: info: Loading plugin "inputs"...
Sep 26 08:53:12 sanvuon volumio[1085]: info: Loading plugin "updater_comm"...
Sep 26 08:53:12 sanvuon volumio[1085]: info: Plugin mpdemulation is not enabled
Sep 26 08:53:12 sanvuon volumio[1085]: info: Loading plugin "rest_api"...
Sep 26 08:53:12 sanvuon volumio[1085]: info: Loading plugin "websocket"...
Sep 26 08:53:12 sanvuon volumio[1085]: info: Loading i18n strings for locale vi
Sep 26 08:53:12 sanvuon volumio[1085]: Updating browse sources language
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::initPlayerControls
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: Forking 3 albumart workers
Sep 26 08:53:12 sanvuon volumio[1085]: Express server listening on port 3000
Sep 26 08:53:12 sanvuon volumio[1085]: [Metrics] WebUI: 3s 301.11ms
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreStateMachine::resetVolumioState
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreStateMachine::getcurrentVolume
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::volumioRetrievevolume
Sep 26 08:53:12 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 26 08:53:12 sanvuon volumio[1085]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Sep 26 08:53:12 sanvuon volumio[1085]: wlan0 Interface doesn't support scanning : Resource temporarily unavailable
Sep 26 08:53:12 sanvuon volumio[1085]: info: Cannot use regular scanning, forcing with ap-force
Sep 26 08:53:12 sanvuon sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Sep 26 08:53:12 sanvuon sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:13 sanvuon volumio[1085]: Starting albumart workers
Sep 26 08:53:13 sanvuon volumio[1085]: Starting albumart workers
Sep 26 08:53:13 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:13] [connect] Successful connection
Sep 26 08:53:13 sanvuon volumio[1085]: Starting albumart workers
Sep 26 08:53:13 sanvuon sudo[1168]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:13 sanvuon volumio[1085]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 1
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreStateMachine::pushState
Sep 26 08:53:13 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreStateMachine::updateTrackBlock
Sep 26 08:53:13 sanvuon volumio[1085]: info: CorePlayQueue::getTrackBlock
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::volumioRetrievevolume
Sep 26 08:53:13 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1727315593 101
Sep 26 08:53:13 sanvuon volumio[1085]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
Sep 26 08:53:13 sanvuon volumio[1085]: info: Reloading queue from file
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreStateMachine::pushState
Sep 26 08:53:13 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreStateMachine::setRepeat true single undefined
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreStateMachine::pushState
Sep 26 08:53:13 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreStateMachine::setRandom false
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreStateMachine::pushState
Sep 26 08:53:13 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:13 sanvuon volumio[1085]: info: Setting Device type: Raspberry PI
Sep 26 08:53:13 sanvuon volumio[1085]: info: Discovery: adding 4af831ec-95a5-401d-ab45-640a06f62c01
Sep 26 08:53:13 sanvuon volumio[1085]: info: Discovery: Found device SanVuon
Sep 26 08:53:13 sanvuon volumio[1085]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:13 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:15 sanvuon volumio[1085]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 3
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 26 08:53:15 sanvuon volumio[1085]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Sep 26 08:53:15 sanvuon volumio[1085]: info: Received Get System Version
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 26 08:53:15 sanvuon volumio[1085]: info: Received Get System Info
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 26 08:53:15 sanvuon volumio[1085]: info: Discovery: Getting this device information
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:15 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:15 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 26 08:53:15 sanvuon volumio[1085]: info: Received Get System Info
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 26 08:53:15 sanvuon volumio[1085]: info: Discovery: Getting this device information
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:15 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 26 08:53:15 sanvuon volumio[1085]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:15 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:15 sanvuon volumio[1085]: info: Listing playlists
Sep 26 08:53:17 sanvuon volumio[1085]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:17 sanvuon volumio[1085]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:18 sanvuon volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Sep 26 08:53:18 sanvuon volumio[1085]: verbose: ControllerMpd::sendMpdCommand rescan
Sep 26 08:53:18 sanvuon volumio[1085]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:53:18 sanvuon volumio[1085]: TypeError: Cannot read property 'then' of undefined
Sep 26 08:53:18 sanvuon volumio[1085]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
Sep 26 08:53:18 sanvuon volumio[1085]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15)
Sep 26 08:53:18 sanvuon volumio[1085]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Sep 26 08:53:18 sanvuon volumio[1085]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26)
Sep 26 08:53:18 sanvuon volumio[1085]: at Socket.emit (events.js:315:20)
Sep 26 08:53:18 sanvuon volumio[1085]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Sep 26 08:53:18 sanvuon volumio[1085]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Sep 26 08:53:18 sanvuon volumio[1085]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:53:18 sanvuon sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-26 08:52
Sep 26 08:53:18 sanvuon sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:18 sanvuon sudo[1215]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:18 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:18] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 26 08:53:18 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:18] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 26 08:53:18 sanvuon systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 26 08:53:18 sanvuon systemd[1]: media-Unisstant.mount: Succeeded.
Sep 26 08:53:18 sanvuon systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 26 08:53:18 sanvuon systemd[1]: Started dynamicswap service.
Sep 26 08:53:18 sanvuon systemd[1]: dynamicswap.service: Succeeded.
Sep 26 08:53:19 sanvuon systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 26 08:53:19 sanvuon systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2.
Sep 26 08:53:19 sanvuon systemd[1]: Stopped Volumio Backend Module.
Sep 26 08:53:19 sanvuon systemd[1]: Started Volumio Backend Module.
Sep 26 08:53:19 sanvuon systemd[1]: Started dynamicswap service.
Sep 26 08:53:19 sanvuon systemd[1]: dynamicswap.service: Succeeded.
Sep 26 08:53:20 sanvuon volumio[1227]: info: -------------------------------------------
Sep 26 08:53:20 sanvuon volumio[1227]: info: ----- Volumio3 ----
Sep 26 08:53:20 sanvuon volumio[1227]: info: -------------------------------------------
Sep 26 08:53:20 sanvuon volumio[1227]: info: ----- System startup ----
Sep 26 08:53:20 sanvuon volumio[1227]: info: -------------------------------------------
Sep 26 08:53:20 sanvuon volumio[1227]: info: MYVOLUMIO Environment detected
Sep 26 08:53:20 sanvuon volumio[1227]: info: Plugin folders cleanup
Sep 26 08:53:20 sanvuon volumio[1227]: info: Scanning into folder /volumio/app/plugins/
Sep 26 08:53:20 sanvuon volumio[1227]: info: Scanning category audio_interface
Sep 26 08:53:20 sanvuon volumio[1227]: info: Scanning category miscellanea
Sep 26 08:53:20 sanvuon volumio[1227]: info: Scanning category music_service
Sep 26 08:53:20 sanvuon volumio[1227]: info: Scanning category plugins.json
Sep 26 08:53:20 sanvuon volumio[1227]: info: Scanning category system_controller
Sep 26 08:53:20 sanvuon volumio[1227]: info: Scanning category user_interface
Sep 26 08:53:20 sanvuon volumio[1227]: info: Scanning into folder /data/plugins/
Sep 26 08:53:20 sanvuon volumio[1227]: info: Scanning category music_service
Sep 26 08:53:20 sanvuon volumio[1227]: info: Plugin folders cleanup completed
Sep 26 08:53:20 sanvuon volumio[1227]: info: -------------------------------------------
Sep 26 08:53:20 sanvuon volumio[1227]: info: ----- Core plugins startup ----
Sep 26 08:53:20 sanvuon volumio[1227]: info: -------------------------------------------
Sep 26 08:53:20 sanvuon volumio[1227]: info: Loading plugins from folder /volumio/app/plugins/
Sep 26 08:53:20 sanvuon volumio[1227]: info: Adding plugin upnp to MyMusic Plugins
Sep 26 08:53:20 sanvuon volumio[1227]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 26 08:53:20 sanvuon volumio[1227]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 26 08:53:20 sanvuon volumio[1227]: info: Loading plugins from folder /data/plugins/
Sep 26 08:53:20 sanvuon volumio[1227]: info: Loading plugin "system"...
Sep 26 08:53:20 sanvuon volumio[1227]: info: Loading plugin "appearance"...
Sep 26 08:53:21 sanvuon volumio[1227]: info: Loading plugin "network"...
Sep 26 08:53:21 sanvuon volumio[1227]: info: Refreshing Cached IP Addresses
Sep 26 08:53:21 sanvuon sudo[1289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 26 08:53:21 sanvuon sudo[1289]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:21 sanvuon sudo[1289]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:21 sanvuon sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 26 08:53:21 sanvuon volumio[1227]: info: Loading plugin "services"...
Sep 26 08:53:21 sanvuon sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:21 sanvuon volumio[1227]: info: Loading plugin "alsa_controller"...
Sep 26 08:53:21 sanvuon sudo[1291]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:21 sanvuon sudo[1294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 26 08:53:21 sanvuon sudo[1294]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:21 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 26 08:53:21 sanvuon volumio[1227]: info: Loading plugin "wizard"...
Sep 26 08:53:21 sanvuon volumio[1227]: info: Loading plugin "networkfs"...
Sep 26 08:53:21 sanvuon volumio[1227]: info: Starting Udev Watcher for removable devices
Sep 26 08:53:21 sanvuon volumio[1227]: info: Ignoring mount for partition: boot
Sep 26 08:53:21 sanvuon volumio[1227]: info: Ignoring mount for partition: volumio
Sep 26 08:53:21 sanvuon volumio[1227]: info: Ignoring mount for partition: volumio_data
Sep 26 08:53:21 sanvuon volumio[1227]: info: Mounting Device Unisstant
Sep 26 08:53:21 sanvuon sudo[1303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Unisstant -o noatime
Sep 26 08:53:21 sanvuon sudo[1303]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:21 sanvuon sudo[1303]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:21 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 26 08:53:21 sanvuon volumio[1227]: info: Loading plugin "volumio_command_line_client"...
Sep 26 08:53:21 sanvuon volumio[1227]: info: Plugin upnp is not enabled
Sep 26 08:53:21 sanvuon volumio[1227]: info: Loading plugin "my_music"...
Sep 26 08:53:21 sanvuon volumio[1227]: info: Loading plugin "mpd"...
Sep 26 08:53:22 sanvuon volumio[1227]: info: Loading plugin "upnp_browser"...
Sep 26 08:53:22 sanvuon volumio[1227]: info: Loading plugin "alarm-clock"...
Sep 26 08:53:22 sanvuon volumio[1227]: info: Loading plugin "airplay_emulation"...
Sep 26 08:53:22 sanvuon volumio[1227]: info: Starting Shairport Sync
Sep 26 08:53:22 sanvuon volumio[1227]: info: Loading plugin "last_100"...
Sep 26 08:53:22 sanvuon volumio[1227]: info: Loading plugin "webradio"...
Sep 26 08:53:22 sanvuon volumio[1227]: info: Loading plugin "i2s_dacs"...
Sep 26 08:53:22 sanvuon volumio[1227]: info: I2S DAC not set, start Auto-detection
Sep 26 08:53:22 sanvuon volumio[1227]: info: Loading plugin "volumiodiscovery"...
Sep 26 08:53:22 sanvuon volumio[1227]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:22 sanvuon volumio[1227]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:22 sanvuon node[1227]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:22 sanvuon volumio[1227]: *** WARNING *** For more information see
Sep 26 08:53:22 sanvuon volumio[1227]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:22 sanvuon volumio[1227]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:22 sanvuon volumio[1227]: *** WARNING *** For more information see
Sep 26 08:53:22 sanvuon node[1227]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:22 sanvuon node[1227]: *** WARNING *** For more information see
Sep 26 08:53:22 sanvuon node[1227]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:22 sanvuon node[1227]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:22 sanvuon node[1227]: *** WARNING *** For more information see
Sep 26 08:53:22 sanvuon volumio[1227]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 26 08:53:22 sanvuon volumio[1227]: info: Discovery: Started advertising with name: SanVuon
Sep 26 08:53:22 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 26 08:53:22 sanvuon volumio[1227]: info: Loading plugin "youtube2"...
Sep 26 08:53:23 sanvuon volumio[1227]: info: Loading plugin "outputs"...
Sep 26 08:53:23 sanvuon volumio[1227]: info: Loading plugin "albumart"...
Sep 26 08:53:23 sanvuon volumio[1227]: info: Plugin example_plugin is not enabled
Sep 26 08:53:23 sanvuon volumio[1227]: info: Loading plugin "inputs"...
Sep 26 08:53:23 sanvuon volumio[1227]: info: Loading plugin "updater_comm"...
Sep 26 08:53:23 sanvuon volumio[1227]: info: Plugin mpdemulation is not enabled
Sep 26 08:53:23 sanvuon volumio[1227]: info: Loading plugin "rest_api"...
Sep 26 08:53:23 sanvuon volumio[1227]: info: Loading plugin "websocket"...
Sep 26 08:53:23 sanvuon volumio[1227]: info: Loading i18n strings for locale vi
Sep 26 08:53:23 sanvuon volumio[1227]: Updating browse sources language
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 26 08:53:23 sanvuon sudo[1294]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::initPlayerControls
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: Forking 3 albumart workers
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: Express server listening on port 3000
Sep 26 08:53:23 sanvuon volumio[1227]: [Metrics] WebUI: 3s 510.79ms
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreStateMachine::resetVolumioState
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreStateMachine::getcurrentVolume
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::volumioRetrievevolume
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 26 08:53:23 sanvuon volumio[1227]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 1
Sep 26 08:53:23 sanvuon volumio[1227]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 2
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreStateMachine::pushState
Sep 26 08:53:23 sanvuon volumio[1227]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreStateMachine::updateTrackBlock
Sep 26 08:53:23 sanvuon volumio[1227]: info: CorePlayQueue::getTrackBlock
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::volumioRetrievevolume
Sep 26 08:53:23 sanvuon volumio[1227]: info: Reloading queue from file
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreStateMachine::setRepeat true single undefined
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreStateMachine::pushState
Sep 26 08:53:23 sanvuon volumio[1227]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreStateMachine::setRandom false
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreStateMachine::pushState
Sep 26 08:53:23 sanvuon volumio[1227]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:23 sanvuon volumio[1227]: info: Setting Device type: Raspberry PI
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreStateMachine::pushState
Sep 26 08:53:23 sanvuon volumio[1227]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:23 sanvuon volumio[1227]: info: Discovery: adding 4af831ec-95a5-401d-ab45-640a06f62c01
Sep 26 08:53:23 sanvuon volumio[1227]: info: Discovery: Found device SanVuon
Sep 26 08:53:23 sanvuon volumio[1227]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:23 sanvuon volumio[1227]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:23 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:23] [connect] Successful connection
Sep 26 08:53:23 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1727315603 101
Sep 26 08:53:23 sanvuon volumio[1227]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3
Sep 26 08:53:24 sanvuon volumio[1227]: Starting albumart workers
Sep 26 08:53:24 sanvuon volumio[1227]: Starting albumart workers
Sep 26 08:53:24 sanvuon volumio[1227]: Starting albumart workers
Sep 26 08:53:25 sanvuon volumio[1227]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 4
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:25 sanvuon volumio[1227]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 26 08:53:25 sanvuon volumio[1227]: info: Received Get System Info
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 26 08:53:25 sanvuon volumio[1227]: info: Discovery: Getting this device information
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:25 sanvuon volumio[1227]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 26 08:53:25 sanvuon volumio[1227]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:25 sanvuon volumio[1227]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:25 sanvuon volumio[1227]: info: Listing playlists
Sep 26 08:53:26 sanvuon ntpd[713]: Soliciting pool server 203.113.174.44
Sep 26 08:53:27 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:53:27 sanvuon volumio[1227]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:27 sanvuon volumio[1227]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:27 sanvuon volumio[1227]: info: Listing playlists
Sep 26 08:53:27 sanvuon volumio[1227]: info: Listing playlists
Sep 26 08:53:28 sanvuon ntpd[713]: Soliciting pool server 203.113.174.44
Sep 26 08:53:30 sanvuon volumio[1227]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Sep 26 08:53:30 sanvuon volumio[1227]: verbose: ControllerMpd::sendMpdCommand rescan
Sep 26 08:53:30 sanvuon volumio[1227]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:53:30 sanvuon volumio[1227]: TypeError: Cannot read property 'then' of undefined
Sep 26 08:53:30 sanvuon volumio[1227]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
Sep 26 08:53:30 sanvuon volumio[1227]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15)
Sep 26 08:53:30 sanvuon volumio[1227]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Sep 26 08:53:30 sanvuon volumio[1227]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26)
Sep 26 08:53:30 sanvuon volumio[1227]: at Socket.emit (events.js:315:20)
Sep 26 08:53:30 sanvuon volumio[1227]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Sep 26 08:53:30 sanvuon volumio[1227]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Sep 26 08:53:30 sanvuon volumio[1227]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:53:30 sanvuon ntpd[713]: Soliciting pool server 203.113.174.44
Sep 26 08:53:30 sanvuon sudo[1390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-26 08:52
Sep 26 08:53:30 sanvuon sudo[1390]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:30 sanvuon sudo[1390]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:31 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:31] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 26 08:53:31 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:31] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 26 08:53:31 sanvuon systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 26 08:53:31 sanvuon systemd[1]: media-Unisstant.mount: Succeeded.
Sep 26 08:53:31 sanvuon systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 26 08:53:31 sanvuon systemd[1]: Started dynamicswap service.
Sep 26 08:53:31 sanvuon systemd[1]: dynamicswap.service: Succeeded.
Sep 26 08:53:31 sanvuon systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 26 08:53:31 sanvuon systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3.
Sep 26 08:53:31 sanvuon systemd[1]: Started dynamicswap service.
Sep 26 08:53:31 sanvuon systemd[1]: Stopped Volumio Backend Module.
Sep 26 08:53:31 sanvuon systemd[1]: Started Volumio Backend Module.
Sep 26 08:53:31 sanvuon systemd[1]: dynamicswap.service: Succeeded.
Sep 26 08:53:31 sanvuon ntpd[713]: Soliciting pool server 203.113.174.44
Sep 26 08:53:32 sanvuon volumio[1402]: info: -------------------------------------------
Sep 26 08:53:32 sanvuon volumio[1402]: info: ----- Volumio3 ----
Sep 26 08:53:32 sanvuon volumio[1402]: info: -------------------------------------------
Sep 26 08:53:32 sanvuon volumio[1402]: info: ----- System startup ----
Sep 26 08:53:32 sanvuon volumio[1402]: info: -------------------------------------------
Sep 26 08:53:32 sanvuon volumio[1402]: info: MYVOLUMIO Environment detected
Sep 26 08:53:32 sanvuon volumio[1402]: info: Plugin folders cleanup
Sep 26 08:53:32 sanvuon volumio[1402]: info: Scanning into folder /volumio/app/plugins/
Sep 26 08:53:32 sanvuon volumio[1402]: info: Scanning category audio_interface
Sep 26 08:53:32 sanvuon volumio[1402]: info: Scanning category miscellanea
Sep 26 08:53:32 sanvuon volumio[1402]: info: Scanning category music_service
Sep 26 08:53:32 sanvuon volumio[1402]: info: Scanning category plugins.json
Sep 26 08:53:32 sanvuon volumio[1402]: info: Scanning category system_controller
Sep 26 08:53:32 sanvuon volumio[1402]: info: Scanning category user_interface
Sep 26 08:53:32 sanvuon volumio[1402]: info: Scanning into folder /data/plugins/
Sep 26 08:53:32 sanvuon volumio[1402]: info: Scanning category music_service
Sep 26 08:53:32 sanvuon volumio[1402]: info: Plugin folders cleanup completed
Sep 26 08:53:32 sanvuon volumio[1402]: info: -------------------------------------------
Sep 26 08:53:32 sanvuon volumio[1402]: info: ----- Core plugins startup ----
Sep 26 08:53:32 sanvuon volumio[1402]: info: -------------------------------------------
Sep 26 08:53:32 sanvuon volumio[1402]: info: Loading plugins from folder /volumio/app/plugins/
Sep 26 08:53:32 sanvuon volumio[1402]: info: Adding plugin upnp to MyMusic Plugins
Sep 26 08:53:32 sanvuon volumio[1402]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 26 08:53:32 sanvuon volumio[1402]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 26 08:53:32 sanvuon volumio[1402]: info: Loading plugins from folder /data/plugins/
Sep 26 08:53:32 sanvuon volumio[1402]: info: Loading plugin "system"...
Sep 26 08:53:32 sanvuon volumio[1402]: info: Loading plugin "appearance"...
Sep 26 08:53:33 sanvuon volumio[1402]: info: Loading plugin "network"...
Sep 26 08:53:33 sanvuon volumio[1402]: info: Refreshing Cached IP Addresses
Sep 26 08:53:33 sanvuon sudo[1428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 26 08:53:33 sanvuon sudo[1428]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:33 sanvuon sudo[1428]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:33 sanvuon sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 26 08:53:33 sanvuon volumio[1402]: info: Loading plugin "services"...
Sep 26 08:53:33 sanvuon sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:33 sanvuon volumio[1402]: info: Loading plugin "alsa_controller"...
Sep 26 08:53:33 sanvuon sudo[1430]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:33 sanvuon sudo[1433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 26 08:53:33 sanvuon sudo[1433]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:33 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 26 08:53:33 sanvuon volumio[1402]: info: Loading plugin "wizard"...
Sep 26 08:53:33 sanvuon volumio[1402]: info: Loading plugin "networkfs"...
Sep 26 08:53:33 sanvuon volumio[1402]: info: Starting Udev Watcher for removable devices
Sep 26 08:53:33 sanvuon volumio[1402]: info: Ignoring mount for partition: boot
Sep 26 08:53:33 sanvuon volumio[1402]: info: Ignoring mount for partition: volumio
Sep 26 08:53:33 sanvuon volumio[1402]: info: Ignoring mount for partition: volumio_data
Sep 26 08:53:33 sanvuon volumio[1402]: info: Mounting Device Unisstant
Sep 26 08:53:33 sanvuon sudo[1442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Unisstant -o noatime
Sep 26 08:53:33 sanvuon sudo[1442]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:33 sanvuon sudo[1442]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:33 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 26 08:53:33 sanvuon volumio[1402]: info: Loading plugin "volumio_command_line_client"...
Sep 26 08:53:33 sanvuon volumio[1402]: info: Plugin upnp is not enabled
Sep 26 08:53:33 sanvuon volumio[1402]: info: Loading plugin "my_music"...
Sep 26 08:53:33 sanvuon volumio[1402]: info: Loading plugin "mpd"...
Sep 26 08:53:33 sanvuon volumio[1402]: info: Loading plugin "upnp_browser"...
Sep 26 08:53:34 sanvuon volumio[1402]: info: Loading plugin "alarm-clock"...
Sep 26 08:53:34 sanvuon volumio[1402]: info: Loading plugin "airplay_emulation"...
Sep 26 08:53:34 sanvuon volumio[1402]: info: Starting Shairport Sync
Sep 26 08:53:34 sanvuon volumio[1402]: info: Loading plugin "last_100"...
Sep 26 08:53:34 sanvuon volumio[1402]: info: Loading plugin "webradio"...
Sep 26 08:53:34 sanvuon volumio[1402]: info: Loading plugin "i2s_dacs"...
Sep 26 08:53:34 sanvuon volumio[1402]: info: I2S DAC not set, start Auto-detection
Sep 26 08:53:34 sanvuon volumio[1402]: info: Loading plugin "volumiodiscovery"...
Sep 26 08:53:34 sanvuon volumio[1402]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:34 sanvuon volumio[1402]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:34 sanvuon node[1402]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:34 sanvuon volumio[1402]: *** WARNING *** For more information see
Sep 26 08:53:34 sanvuon volumio[1402]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:34 sanvuon volumio[1402]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:34 sanvuon volumio[1402]: *** WARNING *** For more information see
Sep 26 08:53:34 sanvuon node[1402]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:34 sanvuon node[1402]: *** WARNING *** For more information see
Sep 26 08:53:34 sanvuon node[1402]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:34 sanvuon node[1402]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:34 sanvuon node[1402]: *** WARNING *** For more information see
Sep 26 08:53:34 sanvuon volumio[1402]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 26 08:53:34 sanvuon volumio[1402]: info: Discovery: Started advertising with name: SanVuon
Sep 26 08:53:34 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 26 08:53:34 sanvuon volumio[1402]: info: Loading plugin "youtube2"...
Sep 26 08:53:34 sanvuon sudo[1433]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:35 sanvuon volumio[1402]: info: Loading plugin "outputs"...
Sep 26 08:53:35 sanvuon volumio[1402]: info: Loading plugin "albumart"...
Sep 26 08:53:35 sanvuon volumio[1402]: info: Plugin example_plugin is not enabled
Sep 26 08:53:35 sanvuon volumio[1402]: info: Loading plugin "inputs"...
Sep 26 08:53:35 sanvuon volumio[1402]: info: Loading plugin "updater_comm"...
Sep 26 08:53:35 sanvuon volumio[1402]: info: Plugin mpdemulation is not enabled
Sep 26 08:53:35 sanvuon volumio[1402]: info: Loading plugin "rest_api"...
Sep 26 08:53:35 sanvuon volumio[1402]: info: Loading plugin "websocket"...
Sep 26 08:53:35 sanvuon volumio[1402]: info: Loading i18n strings for locale vi
Sep 26 08:53:35 sanvuon volumio[1402]: Updating browse sources language
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::initPlayerControls
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: Express server listening on port 3000
Sep 26 08:53:35 sanvuon volumio[1402]: [Metrics] WebUI: 3s 149.90ms
Sep 26 08:53:35 sanvuon volumio[1402]: Forking 3 albumart workers
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreStateMachine::resetVolumioState
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreStateMachine::getcurrentVolume
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::volumioRetrievevolume
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 26 08:53:35 sanvuon volumio[1402]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 1
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreStateMachine::pushState
Sep 26 08:53:35 sanvuon volumio[1402]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreStateMachine::updateTrackBlock
Sep 26 08:53:35 sanvuon volumio[1402]: info: CorePlayQueue::getTrackBlock
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::volumioRetrievevolume
Sep 26 08:53:35 sanvuon volumio[1402]: info: Reloading queue from file
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreStateMachine::setRepeat true single undefined
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreStateMachine::pushState
Sep 26 08:53:35 sanvuon volumio[1402]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreStateMachine::setRandom false
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreStateMachine::pushState
Sep 26 08:53:35 sanvuon volumio[1402]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:35 sanvuon volumio[1402]: info: Setting Device type: Raspberry PI
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreStateMachine::pushState
Sep 26 08:53:35 sanvuon volumio[1402]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:35 sanvuon volumio[1402]: info: Discovery: adding 4af831ec-95a5-401d-ab45-640a06f62c01
Sep 26 08:53:35 sanvuon volumio[1402]: info: Discovery: Found device SanVuon
Sep 26 08:53:35 sanvuon volumio[1402]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:35 sanvuon volumio[1402]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:35 sanvuon volumio[1402]: Starting albumart workers
Sep 26 08:53:35 sanvuon volumio[1402]: Starting albumart workers
Sep 26 08:53:35 sanvuon volumio[1402]: Starting albumart workers
Sep 26 08:53:36 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:36] [connect] Successful connection
Sep 26 08:53:36 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:36] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1727315616 101
Sep 26 08:53:36 sanvuon volumio[1402]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
Sep 26 08:53:37 sanvuon volumio[1402]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:37 sanvuon volumio[1402]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:38 sanvuon volumio[1402]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 3
Sep 26 08:53:38 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:39 sanvuon volumio[1402]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 26 08:53:39 sanvuon volumio[1402]: info: Received Get System Info
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 26 08:53:39 sanvuon volumio[1402]: info: Discovery: Getting this device information
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:39 sanvuon volumio[1402]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:39 sanvuon volumio[1402]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:39 sanvuon volumio[1402]: info: Listing playlists
Sep 26 08:53:39 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:53:44 sanvuon volumio[1402]: info: CoreCommandRouter::volumioGetQueue
Sep 26 08:53:44 sanvuon volumio[1402]: info: CoreStateMachine::getQueue
Sep 26 08:53:44 sanvuon volumio[1402]: info: CorePlayQueue::getQueue
Sep 26 08:53:45 sanvuon volumio[1402]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Sep 26 08:53:45 sanvuon volumio[1402]: info: CURURI: albums://
Sep 26 08:53:45 sanvuon volumio[1402]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:53:45 sanvuon volumio[1402]: TypeError: Cannot read property 'sendCommand' of undefined
Sep 26 08:53:45 sanvuon volumio[1402]: at /volumio/app/plugins/music_service/mpd/index.js:2986:22
Sep 26 08:53:45 sanvuon volumio[1402]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Sep 26 08:53:45 sanvuon volumio[1402]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:53:45 sanvuon sudo[1529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-26 08:52
Sep 26 08:53:45 sanvuon sudo[1529]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:45 sanvuon sudo[1529]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:47 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:47] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 26 08:53:47 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:47] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 26 08:53:47 sanvuon systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 26 08:53:47 sanvuon systemd[1]: media-Unisstant.mount: Succeeded.
Sep 26 08:53:47 sanvuon systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 26 08:53:47 sanvuon systemd[1]: Started dynamicswap service.
Sep 26 08:53:47 sanvuon systemd[1]: dynamicswap.service: Succeeded.
Sep 26 08:53:47 sanvuon systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 26 08:53:47 sanvuon systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4.
Sep 26 08:53:47 sanvuon systemd[1]: Started dynamicswap service.
Sep 26 08:53:47 sanvuon systemd[1]: Stopped Volumio Backend Module.
Sep 26 08:53:47 sanvuon systemd[1]: Started Volumio Backend Module.
Sep 26 08:53:47 sanvuon systemd[1]: dynamicswap.service: Succeeded.
Sep 26 08:53:48 sanvuon volumio[1544]: info: -------------------------------------------
Sep 26 08:53:48 sanvuon volumio[1544]: info: ----- Volumio3 ----
Sep 26 08:53:48 sanvuon volumio[1544]: info: -------------------------------------------
Sep 26 08:53:48 sanvuon volumio[1544]: info: ----- System startup ----
Sep 26 08:53:48 sanvuon volumio[1544]: info: -------------------------------------------
Sep 26 08:53:48 sanvuon volumio[1544]: info: MYVOLUMIO Environment detected
Sep 26 08:53:48 sanvuon volumio[1544]: info: Plugin folders cleanup
Sep 26 08:53:48 sanvuon volumio[1544]: info: Scanning into folder /volumio/app/plugins/
Sep 26 08:53:48 sanvuon volumio[1544]: info: Scanning category audio_interface
Sep 26 08:53:48 sanvuon volumio[1544]: info: Scanning category miscellanea
Sep 26 08:53:48 sanvuon volumio[1544]: info: Scanning category music_service
Sep 26 08:53:48 sanvuon volumio[1544]: info: Scanning category plugins.json
Sep 26 08:53:48 sanvuon volumio[1544]: info: Scanning category system_controller
Sep 26 08:53:48 sanvuon volumio[1544]: info: Scanning category user_interface
Sep 26 08:53:48 sanvuon volumio[1544]: info: Scanning into folder /data/plugins/
Sep 26 08:53:48 sanvuon volumio[1544]: info: Scanning category music_service
Sep 26 08:53:48 sanvuon volumio[1544]: info: Plugin folders cleanup completed
Sep 26 08:53:48 sanvuon volumio[1544]: info: -------------------------------------------
Sep 26 08:53:48 sanvuon volumio[1544]: info: ----- Core plugins startup ----
Sep 26 08:53:48 sanvuon volumio[1544]: info: -------------------------------------------
Sep 26 08:53:48 sanvuon volumio[1544]: info: Loading plugins from folder /volumio/app/plugins/
Sep 26 08:53:48 sanvuon volumio[1544]: info: Adding plugin upnp to MyMusic Plugins
Sep 26 08:53:48 sanvuon volumio[1544]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 26 08:53:48 sanvuon volumio[1544]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 26 08:53:48 sanvuon volumio[1544]: info: Loading plugins from folder /data/plugins/
Sep 26 08:53:48 sanvuon volumio[1544]: info: Loading plugin "system"...
Sep 26 08:53:48 sanvuon volumio[1544]: info: Loading plugin "appearance"...
Sep 26 08:53:49 sanvuon volumio[1544]: info: Loading plugin "network"...
Sep 26 08:53:49 sanvuon volumio[1544]: info: Refreshing Cached IP Addresses
Sep 26 08:53:49 sanvuon sudo[1570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 26 08:53:49 sanvuon sudo[1570]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:49 sanvuon sudo[1570]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:49 sanvuon sudo[1572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 26 08:53:49 sanvuon sudo[1572]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:49 sanvuon volumio[1544]: info: Loading plugin "services"...
Sep 26 08:53:49 sanvuon volumio[1544]: info: Loading plugin "alsa_controller"...
Sep 26 08:53:49 sanvuon sudo[1572]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:49 sanvuon sudo[1576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 26 08:53:49 sanvuon sudo[1576]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:49 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 26 08:53:49 sanvuon volumio[1544]: info: Loading plugin "wizard"...
Sep 26 08:53:49 sanvuon volumio[1544]: info: Loading plugin "networkfs"...
Sep 26 08:53:49 sanvuon volumio[1544]: info: Starting Udev Watcher for removable devices
Sep 26 08:53:49 sanvuon volumio[1544]: info: Ignoring mount for partition: boot
Sep 26 08:53:49 sanvuon volumio[1544]: info: Ignoring mount for partition: volumio
Sep 26 08:53:49 sanvuon volumio[1544]: info: Ignoring mount for partition: volumio_data
Sep 26 08:53:49 sanvuon volumio[1544]: info: Mounting Device Unisstant
Sep 26 08:53:49 sanvuon sudo[1584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Unisstant -o noatime
Sep 26 08:53:49 sanvuon sudo[1584]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 26 08:53:50 sanvuon sudo[1584]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:50 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "volumio_command_line_client"...
Sep 26 08:53:50 sanvuon volumio[1544]: info: Plugin upnp is not enabled
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "my_music"...
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "mpd"...
Sep 26 08:53:50 sanvuon sudo[1576]: pam_unix(sudo:session): session closed for user root
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "upnp_browser"...
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "alarm-clock"...
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "airplay_emulation"...
Sep 26 08:53:50 sanvuon volumio[1544]: info: Starting Shairport Sync
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "last_100"...
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "webradio"...
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "i2s_dacs"...
Sep 26 08:53:50 sanvuon volumio[1544]: info: I2S DAC not set, start Auto-detection
Sep 26 08:53:50 sanvuon volumio[1544]: info: Loading plugin "volumiodiscovery"...
Sep 26 08:53:51 sanvuon volumio[1544]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:51 sanvuon volumio[1544]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:51 sanvuon node[1544]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:51 sanvuon volumio[1544]: *** WARNING *** For more information see
Sep 26 08:53:51 sanvuon volumio[1544]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:51 sanvuon volumio[1544]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:51 sanvuon volumio[1544]: *** WARNING *** For more information see
Sep 26 08:53:51 sanvuon node[1544]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:51 sanvuon node[1544]: *** WARNING *** For more information see
Sep 26 08:53:51 sanvuon node[1544]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 26 08:53:51 sanvuon node[1544]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 26 08:53:51 sanvuon node[1544]: *** WARNING *** For more information see
Sep 26 08:53:51 sanvuon volumio[1544]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 26 08:53:51 sanvuon volumio[1544]: info: Discovery: Started advertising with name: SanVuon
Sep 26 08:53:51 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 26 08:53:51 sanvuon volumio[1544]: info: Loading plugin "youtube2"...
Sep 26 08:53:51 sanvuon volumio[1544]: info: Loading plugin "outputs"...
Sep 26 08:53:51 sanvuon volumio[1544]: info: Loading plugin "albumart"...
Sep 26 08:53:51 sanvuon volumio[1544]: info: Plugin example_plugin is not enabled
Sep 26 08:53:51 sanvuon volumio[1544]: info: Loading plugin "inputs"...
Sep 26 08:53:51 sanvuon volumio[1544]: info: Loading plugin "updater_comm"...
Sep 26 08:53:51 sanvuon volumio[1544]: info: Plugin mpdemulation is not enabled
Sep 26 08:53:51 sanvuon volumio[1544]: info: Loading plugin "rest_api"...
Sep 26 08:53:51 sanvuon volumio[1544]: info: Loading plugin "websocket"...
Sep 26 08:53:51 sanvuon volumio[1544]: info: Loading i18n strings for locale vi
Sep 26 08:53:51 sanvuon volumio[1544]: Updating browse sources language
Sep 26 08:53:51 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 26 08:53:51 sanvuon volumio[1544]: Forking 3 albumart workers
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::initPlayerControls
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: Express server listening on port 3000
Sep 26 08:53:52 sanvuon volumio[1544]: [Metrics] WebUI: 4s 6.55ms
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreStateMachine::resetVolumioState
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreStateMachine::getcurrentVolume
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::volumioRetrievevolume
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 26 08:53:52 sanvuon volumio[1544]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 1
Sep 26 08:53:52 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:52] [connect] Successful connection
Sep 26 08:53:52 sanvuon volumio[1544]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 2
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreStateMachine::pushState
Sep 26 08:53:52 sanvuon volumio[1544]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreStateMachine::updateTrackBlock
Sep 26 08:53:52 sanvuon volumio[1544]: info: CorePlayQueue::getTrackBlock
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::volumioRetrievevolume
Sep 26 08:53:52 sanvuon volumio[1544]: info: Reloading queue from file
Sep 26 08:53:52 sanvuon volumio-remote-updater[548]: [2024-09-26 08:53:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1727315632 101
Sep 26 08:53:52 sanvuon volumio[1544]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreStateMachine::setRepeat true single undefined
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreStateMachine::pushState
Sep 26 08:53:52 sanvuon volumio[1544]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreStateMachine::setRandom false
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreStateMachine::pushState
Sep 26 08:53:52 sanvuon volumio[1544]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:52 sanvuon volumio[1544]: info: Setting Device type: Raspberry PI
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreStateMachine::pushState
Sep 26 08:53:52 sanvuon volumio[1544]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::volumioPushState
Sep 26 08:53:52 sanvuon volumio[1544]: info: Discovery: adding 4af831ec-95a5-401d-ab45-640a06f62c01
Sep 26 08:53:52 sanvuon volumio[1544]: info: Discovery: Found device SanVuon
Sep 26 08:53:52 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:52 sanvuon volumio[1544]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:52 sanvuon volumio[1544]: Starting albumart workers
Sep 26 08:53:52 sanvuon volumio[1544]: Starting albumart workers
Sep 26 08:53:52 sanvuon volumio[1544]: Starting albumart workers
Sep 26 08:53:55 sanvuon volumio[1544]: verbose: New Socket.io Connection to 192.168.100.163 from 192.168.100.8 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Mobile Safari/537.36 Total Clients: 4
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:55 sanvuon volumio[1544]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 26 08:53:55 sanvuon volumio[1544]: info: Received Get System Info
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 26 08:53:55 sanvuon volumio[1544]: info: Discovery: Getting this device information
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:55 sanvuon volumio[1544]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:55 sanvuon volumio[1544]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:55 sanvuon volumio[1544]: info: Listing playlists
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetQueue
Sep 26 08:53:55 sanvuon volumio[1544]: info: CoreStateMachine::getQueue
Sep 26 08:53:55 sanvuon volumio[1544]: info: CorePlayQueue::getQueue
Sep 26 08:53:57 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetState
Sep 26 08:53:57 sanvuon volumio[1544]: info: CorePlayQueue::getTrack 0
Sep 26 08:53:57 sanvuon volumio[1544]: info: Listing playlists
Sep 26 08:53:57 sanvuon volumio[1544]: info: Listing playlists
Sep 26 08:53:59 sanvuon wpa_supplicant[802]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="EliteHouses"
Sep 26 08:53:59 sanvuon wpa_supplicant[802]: wlan0: Trying to associate with SSID 'EliteHouses'
Sep 26 08:54:00 sanvuon wpa_supplicant[802]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16
Sep 26 08:54:00 sanvuon wpa_supplicant[802]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="EliteHouses" auth_failures=4 duration=77 reason=CONN_FAILED
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 26 08:54:03 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 26 08:54:05 sanvuon volumio[1544]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Sep 26 08:54:05 sanvuon volumio[1544]: verbose: ControllerMpd::sendMpdCommand update
Sep 26 08:54:05 sanvuon volumio[1544]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:54:05 sanvuon volumio[1544]: TypeError: Cannot read property 'then' of undefined
Sep 26 08:54:05 sanvuon volumio[1544]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
Sep 26 08:54:05 sanvuon volumio[1544]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1898:15)
Sep 26 08:54:05 sanvuon volumio[1544]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Sep 26 08:54:05 sanvuon volumio[1544]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26)
Sep 26 08:54:05 sanvuon volumio[1544]: at Socket.emit (events.js:315:20)
Sep 26 08:54:05 sanvuon volumio[1544]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Sep 26 08:54:05 sanvuon volumio[1544]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Sep 26 08:54:05 sanvuon volumio[1544]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 26 08:54:05 sanvuon sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-26 08:53
Sep 26 08:54:05 sanvuon sudo[1671]: 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"