-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Sat 2025-07-05 09:06:51 CST. -- Jul 05 09:05:13 volumio systemd-timedated[1003]: Changed local time to Sat Jul 5 09:05:13 2025 Jul 05 09:05:13 volumio sudo[1001]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:13 volumio volumio-time-update[560]: volumio-time-update-util: System time updated successfully. Jul 05 09:05:13 volumio systemd[1]: Starting Daily apt download activities... Jul 05 09:05:13 volumio systemd[1]: Started Volumio Time Update Utility. Jul 05 09:05:13 volumio systemd[1]: Reached target Multi-User System. Jul 05 09:05:13 volumio systemd[1]: Reached target Graphical Interface. Jul 05 09:05:13 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jul 05 09:05:13 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jul 05 09:05:13 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jul 05 09:05:13 volumio volumio[966]: info: ------------------------------------------- Jul 05 09:05:13 volumio volumio[966]: info: ----- Volumio3 ---- Jul 05 09:05:13 volumio volumio[966]: info: ------------------------------------------- Jul 05 09:05:13 volumio volumio[966]: info: ----- System startup ---- Jul 05 09:05:13 volumio volumio[966]: info: ------------------------------------------- Jul 05 09:05:14 volumio sh[473]: timed out Jul 05 09:05:14 volumio dhcpcd[508]: timed out Jul 05 09:05:14 volumio sh[473]: dhcpcd exited Jul 05 09:05:14 volumio dhcpcd[508]: dhcpcd exited Jul 05 09:05:14 volumio sh[473]: ifup: failed to bring up eth0 Jul 05 09:05:14 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jul 05 09:05:14 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jul 05 09:05:15 volumio systemd[1]: apt-daily.service: Succeeded. Jul 05 09:05:15 volumio systemd[1]: Started Daily apt download activities. Jul 05 09:05:15 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jul 05 09:05:16 volumio volumio[966]: info: MYVOLUMIO Environment detected Jul 05 09:05:16 volumio volumio[966]: info: Plugin folders cleanup Jul 05 09:05:16 volumio volumio[966]: info: Scanning into folder /volumio/app/plugins/ Jul 05 09:05:16 volumio volumio[966]: info: Scanning category audio_interface Jul 05 09:05:16 volumio volumio[966]: info: Scanning category miscellanea Jul 05 09:05:16 volumio volumio[966]: info: Scanning category music_service Jul 05 09:05:16 volumio volumio[966]: info: Scanning category plugins.json Jul 05 09:05:16 volumio volumio[966]: info: Scanning category system_controller Jul 05 09:05:16 volumio volumio[966]: info: Scanning category user_interface Jul 05 09:05:16 volumio volumio[966]: info: Scanning into folder /data/plugins/ Jul 05 09:05:16 volumio volumio[966]: info: Plugin folders cleanup completed Jul 05 09:05:16 volumio volumio[966]: info: ------------------------------------------- Jul 05 09:05:16 volumio volumio[966]: info: ----- Core plugins startup ---- Jul 05 09:05:16 volumio volumio[966]: info: ------------------------------------------- Jul 05 09:05:16 volumio volumio[966]: info: Loading plugins from folder /volumio/app/plugins/ Jul 05 09:05:16 volumio volumio[966]: info: Adding plugin upnp to MyMusic Plugins Jul 05 09:05:16 volumio volumio[966]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 05 09:05:16 volumio volumio[966]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 05 09:05:16 volumio volumio[966]: info: Loading plugins from folder /data/plugins/ Jul 05 09:05:16 volumio volumio[966]: info: Loading plugin "system"... Jul 05 09:05:16 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 05 09:05:16 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jul 05 09:05:16 volumio systemd[1]: Startup finished in 16.103s (kernel) + 40.060s (userspace) = 56.163s. Jul 05 09:05:16 volumio volumio[966]: info: Loading plugin "appearance"... Jul 05 09:05:18 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jul 05 09:05:18 volumio volumio-remote-updater[575]: [2025-07-05 09:05:18] [connect] Successful connection Jul 05 09:05:19 volumio volumio[966]: info: Loading plugin "network"... Jul 05 09:05:19 volumio volumio[966]: info: Refreshing Cached IP Addresses Jul 05 09:05:19 volumio sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 05 09:05:19 volumio sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:19 volumio sudo[1127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 05 09:05:19 volumio sudo[1127]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:19 volumio sudo[1125]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:19 volumio sudo[1127]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:19 volumio volumio[966]: info: Loading plugin "services"... Jul 05 09:05:19 volumio volumio[966]: info: Loading plugin "alsa_controller"... Jul 05 09:05:19 volumio sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 05 09:05:19 volumio sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:19 volumio volumio[966]: warn: Unable to locate the audio output device E70 Velvet. Please configure a valid output device. Jul 05 09:05:19 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 05 09:05:19 volumio volumio[966]: info: Loading plugin "wizard"... Jul 05 09:05:19 volumio volumio[966]: info: Loading plugin "networkfs"... Jul 05 09:05:19 volumio volumio[966]: info: Starting Udev Watcher for removable devices Jul 05 09:05:20 volumio volumio[966]: info: Ignoring mount for partition: boot Jul 05 09:05:20 volumio volumio[966]: info: Ignoring mount for partition: volumio Jul 05 09:05:20 volumio volumio[966]: info: Ignoring mount for partition: volumio_data Jul 05 09:05:20 volumio volumio[966]: info: Mounting Device F4F2-C02C Jul 05 09:05:20 volumio sudo[1154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/F4F2-C02C -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jul 05 09:05:20 volumio sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:21 volumio sudo[1136]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:24 volumio kernel: usb 1-1.2: reset high-speed USB device number 4 using dwc_otg Jul 05 09:05:24 volumio kernel: sd 0:0:0:0: [sda] 120164352 512-byte logical blocks: (61.5 GB/57.3 GiB) Jul 05 09:05:24 volumio kernel: sda: sda1 Jul 05 09:05:24 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jul 05 09:05:24 volumio sudo[1154]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:24 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jul 05 09:05:24 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 05 09:05:24 volumio volumio[966]: info: Loading plugin "volumio_command_line_client"... Jul 05 09:05:24 volumio volumio[966]: info: Loading plugin "upnp"... Jul 05 09:05:24 volumio volumio[966]: info: [1751677524742] Starting Upmpd Daemon Jul 05 09:05:24 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 05 09:05:24 volumio volumio[966]: info: Loading plugin "my_music"... Jul 05 09:05:24 volumio volumio[966]: info: Loading plugin "mpd"... Jul 05 09:05:25 volumio volumio[966]: info: Loading plugin "upnp_browser"... Jul 05 09:05:26 volumio volumio[966]: info: Loading plugin "alarm-clock"... Jul 05 09:05:26 volumio volumio[966]: info: Loading plugin "airplay_emulation"... Jul 05 09:05:26 volumio volumio[966]: info: Starting Shairport Sync Jul 05 09:05:26 volumio volumio[966]: info: Loading plugin "last_100"... Jul 05 09:05:26 volumio volumio[966]: info: Loading plugin "webradio"... Jul 05 09:05:27 volumio volumio[966]: info: Loading plugin "i2s_dacs"... Jul 05 09:05:27 volumio volumio[966]: info: I2S DAC not set, start Auto-detection Jul 05 09:05:27 volumio volumio[966]: info: Loading plugin "volumiodiscovery"... Jul 05 09:05:27 volumio volumio[966]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 05 09:05:27 volumio volumio[966]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 05 09:05:27 volumio volumio[966]: *** WARNING *** For more information see Jul 05 09:05:27 volumio node[966]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 05 09:05:27 volumio volumio[966]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 05 09:05:27 volumio volumio[966]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 05 09:05:27 volumio volumio[966]: *** WARNING *** For more information see Jul 05 09:05:27 volumio node[966]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 05 09:05:27 volumio node[966]: *** WARNING *** For more information see Jul 05 09:05:27 volumio node[966]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 05 09:05:27 volumio node[966]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 05 09:05:27 volumio node[966]: *** WARNING *** For more information see Jul 05 09:05:27 volumio volumio[966]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 05 09:05:27 volumio volumio[966]: info: Discovery: Started advertising with name: Volumio Jul 05 09:05:27 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 05 09:05:27 volumio volumio[966]: info: Loading plugin "outputs"... Jul 05 09:05:27 volumio volumio[966]: info: Loading plugin "albumart"... Jul 05 09:05:27 volumio volumio[966]: info: Plugin example_plugin is not enabled Jul 05 09:05:27 volumio volumio[966]: info: Loading plugin "inputs"... Jul 05 09:05:27 volumio volumio[966]: info: Loading plugin "updater_comm"... Jul 05 09:05:28 volumio volumio[966]: info: Plugin mpdemulation is not enabled Jul 05 09:05:28 volumio volumio[966]: info: Loading plugin "rest_api"... Jul 05 09:05:28 volumio volumio[966]: info: Loading plugin "websocket"... Jul 05 09:05:28 volumio volumio[966]: info: Starting Socket.io Server version 2.3.0 Jul 05 09:05:28 volumio volumio[966]: info: Loading i18n strings for locale zh Jul 05 09:05:28 volumio volumio[966]: Updating browse sources language Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 09:05:28 volumio volumio[966]: Forking 3 albumart workers Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::initPlayerControls Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 05 09:05:28 volumio volumio[966]: Express server listening on port 3000 Jul 05 09:05:28 volumio volumio[966]: [Metrics] WebUI: 17s 201.65ms Jul 05 09:05:29 volumio volumio[966]: info: CoreStateMachine::resetVolumioState Jul 05 09:05:29 volumio volumio[966]: info: CoreStateMachine::getcurrentVolume Jul 05 09:05:29 volumio volumio[966]: info: CoreCommandRouter::volumioRetrievevolume Jul 05 09:05:29 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:05:29 volumio volumio[966]: info: Volumio Network Manager: Network status updated: 2 Jul 05 09:05:29 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:29 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 09:05:29 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:29 volumio volumio[966]: info: CoreStateMachine::updateTrackBlock Jul 05 09:05:29 volumio volumio[966]: info: CorePlayQueue::getTrackBlock Jul 05 09:05:29 volumio volumio[966]: info: CoreCommandRouter::volumioRetrievevolume Jul 05 09:05:29 volumio volumio[966]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/F4F2-C02C /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_00017413082024094215-0:0-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"28","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"F4F2-C02C","ID_FS_UUID_ENC":"F4F2-C02C","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5583","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"32","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"120164320","ID_PART_ENTRY_TYPE":"0xc","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_00017413082024094215-0:0","ID_SERIAL_SHORT":"00017413082024094215","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"1961","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"5745174"} Jul 05 09:05:29 volumio sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Jul 05 09:05:29 volumio sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:29 volumio sudo[1205]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:29 volumio systemd[1]: media-F4F2\x2dC02C.mount: Succeeded. Jul 05 09:05:29 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:29 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:29 volumio volumio[966]: info: Scanning new location : "USB/F4F2-C02C" Jul 05 09:05:29 volumio volumio[966]: info: Reloading queue from file Jul 05 09:05:29 volumio volumio[966]: info: Mounting Device F4F2-C02C Jul 05 09:05:30 volumio sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/F4F2-C02C -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jul 05 09:05:30 volumio sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:30 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jul 05 09:05:30 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jul 05 09:05:30 volumio sudo[1232]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:30 volumio volumio[966]: info: CoreStateMachine::setRepeat null single undefined Jul 05 09:05:30 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:30 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:30 volumio volumio[966]: info: CoreStateMachine::setRandom null Jul 05 09:05:30 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:30 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:30 volumio volumio[966]: info: Setting Device type: Raspberry PI Jul 05 09:05:30 volumio volumio[966]: Starting albumart workers Jul 05 09:05:30 volumio volumio[966]: info: Completed loading Core Plugins Jul 05 09:05:30 volumio volumio[966]: info: Preparing to generate the ALSA configuration file Jul 05 09:05:30 volumio volumio[966]: Starting albumart workers Jul 05 09:05:30 volumio volumio[966]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 05 09:05:30 volumio volumio[966]: info: Reading ALSA contributions from plugins. Jul 05 09:05:30 volumio volumio[966]: Starting albumart workers Jul 05 09:05:30 volumio volumio[966]: info: Asound.conf file unchanged, so no further update is needed Jul 05 09:05:30 volumio volumio[966]: info: Output device has changed, restarting MPD Jul 05 09:05:30 volumio volumio[966]: info: Output device has changed, restarting Shairport Sync Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:05:30 volumio sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 05 09:05:30 volumio sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:30 volumio sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 05 09:05:30 volumio sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:30 volumio sudo[1236]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:30 volumio volumio[966]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 05 09:05:30 volumio volumio[966]: info: ___________ START PLUGINS ___________ Jul 05 09:05:30 volumio systemd[1]: Stopping Music Player Daemon... Jul 05 09:05:30 volumio volumio[966]: info: ControllerMpd::onStart: Initializing MPD Jul 05 09:05:30 volumio volumio[966]: info: Creating MPD Configuration file Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 05 09:05:30 volumio volumio[966]: info: [1751677530651] CoreMusicLibrary::Adding element 媒体服务器 Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 09:05:30 volumio sudo[1245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 05 09:05:30 volumio sudo[1247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 05 09:05:30 volumio sudo[1245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:30 volumio sudo[1247]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:30 volumio sudo[1245]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:05:30 volumio systemd[1]: mpd.service: Succeeded. Jul 05 09:05:30 volumio systemd[1]: Stopped Music Player Daemon. Jul 05 09:05:30 volumio systemd[1]: Starting Music Player Daemon... Jul 05 09:05:30 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 05 09:05:30 volumio systemd[1]: mpd.service: Succeeded. Jul 05 09:05:30 volumio systemd[1]: Stopped Music Player Daemon. Jul 05 09:05:30 volumio systemd[1]: Starting Music Player Daemon... Jul 05 09:05:30 volumio volumio[966]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:30 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:05:31 volumio volumio[966]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 05 09:05:31 volumio volumio[966]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 05 09:05:31 volumio volumio[966]: info: [1751677531116] CoreMusicLibrary::Adding element Last_100 Jul 05 09:05:31 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 09:05:31 volumio volumio[966]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 05 09:05:31 volumio volumio[966]: info: [1751677531134] CoreMusicLibrary::Adding element Webradio Jul 05 09:05:31 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 09:05:31 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 05 09:05:31 volumio volumio[966]: info: Initializing BBC Radios Jul 05 09:05:31 volumio sudo[1254]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 05 09:05:31 volumio sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:31 volumio sudo[1254]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:31 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 05 09:05:31 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:05:31 volumio volumio[966]: info: Volumio Calling Home Jul 05 09:05:32 volumio volumio[966]: info: Discovery: adding 36b1576d-1b13-4180-82e6-8e4f49dafe09 Jul 05 09:05:32 volumio volumio[966]: info: Discovery: Found device Volumio Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Jul 05 09:05:32 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:32 volumio volumio[966]: info: MPD Permissions set Jul 05 09:05:32 volumio volumio[966]: info: MPD Permissions set Jul 05 09:05:32 volumio volumio[966]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: Volumio called home Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:05:32 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Jul 05 09:05:32 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:32 volumio volumio[966]: info: Starting Shairport Sync Jul 05 09:05:32 volumio volumio[966]: info: Starting Shairport Sync Jul 05 09:05:32 volumio volumio[966]: info: Starting Shairport Sync Jul 05 09:05:32 volumio sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 05 09:05:32 volumio sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:32 volumio sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 05 09:05:32 volumio sudo[1308]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:32 volumio sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 05 09:05:32 volumio sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:32 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 05 09:05:32 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 05 09:05:32 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 05 09:05:32 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 05 09:05:32 volumio sudo[1308]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:32 volumio sudo[1306]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:32 volumio volumio[966]: info: Shairport-Sync Started Jul 05 09:05:32 volumio volumio[966]: Error adding Membership: Error: addMembership EINVAL Jul 05 09:05:32 volumio volumio[966]: info: Shairport-Sync Started Jul 05 09:05:32 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 05 09:05:32 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 05 09:05:32 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 05 09:05:32 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 05 09:05:32 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 05 09:05:32 volumio sudo[1311]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:33 volumio volumio[966]: info: Shairport-Sync Started Jul 05 09:05:33 volumio volumio[966]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/F4F2-C02C Jul 05 09:05:33 volumio volumio-remote-updater[575]: [2025-07-05 09:05:33] [connect] Successful connection Jul 05 09:05:33 volumio volumio-remote-updater[575]: [2025-07-05 09:05:33] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751677533 101 Jul 05 09:05:33 volumio volumio[966]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Jul 05 09:05:34 volumio mpd[1261]: Jul 05 09:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 05 09:05:34 volumio systemd[1]: Started Music Player Daemon. Jul 05 09:05:34 volumio sudo[1238]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:34 volumio sudo[1247]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:34 volumio volumio[966]: info: Completed starting Core Plugins Jul 05 09:05:34 volumio volumio[966]: info: ------------------------------------------- Jul 05 09:05:34 volumio volumio[966]: info: ----- MyVolumio plugins startup ---- Jul 05 09:05:34 volumio volumio[966]: info: ------------------------------------------- Jul 05 09:05:34 volumio volumio[966]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 05 09:05:34 volumio volumio[966]: error: MPD error: The expression evaluated to a falsy value: Jul 05 09:05:34 volumio volumio[966]: assert.ok(self.idling) Jul 05 09:05:34 volumio volumio[966]: error: The expression evaluated to a falsy value: Jul 05 09:05:34 volumio volumio[966]: assert.ok(self.idling) Jul 05 09:05:34 volumio volumio[966]: info: MPD running with PID1261 Jul 05 09:05:34 volumio volumio[966]: ,establishing connection Jul 05 09:05:34 volumio volumio[966]: error: MPD error: The expression evaluated to a falsy value: Jul 05 09:05:34 volumio volumio[966]: assert.ok(self.idling) Jul 05 09:05:34 volumio volumio[966]: error: The expression evaluated to a falsy value: Jul 05 09:05:34 volumio volumio[966]: assert.ok(self.idling) Jul 05 09:05:34 volumio volumio[966]: info: Scanning removed location : "USB/F4F2-C02C" Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:05:34 volumio volumio[966]: info: Jul 05 09:05:34 volumio volumio[966]: ---------------------------- MPD announces state update: update Jul 05 09:05:34 volumio sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 05 09:05:34 volumio volumio[966]: error: updateQueue error: null Jul 05 09:05:34 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:05:34 volumio sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:05:34 volumio volumio[966]: info: Jul 05 09:05:34 volumio volumio[966]: ---------------------------- MPD announces state update: update Jul 05 09:05:34 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:05:34 volumio sudo[1330]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:05:34 volumio volumio[966]: info: Jul 05 09:05:34 volumio volumio[966]: ---------------------------- MPD announces state update: update Jul 05 09:05:34 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:05:34 volumio sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 05 09:05:34 volumio sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:34 volumio volumio[966]: info: sendMpdCommand status took 41 milliseconds Jul 05 09:05:34 volumio volumio[966]: info: sendMpdCommand status took 31 milliseconds Jul 05 09:05:34 volumio volumio[966]: info: sendMpdCommand status took 28 milliseconds Jul 05 09:05:34 volumio volumio[966]: info: sendMpdCommand status took 24 milliseconds Jul 05 09:05:34 volumio volumio[966]: info: sendMpdCommand status took 22 milliseconds Jul 05 09:05:34 volumio volumio[966]: info: sendMpdCommand status took 18 milliseconds Jul 05 09:05:34 volumio sudo[1332]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:05:34 volumio volumio[966]: info: Command Router : Notfying DB Updatetrue Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:05:34 volumio volumio[966]: info: Command Router : Notfying DB Updatetrue Jul 05 09:05:34 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:05:34 volumio volumio[966]: info: Command Router : Notfying DB Updatetrue Jul 05 09:05:34 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Jul 05 09:05:34 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:05:35 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 05 09:05:35 volumio volumio[966]: verbose: CURRENT POSITION 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:35 volumio volumio[966]: info: No code Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:35 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 05 09:05:35 volumio volumio[966]: verbose: CURRENT POSITION 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:35 volumio volumio[966]: info: No code Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:35 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 05 09:05:35 volumio volumio[966]: verbose: CURRENT POSITION 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:35 volumio volumio[966]: info: No code Jul 05 09:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:05:35 volumio volumio[966]: info: ------------------------------ 333ms Jul 05 09:05:35 volumio volumio[966]: info: ------------------------------ 322ms Jul 05 09:05:35 volumio volumio[966]: info: ------------------------------ 318ms Jul 05 09:05:35 volumio sudo[1342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 05 09:05:35 volumio sudo[1342]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:35 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 05 09:05:35 volumio sudo[1342]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:35 volumio volumio[966]: info: Upmpdcli Daemon Started Jul 05 09:05:35 volumio volumio[1344]: Generating RSA private key, 4096 bit long modulus (2 primes) Jul 05 09:05:40 volumio volumio[1344]: ...............++++ Jul 05 09:05:43 volumio systemd[1]: systemd-timedated.service: Succeeded. Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 05 09:05:43 volumio volumio[966]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 05 09:05:43 volumio volumio[966]: info: Adding plugin bluetooth to MyMusic Plugins Jul 05 09:05:43 volumio volumio[966]: info: Adding plugin multiroom to MyMusic Plugins Jul 05 09:05:43 volumio volumio[966]: info: Adding plugin metavolumio to MyMusic Plugins Jul 05 09:05:44 volumio volumio[966]: info: Adding plugin cd_controller to MyMusic Plugins Jul 05 09:05:44 volumio volumio[966]: info: Adding plugin qobuzconnect to MyMusic Plugins Jul 05 09:05:44 volumio volumio[966]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 05 09:05:44 volumio volumio[966]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 05 09:05:44 volumio volumio[966]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 05 09:05:47 volumio volumio[966]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 05 09:05:47 volumio volumio[966]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 05 09:05:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:05:47 volumio volumio[966]: info: Starting MyVolumio Remote Streaming Endpoints Jul 05 09:05:47 volumio volumio[966]: info: MyVolumio not started Jul 05 09:05:47 volumio volumio[966]: info: Initializing device activation check Jul 05 09:05:47 volumio volumio[966]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 05 09:05:47 volumio volumio[966]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 05 09:05:50 volumio volumio[966]: info: Starting Streaming Service Transparent Proxy Jul 05 09:05:50 volumio volumio[966]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 05 09:05:50 volumio volumio[966]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 05 09:05:50 volumio volumio[966]: info: Streaming services startup Jul 05 09:05:50 volumio volumio[966]: info: Starting Streaming Daemon Jul 05 09:05:50 volumio volumio[966]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 05 09:05:50 volumio sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 05 09:05:50 volumio sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:05:50 volumio sudo[1429]: pam_unix(sudo:session): session closed for user root Jul 05 09:05:50 volumio volumio[966]: error: Cannot start Volumio Streaming Daemon Jul 05 09:05:50 volumio volumio[966]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 05 09:05:50 volumio volumio[966]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 05 09:05:52 volumio volumio[966]: STREAMING PROXY: Starting server on port 3245 Jul 05 09:05:52 volumio volumio[966]: Node JS runtime: 14 Jul 05 09:05:53 volumio ntpd[738]: Soliciting pool server 202.118.1.130 Jul 05 09:05:53 volumio ntpd[738]: Soliciting pool server 202.118.1.81 Jul 05 09:05:54 volumio ntpd[738]: Soliciting pool server 193.182.111.143 Jul 05 09:05:54 volumio ntpd[738]: Soliciting pool server 119.28.183.184 Jul 05 09:05:54 volumio ntpd[738]: Soliciting pool server 193.182.111.12 Jul 05 09:05:55 volumio ntpd[738]: Soliciting pool server 185.209.85.222 Jul 05 09:05:56 volumio ntpd[738]: Soliciting pool server 111.230.189.174 Jul 05 09:05:57 volumio ntpd[738]: Soliciting pool server 84.16.73.33 Jul 05 09:05:57 volumio ntpd[738]: Soliciting pool server 210.28.130.4 Jul 05 09:05:57 volumio ntpd[738]: Soliciting pool server 193.182.111.141 Jul 05 09:05:57 volumio ntpd[738]: Soliciting pool server 139.199.215.251 Jul 05 09:06:01 volumio ntpd[738]: receive: Unexpected origin timestamp 0xec12f8f7.f96785c6 does not match aorg 0000000000.00000000 from server@193.182.111.12 xmt 0xec12f8f9.94090eb6 Jul 05 09:06:02 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 05 09:06:02 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:06:02 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 09:06:03 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 05 09:06:03 volumio volumio-remote-updater[575]: No test mode Jul 05 09:06:03 volumio volumio-remote-updater[575]: No alpha test mode Jul 05 09:06:03 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 05 09:06:03 volumio volumio[966]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jul 05 09:06:03 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Jul 05 09:06:03 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:04 volumio volumio[966]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n
    \n
  • Disable UI controls during DLNA playback
    • \n
  • Fix for Cast functionality halting due to memory filling up
    • \n
  • Fix for XML parsing on web-radio search
    • \n
\n

NEW ADDITIONS

\n
    \n
  • Add link for downloading CORRD in the side-menu
    • \n
\n","title":"Update v3.819","updateavailable":true} Jul 05 09:06:04 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 05 09:06:08 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:06:08 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:06:08 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 05 09:06:08 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 05 09:06:08 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 05 09:06:08 volumio volumio[966]: info: CoreCommandRouter::volumioGetBrowseSources Jul 05 09:06:08 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 05 09:06:10 volumio volumio[1344]: ...........................................................................................................++++ Jul 05 09:06:10 volumio volumio[1344]: e is 65537 (0x010001) Jul 05 09:06:10 volumio volumio[1344]: writing RSA key Jul 05 09:06:11 volumio volumio[966]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jul 05 09:06:11 volumio volumio[966]: info: Completed starting MyVolumio Plugin Jul 05 09:06:11 volumio volumio[966]: [Metrics] CommandRouter: 56s 426.55ms Jul 05 09:06:11 volumio volumio[966]: info: CoreCommandRouter::volumiosetStartupVolume Jul 05 09:06:11 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 09:06:11 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 09:06:11 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Jul 05 09:06:11 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Jul 05 09:06:11 volumio volumio[966]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Jul 05 09:06:11 volumio volumio[966]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Jul 05 09:06:11 volumio volumio[966]: aplay: main:828: audio open error: No such device Jul 05 09:06:12 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 05 09:06:12 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 05 09:06:12 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jul 05 09:06:12 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 05 09:06:18 volumio volumio[966]: info: BOOT COMPLETED Jul 05 09:06:26 volumio volumio[966]: info: MPD Database updated - AlbumList cache refreshed Jul 05 09:06:26 volumio volumio[966]: info: Jul 05 09:06:26 volumio volumio[966]: ---------------------------- MPD announces state update: database Jul 05 09:06:26 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:26 volumio volumio[966]: info: Jul 05 09:06:26 volumio volumio[966]: ---------------------------- MPD announces state update: update Jul 05 09:06:26 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:26 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:26 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:26 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:26 volumio volumio[966]: info: MPD Database updated - AlbumList cache refreshed Jul 05 09:06:26 volumio volumio[966]: info: Jul 05 09:06:26 volumio volumio[966]: ---------------------------- MPD announces state update: database Jul 05 09:06:26 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:26 volumio volumio[966]: info: Jul 05 09:06:26 volumio volumio[966]: ---------------------------- MPD announces state update: update Jul 05 09:06:26 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:26 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:26 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:26 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:26 volumio volumio[966]: info: MPD Database updated - AlbumList cache refreshed Jul 05 09:06:26 volumio volumio[966]: info: Jul 05 09:06:26 volumio volumio[966]: ---------------------------- MPD announces state update: database Jul 05 09:06:26 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:26 volumio volumio[966]: info: Jul 05 09:06:26 volumio volumio[966]: ---------------------------- MPD announces state update: update Jul 05 09:06:26 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:26 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:26 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:26 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:27 volumio volumio[966]: info: sendMpdCommand status took 1412 milliseconds Jul 05 09:06:27 volumio volumio[966]: info: sendMpdCommand status took 1409 milliseconds Jul 05 09:06:27 volumio volumio[966]: info: sendMpdCommand status took 1409 milliseconds Jul 05 09:06:27 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:28 volumio volumio[966]: info: Command Router : Notfying DB Updatefalse Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Jul 05 09:06:28 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:28 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:28 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 05 09:06:28 volumio volumio[966]: verbose: CURRENT POSITION 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: No code Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 05 09:06:28 volumio volumio[966]: verbose: CURRENT POSITION 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: No code Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: ------------------------------ 1586ms Jul 05 09:06:28 volumio volumio[966]: info: ------------------------------ 1587ms Jul 05 09:06:28 volumio volumio[966]: info: sendMpdCommand status took 2319 milliseconds Jul 05 09:06:28 volumio volumio[966]: info: sendMpdCommand status took 2306 milliseconds Jul 05 09:06:28 volumio volumio[966]: info: sendMpdCommand status took 2305 milliseconds Jul 05 09:06:28 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:28 volumio volumio[966]: info: Command Router : Notfying DB Updatefalse Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Jul 05 09:06:28 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:28 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:28 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 05 09:06:28 volumio volumio[966]: verbose: CURRENT POSITION 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: No code Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 05 09:06:28 volumio volumio[966]: verbose: CURRENT POSITION 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: No code Jul 05 09:06:28 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:28 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:28 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:28 volumio volumio[966]: info: ------------------------------ 2454ms Jul 05 09:06:28 volumio volumio[966]: info: ------------------------------ 2456ms Jul 05 09:06:29 volumio volumio[966]: info: sendMpdCommand status took 3219 milliseconds Jul 05 09:06:29 volumio volumio[966]: info: sendMpdCommand status took 3218 milliseconds Jul 05 09:06:29 volumio volumio[966]: info: sendMpdCommand status took 3217 milliseconds Jul 05 09:06:29 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:29 volumio volumio[966]: info: Command Router : Notfying DB Updatefalse Jul 05 09:06:29 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Jul 05 09:06:29 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:29 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:29 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:29 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:29 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:29 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 05 09:06:29 volumio volumio[966]: verbose: CURRENT POSITION 0 Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:29 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:29 volumio volumio[966]: info: No code Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:29 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:29 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:29 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:29 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:29 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 05 09:06:29 volumio volumio[966]: verbose: CURRENT POSITION 0 Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:29 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:29 volumio volumio[966]: info: No code Jul 05 09:06:29 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:29 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:29 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:29 volumio volumio[966]: info: ------------------------------ 3362ms Jul 05 09:06:29 volumio volumio[966]: info: ------------------------------ 3364ms Jul 05 09:06:30 volumio sudo[1519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 05 09:06:30 volumio sudo[1519]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:06:30 volumio sudo[1519]: pam_unix(sudo:session): session closed for user root Jul 05 09:06:30 volumio sudo[1521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 05 09:06:30 volumio sudo[1521]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:06:30 volumio sudo[1521]: pam_unix(sudo:session): session closed for user root Jul 05 09:06:31 volumio volumio[966]: verbose: New Socket.io Connection to 192.168.1.113 from 192.168.1.103 UA: Mozilla/5.0 (Linux; U; Android 14; zh-cn; RMX3920 Build/UKQ1.231108.001) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/115.0.5790.168 Mobile Safari/537.36 HeyTapBrowser/40.9.7.1 Engine version: 3 Transport: polling Total Clients: 4 Jul 05 09:06:31 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 09:06:31 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 05 09:06:31 volumio sudo[1538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 05 09:06:31 volumio sudo[1538]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:06:31 volumio sudo[1538]: pam_unix(sudo:session): session closed for user root Jul 05 09:06:31 volumio sudo[1541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 05 09:06:31 volumio sudo[1541]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 09:06:32 volumio sudo[1541]: pam_unix(sudo:session): session closed for user root Jul 05 09:06:32 volumio volumio[966]: verbose: New Socket.io Connection to 192.168.1.113 from 192.168.1.103 UA: Mozilla/5.0 (Linux; U; Android 14; zh-cn; RMX3920 Build/UKQ1.231108.001) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/115.0.5790.168 Mobile Safari/537.36 HeyTapBrowser/40.9.7.1 Engine version: 3 Transport: polling Total Clients: 5 Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Jul 05 09:06:32 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 09:06:32 volumio volumio[966]: info: Received Get System Info Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 09:06:32 volumio volumio[966]: info: Discovery: Getting this device information Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Jul 05 09:06:32 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Jul 05 09:06:32 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:32 volumio volumio[966]: info: Listing playlists Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 05 09:06:32 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 05 09:06:33 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 05 09:06:33 volumio volumio[966]: info: Received Get System Info Jul 05 09:06:33 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 09:06:33 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 09:06:33 volumio volumio[966]: info: Discovery: Getting this device information Jul 05 09:06:33 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Jul 05 09:06:33 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Jul 05 09:06:33 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 09:06:34 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 05 09:06:37 volumio volumio[966]: info: CoreCommandRouter::volumioGetQueue Jul 05 09:06:37 volumio volumio[966]: info: CoreStateMachine::getQueue Jul 05 09:06:37 volumio volumio[966]: info: CorePlayQueue::getQueue Jul 05 09:06:39 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 05 09:06:39 volumio volumio[966]: info: CURURI: music-library Jul 05 09:06:39 volumio volumio[966]: info: Preload queue cleared Jul 05 09:06:40 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 05 09:06:40 volumio volumio[966]: info: CURURI: music-library/USB Jul 05 09:06:40 volumio volumio[966]: info: Preload queue cleared Jul 05 09:06:41 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 05 09:06:41 volumio volumio[966]: info: CURURI: music-library/USB/F4F2-C02C Jul 05 09:06:41 volumio volumio[966]: info: Preload queue cleared Jul 05 09:06:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 05 09:06:42 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 05 09:06:42 volumio volumio[966]: info: CURURI: music-library/USB/F4F2-C02C/Music Jul 05 09:06:42 volumio volumio[966]: info: Preload queue cleared Jul 05 09:06:45 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 05 09:06:45 volumio volumio[966]: info: CURURI: music-library/USB/F4F2-C02C/Music/五輪真弓 Jul 05 09:06:46 volumio volumio[966]: info: Preload queue cleared Jul 05 09:06:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 05 09:06:47 volumio volumio[966]: info: CURURI: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection Jul 05 09:06:47 volumio volumio[966]: info: Preload queue cleared Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/01 重演.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/02 戀人啊.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/04 再見不許說.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/05 合鍵.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/06 灰燼.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/07 小丑.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/08 約誓.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/09 雨中的二人.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/10 知己.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/11 不問香煙.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/12 Jungle Gym 作家.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/13 光陰之中, 變成小鳥吧!.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/14 戀愛摯友.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/15 手錶.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/16 你突然….mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/17 避雨.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/18 擁抱吧! 戀愛好像是美夢.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/19 不要哭吧!.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Preloading song: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/20 海鷗.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/01 重演.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F01%20%E9%87%8D%E6%BC%94.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/01 重演.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/02 戀人啊.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F02%20%E6%88%80%E4%BA%BA%E5%95%8A.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/02 戀人啊.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F03%20%E4%B8%80%E8%91%89%E8%88%9F.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/04 再見不許說.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F04%20%E5%86%8D%E8%A6%8B%E4%B8%8D%E8%A8%B1%E8%AA%AA.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/04 再見不許說.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/05 合鍵.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F05%20%E5%90%88%E9%8D%B5.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/05 合鍵.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/06 灰燼.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F06%20%E7%81%B0%E7%87%BC.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/06 灰燼.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/07 小丑.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F07%20%E5%B0%8F%E4%B8%91.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/07 小丑.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/08 約誓.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F08%20%E7%B4%84%E8%AA%93.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/08 約誓.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/09 雨中的二人.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F09%20%E9%9B%A8%E4%B8%AD%E7%9A%84%E4%BA%8C%E4%BA%BA.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/09 雨中的二人.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/10 知己.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F10%20%E7%9F%A5%E5%B7%B1.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/10 知己.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/11 不問香煙.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F11%20%E4%B8%8D%E5%95%8F%E9%A6%99%E7%85%99.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/11 不問香煙.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/12 Jungle Gym 作家.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F12%20Jungle%20Gym%20%E4%BD%9C%E5%AE%B6.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/12 Jungle Gym 作家.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/13 光陰之中, 變成小鳥吧!.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F13%20%E5%85%89%E9%99%B0%E4%B9%8B%E4%B8%AD%2C%20%E8%AE%8A%E6%88%90%E5%B0%8F%E9%B3%A5%E5%90%A7!.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/13 光陰之中, 變成小鳥吧!.mp3 Jul 05 09:06:47 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/14 戀愛摯友.mp3 in service mpd Jul 05 09:06:47 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F14%20%E6%88%80%E6%84%9B%E6%91%AF%E5%8F%8B.mp3&metadata=false Jul 05 09:06:47 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/14 戀愛摯友.mp3 Jul 05 09:06:48 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/15 手錶.mp3 in service mpd Jul 05 09:06:48 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F15%20%E6%89%8B%E9%8C%B6.mp3&metadata=false Jul 05 09:06:48 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/15 手錶.mp3 Jul 05 09:06:48 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/16 你突然….mp3 in service mpd Jul 05 09:06:48 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F16%20%E4%BD%A0%E7%AA%81%E7%84%B6%E2%80%A6.mp3&metadata=false Jul 05 09:06:48 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/16 你突然….mp3 Jul 05 09:06:48 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/17 避雨.mp3 in service mpd Jul 05 09:06:48 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F17%20%E9%81%BF%E9%9B%A8.mp3&metadata=false Jul 05 09:06:48 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/17 避雨.mp3 Jul 05 09:06:48 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/18 擁抱吧! 戀愛好像是美夢.mp3 in service mpd Jul 05 09:06:48 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F18%20%E6%93%81%E6%8A%B1%E5%90%A7!%20%E6%88%80%E6%84%9B%E5%A5%BD%E5%83%8F%E6%98%AF%E7%BE%8E%E5%A4%A2.mp3&metadata=false Jul 05 09:06:48 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/18 擁抱吧! 戀愛好像是美夢.mp3 Jul 05 09:06:48 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/19 不要哭吧!.mp3 in service mpd Jul 05 09:06:48 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F19%20%E4%B8%8D%E8%A6%81%E5%93%AD%E5%90%A7!.mp3&metadata=false Jul 05 09:06:48 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/19 不要哭吧!.mp3 Jul 05 09:06:48 volumio volumio[966]: info: Exploding uri music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/20 海鷗.mp3 in service mpd Jul 05 09:06:48 volumio volumio[966]: info: ALBUMART /albumart?cacheid=279&web=%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93/%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection/extralarge&path=%2Fmnt%2FUSB%2FF4F2-C02C%2FMusic%2F%E4%BA%94%E8%BC%AA%E7%9C%9F%E5%BC%93%2F%E7%9C%9F%E5%BC%93%E5%82%B3%20The%20Legendary%20Collection%2F20%20%E6%B5%B7%E9%B7%97.mp3&metadata=false Jul 05 09:06:48 volumio volumio[966]: info: URI /mnt/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/20 海鷗.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Preload queue cleared Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::ClearQueue Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::stop Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::clearPlayQueue Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::saveQueue Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::addQueueItems Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::addQueueItems Jul 05 09:06:49 volumio volumio[966]: info: Preload queue cleared Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/01 重演.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/01 重演.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/02 戀人啊.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/02 戀人啊.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3 Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::saveQueue Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::updateTrackBlock Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::getTrackBlock Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::volumioPlay Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::play index 2 Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::addQueueItems Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::addQueueItems Jul 05 09:06:49 volumio volumio[966]: info: Preload queue cleared Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/04 再見不許說.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/04 再見不許說.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/05 合鍵.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/05 合鍵.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/06 灰燼.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/06 灰燼.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/07 小丑.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/07 小丑.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/08 約誓.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/08 約誓.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/09 雨中的二人.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/09 雨中的二人.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/10 知己.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/10 知己.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/11 不問香煙.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/11 不問香煙.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/12 Jungle Gym 作家.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/12 Jungle Gym 作家.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/13 光陰之中, 變成小鳥吧!.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/13 光陰之中, 變成小鳥吧!.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/14 戀愛摯友.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/14 戀愛摯友.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/15 手錶.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/15 手錶.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/16 你突然….mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/16 你突然….mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/17 避雨.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/17 避雨.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/18 擁抱吧! 戀愛好像是美夢.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/18 擁抱吧! 戀愛好像是美夢.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/19 不要哭吧!.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/19 不要哭吧!.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Adding Item to queue: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/20 海鷗.mp3 Jul 05 09:06:49 volumio volumio[966]: info: Using cached record of: music-library/USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/20 海鷗.mp3 Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::stop Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::saveQueue Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::play index undefined Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::updateTrackBlock Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::getTrackBlock Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::startPlaybackTimer Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::clearAddPlayTracks USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3 Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand stop took 17 milliseconds Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces system playlist update Jul 05 09:06:49 volumio volumio[966]: info: Ignoring MPD Status Update Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand clear took 6 milliseconds Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand add "USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3" Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces system playlist update Jul 05 09:06:49 volumio volumio[966]: info: Ignoring MPD Status Update Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces system playlist update Jul 05 09:06:49 volumio volumio[966]: info: Ignoring MPD Status Update Jul 05 09:06:49 volumio volumio[966]: error: updateQueue error: null Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces system playlist update Jul 05 09:06:49 volumio volumio[966]: info: Ignoring MPD Status Update Jul 05 09:06:49 volumio volumio[966]: info: ------------------------------ 21ms Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand add "USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3" took 17 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: ------------------------------ 13ms Jul 05 09:06:49 volumio volumio[966]: info: ------------------------------ 11ms Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand play Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces system playlist update Jul 05 09:06:49 volumio volumio[966]: info: Ignoring MPD Status Update Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces system playlist update Jul 05 09:06:49 volumio volumio[966]: info: Ignoring MPD Status Update Jul 05 09:06:49 volumio volumio[966]: error: Upnp client error: Error: This socket has been ended by the other party Jul 05 09:06:49 volumio volumio[966]: info: ------------------------------ 28ms Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand play took 21 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: ------------------------------ 20ms Jul 05 09:06:49 volumio volumio[966]: info: ------------------------------ 17ms Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces state update: player Jul 05 09:06:49 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces state update: player Jul 05 09:06:49 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces state update: player Jul 05 09:06:49 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces state update: player Jul 05 09:06:49 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand status took 25 milliseconds Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces state update: player Jul 05 09:06:49 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand status took 42 milliseconds Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand status took 41 milliseconds Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand status took 40 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand clearerror took 27 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand playlistinfo took 24 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand status took 21 milliseconds Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 09:06:49 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:49 volumio volumio[966]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一葉舟","artist":"五輪真弓","album":"真弓傳 The Legendary Collection","uri":"USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3","trackType":"mp3"} Jul 05 09:06:49 volumio volumio[966]: verbose: CURRENT POSITION 2 Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::syncState stateService pause Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:49 volumio volumio[966]: info: ------------------------------ 115ms Jul 05 09:06:49 volumio volumio[966]: info: Jul 05 09:06:49 volumio volumio[966]: ---------------------------- MPD announces state update: player Jul 05 09:06:49 volumio volumio[966]: info: ControllerMpd::getState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand clearerror took 83 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand clearerror took 81 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand clearerror took 79 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand playlistinfo took 62 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand playlistinfo took 61 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand playlistinfo took 60 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand playlistinfo took 56 milliseconds Jul 05 09:06:49 volumio volumio[966]: info: sendMpdCommand status took 13 milliseconds Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::parseState Jul 05 09:06:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 09:06:49 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:49 volumio volumio[966]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一葉舟","artist":"五輪真弓","album":"真弓傳 The Legendary Collection","uri":"USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3","trackType":"mp3"} Jul 05 09:06:49 volumio volumio[966]: verbose: CURRENT POSITION 2 Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::syncState stateService pause Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:49 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:49 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:50 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:50 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:50 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:50 volumio volumio[966]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一葉舟","artist":"五輪真弓","album":"真弓傳 The Legendary Collection","uri":"USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3","trackType":"mp3"} Jul 05 09:06:50 volumio volumio[966]: verbose: CURRENT POSITION 2 Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::syncState stateService pause Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:50 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:50 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:50 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:50 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:50 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:50 volumio volumio[966]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一葉舟","artist":"五輪真弓","album":"真弓傳 The Legendary Collection","uri":"USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3","trackType":"mp3"} Jul 05 09:06:50 volumio volumio[966]: verbose: CURRENT POSITION 2 Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::syncState stateService pause Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:50 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:50 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:50 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:50 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:50 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:50 volumio volumio[966]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一葉舟","artist":"五輪真弓","album":"真弓傳 The Legendary Collection","uri":"USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3","trackType":"mp3"} Jul 05 09:06:50 volumio volumio[966]: verbose: CURRENT POSITION 2 Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::syncState stateService pause Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:50 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:50 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:50 volumio volumio[966]: info: ------------------------------ 225ms Jul 05 09:06:50 volumio volumio[966]: info: ------------------------------ 223ms Jul 05 09:06:50 volumio volumio[966]: info: ------------------------------ 221ms Jul 05 09:06:50 volumio volumio[966]: info: ------------------------------ 202ms Jul 05 09:06:50 volumio volumio[966]: info: sendMpdCommand playlistinfo took 99 milliseconds Jul 05 09:06:50 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Jul 05 09:06:50 volumio volumio[966]: info: ControllerMpd::pushState Jul 05 09:06:50 volumio volumio[966]: info: CoreCommandRouter::servicePushState Jul 05 09:06:50 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:50 volumio volumio[966]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一葉舟","artist":"五輪真弓","album":"真弓傳 The Legendary Collection","uri":"USB/F4F2-C02C/Music/五輪真弓/真弓傳 The Legendary Collection/03 一葉舟.mp3","trackType":"mp3"} Jul 05 09:06:50 volumio volumio[966]: verbose: CURRENT POSITION 2 Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::syncState stateService pause Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Jul 05 09:06:50 volumio volumio[966]: info: CoreStateMachine::pushState Jul 05 09:06:50 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Jul 05 09:06:50 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 09:06:50 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Jul 05 09:06:50 volumio volumio[966]: info: ------------------------------ 147ms Jul 05 09:06:50 volumio volumio[966]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 09:06:50 volumio volumio[966]: Error: connect ECONNREFUSED 4.78.139.50:443 Jul 05 09:06:50 volumio volumio[966]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jul 05 09:06:50 volumio volumio[966]: errno: -111, Jul 05 09:06:50 volumio volumio[966]: code: 'ECONNREFUSED', Jul 05 09:06:50 volumio volumio[966]: syscall: 'connect', Jul 05 09:06:50 volumio volumio[966]: address: '4.78.139.50', Jul 05 09:06:50 volumio volumio[966]: port: 443 Jul 05 09:06:50 volumio volumio[966]: } Jul 05 09:06:50 volumio volumio[966]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 09:06:51 volumio sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-05 09:05 Jul 05 09:06:51 volumio sudo[1611]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"