-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Fri 2024-05-03 21:41:29 CST. --
May 03 21:40:02 volumio volumio[2424]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:04 volumio sudo[2539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 03 21:40:04 volumio sudo[2539]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:04 volumio sudo[2539]: pam_unix(sudo:session): session closed for user root
May 03 21:40:04 volumio sudo[2541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 03 21:40:04 volumio sudo[2541]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:04 volumio sudo[2541]: pam_unix(sudo:session): session closed for user root
May 03 21:40:04 volumio sudo[2545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 03 21:40:04 volumio sudo[2545]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:04 volumio sudo[2545]: pam_unix(sudo:session): session closed for user root
May 03 21:40:04 volumio volumio[2424]: info: Upmpdcli Daemon Started
May 03 21:40:06 volumio volumio[2424]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:10 volumio volumio[2424]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:14 volumio volumio[2424]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:17 volumio volumio[2424]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
May 03 21:40:17 volumio volumio[2424]: verbose: ControllerMpd::sendMpdCommand rescan
May 03 21:40:17 volumio volumio[2424]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:40:17 volumio volumio[2424]: TypeError: Cannot read property 'then' of undefined
May 03 21:40:17 volumio volumio[2424]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
May 03 21:40:17 volumio volumio[2424]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15)
May 03 21:40:17 volumio volumio[2424]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
May 03 21:40:17 volumio volumio[2424]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26)
May 03 21:40:17 volumio volumio[2424]: at Socket.emit (events.js:315:20)
May 03 21:40:17 volumio volumio[2424]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 03 21:40:17 volumio volumio[2424]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 03 21:40:17 volumio volumio[2424]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:40:17 volumio sudo[2556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 21:39
May 03 21:40:17 volumio sudo[2556]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:17 volumio sudo[2556]: pam_unix(sudo:session): session closed for user root
May 03 21:40:17 volumio volumio-remote-updater[550]: [2024-05-03 21:40:17] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
May 03 21:40:17 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
May 03 21:40:17 volumio volumio-remote-updater[550]: [2024-05-03 21:40:17] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
May 03 21:40:17 volumio ntfs-3g[2471]: Unmounting /dev/sda5 ()
May 03 21:40:17 volumio systemd[1]: media-FE5CD09E5CD0534F.mount: Succeeded.
May 03 21:40:17 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
May 03 21:40:17 volumio systemd[1]: Started dynamicswap service.
May 03 21:40:17 volumio systemd[1]: dynamicswap.service: Succeeded.
May 03 21:40:17 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
May 03 21:40:17 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 6.
May 03 21:40:17 volumio systemd[1]: Stopped Volumio Backend Module.
May 03 21:40:17 volumio systemd[1]: Started Volumio Backend Module.
May 03 21:40:17 volumio systemd[1]: Started dynamicswap service.
May 03 21:40:17 volumio systemd[1]: dynamicswap.service: Succeeded.
May 03 21:40:18 volumio volumio[2569]: info: -------------------------------------------
May 03 21:40:18 volumio volumio[2569]: info: ----- Volumio3 ----
May 03 21:40:18 volumio volumio[2569]: info: -------------------------------------------
May 03 21:40:18 volumio volumio[2569]: info: ----- System startup ----
May 03 21:40:18 volumio volumio[2569]: info: -------------------------------------------
May 03 21:40:19 volumio volumio[2569]: info: MYVOLUMIO Environment detected
May 03 21:40:19 volumio volumio[2569]: info: Plugin folders cleanup
May 03 21:40:19 volumio volumio[2569]: info: Scanning into folder /volumio/app/plugins/
May 03 21:40:19 volumio volumio[2569]: info: Scanning category audio_interface
May 03 21:40:19 volumio volumio[2569]: info: Scanning category miscellanea
May 03 21:40:19 volumio volumio[2569]: info: Scanning category music_service
May 03 21:40:19 volumio volumio[2569]: info: Scanning category plugins.json
May 03 21:40:19 volumio volumio[2569]: info: Scanning category system_controller
May 03 21:40:19 volumio volumio[2569]: info: Scanning category user_interface
May 03 21:40:19 volumio volumio[2569]: info: Scanning into folder /data/plugins/
May 03 21:40:19 volumio volumio[2569]: info: Plugin folders cleanup completed
May 03 21:40:19 volumio volumio[2569]: info: -------------------------------------------
May 03 21:40:19 volumio volumio[2569]: info: ----- Core plugins startup ----
May 03 21:40:19 volumio volumio[2569]: info: -------------------------------------------
May 03 21:40:19 volumio volumio[2569]: info: Loading plugins from folder /volumio/app/plugins/
May 03 21:40:19 volumio volumio[2569]: info: Adding plugin upnp to MyMusic Plugins
May 03 21:40:19 volumio volumio[2569]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 03 21:40:19 volumio volumio[2569]: info: Adding plugin upnp_browser to MyMusic Plugins
May 03 21:40:19 volumio volumio[2569]: info: Loading plugins from folder /data/plugins/
May 03 21:40:19 volumio volumio[2569]: info: Loading plugin "system"...
May 03 21:40:19 volumio volumio[2569]: info: Loading plugin "appearance"...
May 03 21:40:19 volumio volumio[2569]: info: Loading plugin "network"...
May 03 21:40:19 volumio volumio[2569]: info: Refreshing Cached IP Addresses
May 03 21:40:19 volumio sudo[2596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 03 21:40:19 volumio sudo[2596]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:19 volumio sudo[2596]: pam_unix(sudo:session): session closed for user root
May 03 21:40:19 volumio sudo[2598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 03 21:40:19 volumio sudo[2598]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:19 volumio volumio[2569]: info: Loading plugin "services"...
May 03 21:40:19 volumio sudo[2598]: pam_unix(sudo:session): session closed for user root
May 03 21:40:19 volumio volumio[2569]: info: Loading plugin "alsa_controller"...
May 03 21:40:19 volumio sudo[2602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 03 21:40:19 volumio sudo[2602]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:20 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 03 21:40:20 volumio volumio[2569]: info: Loading plugin "wizard"...
May 03 21:40:20 volumio volumio[2569]: info: Loading plugin "networkfs"...
May 03 21:40:20 volumio volumio[2569]: info: Starting Udev Watcher for removable devices
May 03 21:40:20 volumio volumio[2569]: info: Ignoring mount for partition: boot
May 03 21:40:20 volumio volumio[2569]: info: Ignoring mount for partition: volumio
May 03 21:40:20 volumio volumio[2569]: info: Ignoring mount for partition: volumio_data
May 03 21:40:20 volumio volumio[2569]: error: Cannot associate FS Label, not mounting
May 03 21:40:20 volumio volumio[2569]: info: Mounting Device FE5CD09E5CD0534F
May 03 21:40:20 volumio sudo[2612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda5 /mnt/USB/FE5CD09E5CD0534F -o noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:40:20 volumio sudo[2612]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:21 volumio sudo[2602]: pam_unix(sudo:session): session closed for user root
May 03 21:40:22 volumio ntfs-3g[2616]: Version 2017.3.23AR.3 integrated FUSE 28
May 03 21:40:22 volumio ntfs-3g[2616]: Mounted /dev/sda5 (Read-Write, label "", NTFS 3.1)
May 03 21:40:22 volumio ntfs-3g[2616]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:40:22 volumio ntfs-3g[2616]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda5,blkdev,blksize=4096
May 03 21:40:22 volumio ntfs-3g[2616]: Global ownership and permissions enforced, configuration type 7
May 03 21:40:22 volumio sudo[2612]: pam_unix(sudo:session): session closed for user root
May 03 21:40:22 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "volumio_command_line_client"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "upnp"...
May 03 21:40:22 volumio volumio[2569]: info: [1714743622173] Starting Upmpd Daemon
May 03 21:40:22 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "my_music"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "mpd"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "upnp_browser"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "alarm-clock"...
May 03 21:40:22 volumio volumio-remote-updater[550]: [2024-05-03 21:40:22] [connect] Successful connection
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "airplay_emulation"...
May 03 21:40:22 volumio volumio[2569]: info: Starting Shairport Sync
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "last_100"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "webradio"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "i2s_dacs"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "volumiodiscovery"...
May 03 21:40:22 volumio volumio[2569]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:22 volumio volumio[2569]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:22 volumio node[2569]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:22 volumio volumio[2569]: *** WARNING *** For more information see
May 03 21:40:22 volumio volumio[2569]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:22 volumio volumio[2569]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:22 volumio volumio[2569]: *** WARNING *** For more information see
May 03 21:40:22 volumio node[2569]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:22 volumio node[2569]: *** WARNING *** For more information see
May 03 21:40:22 volumio node[2569]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:22 volumio node[2569]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:22 volumio node[2569]: *** WARNING *** For more information see
May 03 21:40:22 volumio volumio[2569]: info: Applying required configuration parameters for plugin volumiodiscovery
May 03 21:40:22 volumio volumio[2569]: info: Discovery: Started advertising with name: Volumio
May 03 21:40:22 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "outputs"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "albumart"...
May 03 21:40:22 volumio volumio[2569]: info: Plugin example_plugin is not enabled
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "inputs"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "updater_comm"...
May 03 21:40:22 volumio volumio[2569]: info: Plugin mpdemulation is not enabled
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "rest_api"...
May 03 21:40:22 volumio volumio[2569]: info: Loading plugin "websocket"...
May 03 21:40:22 volumio volumio[2569]: info: Loading i18n strings for locale zh
May 03 21:40:22 volumio volumio[2569]: Updating browse sources language
May 03 21:40:22 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 03 21:40:23 volumio volumio[2569]: Forking 3 albumart workers
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::initPlayerControls
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:40:23 volumio volumio[2569]: Express server listening on port 3000
May 03 21:40:23 volumio volumio[2569]: [Metrics] WebUI: 4s 541.60ms
May 03 21:40:23 volumio volumio[2569]: info: CoreStateMachine::resetVolumioState
May 03 21:40:23 volumio kernel: usb 2-1: USB disconnect, device number 2
May 03 21:40:23 volumio volumio[2569]: info: CoreStateMachine::getcurrentVolume
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::volumioRetrievevolume
May 03 21:40:23 volumio volumio[2569]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/be6aa982-01 /dev/disk/by-id/wwn-0x5000039b62c88d44-part1 /dev/disk/by-id/ata-TOSHIBA_MQ04ABD200_326NP3QBT-part1 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"26","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_PUIS":"1","ID_ATA_FEATURE_SET_PUIS_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"65962","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"65962","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_MODEL":"TOSHIBA_MQ04ABD200","ID_MODEL_ENC":"TOSHIBA\\x20MQ04ABD200\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"63","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"3907024002","ID_PART_ENTRY_TYPE":"0xf","ID_PART_ENTRY_UUID":"be6aa982-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"be6aa982","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"JT001U","ID_SERIAL":"TOSHIBA_MQ04ABD200_326NP3QBT","ID_SERIAL_SHORT":"326NP3QBT","ID_TYPE":"disk","ID_WWN":"0x5000039b62c88d44","ID_WWN_WITH_EXTENSION":"0x5000039b62c88d44","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"1793","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"13062694"}
May 03 21:40:23 volumio volumio[2569]: error: Cannot associate FS Label, not mounting
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:23 volumio volumio[2569]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda5","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/wwn-0x5000039b62c88d44-part5 /dev/disk/by-partuuid/be6aa982-05 /dev/disk/by-uuid/FE5CD09E5CD0534F /dev/disk/by-id/ata-TOSHIBA_MQ04ABD200_326NP3QBT-part5 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part5","DEVNAME":"/dev/sda5","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda5","DEVTYPE":"partition","DISKSEQ":"26","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_PUIS":"1","ID_ATA_FEATURE_SET_PUIS_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"65962","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"65962","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"FE5CD09E5CD0534F","ID_FS_UUID_ENC":"FE5CD09E5CD0534F","ID_MODEL":"TOSHIBA_MQ04ABD200","ID_MODEL_ENC":"TOSHIBA\\x20MQ04ABD200\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"5","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"3907020800","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"be6aa982-05","ID_PART_TABLE_TYPE":"atari","ID_PART_TABLE_UUID":"be6aa982","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"JT001U","ID_SERIAL":"TOSHIBA_MQ04ABD200_326NP3QBT","ID_SERIAL_SHORT":"326NP3QBT","ID_TYPE":"disk","ID_WWN":"0x5000039b62c88d44","ID_WWN_WITH_EXTENSION":"0x5000039b62c88d44","MAJOR":"8","MINOR":"5","PARTN":"5","SEQNUM":"1794","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"13174530"}
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:23 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
May 03 21:40:23 volumio sudo[2655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda5
May 03 21:40:23 volumio sudo[2655]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:23 volumio ntfs-3g[2616]: Unmounting /dev/sda5 ()
May 03 21:40:23 volumio systemd[1]: media-FE5CD09E5CD0534F.mount: Succeeded.
May 03 21:40:23 volumio sudo[2655]: pam_unix(sudo:session): session closed for user root
May 03 21:40:23 volumio ntfs-3g[2616]: Failed to sync device /dev/sda5: No such device
May 03 21:40:23 volumio ntfs-3g[2616]: Failed to close volume /dev/sda5: No such device
May 03 21:40:23 volumio volumio[2569]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (Linux; U; Android 11; zh-cn; Redmi K20 Pro Premium Edition Build/RKQ1.200826.002) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/109.0.5414.118 Mobile Safari/537.36 XiaoMi/MiuiBrowser/18.2.150419 Total Clients: 1
May 03 21:40:23 volumio volumio[2569]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (Linux; U; Android 11; zh-cn; Redmi K20 Pro Premium Edition Build/RKQ1.200826.002) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/109.0.5414.118 Mobile Safari/537.36 XiaoMi/MiuiBrowser/18.2.150419 Total Clients: 2
May 03 21:40:23 volumio volumio-remote-updater[550]: [2024-05-03 21:40:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714743622 101
May 03 21:40:23 volumio volumio[2569]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 03 21:40:23 volumio volumio[2569]: info: Reloading queue from file
May 03 21:40:23 volumio volumio[2569]: info: CoreStateMachine::setRepeat true single undefined
May 03 21:40:23 volumio volumio[2569]: info: CoreStateMachine::pushState
May 03 21:40:23 volumio volumio[2569]: info: CorePlayQueue::getTrack 0
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::volumioPushState
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:23 volumio volumio[2569]: info: CoreStateMachine::setRandom false
May 03 21:40:23 volumio volumio[2569]: info: CoreStateMachine::pushState
May 03 21:40:23 volumio volumio[2569]: info: CorePlayQueue::getTrack 0
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::volumioPushState
May 03 21:40:23 volumio volumio[2569]: info: VolumeController:: Volume=100 Mute =true
May 03 21:40:23 volumio volumio[2569]: info: CoreStateMachine::pushState
May 03 21:40:23 volumio volumio[2569]: info: CorePlayQueue::getTrack 0
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::volumioPushState
May 03 21:40:23 volumio volumio[2569]: info: CoreStateMachine::updateTrackBlock
May 03 21:40:23 volumio volumio[2569]: info: CorePlayQueue::getTrackBlock
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::volumioRetrievevolume
May 03 21:40:23 volumio volumio[2569]: info: Setting Device type: Raspberry PI
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:23 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:23 volumio volumio[2569]: info: VolumeController:: Volume=100 Mute =true
May 03 21:40:23 volumio volumio[2569]: info: CoreStateMachine::pushState
May 03 21:40:23 volumio volumio[2569]: info: CorePlayQueue::getTrack 0
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::volumioPushState
May 03 21:40:23 volumio volumio[2569]: Starting albumart workers
May 03 21:40:23 volumio volumio[2569]: Starting albumart workers
May 03 21:40:23 volumio volumio[2569]: Starting albumart workers
May 03 21:40:23 volumio volumio[2569]: info: Discovery: adding f347ce9b-4c92-4e21-a676-4072e5be2fcc
May 03 21:40:23 volumio volumio[2569]: info: Discovery: Found device Volumio
May 03 21:40:23 volumio volumio[2569]: info: CoreCommandRouter::volumioGetState
May 03 21:40:23 volumio volumio[2569]: info: CorePlayQueue::getTrack 0
May 03 21:40:23 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
May 03 21:40:25 volumio volumio[2569]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (Linux; U; Android 11; zh-cn; Redmi K20 Pro Premium Edition Build/RKQ1.200826.002) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/109.0.5414.118 Mobile Safari/537.36 XiaoMi/MiuiBrowser/18.2.150419 Total Clients: 4
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::volumioGetVisibleSources
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::volumioGetState
May 03 21:40:25 volumio volumio[2569]: info: CorePlayQueue::getTrack 0
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 03 21:40:25 volumio volumio[2569]: info: Received Get System Info
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 03 21:40:25 volumio volumio[2569]: info: Discovery: Getting this device information
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::volumioGetState
May 03 21:40:25 volumio volumio[2569]: info: CorePlayQueue::getTrack 0
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::volumioGetState
May 03 21:40:25 volumio volumio[2569]: info: CorePlayQueue::getTrack 0
May 03 21:40:25 volumio volumio[2569]: info: Listing playlists
May 03 21:40:25 volumio volumio[2569]: info: CoreCommandRouter::volumioGetQueue
May 03 21:40:25 volumio volumio[2569]: info: CoreStateMachine::getQueue
May 03 21:40:25 volumio volumio[2569]: info: CorePlayQueue::getQueue
May 03 21:40:26 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:27 volumio volumio[2569]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/FE5CD09E5CD0534F
May 03 21:40:28 volumio volumio[2569]: info: Scanning removed location : "USB/FE5CD09E5CD0534F"
May 03 21:40:28 volumio kernel: usb 2-1: new SuperSpeed USB device number 3 using xhci_hcd
May 03 21:40:28 volumio kernel: usb 2-1: New USB device found, idVendor=8888, idProduct=7777, bcdDevice= 0.56
May 03 21:40:28 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May 03 21:40:28 volumio kernel: usb 2-1: Product: Externa
May 03 21:40:28 volumio kernel: usb 2-1: Manufacturer: Generic
May 03 21:40:28 volumio kernel: usb 2-1: SerialNumber: 22222222222222220138
May 03 21:40:28 volumio kernel: scsi host0: uas
May 03 21:40:28 volumio kernel: scsi 0:0:0:0: Direct-Access Generic Externa 0056 PQ: 0 ANSI: 6
May 03 21:40:28 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
May 03 21:40:28 volumio kernel: sd 0:0:0:0: [sda] 3907029167 512-byte logical blocks: (2.00 TB/1.82 TiB)
May 03 21:40:28 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off
May 03 21:40:28 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 47 00 00 08
May 03 21:40:28 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
May 03 21:40:28 volumio kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 512 bytes
May 03 21:40:28 volumio kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes
May 03 21:40:28 volumio kernel: sda: sda1 < sda5 >
May 03 21:40:28 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk
May 03 21:40:28 volumio volumio[2569]: error: Cannot associate FS Label, not mounting
May 03 21:40:28 volumio volumio[2569]: info: Mounting Device FE5CD09E5CD0534F
May 03 21:40:28 volumio sudo[2742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda5 /mnt/USB/FE5CD09E5CD0534F -o noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:40:28 volumio sudo[2742]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:30 volumio ntfs-3g[2745]: Version 2017.3.23AR.3 integrated FUSE 28
May 03 21:40:30 volumio ntfs-3g[2745]: Mounted /dev/sda5 (Read-Write, label "", NTFS 3.1)
May 03 21:40:30 volumio ntfs-3g[2745]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:40:30 volumio ntfs-3g[2745]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda5,blkdev,blksize=4096
May 03 21:40:30 volumio ntfs-3g[2745]: Global ownership and permissions enforced, configuration type 7
May 03 21:40:30 volumio sudo[2742]: pam_unix(sudo:session): session closed for user root
May 03 21:40:30 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:30 volumio volumio[2569]: info: Scanning new location : "USB/FE5CD09E5CD0534F"
May 03 21:40:30 volumio volumio[2569]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
May 03 21:40:30 volumio volumio[2569]: verbose: ControllerMpd::sendMpdCommand update
May 03 21:40:30 volumio volumio[2569]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:40:30 volumio volumio[2569]: TypeError: Cannot read property 'then' of undefined
May 03 21:40:30 volumio volumio[2569]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
May 03 21:40:30 volumio volumio[2569]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1898:15)
May 03 21:40:30 volumio volumio[2569]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
May 03 21:40:30 volumio volumio[2569]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26)
May 03 21:40:30 volumio volumio[2569]: at Socket.emit (events.js:315:20)
May 03 21:40:30 volumio volumio[2569]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 03 21:40:30 volumio volumio[2569]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 03 21:40:30 volumio volumio[2569]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:40:31 volumio sudo[2758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 21:39
May 03 21:40:31 volumio sudo[2758]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:31 volumio sudo[2758]: pam_unix(sudo:session): session closed for user root
May 03 21:40:31 volumio volumio-remote-updater[550]: [2024-05-03 21:40:31] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
May 03 21:40:31 volumio volumio-remote-updater[550]: [2024-05-03 21:40:31] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
May 03 21:40:31 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
May 03 21:40:31 volumio ntfs-3g[2745]: Unmounting /dev/sda5 ()
May 03 21:40:31 volumio systemd[1]: media-FE5CD09E5CD0534F.mount: Succeeded.
May 03 21:40:31 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
May 03 21:40:31 volumio systemd[1]: Started dynamicswap service.
May 03 21:40:31 volumio systemd[1]: dynamicswap.service: Succeeded.
May 03 21:40:31 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
May 03 21:40:31 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 7.
May 03 21:40:31 volumio systemd[1]: Stopped Volumio Backend Module.
May 03 21:40:31 volumio systemd[1]: Started Volumio Backend Module.
May 03 21:40:31 volumio systemd[1]: Started dynamicswap service.
May 03 21:40:31 volumio systemd[1]: dynamicswap.service: Succeeded.
May 03 21:40:32 volumio volumio[2768]: info: -------------------------------------------
May 03 21:40:32 volumio volumio[2768]: info: ----- Volumio3 ----
May 03 21:40:32 volumio volumio[2768]: info: -------------------------------------------
May 03 21:40:32 volumio volumio[2768]: info: ----- System startup ----
May 03 21:40:32 volumio volumio[2768]: info: -------------------------------------------
May 03 21:40:33 volumio volumio[2768]: info: MYVOLUMIO Environment detected
May 03 21:40:33 volumio volumio[2768]: info: Plugin folders cleanup
May 03 21:40:33 volumio volumio[2768]: info: Scanning into folder /volumio/app/plugins/
May 03 21:40:33 volumio volumio[2768]: info: Scanning category audio_interface
May 03 21:40:33 volumio volumio[2768]: info: Scanning category miscellanea
May 03 21:40:33 volumio volumio[2768]: info: Scanning category music_service
May 03 21:40:33 volumio volumio[2768]: info: Scanning category plugins.json
May 03 21:40:33 volumio volumio[2768]: info: Scanning category system_controller
May 03 21:40:33 volumio volumio[2768]: info: Scanning category user_interface
May 03 21:40:33 volumio volumio[2768]: info: Scanning into folder /data/plugins/
May 03 21:40:33 volumio volumio[2768]: info: Plugin folders cleanup completed
May 03 21:40:33 volumio volumio[2768]: info: -------------------------------------------
May 03 21:40:33 volumio volumio[2768]: info: ----- Core plugins startup ----
May 03 21:40:33 volumio volumio[2768]: info: -------------------------------------------
May 03 21:40:33 volumio volumio[2768]: info: Loading plugins from folder /volumio/app/plugins/
May 03 21:40:33 volumio volumio[2768]: info: Adding plugin upnp to MyMusic Plugins
May 03 21:40:33 volumio volumio[2768]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 03 21:40:33 volumio volumio[2768]: info: Adding plugin upnp_browser to MyMusic Plugins
May 03 21:40:33 volumio volumio[2768]: info: Loading plugins from folder /data/plugins/
May 03 21:40:33 volumio volumio[2768]: info: Loading plugin "system"...
May 03 21:40:33 volumio volumio[2768]: info: Loading plugin "appearance"...
May 03 21:40:33 volumio volumio[2768]: info: Loading plugin "network"...
May 03 21:40:33 volumio volumio[2768]: info: Refreshing Cached IP Addresses
May 03 21:40:33 volumio sudo[2795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 03 21:40:33 volumio sudo[2795]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:33 volumio sudo[2795]: pam_unix(sudo:session): session closed for user root
May 03 21:40:33 volumio sudo[2797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 03 21:40:33 volumio sudo[2797]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:33 volumio volumio[2768]: info: Loading plugin "services"...
May 03 21:40:33 volumio sudo[2797]: pam_unix(sudo:session): session closed for user root
May 03 21:40:33 volumio volumio[2768]: info: Loading plugin "alsa_controller"...
May 03 21:40:33 volumio sudo[2801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 03 21:40:33 volumio sudo[2801]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:33 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 03 21:40:33 volumio volumio[2768]: info: Loading plugin "wizard"...
May 03 21:40:33 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:33 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:33 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:33 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:33 volumio volumio[2768]: info: Loading plugin "networkfs"...
May 03 21:40:33 volumio volumio[2768]: info: Starting Udev Watcher for removable devices
May 03 21:40:33 volumio volumio[2768]: info: Ignoring mount for partition: boot
May 03 21:40:33 volumio volumio[2768]: info: Ignoring mount for partition: volumio
May 03 21:40:33 volumio volumio[2768]: info: Ignoring mount for partition: volumio_data
May 03 21:40:33 volumio volumio[2768]: error: Cannot associate FS Label, not mounting
May 03 21:40:33 volumio volumio[2768]: info: Mounting Device FE5CD09E5CD0534F
May 03 21:40:33 volumio sudo[2811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda5 /mnt/USB/FE5CD09E5CD0534F -o noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:40:33 volumio sudo[2811]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:35 volumio sudo[2801]: pam_unix(sudo:session): session closed for user root
May 03 21:40:35 volumio ntfs-3g[2815]: Version 2017.3.23AR.3 integrated FUSE 28
May 03 21:40:35 volumio ntfs-3g[2815]: Mounted /dev/sda5 (Read-Write, label "", NTFS 3.1)
May 03 21:40:35 volumio ntfs-3g[2815]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:40:35 volumio ntfs-3g[2815]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda5,blkdev,blksize=4096
May 03 21:40:35 volumio ntfs-3g[2815]: Global ownership and permissions enforced, configuration type 7
May 03 21:40:35 volumio sudo[2811]: pam_unix(sudo:session): session closed for user root
May 03 21:40:35 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:40:35 volumio volumio[2768]: info: Loading plugin "volumio_command_line_client"...
May 03 21:40:35 volumio volumio[2768]: info: Loading plugin "upnp"...
May 03 21:40:35 volumio volumio[2768]: info: [1714743635678] Starting Upmpd Daemon
May 03 21:40:35 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:40:35 volumio volumio[2768]: info: Loading plugin "my_music"...
May 03 21:40:35 volumio volumio[2768]: info: Loading plugin "mpd"...
May 03 21:40:35 volumio volumio[2768]: info: Loading plugin "upnp_browser"...
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "alarm-clock"...
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "airplay_emulation"...
May 03 21:40:36 volumio volumio[2768]: info: Starting Shairport Sync
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "last_100"...
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "webradio"...
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "i2s_dacs"...
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "volumiodiscovery"...
May 03 21:40:36 volumio volumio-remote-updater[550]: [2024-05-03 21:40:36] [connect] Successful connection
May 03 21:40:36 volumio volumio[2768]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:36 volumio volumio[2768]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:36 volumio node[2768]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:36 volumio volumio[2768]: *** WARNING *** For more information see
May 03 21:40:36 volumio volumio[2768]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:36 volumio volumio[2768]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:36 volumio volumio[2768]: *** WARNING *** For more information see
May 03 21:40:36 volumio node[2768]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:36 volumio node[2768]: *** WARNING *** For more information see
May 03 21:40:36 volumio node[2768]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:36 volumio node[2768]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:36 volumio node[2768]: *** WARNING *** For more information see
May 03 21:40:36 volumio volumio[2768]: info: Applying required configuration parameters for plugin volumiodiscovery
May 03 21:40:36 volumio volumio[2768]: info: Discovery: Started advertising with name: Volumio
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "outputs"...
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "albumart"...
May 03 21:40:36 volumio volumio[2768]: info: Plugin example_plugin is not enabled
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "inputs"...
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "updater_comm"...
May 03 21:40:36 volumio volumio[2768]: info: Plugin mpdemulation is not enabled
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "rest_api"...
May 03 21:40:36 volumio volumio[2768]: info: Loading plugin "websocket"...
May 03 21:40:36 volumio volumio[2768]: info: Loading i18n strings for locale zh
May 03 21:40:36 volumio volumio[2768]: Updating browse sources language
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 03 21:40:36 volumio volumio[2768]: Forking 3 albumart workers
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::initPlayerControls
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:40:36 volumio volumio[2768]: Express server listening on port 3000
May 03 21:40:36 volumio volumio[2768]: [Metrics] WebUI: 4s 329.13ms
May 03 21:40:36 volumio volumio[2768]: info: CoreStateMachine::resetVolumioState
May 03 21:40:36 volumio volumio[2768]: info: CoreStateMachine::getcurrentVolume
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::volumioRetrievevolume
May 03 21:40:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:36 volumio volumio[2768]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (Linux; U; Android 11; zh-cn; Redmi K20 Pro Premium Edition Build/RKQ1.200826.002) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/109.0.5414.118 Mobile Safari/537.36 XiaoMi/MiuiBrowser/18.2.150419 Total Clients: 1
May 03 21:40:36 volumio volumio-remote-updater[550]: [2024-05-03 21:40:36] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714743636 101
May 03 21:40:36 volumio volumio[2768]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
May 03 21:40:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 03 21:40:36 volumio volumio[2768]: info: Reloading queue from file
May 03 21:40:36 volumio volumio[2768]: info: CoreStateMachine::setRepeat true single undefined
May 03 21:40:36 volumio volumio[2768]: info: CoreStateMachine::pushState
May 03 21:40:36 volumio volumio[2768]: info: CorePlayQueue::getTrack 0
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::volumioPushState
May 03 21:40:36 volumio volumio[2768]: info: CoreStateMachine::setRandom false
May 03 21:40:36 volumio volumio[2768]: info: CoreStateMachine::pushState
May 03 21:40:36 volumio volumio[2768]: info: CorePlayQueue::getTrack 0
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::volumioPushState
May 03 21:40:36 volumio volumio[2768]: info: Setting Device type: Raspberry PI
May 03 21:40:36 volumio volumio[2768]: info: VolumeController:: Volume=100 Mute =true
May 03 21:40:36 volumio volumio[2768]: info: CoreStateMachine::pushState
May 03 21:40:36 volumio volumio[2768]: info: CorePlayQueue::getTrack 0
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::volumioPushState
May 03 21:40:36 volumio volumio[2768]: info: CoreStateMachine::updateTrackBlock
May 03 21:40:36 volumio volumio[2768]: info: CorePlayQueue::getTrackBlock
May 03 21:40:36 volumio volumio[2768]: info: CoreCommandRouter::volumioRetrievevolume
May 03 21:40:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:37 volumio volumio[2768]: info: VolumeController:: Volume=100 Mute =true
May 03 21:40:37 volumio volumio[2768]: info: CoreStateMachine::pushState
May 03 21:40:37 volumio volumio[2768]: info: CorePlayQueue::getTrack 0
May 03 21:40:37 volumio volumio[2768]: info: CoreCommandRouter::volumioPushState
May 03 21:40:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:37 volumio volumio[2768]: info: Discovery: adding f347ce9b-4c92-4e21-a676-4072e5be2fcc
May 03 21:40:37 volumio volumio[2768]: info: Discovery: Found device Volumio
May 03 21:40:37 volumio volumio[2768]: info: CoreCommandRouter::volumioGetState
May 03 21:40:37 volumio volumio[2768]: info: CorePlayQueue::getTrack 0
May 03 21:40:37 volumio volumio[2768]: Starting albumart workers
May 03 21:40:37 volumio volumio[2768]: Starting albumart workers
May 03 21:40:37 volumio volumio[2768]: Starting albumart workers
May 03 21:40:38 volumio volumio[2768]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (Linux; U; Android 11; zh-cn; Redmi K20 Pro Premium Edition Build/RKQ1.200826.002) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/109.0.5414.118 Mobile Safari/537.36 XiaoMi/MiuiBrowser/18.2.150419 Total Clients: 3
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::volumioGetVisibleSources
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::volumioGetState
May 03 21:40:38 volumio volumio[2768]: info: CorePlayQueue::getTrack 0
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 03 21:40:38 volumio volumio[2768]: info: Received Get System Info
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 03 21:40:38 volumio volumio[2768]: info: Discovery: Getting this device information
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::volumioGetState
May 03 21:40:38 volumio volumio[2768]: info: CorePlayQueue::getTrack 0
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::volumioGetState
May 03 21:40:38 volumio volumio[2768]: info: CorePlayQueue::getTrack 0
May 03 21:40:38 volumio volumio[2768]: info: Listing playlists
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::volumioGetQueue
May 03 21:40:38 volumio volumio[2768]: info: CoreStateMachine::getQueue
May 03 21:40:38 volumio volumio[2768]: info: CorePlayQueue::getQueue
May 03 21:40:38 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:40:39 volumio volumio[2768]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
May 03 21:40:39 volumio volumio[2768]: verbose: ControllerMpd::sendMpdCommand update
May 03 21:40:39 volumio volumio[2768]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:40:39 volumio volumio[2768]: TypeError: Cannot read property 'then' of undefined
May 03 21:40:39 volumio volumio[2768]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
May 03 21:40:39 volumio volumio[2768]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1898:15)
May 03 21:40:39 volumio volumio[2768]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
May 03 21:40:39 volumio volumio[2768]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26)
May 03 21:40:39 volumio volumio[2768]: at Socket.emit (events.js:315:20)
May 03 21:40:39 volumio volumio[2768]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 03 21:40:39 volumio volumio[2768]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 03 21:40:39 volumio volumio[2768]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:40:40 volumio sudo[2891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 21:39
May 03 21:40:40 volumio sudo[2891]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:40 volumio sudo[2891]: pam_unix(sudo:session): session closed for user root
May 03 21:40:40 volumio volumio-remote-updater[550]: [2024-05-03 21:40:40] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
May 03 21:40:40 volumio volumio-remote-updater[550]: [2024-05-03 21:40:40] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
May 03 21:40:40 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
May 03 21:40:40 volumio ntfs-3g[2815]: Unmounting /dev/sda5 ()
May 03 21:40:40 volumio systemd[1]: media-FE5CD09E5CD0534F.mount: Succeeded.
May 03 21:40:40 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
May 03 21:40:40 volumio systemd[1]: Started dynamicswap service.
May 03 21:40:40 volumio systemd[1]: dynamicswap.service: Succeeded.
May 03 21:40:40 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
May 03 21:40:40 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 8.
May 03 21:40:40 volumio systemd[1]: Stopped Volumio Backend Module.
May 03 21:40:40 volumio systemd[1]: Started Volumio Backend Module.
May 03 21:40:40 volumio systemd[1]: Started dynamicswap service.
May 03 21:40:40 volumio systemd[1]: dynamicswap.service: Succeeded.
May 03 21:40:41 volumio volumio[2903]: info: -------------------------------------------
May 03 21:40:41 volumio volumio[2903]: info: ----- Volumio3 ----
May 03 21:40:41 volumio volumio[2903]: info: -------------------------------------------
May 03 21:40:41 volumio volumio[2903]: info: ----- System startup ----
May 03 21:40:41 volumio volumio[2903]: info: -------------------------------------------
May 03 21:40:42 volumio volumio[2903]: info: MYVOLUMIO Environment detected
May 03 21:40:42 volumio volumio[2903]: info: Plugin folders cleanup
May 03 21:40:42 volumio volumio[2903]: info: Scanning into folder /volumio/app/plugins/
May 03 21:40:42 volumio volumio[2903]: info: Scanning category audio_interface
May 03 21:40:42 volumio volumio[2903]: info: Scanning category miscellanea
May 03 21:40:42 volumio volumio[2903]: info: Scanning category music_service
May 03 21:40:42 volumio volumio[2903]: info: Scanning category plugins.json
May 03 21:40:42 volumio volumio[2903]: info: Scanning category system_controller
May 03 21:40:42 volumio volumio[2903]: info: Scanning category user_interface
May 03 21:40:42 volumio volumio[2903]: info: Scanning into folder /data/plugins/
May 03 21:40:42 volumio volumio[2903]: info: Plugin folders cleanup completed
May 03 21:40:42 volumio volumio[2903]: info: -------------------------------------------
May 03 21:40:42 volumio volumio[2903]: info: ----- Core plugins startup ----
May 03 21:40:42 volumio volumio[2903]: info: -------------------------------------------
May 03 21:40:42 volumio volumio[2903]: info: Loading plugins from folder /volumio/app/plugins/
May 03 21:40:42 volumio volumio[2903]: info: Adding plugin upnp to MyMusic Plugins
May 03 21:40:42 volumio volumio[2903]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 03 21:40:42 volumio volumio[2903]: info: Adding plugin upnp_browser to MyMusic Plugins
May 03 21:40:42 volumio volumio[2903]: info: Loading plugins from folder /data/plugins/
May 03 21:40:42 volumio volumio[2903]: info: Loading plugin "system"...
May 03 21:40:42 volumio volumio[2903]: info: Loading plugin "appearance"...
May 03 21:40:42 volumio volumio[2903]: info: Loading plugin "network"...
May 03 21:40:42 volumio volumio[2903]: info: Refreshing Cached IP Addresses
May 03 21:40:42 volumio sudo[2930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 03 21:40:42 volumio sudo[2930]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:42 volumio sudo[2930]: pam_unix(sudo:session): session closed for user root
May 03 21:40:42 volumio sudo[2932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 03 21:40:42 volumio volumio[2903]: info: Loading plugin "services"...
May 03 21:40:42 volumio sudo[2932]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:42 volumio volumio[2903]: info: Loading plugin "alsa_controller"...
May 03 21:40:42 volumio sudo[2932]: pam_unix(sudo:session): session closed for user root
May 03 21:40:42 volumio sudo[2935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 03 21:40:42 volumio sudo[2935]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:42 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:43 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:43 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:43 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:43 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 03 21:40:43 volumio volumio[2903]: info: Loading plugin "wizard"...
May 03 21:40:43 volumio volumio[2903]: info: Loading plugin "networkfs"...
May 03 21:40:43 volumio volumio[2903]: info: Starting Udev Watcher for removable devices
May 03 21:40:43 volumio volumio[2903]: info: Ignoring mount for partition: boot
May 03 21:40:43 volumio volumio[2903]: info: Ignoring mount for partition: volumio
May 03 21:40:43 volumio volumio[2903]: info: Ignoring mount for partition: volumio_data
May 03 21:40:43 volumio volumio[2903]: error: Cannot associate FS Label, not mounting
May 03 21:40:43 volumio volumio[2903]: info: Mounting Device FE5CD09E5CD0534F
May 03 21:40:43 volumio sudo[2946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda5 /mnt/USB/FE5CD09E5CD0534F -o noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:40:43 volumio sudo[2946]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:44 volumio sudo[2935]: pam_unix(sudo:session): session closed for user root
May 03 21:40:44 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:44 volumio ntfs-3g[2949]: Version 2017.3.23AR.3 integrated FUSE 28
May 03 21:40:44 volumio ntfs-3g[2949]: Mounted /dev/sda5 (Read-Write, label "", NTFS 3.1)
May 03 21:40:44 volumio ntfs-3g[2949]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:40:44 volumio ntfs-3g[2949]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda5,blkdev,blksize=4096
May 03 21:40:44 volumio ntfs-3g[2949]: Global ownership and permissions enforced, configuration type 7
May 03 21:40:44 volumio sudo[2946]: pam_unix(sudo:session): session closed for user root
May 03 21:40:44 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:40:44 volumio volumio[2903]: info: Loading plugin "volumio_command_line_client"...
May 03 21:40:44 volumio volumio[2903]: info: Loading plugin "upnp"...
May 03 21:40:44 volumio volumio[2903]: info: [1714743644877] Starting Upmpd Daemon
May 03 21:40:44 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:40:44 volumio volumio[2903]: info: Loading plugin "my_music"...
May 03 21:40:44 volumio volumio[2903]: info: Loading plugin "mpd"...
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "upnp_browser"...
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "alarm-clock"...
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "airplay_emulation"...
May 03 21:40:45 volumio volumio[2903]: info: Starting Shairport Sync
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "last_100"...
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "webradio"...
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "i2s_dacs"...
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "volumiodiscovery"...
May 03 21:40:45 volumio volumio-remote-updater[550]: [2024-05-03 21:40:45] [connect] Successful connection
May 03 21:40:45 volumio volumio[2903]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:45 volumio volumio[2903]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:45 volumio node[2903]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:45 volumio volumio[2903]: *** WARNING *** For more information see
May 03 21:40:45 volumio volumio[2903]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:45 volumio volumio[2903]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:45 volumio volumio[2903]: *** WARNING *** For more information see
May 03 21:40:45 volumio node[2903]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:45 volumio node[2903]: *** WARNING *** For more information see
May 03 21:40:45 volumio node[2903]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 03 21:40:45 volumio node[2903]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:40:45 volumio node[2903]: *** WARNING *** For more information see
May 03 21:40:45 volumio volumio[2903]: info: Applying required configuration parameters for plugin volumiodiscovery
May 03 21:40:45 volumio volumio[2903]: info: Discovery: Started advertising with name: Volumio
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "outputs"...
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "albumart"...
May 03 21:40:45 volumio volumio[2903]: info: Plugin example_plugin is not enabled
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "inputs"...
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "updater_comm"...
May 03 21:40:45 volumio volumio[2903]: info: Plugin mpdemulation is not enabled
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "rest_api"...
May 03 21:40:45 volumio volumio[2903]: info: Loading plugin "websocket"...
May 03 21:40:45 volumio volumio[2903]: info: Loading i18n strings for locale zh
May 03 21:40:45 volumio volumio[2903]: Updating browse sources language
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 03 21:40:45 volumio volumio[2903]: Forking 3 albumart workers
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::initPlayerControls
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:40:45 volumio volumio[2903]: Express server listening on port 3000
May 03 21:40:45 volumio volumio[2903]: [Metrics] WebUI: 4s 264.88ms
May 03 21:40:45 volumio volumio[2903]: info: CoreStateMachine::resetVolumioState
May 03 21:40:45 volumio volumio[2903]: info: CoreStateMachine::getcurrentVolume
May 03 21:40:45 volumio volumio[2903]: info: CoreCommandRouter::volumioRetrievevolume
May 03 21:40:45 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:45 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:45 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:45 volumio volumio[2903]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (Linux; U; Android 11; zh-cn; Redmi K20 Pro Premium Edition Build/RKQ1.200826.002) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/109.0.5414.118 Mobile Safari/537.36 XiaoMi/MiuiBrowser/18.2.150419 Total Clients: 1
May 03 21:40:45 volumio volumio-remote-updater[550]: [2024-05-03 21:40:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714743645 101
May 03 21:40:45 volumio volumio[2903]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
May 03 21:40:45 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:46 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:46 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 03 21:40:46 volumio volumio[2903]: info: Reloading queue from file
May 03 21:40:46 volumio volumio[2903]: info: CoreStateMachine::setRepeat true single undefined
May 03 21:40:46 volumio volumio[2903]: info: CoreStateMachine::pushState
May 03 21:40:46 volumio volumio[2903]: info: CorePlayQueue::getTrack 0
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::volumioPushState
May 03 21:40:46 volumio volumio[2903]: info: CoreStateMachine::setRandom false
May 03 21:40:46 volumio volumio[2903]: info: CoreStateMachine::pushState
May 03 21:40:46 volumio volumio[2903]: info: CorePlayQueue::getTrack 0
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::volumioPushState
May 03 21:40:46 volumio volumio[2903]: info: VolumeController:: Volume=100 Mute =true
May 03 21:40:46 volumio volumio[2903]: info: CoreStateMachine::pushState
May 03 21:40:46 volumio volumio[2903]: info: CorePlayQueue::getTrack 0
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::volumioPushState
May 03 21:40:46 volumio volumio[2903]: info: CoreStateMachine::updateTrackBlock
May 03 21:40:46 volumio volumio[2903]: info: CorePlayQueue::getTrackBlock
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::volumioRetrievevolume
May 03 21:40:46 volumio volumio[2903]: info: Setting Device type: Raspberry PI
May 03 21:40:46 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:46 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:46 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:46 volumio volumio[2903]: info: VolumeController:: Volume=100 Mute =true
May 03 21:40:46 volumio volumio[2903]: info: CoreStateMachine::pushState
May 03 21:40:46 volumio volumio[2903]: info: CorePlayQueue::getTrack 0
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::volumioPushState
May 03 21:40:46 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:46 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:40:46 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:40:46 volumio volumio[2903]: Starting albumart workers
May 03 21:40:46 volumio volumio[2903]: Starting albumart workers
May 03 21:40:46 volumio volumio[2903]: info: Discovery: adding f347ce9b-4c92-4e21-a676-4072e5be2fcc
May 03 21:40:46 volumio volumio[2903]: info: Discovery: Found device Volumio
May 03 21:40:46 volumio volumio[2903]: info: CoreCommandRouter::volumioGetState
May 03 21:40:46 volumio volumio[2903]: info: CorePlayQueue::getTrack 0
May 03 21:40:46 volumio volumio[2903]: Starting albumart workers
May 03 21:40:54 volumio sudo[3018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 03 21:40:54 volumio sudo[3018]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:54 volumio sudo[3018]: pam_unix(sudo:session): session closed for user root
May 03 21:40:54 volumio sudo[3020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 03 21:40:54 volumio sudo[3020]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:54 volumio sudo[3020]: pam_unix(sudo:session): session closed for user root
May 03 21:40:54 volumio sudo[3024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 03 21:40:54 volumio sudo[3024]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:54 volumio sudo[3024]: pam_unix(sudo:session): session closed for user root
May 03 21:40:54 volumio volumio[2903]: info: Upmpdcli Daemon Started
May 03 21:40:56 volumio sudo[3028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 03 21:40:56 volumio sudo[3028]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:56 volumio sudo[3028]: pam_unix(sudo:session): session closed for user root
May 03 21:40:56 volumio sudo[3030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 03 21:40:56 volumio sudo[3030]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:40:56 volumio sudo[3030]: pam_unix(sudo:session): session closed for user root
May 03 21:40:56 volumio volumio[2903]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (Linux; U; Android 11; zh-cn; Redmi K20 Pro Premium Edition Build/RKQ1.200826.002) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/109.0.5414.118 Mobile Safari/537.36 XiaoMi/MiuiBrowser/18.2.150419 Total Clients: 3
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::volumioGetVisibleSources
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::volumioGetState
May 03 21:40:56 volumio volumio[2903]: info: CorePlayQueue::getTrack 0
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 03 21:40:56 volumio volumio[2903]: info: Received Get System Info
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 03 21:40:56 volumio volumio[2903]: info: Discovery: Getting this device information
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::volumioGetState
May 03 21:40:56 volumio volumio[2903]: info: CorePlayQueue::getTrack 0
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::volumioGetState
May 03 21:40:56 volumio volumio[2903]: info: CorePlayQueue::getTrack 0
May 03 21:40:56 volumio volumio[2903]: info: Listing playlists
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 03 21:40:56 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 03 21:40:58 volumio volumio[2903]: info: CoreCommandRouter::volumioGetQueue
May 03 21:40:58 volumio volumio[2903]: info: CoreStateMachine::getQueue
May 03 21:40:58 volumio volumio[2903]: info: CorePlayQueue::getQueue
May 03 21:40:58 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 03 21:40:58 volumio volumio[2903]: info: Received Get System Info
May 03 21:40:58 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 03 21:40:58 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 03 21:40:58 volumio volumio[2903]: info: Discovery: Getting this device information
May 03 21:40:58 volumio volumio[2903]: info: CoreCommandRouter::volumioGetState
May 03 21:40:58 volumio volumio[2903]: info: CorePlayQueue::getTrack 0
May 03 21:40:58 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::getUIConfigOnPlugin
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::volumioGetBrowseSources
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::volumioGetBrowseSources
May 03 21:41:05 volumio volumio[2903]: info: CoreCommandRouter::volumioGetBrowseSources
May 03 21:41:06 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:41:06 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 03 21:41:07 volumio volumio[2903]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
May 03 21:41:07 volumio volumio[2903]: verbose: ControllerMpd::sendMpdCommand rescan
May 03 21:41:07 volumio volumio[2903]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:41:07 volumio volumio[2903]: TypeError: Cannot read property 'then' of undefined
May 03 21:41:07 volumio volumio[2903]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
May 03 21:41:07 volumio volumio[2903]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15)
May 03 21:41:07 volumio volumio[2903]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
May 03 21:41:07 volumio volumio[2903]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26)
May 03 21:41:07 volumio volumio[2903]: at Socket.emit (events.js:315:20)
May 03 21:41:07 volumio volumio[2903]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 03 21:41:07 volumio volumio[2903]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 03 21:41:07 volumio volumio[2903]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:41:07 volumio sudo[3042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 21:40
May 03 21:41:07 volumio sudo[3042]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:07 volumio sudo[3042]: pam_unix(sudo:session): session closed for user root
May 03 21:41:07 volumio volumio-remote-updater[550]: [2024-05-03 21:41:07] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
May 03 21:41:07 volumio volumio-remote-updater[550]: [2024-05-03 21:41:07] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
May 03 21:41:07 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
May 03 21:41:07 volumio ntfs-3g[2949]: Unmounting /dev/sda5 ()
May 03 21:41:07 volumio systemd[1]: media-FE5CD09E5CD0534F.mount: Succeeded.
May 03 21:41:07 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
May 03 21:41:07 volumio systemd[1]: Started dynamicswap service.
May 03 21:41:07 volumio systemd[1]: dynamicswap.service: Succeeded.
May 03 21:41:08 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
May 03 21:41:08 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 9.
May 03 21:41:08 volumio systemd[1]: Started dynamicswap service.
May 03 21:41:08 volumio systemd[1]: Stopped Volumio Backend Module.
May 03 21:41:08 volumio systemd[1]: Started Volumio Backend Module.
May 03 21:41:08 volumio systemd[1]: dynamicswap.service: Succeeded.
May 03 21:41:09 volumio volumio[3056]: info: -------------------------------------------
May 03 21:41:09 volumio volumio[3056]: info: ----- Volumio3 ----
May 03 21:41:09 volumio volumio[3056]: info: -------------------------------------------
May 03 21:41:09 volumio volumio[3056]: info: ----- System startup ----
May 03 21:41:09 volumio volumio[3056]: info: -------------------------------------------
May 03 21:41:09 volumio volumio[3056]: info: MYVOLUMIO Environment detected
May 03 21:41:09 volumio volumio[3056]: info: Plugin folders cleanup
May 03 21:41:09 volumio volumio[3056]: info: Scanning into folder /volumio/app/plugins/
May 03 21:41:09 volumio volumio[3056]: info: Scanning category audio_interface
May 03 21:41:09 volumio volumio[3056]: info: Scanning category miscellanea
May 03 21:41:09 volumio volumio[3056]: info: Scanning category music_service
May 03 21:41:09 volumio volumio[3056]: info: Scanning category plugins.json
May 03 21:41:09 volumio volumio[3056]: info: Scanning category system_controller
May 03 21:41:09 volumio volumio[3056]: info: Scanning category user_interface
May 03 21:41:09 volumio volumio[3056]: info: Scanning into folder /data/plugins/
May 03 21:41:09 volumio volumio[3056]: info: Plugin folders cleanup completed
May 03 21:41:09 volumio volumio[3056]: info: -------------------------------------------
May 03 21:41:09 volumio volumio[3056]: info: ----- Core plugins startup ----
May 03 21:41:09 volumio volumio[3056]: info: -------------------------------------------
May 03 21:41:09 volumio volumio[3056]: info: Loading plugins from folder /volumio/app/plugins/
May 03 21:41:09 volumio volumio[3056]: info: Adding plugin upnp to MyMusic Plugins
May 03 21:41:09 volumio volumio[3056]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 03 21:41:09 volumio volumio[3056]: info: Adding plugin upnp_browser to MyMusic Plugins
May 03 21:41:09 volumio volumio[3056]: info: Loading plugins from folder /data/plugins/
May 03 21:41:09 volumio volumio[3056]: info: Loading plugin "system"...
May 03 21:41:09 volumio volumio[3056]: info: Loading plugin "appearance"...
May 03 21:41:10 volumio volumio[3056]: info: Loading plugin "network"...
May 03 21:41:10 volumio volumio[3056]: info: Refreshing Cached IP Addresses
May 03 21:41:10 volumio sudo[3082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 03 21:41:10 volumio sudo[3082]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:10 volumio sudo[3082]: pam_unix(sudo:session): session closed for user root
May 03 21:41:10 volumio sudo[3084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 03 21:41:10 volumio volumio[3056]: info: Loading plugin "services"...
May 03 21:41:10 volumio sudo[3084]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:10 volumio volumio[3056]: info: Loading plugin "alsa_controller"...
May 03 21:41:10 volumio sudo[3084]: pam_unix(sudo:session): session closed for user root
May 03 21:41:10 volumio sudo[3087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 03 21:41:10 volumio sudo[3087]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:10 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 03 21:41:10 volumio volumio[3056]: info: Loading plugin "wizard"...
May 03 21:41:10 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:10 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:10 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:41:10 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:41:10 volumio volumio[3056]: info: Loading plugin "networkfs"...
May 03 21:41:10 volumio volumio[3056]: info: Starting Udev Watcher for removable devices
May 03 21:41:10 volumio volumio[3056]: info: Ignoring mount for partition: boot
May 03 21:41:10 volumio volumio[3056]: info: Ignoring mount for partition: volumio
May 03 21:41:10 volumio volumio[3056]: info: Ignoring mount for partition: volumio_data
May 03 21:41:10 volumio volumio[3056]: error: Cannot associate FS Label, not mounting
May 03 21:41:10 volumio volumio[3056]: info: Mounting Device FE5CD09E5CD0534F
May 03 21:41:10 volumio sudo[3098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda5 /mnt/USB/FE5CD09E5CD0534F -o noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:41:10 volumio sudo[3098]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:11 volumio sudo[3087]: pam_unix(sudo:session): session closed for user root
May 03 21:41:12 volumio ntfs-3g[3101]: Version 2017.3.23AR.3 integrated FUSE 28
May 03 21:41:12 volumio ntfs-3g[3101]: Mounted /dev/sda5 (Read-Write, label "", NTFS 3.1)
May 03 21:41:12 volumio ntfs-3g[3101]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
May 03 21:41:12 volumio ntfs-3g[3101]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda5,blkdev,blksize=4096
May 03 21:41:12 volumio ntfs-3g[3101]: Global ownership and permissions enforced, configuration type 7
May 03 21:41:12 volumio sudo[3098]: pam_unix(sudo:session): session closed for user root
May 03 21:41:12 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "volumio_command_line_client"...
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "upnp"...
May 03 21:41:12 volumio volumio[3056]: info: [1714743672414] Starting Upmpd Daemon
May 03 21:41:12 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "my_music"...
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "mpd"...
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "upnp_browser"...
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "alarm-clock"...
May 03 21:41:12 volumio volumio-remote-updater[550]: [2024-05-03 21:41:12] [connect] Successful connection
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "airplay_emulation"...
May 03 21:41:12 volumio volumio[3056]: info: Starting Shairport Sync
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "last_100"...
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "webradio"...
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "i2s_dacs"...
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "volumiodiscovery"...
May 03 21:41:12 volumio volumio[3056]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 03 21:41:12 volumio volumio[3056]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:41:12 volumio node[3056]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 03 21:41:12 volumio volumio[3056]: *** WARNING *** For more information see
May 03 21:41:12 volumio volumio[3056]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 03 21:41:12 volumio volumio[3056]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:41:12 volumio volumio[3056]: *** WARNING *** For more information see
May 03 21:41:12 volumio node[3056]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:41:12 volumio node[3056]: *** WARNING *** For more information see
May 03 21:41:12 volumio node[3056]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 03 21:41:12 volumio node[3056]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 03 21:41:12 volumio node[3056]: *** WARNING *** For more information see
May 03 21:41:12 volumio volumio[3056]: info: Applying required configuration parameters for plugin volumiodiscovery
May 03 21:41:12 volumio volumio[3056]: info: Discovery: Started advertising with name: Volumio
May 03 21:41:12 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "outputs"...
May 03 21:41:12 volumio volumio[3056]: info: Loading plugin "albumart"...
May 03 21:41:13 volumio volumio[3056]: info: Plugin example_plugin is not enabled
May 03 21:41:13 volumio volumio[3056]: info: Loading plugin "inputs"...
May 03 21:41:13 volumio volumio[3056]: info: Loading plugin "updater_comm"...
May 03 21:41:13 volumio volumio[3056]: info: Plugin mpdemulation is not enabled
May 03 21:41:13 volumio volumio[3056]: info: Loading plugin "rest_api"...
May 03 21:41:13 volumio volumio[3056]: info: Loading plugin "websocket"...
May 03 21:41:13 volumio volumio[3056]: info: Loading i18n strings for locale zh
May 03 21:41:13 volumio volumio[3056]: Updating browse sources language
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 03 21:41:13 volumio volumio[3056]: Forking 3 albumart workers
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::initPlayerControls
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 03 21:41:13 volumio volumio[3056]: Express server listening on port 3000
May 03 21:41:13 volumio volumio[3056]: [Metrics] WebUI: 4s 581.04ms
May 03 21:41:13 volumio volumio[3056]: info: CoreStateMachine::resetVolumioState
May 03 21:41:13 volumio volumio[3056]: info: CoreStateMachine::getcurrentVolume
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::volumioRetrievevolume
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:41:13 volumio volumio[3056]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (Linux; U; Android 11; zh-cn; Redmi K20 Pro Premium Edition Build/RKQ1.200826.002) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/109.0.5414.118 Mobile Safari/537.36 XiaoMi/MiuiBrowser/18.2.150419 Total Clients: 1
May 03 21:41:13 volumio volumio-remote-updater[550]: [2024-05-03 21:41:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714743672 101
May 03 21:41:13 volumio volumio[3056]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 03 21:41:13 volumio volumio[3056]: info: Reloading queue from file
May 03 21:41:13 volumio volumio[3056]: info: CoreStateMachine::setRepeat true single undefined
May 03 21:41:13 volumio volumio[3056]: info: CoreStateMachine::pushState
May 03 21:41:13 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 03 21:41:13 volumio volumio[3056]: info: CoreStateMachine::setRandom false
May 03 21:41:13 volumio volumio[3056]: info: CoreStateMachine::pushState
May 03 21:41:13 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 03 21:41:13 volumio volumio[3056]: info: Setting Device type: Raspberry PI
May 03 21:41:13 volumio volumio[3056]: info: VolumeController:: Volume=100 Mute =true
May 03 21:41:13 volumio volumio[3056]: info: CoreStateMachine::pushState
May 03 21:41:13 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 03 21:41:13 volumio volumio[3056]: info: CoreStateMachine::updateTrackBlock
May 03 21:41:13 volumio volumio[3056]: info: CorePlayQueue::getTrackBlock
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::volumioRetrievevolume
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
May 03 21:41:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
May 03 21:41:13 volumio volumio[3056]: info: VolumeController:: Volume=100 Mute =true
May 03 21:41:13 volumio volumio[3056]: info: CoreStateMachine::pushState
May 03 21:41:13 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 03 21:41:13 volumio volumio[3056]: Starting albumart workers
May 03 21:41:13 volumio volumio[3056]: Starting albumart workers
May 03 21:41:13 volumio volumio[3056]: info: Discovery: adding f347ce9b-4c92-4e21-a676-4072e5be2fcc
May 03 21:41:13 volumio volumio[3056]: Starting albumart workers
May 03 21:41:13 volumio volumio[3056]: info: Discovery: Found device Volumio
May 03 21:41:13 volumio volumio[3056]: info: CoreCommandRouter::volumioGetState
May 03 21:41:13 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 03 21:41:16 volumio volumio[3056]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (Linux; U; Android 11; zh-cn; Redmi K20 Pro Premium Edition Build/RKQ1.200826.002) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/109.0.5414.118 Mobile Safari/537.36 XiaoMi/MiuiBrowser/18.2.150419 Total Clients: 3
May 03 21:41:16 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 03 21:41:16 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 03 21:41:16 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 03 21:41:16 volumio volumio[3056]: info: CoreCommandRouter::volumioGetVisibleSources
May 03 21:41:16 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 03 21:41:16 volumio volumio[3056]: info: CoreCommandRouter::volumioGetState
May 03 21:41:16 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 03 21:41:16 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 03 21:41:17 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 03 21:41:17 volumio volumio[3056]: info: Received Get System Info
May 03 21:41:17 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 03 21:41:17 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 03 21:41:17 volumio volumio[3056]: info: Discovery: Getting this device information
May 03 21:41:17 volumio volumio[3056]: info: CoreCommandRouter::volumioGetState
May 03 21:41:17 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 03 21:41:17 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 03 21:41:17 volumio volumio[3056]: info: CoreCommandRouter::volumioGetState
May 03 21:41:17 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 03 21:41:17 volumio volumio[3056]: info: Listing playlists
May 03 21:41:17 volumio volumio[3056]: info: CoreCommandRouter::volumioGetQueue
May 03 21:41:17 volumio volumio[3056]: info: CoreStateMachine::getQueue
May 03 21:41:17 volumio volumio[3056]: info: CorePlayQueue::getQueue
May 03 21:41:19 volumio volumio[3056]: info: CoreCommandRouter::getUIConfigOnPlugin
May 03 21:41:19 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 03 21:41:19 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
May 03 21:41:19 volumio sudo[3172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
May 03 21:41:19 volumio sudo[3172]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:19 volumio sudo[3177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
May 03 21:41:19 volumio sudo[3177]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:19 volumio sudo[3172]: pam_unix(sudo:session): session closed for user root
May 03 21:41:19 volumio sudo[3177]: pam_unix(sudo:session): session closed for user root
May 03 21:41:19 volumio sudo[3186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
May 03 21:41:19 volumio sudo[3186]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:19 volumio sudo[3186]: pam_unix(sudo:session): session closed for user root
May 03 21:41:19 volumio sudo[3191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
May 03 21:41:19 volumio sudo[3191]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:19 volumio sudo[3191]: pam_unix(sudo:session): session closed for user root
May 03 21:41:19 volumio sudo[3197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 03 21:41:19 volumio sudo[3197]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:19 volumio sudo[3197]: pam_unix(sudo:session): session closed for user root
May 03 21:41:19 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
May 03 21:41:19 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
May 03 21:41:19 volumio sudo[3201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 03 21:41:19 volumio sudo[3201]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:19 volumio sudo[3201]: pam_unix(sudo:session): session closed for user root
May 03 21:41:19 volumio sudo[3204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 03 21:41:19 volumio sudo[3204]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:21 volumio sudo[3204]: pam_unix(sudo:session): session closed for user root
May 03 21:41:22 volumio sudo[3207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 03 21:41:22 volumio sudo[3207]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:22 volumio sudo[3207]: pam_unix(sudo:session): session closed for user root
May 03 21:41:22 volumio sudo[3210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 03 21:41:22 volumio sudo[3210]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:22 volumio sudo[3210]: pam_unix(sudo:session): session closed for user root
May 03 21:41:22 volumio sudo[3213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 03 21:41:22 volumio sudo[3213]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 03 21:41:22 volumio sudo[3213]: pam_unix(sudo:session): session closed for user root
May 03 21:41:22 volumio volumio[3056]: info: Upmpdcli Daemon Started
May 03 21:41:29 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 03 21:41:29 volumio volumio[3056]: info: CURURI: albums://
May 03 21:41:29 volumio volumio[3056]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:41:29 volumio volumio[3056]: TypeError: Cannot read property 'sendCommand' of undefined
May 03 21:41:29 volumio volumio[3056]: at /volumio/app/plugins/music_service/mpd/index.js:2986:22
May 03 21:41:29 volumio volumio[3056]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 03 21:41:29 volumio volumio[3056]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 03 21:41:29 volumio sudo[3262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 21:40
May 03 21:41:29 volumio sudo[3262]: 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"