-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Sun 2024-04-21 09:28:41 +07. --
Apr 21 09:27:00 music volumio[1262]: info: Discovery: Getting this device information
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:00 music volumio[1262]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:00 music volumio[1262]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:00 music volumio[1262]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 21 09:27:00 music volumio[1262]: info: Received Get System Info
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:27:00 music volumio[1262]: info: Discovery: Getting this device information
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:00 music volumio[1262]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:00 music volumio[1262]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:00 music volumio[1262]: info: Listing playlists
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:00 music volumio[1262]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:01 music wpa_supplicant[771]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16
Apr 21 09:27:01 music wpa_supplicant[771]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="KEN STUDIO" auth_failures=2 duration=23 reason=CONN_FAILED
Apr 21 09:27:02 music ntpd[679]: Soliciting pool server 203.113.174.44
Apr 21 09:27:02 music ntpd[679]: Soliciting pool server 203.113.174.44
Apr 21 09:27:02 music ntpd[679]: Soliciting pool server 203.113.174.44
Apr 21 09:27:03 music ntpd[679]: Soliciting pool server 103.130.217.41
Apr 21 09:27:03 music ntpd[679]: Soliciting pool server 103.130.217.41
Apr 21 09:27:04 music ntpd[679]: Soliciting pool server 2406:2000:e4:a1f::1000
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:27:04 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 21 09:27:07 music sudo[1376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 21 09:27:07 music sudo[1376]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:07 music sudo[1376]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:07 music sudo[1379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 21 09:27:07 music sudo[1379]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:07 music sudo[1379]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:07 music sudo[1382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 21 09:27:07 music sudo[1382]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:07 music sudo[1382]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:07 music volumio[1262]: info: Upmpdcli Daemon Started
Apr 21 09:27:08 music volumio[1262]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:08 music volumio[1262]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:08 music volumio[1262]: info: Listing playlists
Apr 21 09:27:08 music volumio[1262]: info: Listing playlists
Apr 21 09:27:08 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:27:09 music volumio[1262]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 21 09:27:10 music volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Apr 21 09:27:10 music volumio[1262]: verbose: ControllerMpd::sendMpdCommand rescan
Apr 21 09:27:10 music volumio[1262]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:27:10 music volumio[1262]: TypeError: Cannot read property 'then' of undefined
Apr 21 09:27:10 music volumio[1262]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
Apr 21 09:27:10 music volumio[1262]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15)
Apr 21 09:27:10 music volumio[1262]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Apr 21 09:27:10 music volumio[1262]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26)
Apr 21 09:27:10 music volumio[1262]: at Socket.emit (events.js:315:20)
Apr 21 09:27:10 music volumio[1262]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 21 09:27:10 music volumio[1262]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 21 09:27:10 music volumio[1262]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:27:10 music sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 09:26
Apr 21 09:27:10 music sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:10 music sudo[1393]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:10 music volumio-remote-updater[525]: [2024-04-21 09:27:10] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 21 09:27:10 music volumio-remote-updater[525]: [2024-04-21 09:27:10] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 21 09:27:10 music systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 21 09:27:10 music systemd[1]: media-LOCAL.mount: Succeeded.
Apr 21 09:27:10 music systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 21 09:27:10 music systemd[1]: Started dynamicswap service.
Apr 21 09:27:10 music systemd[1]: dynamicswap.service: Succeeded.
Apr 21 09:27:10 music systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 21 09:27:10 music systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3.
Apr 21 09:27:10 music systemd[1]: Stopped Volumio Backend Module.
Apr 21 09:27:10 music systemd[1]: Started Volumio Backend Module.
Apr 21 09:27:10 music systemd[1]: Started dynamicswap service.
Apr 21 09:27:10 music systemd[1]: dynamicswap.service: Succeeded.
Apr 21 09:27:34 music ntpd[679]: receive: Unexpected origin timestamp 0xe9cef7ff.29e86bf3 does not match aorg 0000000000.00000000 from server@203.113.174.44 xmt 0xe9cef816.5b83563c
Apr 21 09:27:35 music volumio[1405]: info: -------------------------------------------
Apr 21 09:27:35 music volumio[1405]: info: ----- Volumio3 ----
Apr 21 09:27:35 music volumio[1405]: info: -------------------------------------------
Apr 21 09:27:35 music volumio[1405]: info: ----- System startup ----
Apr 21 09:27:35 music volumio[1405]: info: -------------------------------------------
Apr 21 09:27:35 music volumio[1405]: info: MYVOLUMIO Environment detected
Apr 21 09:27:35 music volumio[1405]: info: Plugin folders cleanup
Apr 21 09:27:35 music volumio[1405]: info: Scanning into folder /volumio/app/plugins/
Apr 21 09:27:35 music volumio[1405]: info: Scanning category audio_interface
Apr 21 09:27:35 music volumio[1405]: info: Scanning category miscellanea
Apr 21 09:27:35 music volumio[1405]: info: Scanning category music_service
Apr 21 09:27:35 music volumio[1405]: info: Scanning category plugins.json
Apr 21 09:27:35 music volumio[1405]: info: Scanning category system_controller
Apr 21 09:27:35 music volumio[1405]: info: Scanning category user_interface
Apr 21 09:27:35 music volumio[1405]: info: Scanning into folder /data/plugins/
Apr 21 09:27:35 music volumio[1405]: info: Scanning category audio_interface
Apr 21 09:27:35 music volumio[1405]: info: Scanning category music_service
Apr 21 09:27:35 music volumio[1405]: info: Plugin folders cleanup completed
Apr 21 09:27:35 music volumio[1405]: info: -------------------------------------------
Apr 21 09:27:35 music volumio[1405]: info: ----- Core plugins startup ----
Apr 21 09:27:35 music volumio[1405]: info: -------------------------------------------
Apr 21 09:27:35 music volumio[1405]: info: Loading plugins from folder /volumio/app/plugins/
Apr 21 09:27:35 music volumio[1405]: info: Adding plugin upnp to MyMusic Plugins
Apr 21 09:27:35 music volumio[1405]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 21 09:27:35 music volumio[1405]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 21 09:27:35 music volumio[1405]: info: Loading plugins from folder /data/plugins/
Apr 21 09:27:35 music volumio[1405]: info: Loading plugin "system"...
Apr 21 09:27:35 music volumio[1405]: info: Loading plugin "appearance"...
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "network"...
Apr 21 09:27:36 music volumio[1405]: info: Refreshing Cached IP Addresses
Apr 21 09:27:36 music sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 21 09:27:36 music sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:36 music sudo[1432]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:36 music sudo[1434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "services"...
Apr 21 09:27:36 music sudo[1434]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "alsa_controller"...
Apr 21 09:27:36 music sudo[1434]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:36 music sudo[1437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 21 09:27:36 music sudo[1437]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:36 music sudo[1437]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:36 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "wizard"...
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "networkfs"...
Apr 21 09:27:36 music volumio[1405]: info: Starting Udev Watcher for removable devices
Apr 21 09:27:36 music volumio[1405]: info: Ignoring mount for partition: boot
Apr 21 09:27:36 music volumio[1405]: info: Ignoring mount for partition: volumio
Apr 21 09:27:36 music volumio[1405]: info: Ignoring mount for partition: volumio_data
Apr 21 09:27:36 music volumio[1405]: info: Mounting Device LOCAL
Apr 21 09:27:36 music sudo[1448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/LOCAL -o noatime
Apr 21 09:27:36 music sudo[1448]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:36 music sudo[1448]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:36 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "volumio_command_line_client"...
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "upnp"...
Apr 21 09:27:36 music volumio[1405]: info: [1713666456356] Starting Upmpd Daemon
Apr 21 09:27:36 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "my_music"...
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "mpd"...
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "upnp_browser"...
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "alarm-clock"...
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "airplay_emulation"...
Apr 21 09:27:36 music volumio[1405]: info: Starting Shairport Sync
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "last_100"...
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "webradio"...
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "i2s_dacs"...
Apr 21 09:27:36 music volumio[1405]: info: I2S DAC not set, start Auto-detection
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "volumiodiscovery"...
Apr 21 09:27:36 music volumio[1405]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:27:36 music volumio[1405]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:27:36 music node[1405]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:27:36 music volumio[1405]: *** WARNING *** For more information see
Apr 21 09:27:36 music volumio[1405]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:27:36 music volumio[1405]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:27:36 music volumio[1405]: *** WARNING *** For more information see
Apr 21 09:27:36 music node[1405]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:27:36 music node[1405]: *** WARNING *** For more information see
Apr 21 09:27:36 music node[1405]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:27:36 music node[1405]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:27:36 music node[1405]: *** WARNING *** For more information see
Apr 21 09:27:36 music volumio[1405]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 21 09:27:36 music volumio[1405]: info: Discovery: Started advertising with name: Music
Apr 21 09:27:36 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:27:36 music volumio[1405]: info: Loading plugin "youtube2"...
Apr 21 09:27:37 music volumio[1405]: info: Loading plugin "outputs"...
Apr 21 09:27:37 music volumio[1405]: info: Loading plugin "albumart"...
Apr 21 09:27:37 music volumio[1405]: info: Plugin example_plugin is not enabled
Apr 21 09:27:37 music volumio[1405]: info: Loading plugin "inputs"...
Apr 21 09:27:37 music volumio[1405]: info: Loading plugin "updater_comm"...
Apr 21 09:27:37 music volumio[1405]: info: Plugin mpdemulation is not enabled
Apr 21 09:27:37 music volumio[1405]: info: Loading plugin "rest_api"...
Apr 21 09:27:37 music volumio[1405]: info: Loading plugin "websocket"...
Apr 21 09:27:37 music volumio[1405]: info: Loading plugin "fusiondsp"...
Apr 21 09:27:37 music volumio[1405]: Forking 3 albumart workers
Apr 21 09:27:37 music volumio[1405]: info: Applying required configuration parameters for plugin fusiondsp
Apr 21 09:27:38 music volumio[1405]: info: Loading i18n strings for locale en
Apr 21 09:27:38 music volumio[1405]: Updating browse sources language
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::initPlayerControls
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:38 music volumio[1405]: Express server listening on port 3000
Apr 21 09:27:38 music volumio[1405]: [Metrics] WebUI: 3s 587.18ms
Apr 21 09:27:38 music volumio[1405]: info: CoreStateMachine::resetVolumioState
Apr 21 09:27:38 music volumio[1405]: info: CoreStateMachine::getcurrentVolume
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::volumioRetrievevolume
Apr 21 09:27:38 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 21 09:27:38 music volumio[1405]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 21 09:27:38 music volumio[1405]: wlan0 Interface doesn't support scanning : Device or resource busy
Apr 21 09:27:38 music volumio[1405]: info: Cannot use regular scanning, forcing with ap-force
Apr 21 09:27:38 music sudo[1487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 21 09:27:38 music sudo[1487]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:38 music volumio[1405]: Starting albumart workers
Apr 21 09:27:38 music volumio[1405]: Starting albumart workers
Apr 21 09:27:38 music volumio[1405]: Starting albumart workers
Apr 21 09:27:38 music volumio-remote-updater[525]: [2024-04-21 09:27:38] [connect] Successful connection
Apr 21 09:27:41 music sudo[1487]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:41 music volumio[1405]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 1
Apr 21 09:27:41 music volumio[1405]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 2
Apr 21 09:27:41 music volumio[1405]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 3
Apr 21 09:27:41 music volumio[1405]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 4
Apr 21 09:27:41 music volumio[1405]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 5
Apr 21 09:27:41 music volumio[1405]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 6
Apr 21 09:27:41 music volumio-remote-updater[525]: [2024-04-21 09:27:41] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713666458 101
Apr 21 09:27:41 music volumio[1405]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 7
Apr 21 09:27:41 music volumio[1405]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 8
Apr 21 09:27:41 music volumio[1405]: info: Reloading queue from file
Apr 21 09:27:41 music volumio[1405]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 9
Apr 21 09:27:41 music volumio[1405]: info: VolumeController:: Volume=22 Mute =false
Apr 21 09:27:41 music volumio[1405]: info: CoreStateMachine::pushState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioPushState
Apr 21 09:27:41 music volumio[1405]: info: CoreStateMachine::updateTrackBlock
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrackBlock
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioRetrievevolume
Apr 21 09:27:41 music volumio[1405]: info: CoreStateMachine::setRepeat null single undefined
Apr 21 09:27:41 music volumio[1405]: info: CoreStateMachine::pushState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioPushState
Apr 21 09:27:41 music volumio[1405]: info: CoreStateMachine::setRandom true
Apr 21 09:27:41 music volumio[1405]: info: CoreStateMachine::pushState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioPushState
Apr 21 09:27:41 music volumio[1405]: info: Setting Device type: Raspberry PI
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: Discovery: adding 388ef808-04e9-471f-96d1-76b43e21db8f
Apr 21 09:27:41 music volumio[1405]: info: Discovery: Found device Music
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: VolumeController:: Volume=22 Mute =false
Apr 21 09:27:41 music volumio[1405]: info: CoreStateMachine::pushState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioPushState
Apr 21 09:27:41 music volumio[1405]: info: Received Get System Info
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:27:41 music volumio[1405]: info: Discovery: Getting this device information
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 21 09:27:41 music volumio[1405]: info: Received Get System Info
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:27:41 music volumio[1405]: info: Discovery: Getting this device information
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:41 music volumio[1405]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:41 music volumio[1405]: info: Listing playlists
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:41 music volumio[1405]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:43 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:27:45 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 21 09:27:46 music sudo[1522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 21 09:27:46 music sudo[1522]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:46 music sudo[1522]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:46 music sudo[1525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 21 09:27:46 music sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:46 music sudo[1525]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:46 music sudo[1528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 21 09:27:46 music sudo[1528]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:46 music sudo[1528]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:46 music volumio[1405]: info: Upmpdcli Daemon Started
Apr 21 09:27:46 music volumio[1405]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Apr 21 09:27:46 music volumio[1405]: verbose: ControllerMpd::sendMpdCommand rescan
Apr 21 09:27:46 music volumio[1405]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:27:46 music volumio[1405]: TypeError: Cannot read property 'then' of undefined
Apr 21 09:27:46 music volumio[1405]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
Apr 21 09:27:46 music volumio[1405]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15)
Apr 21 09:27:46 music volumio[1405]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Apr 21 09:27:46 music volumio[1405]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26)
Apr 21 09:27:46 music volumio[1405]: at Socket.emit (events.js:315:20)
Apr 21 09:27:46 music volumio[1405]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 21 09:27:46 music volumio[1405]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 21 09:27:46 music volumio[1405]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:27:46 music sudo[1539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 09:26
Apr 21 09:27:46 music sudo[1539]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:46 music sudo[1539]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:46 music volumio-remote-updater[525]: [2024-04-21 09:27:46] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 21 09:27:46 music volumio-remote-updater[525]: [2024-04-21 09:27:46] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 21 09:27:46 music systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 21 09:27:46 music systemd[1]: media-LOCAL.mount: Succeeded.
Apr 21 09:27:46 music systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 21 09:27:47 music systemd[1]: Started dynamicswap service.
Apr 21 09:27:47 music systemd[1]: dynamicswap.service: Succeeded.
Apr 21 09:27:47 music systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 21 09:27:47 music systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4.
Apr 21 09:27:47 music systemd[1]: Stopped Volumio Backend Module.
Apr 21 09:27:47 music systemd[1]: Started Volumio Backend Module.
Apr 21 09:27:47 music systemd[1]: Started dynamicswap service.
Apr 21 09:27:47 music systemd[1]: dynamicswap.service: Succeeded.
Apr 21 09:27:48 music volumio[1550]: info: -------------------------------------------
Apr 21 09:27:48 music volumio[1550]: info: ----- Volumio3 ----
Apr 21 09:27:48 music volumio[1550]: info: -------------------------------------------
Apr 21 09:27:48 music volumio[1550]: info: ----- System startup ----
Apr 21 09:27:48 music volumio[1550]: info: -------------------------------------------
Apr 21 09:27:48 music volumio[1550]: info: MYVOLUMIO Environment detected
Apr 21 09:27:48 music volumio[1550]: info: Plugin folders cleanup
Apr 21 09:27:48 music volumio[1550]: info: Scanning into folder /volumio/app/plugins/
Apr 21 09:27:48 music volumio[1550]: info: Scanning category audio_interface
Apr 21 09:27:48 music volumio[1550]: info: Scanning category miscellanea
Apr 21 09:27:48 music volumio[1550]: info: Scanning category music_service
Apr 21 09:27:48 music volumio[1550]: info: Scanning category plugins.json
Apr 21 09:27:48 music volumio[1550]: info: Scanning category system_controller
Apr 21 09:27:48 music volumio[1550]: info: Scanning category user_interface
Apr 21 09:27:48 music volumio[1550]: info: Scanning into folder /data/plugins/
Apr 21 09:27:48 music volumio[1550]: info: Scanning category audio_interface
Apr 21 09:27:48 music volumio[1550]: info: Scanning category music_service
Apr 21 09:27:48 music volumio[1550]: info: Plugin folders cleanup completed
Apr 21 09:27:48 music volumio[1550]: info: -------------------------------------------
Apr 21 09:27:48 music volumio[1550]: info: ----- Core plugins startup ----
Apr 21 09:27:48 music volumio[1550]: info: -------------------------------------------
Apr 21 09:27:48 music volumio[1550]: info: Loading plugins from folder /volumio/app/plugins/
Apr 21 09:27:48 music volumio[1550]: info: Adding plugin upnp to MyMusic Plugins
Apr 21 09:27:48 music volumio[1550]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 21 09:27:48 music volumio[1550]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 21 09:27:48 music volumio[1550]: info: Loading plugins from folder /data/plugins/
Apr 21 09:27:48 music volumio[1550]: info: Loading plugin "system"...
Apr 21 09:27:48 music volumio[1550]: info: Loading plugin "appearance"...
Apr 21 09:27:49 music volumio[1550]: info: Loading plugin "network"...
Apr 21 09:27:49 music volumio[1550]: info: Refreshing Cached IP Addresses
Apr 21 09:27:49 music sudo[1577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 21 09:27:49 music sudo[1577]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:49 music sudo[1577]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:49 music sudo[1579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 21 09:27:49 music volumio[1550]: info: Loading plugin "services"...
Apr 21 09:27:49 music sudo[1579]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:49 music volumio[1550]: info: Loading plugin "alsa_controller"...
Apr 21 09:27:49 music sudo[1579]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:49 music sudo[1582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 21 09:27:49 music sudo[1582]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:49 music sudo[1582]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:49 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 21 09:27:49 music volumio[1550]: info: Loading plugin "wizard"...
Apr 21 09:27:49 music volumio[1550]: info: Loading plugin "networkfs"...
Apr 21 09:27:49 music volumio[1550]: info: Starting Udev Watcher for removable devices
Apr 21 09:27:49 music volumio[1550]: info: Ignoring mount for partition: boot
Apr 21 09:27:49 music volumio[1550]: info: Ignoring mount for partition: volumio
Apr 21 09:27:49 music volumio[1550]: info: Ignoring mount for partition: volumio_data
Apr 21 09:27:49 music volumio[1550]: info: Mounting Device LOCAL
Apr 21 09:27:49 music sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/LOCAL -o noatime
Apr 21 09:27:49 music sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:50 music sudo[1593]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:50 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "volumio_command_line_client"...
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "upnp"...
Apr 21 09:27:50 music volumio[1550]: info: [1713666470066] Starting Upmpd Daemon
Apr 21 09:27:50 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "my_music"...
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "mpd"...
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "upnp_browser"...
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "alarm-clock"...
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "airplay_emulation"...
Apr 21 09:27:50 music volumio[1550]: info: Starting Shairport Sync
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "last_100"...
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "webradio"...
Apr 21 09:27:50 music wpa_supplicant[771]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="KEN STUDIO"
Apr 21 09:27:50 music wpa_supplicant[771]: wlan0: Trying to associate with SSID 'KEN STUDIO'
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "i2s_dacs"...
Apr 21 09:27:50 music volumio[1550]: info: I2S DAC not set, start Auto-detection
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "volumiodiscovery"...
Apr 21 09:27:50 music volumio[1550]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:27:50 music volumio[1550]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:27:50 music node[1550]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:27:50 music volumio[1550]: *** WARNING *** For more information see
Apr 21 09:27:50 music volumio[1550]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:27:50 music volumio[1550]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:27:50 music volumio[1550]: *** WARNING *** For more information see
Apr 21 09:27:50 music node[1550]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:27:50 music node[1550]: *** WARNING *** For more information see
Apr 21 09:27:50 music node[1550]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:27:50 music node[1550]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:27:50 music node[1550]: *** WARNING *** For more information see
Apr 21 09:27:50 music volumio[1550]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 21 09:27:50 music volumio[1550]: info: Discovery: Started advertising with name: Music
Apr 21 09:27:50 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:27:50 music volumio[1550]: info: Loading plugin "youtube2"...
Apr 21 09:27:51 music volumio[1550]: info: Loading plugin "outputs"...
Apr 21 09:27:51 music volumio[1550]: info: Loading plugin "albumart"...
Apr 21 09:27:51 music volumio[1550]: info: Plugin example_plugin is not enabled
Apr 21 09:27:51 music volumio[1550]: info: Loading plugin "inputs"...
Apr 21 09:27:51 music volumio[1550]: info: Loading plugin "updater_comm"...
Apr 21 09:27:51 music volumio[1550]: info: Plugin mpdemulation is not enabled
Apr 21 09:27:51 music volumio[1550]: info: Loading plugin "rest_api"...
Apr 21 09:27:51 music volumio[1550]: info: Loading plugin "websocket"...
Apr 21 09:27:51 music volumio[1550]: info: Loading plugin "fusiondsp"...
Apr 21 09:27:51 music volumio[1550]: Forking 3 albumart workers
Apr 21 09:27:51 music volumio[1550]: info: Applying required configuration parameters for plugin fusiondsp
Apr 21 09:27:51 music volumio[1550]: info: Loading i18n strings for locale en
Apr 21 09:27:51 music volumio[1550]: Updating browse sources language
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::initPlayerControls
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:51 music volumio-remote-updater[525]: [2024-04-21 09:27:51] [connect] Successful connection
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:27:51 music volumio[1550]: Express server listening on port 3000
Apr 21 09:27:51 music volumio[1550]: [Metrics] WebUI: 3s 981.66ms
Apr 21 09:27:51 music volumio[1550]: info: CoreStateMachine::resetVolumioState
Apr 21 09:27:51 music volumio[1550]: info: CoreStateMachine::getcurrentVolume
Apr 21 09:27:51 music volumio[1550]: info: CoreCommandRouter::volumioRetrievevolume
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 21 09:27:52 music volumio[1550]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 21 09:27:52 music volumio[1550]: wlan0 Interface doesn't support scanning : Device or resource busy
Apr 21 09:27:52 music volumio[1550]: info: Cannot use regular scanning, forcing with ap-force
Apr 21 09:27:52 music sudo[1632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 21 09:27:52 music sudo[1632]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:52 music sudo[1632]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:52 music volumio[1550]: command failed: Resource temporarily unavailable (-11)
Apr 21 09:27:52 music volumio[1550]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 21 09:27:52 music volumio[1550]: command failed: Resource temporarily unavailable (-11)
Apr 21 09:27:52 music kernel: ieee80211 phy0: brcmf_cfg80211_scan: Connecting: status (3)
Apr 21 09:27:52 music volumio[1550]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 1
Apr 21 09:27:52 music volumio[1550]: Starting albumart workers
Apr 21 09:27:52 music volumio[1550]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 2
Apr 21 09:27:52 music volumio[1550]: Starting albumart workers
Apr 21 09:27:52 music volumio[1550]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 3
Apr 21 09:27:52 music volumio[1550]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 4
Apr 21 09:27:52 music volumio-remote-updater[525]: [2024-04-21 09:27:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713666471 101
Apr 21 09:27:52 music volumio[1550]: Starting albumart workers
Apr 21 09:27:52 music volumio[1550]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 5
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: Reloading queue from file
Apr 21 09:27:52 music volumio[1550]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 6
Apr 21 09:27:52 music volumio[1550]: info: CoreStateMachine::setRepeat null single undefined
Apr 21 09:27:52 music volumio[1550]: info: CoreStateMachine::pushState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioPushState
Apr 21 09:27:52 music volumio[1550]: info: CoreStateMachine::setRandom true
Apr 21 09:27:52 music volumio[1550]: info: CoreStateMachine::pushState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioPushState
Apr 21 09:27:52 music volumio[1550]: info: Setting Device type: Raspberry PI
Apr 21 09:27:52 music volumio[1550]: info: Listing playlists
Apr 21 09:27:52 music volumio[1550]: info: Listing playlists
Apr 21 09:27:52 music volumio[1550]: info: VolumeController:: Volume=22 Mute =false
Apr 21 09:27:52 music volumio[1550]: info: CoreStateMachine::pushState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioPushState
Apr 21 09:27:52 music volumio[1550]: info: CoreStateMachine::updateTrackBlock
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrackBlock
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioRetrievevolume
Apr 21 09:27:52 music volumio[1550]: info: Discovery: adding 388ef808-04e9-471f-96d1-76b43e21db8f
Apr 21 09:27:52 music volumio[1550]: info: Discovery: Found device Music
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music kernel: usb 2-2: USB disconnect, device number 2
Apr 21 09:27:52 music volumio[1550]: info: Received Get System Info
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:27:52 music volumio[1550]: info: Discovery: Getting this device information
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 21 09:27:52 music volumio[1550]: info: Received Get System Info
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:27:52 music volumio[1550]: info: Discovery: Getting this device information
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: Listing playlists
Apr 21 09:27:52 music volumio[1550]: info: VolumeController:: Volume=22 Mute =false
Apr 21 09:27:52 music volumio[1550]: info: CoreStateMachine::pushState
Apr 21 09:27:52 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::volumioPushState
Apr 21 09:27:52 music volumio[1550]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/BAFD-7DF1 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/c3072e18-01 /dev/disk/by-id/usb-SanDisk_SanDisk_3.2_Gen1_A20038B12C0E0D14-0:0-part1 /dev/disk/by-label/LOCAL","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"28","ID_BUS":"usb","ID_FS_LABEL":"LOCAL","ID_FS_LABEL_ENC":"LOCAL","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"BAFD-7DF1","ID_FS_UUID_ENC":"BAFD-7DF1","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2_Gen1","ID_MODEL_ENC":"SanDisk\\x203.2\\x20Gen1","ID_MODEL_ID":"55b1","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"7552","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"244449920","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"c3072e18-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"c3072e18","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_2_1_0-scsi-0_0_0_0","ID_REVISION":"DL17","ID_SERIAL":"SanDisk_SanDisk_3.2_Gen1_A20038B12C0E0D14-0:0","ID_SERIAL_SHORT":"A20038B12C0E0D14","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"SanDisk","ID_VENDOR_ENC":"SanDisk\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"1821","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"13606295"}
Apr 21 09:27:52 music sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1
Apr 21 09:27:52 music sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:52 music mount.exfat[1596]: failed to write super block
Apr 21 09:27:52 music systemd[1]: media-LOCAL.mount: Succeeded.
Apr 21 09:27:52 music sudo[1671]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:52 music volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:53 music volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:27:53 music dhcpcd[882]: wlan0: carrier acquired
Apr 21 09:27:53 music dhcpcd[882]: wlan0: connected to Access Point `KEN STUDIO'
Apr 21 09:27:53 music wpa_supplicant[771]: wlan0: Associated with 12:82:3d:85:dc:a8
Apr 21 09:27:53 music wpa_supplicant[771]: wlan0: CTRL-EVENT-CONNECTED - Connection to 12:82:3d:85:dc:a8 completed [id=0 id_str=]
Apr 21 09:27:53 music wpa_supplicant[771]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 21 09:27:53 music wpa_supplicant[771]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN
Apr 21 09:27:53 music dhcpcd[882]: wlan0: IAID dd:51:12:c8
Apr 21 09:27:53 music dhcpcd[882]: wlan0: adding address fe80::da3a:ddff:fe51:12c8
Apr 21 09:27:53 music dhcpcd[882]: ipv6_addaddr1: Permission denied
Apr 21 09:27:53 music dhcpcd[882]: wlan0: probing address 192.168.110.115/24
Apr 21 09:27:53 music kernel: ieee80211 phy0: brcmf_cfg80211_reg_notifier: Firmware rejected country setting
Apr 21 09:27:53 music dhcpcd[882]: wlan0: carrier lost
Apr 21 09:27:53 music dhcpcd[882]: wlan0: carrier acquired
Apr 21 09:27:53 music dhcpcd[882]: wlan0: IAID dd:51:12:c8
Apr 21 09:27:53 music dhcpcd[882]: wlan0: probing address 192.168.110.115/24
Apr 21 09:27:53 music dhcpcd[882]: wlan0: soliciting an IPv6 router
Apr 21 09:27:53 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:27:56 music volumio[1550]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/LOCAL
Apr 21 09:27:57 music kernel: usb 2-1: new SuperSpeed USB device number 3 using xhci_hcd
Apr 21 09:27:57 music kernel: usb 2-1: New USB device found, idVendor=0781, idProduct=55b1, bcdDevice= 1.10
Apr 21 09:27:57 music kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Apr 21 09:27:57 music kernel: usb 2-1: Product: SanDisk 3.2 Gen1
Apr 21 09:27:57 music kernel: usb 2-1: Manufacturer: SanDisk
Apr 21 09:27:57 music kernel: usb 2-1: SerialNumber: A20038B12C0E0D14
Apr 21 09:27:57 music kernel: usb-storage 2-1:1.0: USB Mass Storage device detected
Apr 21 09:27:57 music kernel: scsi host0: usb-storage 2-1:1.0
Apr 21 09:27:57 music volumio[1550]: MPD error: Connection refused
Apr 21 09:27:57 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:27:58 music dhcpcd[882]: wlan0: using static address 192.168.110.115/24
Apr 21 09:27:58 music avahi-daemon[557]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.110.115.
Apr 21 09:27:58 music avahi-daemon[557]: New relevant interface wlan0.IPv4 for mDNS.
Apr 21 09:27:58 music avahi-daemon[557]: Registering new address record for 192.168.110.115 on wlan0.IPv4.
Apr 21 09:27:58 music dhcpcd[882]: wlan0: adding route to 192.168.110.0/24
Apr 21 09:27:58 music dhcpcd[882]: wlan0: adding default route via 192.168.110.1
Apr 21 09:27:58 music kernel: scsi 0:0:0:0: Direct-Access SanDisk SanDisk 3.2 Gen1 DL17 PQ: 0 ANSI: 6
Apr 21 09:27:58 music kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Apr 21 09:27:58 music kernel: sd 0:0:0:0: [sda] 244457472 512-byte logical blocks: (125 GB/117 GiB)
Apr 21 09:27:58 music kernel: sd 0:0:0:0: [sda] Write Protect is off
Apr 21 09:27:58 music kernel: sd 0:0:0:0: [sda] Mode Sense: 45 00 00 00
Apr 21 09:27:58 music kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
Apr 21 09:27:58 music kernel: sda: sda1
Apr 21 09:27:58 music kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk
Apr 21 09:27:58 music volumio[1550]: info: Mounting Device LOCAL
Apr 21 09:27:58 music sudo[1746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/LOCAL -o noatime
Apr 21 09:27:58 music sudo[1746]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:27:58 music mount.exfat[1748]: volume was not unmounted cleanly
Apr 21 09:27:58 music sudo[1746]: pam_unix(sudo:session): session closed for user root
Apr 21 09:27:58 music volumio[1550]: WARN: volume was not unmounted cleanly.
Apr 21 09:27:58 music volumio[1550]: MPD error: Connection refused
Apr 21 09:27:59 music volumio[1550]: info: Discovery: this is already registered, 388ef808-04e9-471f-96d1-76b43e21db8f
Apr 21 09:27:59 music volumio[1550]: info: Discovery: Found device Music
Apr 21 09:27:59 music volumio[1550]: info: CoreCommandRouter::volumioGetState
Apr 21 09:27:59 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:27:59 music ntpd[679]: Listen normally on 4 wlan0 192.168.110.115:123
Apr 21 09:27:59 music ntpd[679]: new interface(s) found: waking up resolver
Apr 21 09:28:00 music sudo[1753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 21 09:28:00 music sudo[1753]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:00 music sudo[1753]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:00 music sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 21 09:28:00 music sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:00 music sudo[1755]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:00 music sudo[1759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 21 09:28:00 music sudo[1759]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:00 music sudo[1759]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:00 music volumio[1550]: info: Upmpdcli Daemon Started
Apr 21 09:28:01 music volumio[1550]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:01 music volumio[1550]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:01 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:28:02 music volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Apr 21 09:28:02 music volumio[1550]: verbose: ControllerMpd::sendMpdCommand rescan
Apr 21 09:28:02 music volumio[1550]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:28:02 music volumio[1550]: TypeError: Cannot read property 'then' of undefined
Apr 21 09:28:02 music volumio[1550]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
Apr 21 09:28:02 music volumio[1550]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15)
Apr 21 09:28:02 music volumio[1550]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Apr 21 09:28:02 music volumio[1550]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26)
Apr 21 09:28:02 music volumio[1550]: at Socket.emit (events.js:315:20)
Apr 21 09:28:02 music volumio[1550]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 21 09:28:02 music volumio[1550]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 21 09:28:02 music volumio[1550]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:28:02 music sudo[1770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 09:27
Apr 21 09:28:02 music sudo[1770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:02 music sudo[1770]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:02 music volumio-remote-updater[525]: [2024-04-21 09:28:02] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 21 09:28:02 music volumio-remote-updater[525]: [2024-04-21 09:28:02] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 21 09:28:02 music systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 21 09:28:02 music systemd[1]: media-LOCAL.mount: Succeeded.
Apr 21 09:28:02 music systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 21 09:28:02 music systemd[1]: Started dynamicswap service.
Apr 21 09:28:02 music systemd[1]: dynamicswap.service: Succeeded.
Apr 21 09:28:02 music systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 21 09:28:02 music systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5.
Apr 21 09:28:02 music systemd[1]: Started dynamicswap service.
Apr 21 09:28:02 music systemd[1]: Stopped Volumio Backend Module.
Apr 21 09:28:02 music systemd[1]: Started Volumio Backend Module.
Apr 21 09:28:02 music systemd[1]: dynamicswap.service: Succeeded.
Apr 21 09:28:03 music volumio[1782]: info: -------------------------------------------
Apr 21 09:28:03 music volumio[1782]: info: ----- Volumio3 ----
Apr 21 09:28:03 music volumio[1782]: info: -------------------------------------------
Apr 21 09:28:03 music volumio[1782]: info: ----- System startup ----
Apr 21 09:28:03 music volumio[1782]: info: -------------------------------------------
Apr 21 09:28:04 music volumio[1782]: info: MYVOLUMIO Environment detected
Apr 21 09:28:04 music volumio[1782]: info: Plugin folders cleanup
Apr 21 09:28:04 music volumio[1782]: info: Scanning into folder /volumio/app/plugins/
Apr 21 09:28:04 music volumio[1782]: info: Scanning category audio_interface
Apr 21 09:28:04 music volumio[1782]: info: Scanning category miscellanea
Apr 21 09:28:04 music volumio[1782]: info: Scanning category music_service
Apr 21 09:28:04 music volumio[1782]: info: Scanning category plugins.json
Apr 21 09:28:04 music volumio[1782]: info: Scanning category system_controller
Apr 21 09:28:04 music volumio[1782]: info: Scanning category user_interface
Apr 21 09:28:04 music volumio[1782]: info: Scanning into folder /data/plugins/
Apr 21 09:28:04 music volumio[1782]: info: Scanning category audio_interface
Apr 21 09:28:04 music volumio[1782]: info: Scanning category music_service
Apr 21 09:28:04 music volumio[1782]: info: Plugin folders cleanup completed
Apr 21 09:28:04 music volumio[1782]: info: -------------------------------------------
Apr 21 09:28:04 music volumio[1782]: info: ----- Core plugins startup ----
Apr 21 09:28:04 music volumio[1782]: info: -------------------------------------------
Apr 21 09:28:04 music volumio[1782]: info: Loading plugins from folder /volumio/app/plugins/
Apr 21 09:28:04 music volumio[1782]: info: Adding plugin upnp to MyMusic Plugins
Apr 21 09:28:04 music volumio[1782]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 21 09:28:04 music volumio[1782]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 21 09:28:04 music volumio[1782]: info: Loading plugins from folder /data/plugins/
Apr 21 09:28:04 music volumio[1782]: info: Loading plugin "system"...
Apr 21 09:28:04 music volumio[1782]: info: Loading plugin "appearance"...
Apr 21 09:28:04 music volumio[1782]: info: Loading plugin "network"...
Apr 21 09:28:04 music volumio[1782]: info: Refreshing Cached IP Addresses
Apr 21 09:28:04 music sudo[1808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 21 09:28:04 music sudo[1808]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:04 music sudo[1808]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:04 music sudo[1810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 21 09:28:04 music sudo[1810]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:04 music volumio[1782]: info: Loading plugin "services"...
Apr 21 09:28:04 music sudo[1810]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:04 music volumio[1782]: info: Loading plugin "alsa_controller"...
Apr 21 09:28:04 music sudo[1814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 21 09:28:04 music sudo[1814]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:04 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 21 09:28:04 music volumio[1782]: info: Loading plugin "wizard"...
Apr 21 09:28:04 music volumio[1782]: info: Loading plugin "networkfs"...
Apr 21 09:28:04 music volumio[1782]: info: Starting Udev Watcher for removable devices
Apr 21 09:28:04 music volumio[1782]: info: Ignoring mount for partition: boot
Apr 21 09:28:04 music volumio[1782]: info: Ignoring mount for partition: volumio
Apr 21 09:28:04 music volumio[1782]: info: Ignoring mount for partition: volumio_data
Apr 21 09:28:05 music volumio[1782]: info: Mounting Device LOCAL
Apr 21 09:28:05 music sudo[1824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/LOCAL -o noatime
Apr 21 09:28:05 music sudo[1824]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:06 music sudo[1824]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:06 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "volumio_command_line_client"...
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "upnp"...
Apr 21 09:28:06 music volumio[1782]: info: [1713666486059] Starting Upmpd Daemon
Apr 21 09:28:06 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "my_music"...
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "mpd"...
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "upnp_browser"...
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "alarm-clock"...
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "airplay_emulation"...
Apr 21 09:28:06 music volumio[1782]: info: Starting Shairport Sync
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "last_100"...
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "webradio"...
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "i2s_dacs"...
Apr 21 09:28:06 music volumio[1782]: info: I2S DAC not set, start Auto-detection
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "volumiodiscovery"...
Apr 21 09:28:06 music volumio[1782]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:28:06 music volumio[1782]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:28:06 music node[1782]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:28:06 music volumio[1782]: *** WARNING *** For more information see
Apr 21 09:28:06 music volumio[1782]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:28:06 music volumio[1782]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:28:06 music volumio[1782]: *** WARNING *** For more information see
Apr 21 09:28:06 music node[1782]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:28:06 music node[1782]: *** WARNING *** For more information see
Apr 21 09:28:06 music node[1782]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:28:06 music node[1782]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:28:06 music node[1782]: *** WARNING *** For more information see
Apr 21 09:28:06 music volumio[1782]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 21 09:28:06 music volumio[1782]: info: Discovery: Started advertising with name: Music
Apr 21 09:28:06 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:28:06 music volumio[1782]: info: Loading plugin "youtube2"...
Apr 21 09:28:07 music volumio[1782]: info: Loading plugin "outputs"...
Apr 21 09:28:07 music volumio[1782]: info: Loading plugin "albumart"...
Apr 21 09:28:07 music volumio[1782]: info: Plugin example_plugin is not enabled
Apr 21 09:28:07 music volumio[1782]: info: Loading plugin "inputs"...
Apr 21 09:28:07 music volumio[1782]: info: Loading plugin "updater_comm"...
Apr 21 09:28:07 music volumio[1782]: info: Plugin mpdemulation is not enabled
Apr 21 09:28:07 music volumio[1782]: info: Loading plugin "rest_api"...
Apr 21 09:28:07 music volumio[1782]: info: Loading plugin "websocket"...
Apr 21 09:28:07 music volumio[1782]: info: Loading plugin "fusiondsp"...
Apr 21 09:28:07 music volumio[1782]: Forking 3 albumart workers
Apr 21 09:28:07 music volumio-remote-updater[525]: [2024-04-21 09:28:07] [connect] Successful connection
Apr 21 09:28:07 music volumio[1782]: info: Applying required configuration parameters for plugin fusiondsp
Apr 21 09:28:07 music volumio[1782]: info: Loading i18n strings for locale en
Apr 21 09:28:07 music volumio[1782]: Updating browse sources language
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::initPlayerControls
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:07 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:28:07 music volumio[1782]: Express server listening on port 3000
Apr 21 09:28:07 music volumio[1782]: [Metrics] WebUI: 4s 533.85ms
Apr 21 09:28:08 music volumio[1782]: info: CoreStateMachine::resetVolumioState
Apr 21 09:28:08 music volumio[1782]: info: CoreStateMachine::getcurrentVolume
Apr 21 09:28:08 music volumio[1782]: info: CoreCommandRouter::volumioRetrievevolume
Apr 21 09:28:08 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.115 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 1
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 2
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.115 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 3
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 4
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.115 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 5
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 6
Apr 21 09:28:08 music volumio[1782]: Starting albumart workers
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.115 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 7
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 8
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.115 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 9
Apr 21 09:28:08 music volumio-remote-updater[525]: [2024-04-21 09:28:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713666487 101
Apr 21 09:28:08 music volumio[1782]: Starting albumart workers
Apr 21 09:28:08 music volumio[1782]: Starting albumart workers
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 10
Apr 21 09:28:08 music volumio[1782]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 11
Apr 21 09:28:09 music sudo[1814]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:09 music volumio[1782]: info: Reloading queue from file
Apr 21 09:28:09 music volumio[1782]: info: VolumeController:: Volume=22 Mute =false
Apr 21 09:28:09 music volumio[1782]: info: CoreStateMachine::pushState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioPushState
Apr 21 09:28:09 music volumio[1782]: info: CoreStateMachine::updateTrackBlock
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrackBlock
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioRetrievevolume
Apr 21 09:28:09 music volumio[1782]: info: CoreStateMachine::setRepeat null single undefined
Apr 21 09:28:09 music volumio[1782]: info: CoreStateMachine::pushState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioPushState
Apr 21 09:28:09 music volumio[1782]: info: CoreStateMachine::setRandom true
Apr 21 09:28:09 music volumio[1782]: info: CoreStateMachine::pushState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioPushState
Apr 21 09:28:09 music volumio[1782]: info: Setting Device type: Raspberry PI
Apr 21 09:28:09 music volumio[1782]: info: VolumeController:: Volume=22 Mute =false
Apr 21 09:28:09 music volumio[1782]: info: CoreStateMachine::pushState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioPushState
Apr 21 09:28:09 music volumio[1782]: info: Discovery: adding 388ef808-04e9-471f-96d1-76b43e21db8f
Apr 21 09:28:09 music volumio[1782]: info: Discovery: Found device Music
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: Received Get System Info
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:28:09 music volumio[1782]: info: Discovery: Getting this device information
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 21 09:28:09 music volumio[1782]: info: Received Get System Info
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:28:09 music volumio[1782]: info: Discovery: Getting this device information
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: Listing playlists
Apr 21 09:28:09 music volumio[1782]: info: Discovery: this is already registered, 388ef808-04e9-471f-96d1-76b43e21db8f
Apr 21 09:28:09 music volumio[1782]: info: Discovery: Found device Music
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:09 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:28:09 music volumio[1782]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:28:10 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:28:11 music volumio[1782]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:11 music volumio[1782]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:11 music volumio[1782]: info: Listing playlists
Apr 21 09:28:11 music volumio[1782]: info: Listing playlists
Apr 21 09:28:12 music volumio[1782]: info: CoreCommandRouter::volumioGetQueue
Apr 21 09:28:12 music volumio[1782]: info: CoreStateMachine::getQueue
Apr 21 09:28:12 music volumio[1782]: info: CorePlayQueue::getQueue
Apr 21 09:28:13 music volumio[1782]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 21 09:28:13 music volumio[1782]: info: CURURI: albums://
Apr 21 09:28:13 music volumio[1782]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:28:13 music volumio[1782]: TypeError: Cannot read property 'sendCommand' of undefined
Apr 21 09:28:13 music volumio[1782]: at /volumio/app/plugins/music_service/mpd/index.js:2986:22
Apr 21 09:28:13 music volumio[1782]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 21 09:28:13 music volumio[1782]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:28:13 music sudo[1905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 09:27
Apr 21 09:28:13 music sudo[1905]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:13 music sudo[1905]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:14 music volumio-remote-updater[525]: [2024-04-21 09:28:14] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 21 09:28:14 music volumio-remote-updater[525]: [2024-04-21 09:28:14] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 21 09:28:14 music systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 21 09:28:14 music systemd[1]: media-LOCAL.mount: Succeeded.
Apr 21 09:28:14 music systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 21 09:28:14 music systemd[1]: Started dynamicswap service.
Apr 21 09:28:14 music systemd[1]: dynamicswap.service: Succeeded.
Apr 21 09:28:14 music systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 21 09:28:14 music systemd[1]: volumio.service: Scheduled restart job, restart counter is at 6.
Apr 21 09:28:14 music systemd[1]: Stopped Volumio Backend Module.
Apr 21 09:28:15 music systemd[1]: Started Volumio Backend Module.
Apr 21 09:28:15 music systemd[1]: Started dynamicswap service.
Apr 21 09:28:15 music systemd[1]: dynamicswap.service: Succeeded.
Apr 21 09:28:16 music volumio[1919]: info: -------------------------------------------
Apr 21 09:28:16 music volumio[1919]: info: ----- Volumio3 ----
Apr 21 09:28:16 music volumio[1919]: info: -------------------------------------------
Apr 21 09:28:16 music volumio[1919]: info: ----- System startup ----
Apr 21 09:28:16 music volumio[1919]: info: -------------------------------------------
Apr 21 09:28:16 music volumio[1919]: info: MYVOLUMIO Environment detected
Apr 21 09:28:16 music volumio[1919]: info: Plugin folders cleanup
Apr 21 09:28:16 music volumio[1919]: info: Scanning into folder /volumio/app/plugins/
Apr 21 09:28:16 music volumio[1919]: info: Scanning category audio_interface
Apr 21 09:28:16 music volumio[1919]: info: Scanning category miscellanea
Apr 21 09:28:16 music volumio[1919]: info: Scanning category music_service
Apr 21 09:28:16 music volumio[1919]: info: Scanning category plugins.json
Apr 21 09:28:16 music volumio[1919]: info: Scanning category system_controller
Apr 21 09:28:16 music volumio[1919]: info: Scanning category user_interface
Apr 21 09:28:16 music volumio[1919]: info: Scanning into folder /data/plugins/
Apr 21 09:28:16 music volumio[1919]: info: Scanning category audio_interface
Apr 21 09:28:16 music volumio[1919]: info: Scanning category music_service
Apr 21 09:28:16 music volumio[1919]: info: Plugin folders cleanup completed
Apr 21 09:28:16 music volumio[1919]: info: -------------------------------------------
Apr 21 09:28:16 music volumio[1919]: info: ----- Core plugins startup ----
Apr 21 09:28:16 music volumio[1919]: info: -------------------------------------------
Apr 21 09:28:16 music volumio[1919]: info: Loading plugins from folder /volumio/app/plugins/
Apr 21 09:28:16 music volumio[1919]: info: Adding plugin upnp to MyMusic Plugins
Apr 21 09:28:16 music volumio[1919]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 21 09:28:16 music volumio[1919]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 21 09:28:16 music volumio[1919]: info: Loading plugins from folder /data/plugins/
Apr 21 09:28:16 music volumio[1919]: info: Loading plugin "system"...
Apr 21 09:28:16 music volumio[1919]: info: Loading plugin "appearance"...
Apr 21 09:28:17 music volumio[1919]: info: Loading plugin "network"...
Apr 21 09:28:17 music volumio[1919]: info: Refreshing Cached IP Addresses
Apr 21 09:28:17 music sudo[1981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 21 09:28:17 music sudo[1981]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:17 music sudo[1981]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:17 music sudo[1983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 21 09:28:17 music volumio[1919]: info: Loading plugin "services"...
Apr 21 09:28:17 music sudo[1983]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:17 music volumio[1919]: info: Loading plugin "alsa_controller"...
Apr 21 09:28:17 music sudo[1983]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:17 music sudo[1986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 21 09:28:17 music sudo[1986]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:17 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 21 09:28:17 music volumio[1919]: info: Loading plugin "wizard"...
Apr 21 09:28:17 music volumio[1919]: info: Loading plugin "networkfs"...
Apr 21 09:28:17 music volumio[1919]: info: Starting Udev Watcher for removable devices
Apr 21 09:28:17 music volumio[1919]: info: Ignoring mount for partition: boot
Apr 21 09:28:17 music volumio[1919]: info: Ignoring mount for partition: volumio
Apr 21 09:28:17 music volumio[1919]: info: Ignoring mount for partition: volumio_data
Apr 21 09:28:17 music volumio[1919]: info: Mounting Device LOCAL
Apr 21 09:28:17 music sudo[1997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/LOCAL -o noatime
Apr 21 09:28:17 music sudo[1997]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:17 music sudo[1997]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:17 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:28:17 music volumio[1919]: info: Loading plugin "volumio_command_line_client"...
Apr 21 09:28:17 music volumio[1919]: info: Loading plugin "upnp"...
Apr 21 09:28:17 music volumio[1919]: info: [1713666497796] Starting Upmpd Daemon
Apr 21 09:28:17 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:28:17 music volumio[1919]: info: Loading plugin "my_music"...
Apr 21 09:28:17 music volumio[1919]: info: Loading plugin "mpd"...
Apr 21 09:28:18 music volumio[1919]: info: Loading plugin "upnp_browser"...
Apr 21 09:28:18 music volumio[1919]: info: Loading plugin "alarm-clock"...
Apr 21 09:28:18 music volumio[1919]: info: Loading plugin "airplay_emulation"...
Apr 21 09:28:18 music volumio[1919]: info: Starting Shairport Sync
Apr 21 09:28:18 music volumio[1919]: info: Loading plugin "last_100"...
Apr 21 09:28:18 music volumio[1919]: info: Loading plugin "webradio"...
Apr 21 09:28:18 music volumio[1919]: info: Loading plugin "i2s_dacs"...
Apr 21 09:28:18 music volumio[1919]: info: I2S DAC not set, start Auto-detection
Apr 21 09:28:18 music volumio[1919]: info: Loading plugin "volumiodiscovery"...
Apr 21 09:28:18 music volumio[1919]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:28:18 music volumio[1919]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:28:18 music node[1919]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:28:18 music volumio[1919]: *** WARNING *** For more information see
Apr 21 09:28:18 music volumio[1919]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:28:18 music volumio[1919]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:28:18 music volumio[1919]: *** WARNING *** For more information see
Apr 21 09:28:18 music node[1919]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:28:18 music node[1919]: *** WARNING *** For more information see
Apr 21 09:28:18 music node[1919]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 21 09:28:18 music node[1919]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 21 09:28:18 music node[1919]: *** WARNING *** For more information see
Apr 21 09:28:18 music volumio[1919]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 21 09:28:18 music volumio[1919]: info: Discovery: Started advertising with name: Music
Apr 21 09:28:18 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 21 09:28:18 music volumio[1919]: info: Loading plugin "youtube2"...
Apr 21 09:28:19 music volumio[1919]: info: Loading plugin "outputs"...
Apr 21 09:28:19 music volumio[1919]: info: Loading plugin "albumart"...
Apr 21 09:28:19 music volumio[1919]: info: Plugin example_plugin is not enabled
Apr 21 09:28:19 music volumio[1919]: info: Loading plugin "inputs"...
Apr 21 09:28:19 music volumio[1919]: info: Loading plugin "updater_comm"...
Apr 21 09:28:19 music volumio[1919]: info: Plugin mpdemulation is not enabled
Apr 21 09:28:19 music volumio[1919]: info: Loading plugin "rest_api"...
Apr 21 09:28:19 music volumio[1919]: info: Loading plugin "websocket"...
Apr 21 09:28:19 music volumio[1919]: info: Loading plugin "fusiondsp"...
Apr 21 09:28:19 music volumio[1919]: Forking 3 albumart workers
Apr 21 09:28:19 music volumio[1919]: info: Applying required configuration parameters for plugin fusiondsp
Apr 21 09:28:19 music volumio[1919]: info: Loading i18n strings for locale en
Apr 21 09:28:19 music volumio[1919]: Updating browse sources language
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 21 09:28:19 music volumio-remote-updater[525]: [2024-04-21 09:28:19] [connect] Successful connection
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::initPlayerControls
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:28:19 music volumio[1919]: Express server listening on port 3000
Apr 21 09:28:19 music volumio[1919]: [Metrics] WebUI: 4s 48.00ms
Apr 21 09:28:19 music volumio[1919]: info: CoreStateMachine::resetVolumioState
Apr 21 09:28:19 music volumio[1919]: info: CoreStateMachine::getcurrentVolume
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::volumioRetrievevolume
Apr 21 09:28:19 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 21 09:28:19 music volumio[1919]: Starting albumart workers
Apr 21 09:28:19 music volumio[1919]: Starting albumart workers
Apr 21 09:28:19 music volumio[1919]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 1
Apr 21 09:28:19 music volumio[1919]: verbose: New Socket.io Connection to 192.168.110.115 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 2
Apr 21 09:28:19 music volumio[1919]: Starting albumart workers
Apr 21 09:28:19 music volumio-remote-updater[525]: [2024-04-21 09:28:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713666499 101
Apr 21 09:28:19 music volumio[1919]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3
Apr 21 09:28:21 music volumio[1919]: info: Reloading queue from file
Apr 21 09:28:21 music volumio[1919]: info: VolumeController:: Volume=22 Mute =false
Apr 21 09:28:21 music volumio[1919]: info: CoreStateMachine::pushState
Apr 21 09:28:21 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::volumioPushState
Apr 21 09:28:21 music volumio[1919]: info: CoreStateMachine::updateTrackBlock
Apr 21 09:28:21 music volumio[1919]: info: CorePlayQueue::getTrackBlock
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::volumioRetrievevolume
Apr 21 09:28:21 music volumio[1919]: info: CoreStateMachine::setRepeat null single undefined
Apr 21 09:28:21 music volumio[1919]: info: CoreStateMachine::pushState
Apr 21 09:28:21 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::volumioPushState
Apr 21 09:28:21 music volumio[1919]: info: CoreStateMachine::setRandom true
Apr 21 09:28:21 music volumio[1919]: info: CoreStateMachine::pushState
Apr 21 09:28:21 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::volumioPushState
Apr 21 09:28:21 music volumio[1919]: info: Setting Device type: Raspberry PI
Apr 21 09:28:21 music volumio[1919]: info: Discovery: adding 388ef808-04e9-471f-96d1-76b43e21db8f
Apr 21 09:28:21 music volumio[1919]: info: Discovery: Found device Music
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:21 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:21 music volumio[1919]: info: Discovery: this is already registered, 388ef808-04e9-471f-96d1-76b43e21db8f
Apr 21 09:28:21 music volumio[1919]: info: Discovery: Found device Music
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:21 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:21 music volumio[1919]: info: VolumeController:: Volume=22 Mute =false
Apr 21 09:28:21 music volumio[1919]: info: CoreStateMachine::pushState
Apr 21 09:28:21 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::volumioPushState
Apr 21 09:28:21 music sudo[1986]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:21 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:21 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:27 music sudo[2069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 21 09:28:27 music sudo[2069]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:27 music sudo[2069]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:27 music sudo[2071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 21 09:28:27 music sudo[2071]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:27 music sudo[2071]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:27 music sudo[2075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 21 09:28:27 music sudo[2075]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:27 music sudo[2075]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:27 music volumio[1919]: info: Upmpdcli Daemon Started
Apr 21 09:28:31 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:31 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:31 music volumio[1919]: info: Listing playlists
Apr 21 09:28:31 music volumio[1919]: info: Listing playlists
Apr 21 09:28:36 music ntpd[679]: Soliciting pool server 2406:2000:fc:437::2000
Apr 21 09:28:36 music sudo[2078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 21 09:28:36 music sudo[2078]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:36 music sudo[2078]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:36 music sudo[2080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 21 09:28:36 music sudo[2080]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 21 09:28:36 music sudo[2080]: pam_unix(sudo:session): session closed for user root
Apr 21 09:28:36 music volumio[1919]: verbose: New Socket.io Connection to 192.168.110.114 from 192.168.110.193 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 Total Clients: 4
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:37 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::volumioGetQueue
Apr 21 09:28:37 music volumio[1919]: info: CoreStateMachine::getQueue
Apr 21 09:28:37 music volumio[1919]: info: CorePlayQueue::getQueue
Apr 21 09:28:37 music volumio[1919]: info: Listing playlists
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 21 09:28:37 music volumio[1919]: info: Received Get System Info
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:28:37 music volumio[1919]: info: Discovery: Getting this device information
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:37 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:37 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 21 09:28:37 music volumio[1919]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:28:38 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 21 09:28:38 music volumio[1919]: info: Received Get System Info
Apr 21 09:28:38 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:28:38 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:28:38 music volumio[1919]: info: Discovery: Getting this device information
Apr 21 09:28:38 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:38 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:38 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:28:39 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 21 09:28:40 music volumio[1919]: info: Received Get System Info
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 21 09:28:40 music volumio[1919]: info: Discovery: Getting this device information
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:40 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 21 09:28:40 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 21 09:28:41 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Apr 21 09:28:41 music volumio[1919]: info: CoreCommandRouter::volumioGetState
Apr 21 09:28:41 music volumio[1919]: info: CorePlayQueue::getTrack 0
Apr 21 09:28:41 music volumio[1919]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Apr 21 09:28:41 music volumio[1919]: verbose: ControllerMpd::sendMpdCommand rescan
Apr 21 09:28:41 music volumio[1919]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:28:41 music volumio[1919]: TypeError: Cannot read property 'then' of undefined
Apr 21 09:28:41 music volumio[1919]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
Apr 21 09:28:41 music volumio[1919]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15)
Apr 21 09:28:41 music volumio[1919]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Apr 21 09:28:41 music volumio[1919]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26)
Apr 21 09:28:41 music volumio[1919]: at Socket.emit (events.js:315:20)
Apr 21 09:28:41 music volumio[1919]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 21 09:28:41 music volumio[1919]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 21 09:28:41 music volumio[1919]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 09:28:41 music sudo[2092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 09:27
Apr 21 09:28:41 music sudo[2092]: 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"