-- Logs begin at Sat 2024-11-02 17:05:48 +07, end at Sat 2024-11-02 19:08:55 +07. -- Nov 02 19:07:00 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 02 19:07:00 volumio volumio[992]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 02 19:07:00 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 02 19:07:00 volumio volumio[992]: info: Received Get System Version Nov 02 19:07:00 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 02 19:07:00 volumio volumio[992]: info: Received Get System Info Nov 02 19:07:00 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:00 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:00 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:00 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:00 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:00 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:07:05 volumio volumio[992]: info: CALLMETHOD: system_controller system saveHDMISettings [object Object] Nov 02 19:07:05 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , saveHDMISettings Nov 02 19:07:05 volumio sudo[8674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk.service Nov 02 19:07:05 volumio sudo[8674]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:07:05 volumio startx[994]: xinit: connection to X server lost Nov 02 19:07:05 volumio systemd[1]: Stopping Start Volumio Kiosk... Nov 02 19:07:05 volumio startx[994]: [1B blob data] Nov 02 19:07:05 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:07:06 volumio kernel: i915 0000:00:02.0: [drm] Reducing the compressed framebuffer size. This may lead to less power savings than a non-reduced-size. Try to increase stolen memory size if available in BIOS. Nov 02 19:07:06 volumio startx[994]: waiting for X server to shut down (II) Server terminated successfully (0). Closing log file. Nov 02 19:07:06 volumio startx[994]: xinit: unexpected signal 15 Nov 02 19:07:06 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Nov 02 19:07:06 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Nov 02 19:07:06 volumio systemd[1]: Stopped Start Volumio Kiosk. Nov 02 19:07:06 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:07:06 volumio systemd[1]: Started Start Volumio Kiosk. Nov 02 19:07:06 volumio sudo[8674]: pam_unix(sudo:session): session closed for user root Nov 02 19:07:06 volumio sudo[8683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable volumio-kiosk.service Nov 02 19:07:06 volumio sudo[8683]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:07:06 volumio systemd[1]: Reloading. Nov 02 19:07:07 volumio startx[8682]: X.Org X Server 1.20.4 Nov 02 19:07:07 volumio startx[8682]: X Protocol Version 11, Revision 0 Nov 02 19:07:07 volumio startx[8682]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Nov 02 19:07:07 volumio startx[8682]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Nov 02 19:07:07 volumio startx[8682]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d66df255-1f4a-47df-a7f6-91cae8377b11 bootpart=UUID=89E0-D0B2 datapart=UUID=5bfa9188-e19d-4bed-8483-f02184e740b8 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Nov 02 19:07:07 volumio startx[8682]: Build Date: 18 December 2021 09:05:36AM Nov 02 19:07:07 volumio startx[8682]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Nov 02 19:07:07 volumio startx[8682]: Current version of pixman: 0.36.0 Nov 02 19:07:07 volumio startx[8682]: Before reporting problems, check http://wiki.x.org Nov 02 19:07:07 volumio startx[8682]: to make sure that you have the latest version. Nov 02 19:07:07 volumio startx[8682]: Markers: (--) probed, (**) from config file, (==) default setting, Nov 02 19:07:07 volumio startx[8682]: (++) from command line, (!!) notice, (II) informational, Nov 02 19:07:07 volumio startx[8682]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Nov 02 19:07:07 volumio startx[8682]: (==) Log file: "/var/log/Xorg.0.log", Time: Sat Nov 2 19:07:07 2024 Nov 02 19:07:07 volumio startx[8682]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Nov 02 19:07:07 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 02 19:07:07 volumio sudo[8683]: pam_unix(sudo:session): session closed for user root Nov 02 19:07:07 volumio volumio[992]: info: enable volumio-kiosk service success Nov 02 19:07:07 volumio kernel: broken atomic modeset userspace detected, disabling atomic Nov 02 19:07:08 volumio startx[8682]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Nov 02 19:07:11 volumio volumio[992]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Nov 02 19:07:11 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 02 19:07:12 volumio volumio[992]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::volumioGetVisibleSources Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:12 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 02 19:07:12 volumio volumio[992]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 02 19:07:12 volumio volumio[992]: info: Received Get System Info Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:12 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:12 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:12 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:12 volumio volumio[992]: info: Listing playlists Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 02 19:07:12 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 02 19:07:13 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 02 19:07:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 02 19:07:13 volumio volumio[992]: info: Received Get System Info Nov 02 19:07:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:13 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:13 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:07:15 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 02 19:07:15 volumio volumio[992]: info: Received Get System Info Nov 02 19:07:15 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:15 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:15 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:15 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:15 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:15 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:07:18 volumio volumio[992]: info: CALLMETHOD: system_controller system saveHDMISettings [object Object] Nov 02 19:07:18 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , saveHDMISettings Nov 02 19:07:18 volumio sudo[9058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk.service Nov 02 19:07:18 volumio sudo[9058]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:07:18 volumio startx[8682]: xinit: connection to X server lost Nov 02 19:07:18 volumio systemd[1]: Stopping Start Volumio Kiosk... Nov 02 19:07:18 volumio startx[8682]: [1B blob data] Nov 02 19:07:18 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:07:20 volumio startx[8682]: waiting for X server to shut down .(II) Server terminated successfully (0). Closing log file. Nov 02 19:07:20 volumio startx[8682]: xinit: unexpected signal 15 Nov 02 19:07:20 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Nov 02 19:07:20 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Nov 02 19:07:20 volumio systemd[1]: Stopped Start Volumio Kiosk. Nov 02 19:07:20 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:07:21 volumio systemd[1]: Started Start Volumio Kiosk. Nov 02 19:07:21 volumio sudo[9058]: pam_unix(sudo:session): session closed for user root Nov 02 19:07:21 volumio sudo[9066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable volumio-kiosk.service Nov 02 19:07:21 volumio sudo[9066]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:07:21 volumio systemd[1]: Reloading. Nov 02 19:07:21 volumio startx[9065]: X.Org X Server 1.20.4 Nov 02 19:07:21 volumio startx[9065]: X Protocol Version 11, Revision 0 Nov 02 19:07:21 volumio startx[9065]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Nov 02 19:07:21 volumio startx[9065]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Nov 02 19:07:21 volumio startx[9065]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d66df255-1f4a-47df-a7f6-91cae8377b11 bootpart=UUID=89E0-D0B2 datapart=UUID=5bfa9188-e19d-4bed-8483-f02184e740b8 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Nov 02 19:07:21 volumio startx[9065]: Build Date: 18 December 2021 09:05:36AM Nov 02 19:07:21 volumio startx[9065]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Nov 02 19:07:21 volumio startx[9065]: Current version of pixman: 0.36.0 Nov 02 19:07:21 volumio startx[9065]: Before reporting problems, check http://wiki.x.org Nov 02 19:07:21 volumio startx[9065]: to make sure that you have the latest version. Nov 02 19:07:21 volumio startx[9065]: Markers: (--) probed, (**) from config file, (==) default setting, Nov 02 19:07:21 volumio startx[9065]: (++) from command line, (!!) notice, (II) informational, Nov 02 19:07:21 volumio startx[9065]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Nov 02 19:07:21 volumio startx[9065]: (==) Log file: "/var/log/Xorg.0.log", Time: Sat Nov 2 19:07:21 2024 Nov 02 19:07:21 volumio startx[9065]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Nov 02 19:07:21 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 02 19:07:21 volumio kernel: broken atomic modeset userspace detected, disabling atomic Nov 02 19:07:21 volumio sudo[9066]: pam_unix(sudo:session): session closed for user root Nov 02 19:07:21 volumio volumio[992]: info: enable volumio-kiosk service success Nov 02 19:07:22 volumio startx[9065]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Nov 02 19:07:23 volumio volumio[992]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 02 19:07:23 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 02 19:07:24 volumio volumio[992]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::volumioGetVisibleSources Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:24 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 02 19:07:24 volumio volumio[992]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 02 19:07:24 volumio volumio[992]: info: Received Get System Info Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:24 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:24 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:24 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:24 volumio volumio[992]: info: Listing playlists Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 02 19:07:24 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 02 19:07:25 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:25 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:25 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 02 19:07:25 volumio volumio[992]: info: CURURI: music-library Nov 02 19:07:25 volumio volumio[992]: info: Preload queue cleared Nov 02 19:07:25 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 02 19:07:25 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 02 19:07:25 volumio volumio[992]: info: Received Get System Info Nov 02 19:07:25 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:25 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:25 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:25 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:25 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:25 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:07:26 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 02 19:07:26 volumio volumio[992]: info: CURURI: music-library/INTERNAL Nov 02 19:07:26 volumio volumio[992]: info: Preload queue cleared Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/กำแพง.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ขอเวลาลืม.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/คนไม่จำเป็น.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ไม่เดียงสา.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เรื่องที่ขอ.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ห้องนอน.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/อ้าว.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/21 Guns.mp3 Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/9 นาฬิกา.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ที่ว่าง.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ทนได้ทุกที.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ทางผ่าน.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เจ็บที่ต้องรู้.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เหงาปาก.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ดวงเดือน.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ถ้าเธอรักฉันจริง.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/สลักจิต (feat. ดา เอ็นโดรฟิน).flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ถ้าเราเจอกันอีก (Until Then).flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ความพยายาม.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/รักฉันเรียกว่าเธอ.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ฉันจะมีเธออยู่.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ดาว.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/กรรมตามสนอง.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เหนื่อยเกินไปหรือเปล่า.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/Me Too.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/B.Y.O.B..flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ได้แต่นึกถึง.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/คนแปลกหน้าคนนี้.aiff Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ฝาก.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/2. Red (Taylor's Version).flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/Still Shred.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ต่าง.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/The Raven.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ยิ่งใกล้ยิ่งเจ็บ.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/หมากเกมนี้.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เจ็บจนไม่เข้าใจ.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/Undo.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ขี้หึง.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/มนุษย์ค้างคาว.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/หวาน.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ก็ยังเป็นเธอ.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/กลิ่นดอกไม้.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เกินความจำเป็น.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ขอโทษในสิ่งที่เธอไม่รู้.m4a Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ดอกไม้กับหัวใจ.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/คำอวยพร.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เจ็บช้ำ.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ชีวิตเธอดีอยู่แล้ว.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ดวงเดือน.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เตลิด.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ถ้าฉันเป็นเขา.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เธอมีเขา.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/นอกจากชื่อฉัน.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/นาทีนี้.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/บรรยากาศ.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/บานปลาย (best wishes).flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ปล่อย.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ปลิว.aiff Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/นานานานานา.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ฝนตกไหม.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/รักสามเศร้า.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/มีสิทธิ์อะไร.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/เหตุเกิดที่รัฐฉาน.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/รักฉันเพราะอะไร.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/รักแรก (เพลงประกอบภาพยนตร์ รักแรกโคตรลืมยาก My Precious).flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ฤดูที่ฉันเหงา.wav Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/วาดไว้.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/วาสนาผู้ใด.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/การเดินทาง.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/หลอกให้รัก.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/หากฉันตาย.flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ຕື່ນຈາກຝັນ (ตื่นจากฝัน).flac Nov 02 19:07:26 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/ແພງອ້າຍ ( แพงอ้าย ).flac Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/กำแพง.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=//mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%81%E0%B8%B3%E0%B9%81%E0%B8%9E%E0%B8%87.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/กำแพง.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ขอเวลาลืม.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=//mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%82%E0%B8%AD%E0%B9%80%E0%B8%A7%E0%B8%A5%E0%B8%B2%E0%B8%A5%E0%B8%B7%E0%B8%A1.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/ขอเวลาลืม.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/คนไม่จำเป็น.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=//mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%84%E0%B8%99%E0%B9%84%E0%B8%A1%E0%B9%88%E0%B8%88%E0%B8%B3%E0%B9%80%E0%B8%9B%E0%B9%87%E0%B8%99.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/คนไม่จำเป็น.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ไม่เดียงสา.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=//mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%84%E0%B8%A1%E0%B9%88%E0%B9%80%E0%B8%94%E0%B8%B5%E0%B8%A2%E0%B8%87%E0%B8%AA%E0%B8%B2.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/ไม่เดียงสา.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เรื่องที่ขอ.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=//mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%A3%E0%B8%B7%E0%B9%88%E0%B8%AD%E0%B8%87%E0%B8%97%E0%B8%B5%E0%B9%88%E0%B8%82%E0%B8%AD.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/เรื่องที่ขอ.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ห้องนอน.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=//mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%AB%E0%B9%89%E0%B8%AD%E0%B8%87%E0%B8%99%E0%B8%AD%E0%B8%99.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/ห้องนอน.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/อ้าว.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=//mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%AD%E0%B9%89%E0%B8%B2%E0%B8%A7.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/อ้าว.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/21 Guns.mp3 in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Green%20Day/21st%20Century%20Breakdown/mega&path=%2Fmnt%2FINTERNAL%2F21%20Guns.mp3&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/21 Guns.mp3 Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/9 นาฬิกา.flac in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=SPF/9%20%E0%B8%99%E0%B8%B2%E0%B8%AC%E0%B8%B4%E0%B8%81%E0%B8%B2%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F9%20%E0%B8%99%E0%B8%B2%E0%B8%AC%E0%B8%B4%E0%B8%81%E0%B8%B2.flac&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/9 นาฬิกา.flac Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ที่ว่าง.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Pause/Bakery%20Best%20Selection%20Pause/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%97%E0%B8%B5%E0%B9%88%E0%B8%A7%E0%B9%88%E0%B8%B2%E0%B8%87.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/ที่ว่าง.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ทนได้ทุกที.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Tum%20Somprasong/Best%20Of%20%E0%B8%95%E0%B8%B1%E0%B9%89%E0%B8%A1%20%E0%B8%AA%E0%B8%A1%E0%B8%9B%E0%B8%A3%E0%B8%B0%E0%B8%AA%E0%B8%87%E0%B8%84%E0%B9%8C%20%E0%B8%AA%E0%B8%B4%E0%B8%87%E0%B8%AB%E0%B8%A7%E0%B8%99%E0%B8%A7%E0%B8%B1%E0%B8%92%E0%B8%99%E0%B9%8C/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%97%E0%B8%99%E0%B9%84%E0%B8%94%E0%B9%89%E0%B8%97%E0%B8%B8%E0%B8%81%E0%B8%97%E0%B8%B5.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/ทนได้ทุกที.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ทางผ่าน.flac in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Pure/BLACK%20VALENTINE/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%97%E0%B8%B2%E0%B8%87%E0%B8%9C%E0%B9%88%E0%B8%B2%E0%B8%99.flac&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/ทางผ่าน.flac Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เจ็บที่ต้องรู้.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=The%20Mousses/Change/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%88%E0%B9%87%E0%B8%9A%E0%B8%97%E0%B8%B5%E0%B9%88%E0%B8%95%E0%B9%89%E0%B8%AD%E0%B8%87%E0%B8%A3%E0%B8%B9%E0%B9%89.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/เจ็บที่ต้องรู้.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เหงาปาก.flac in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=K-OTIC/Free%20To%20Play/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%AB%E0%B8%87%E0%B8%B2%E0%B8%9B%E0%B8%B2%E0%B8%81.flac&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/เหงาปาก.flac Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ดวงเดือน.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=JOEY%20PHUWASIT/GMM%20Grammy%20Best%20of%20the%20Year%202021/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%94%E0%B8%A7%E0%B8%87%E0%B9%80%E0%B8%94%E0%B8%B7%E0%B8%AD%E0%B8%99.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/ดวงเดือน.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ถ้าเธอรักฉันจริง.wav in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Three%20Man%20Down/GMM%20Grammy%20Best%20of%20the%20Year%202021/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%96%E0%B9%89%E0%B8%B2%E0%B9%80%E0%B8%98%E0%B8%AD%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B8%88%E0%B8%A3%E0%B8%B4%E0%B8%87.wav&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/ถ้าเธอรักฉันจริง.wav Nov 02 19:07:26 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/สลักจิต (feat. ดา เอ็นโดรฟิน).flac in service mpd Nov 02 19:07:26 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=%E0%B8%9B%E0%B9%8A%E0%B8%AD%E0%B8%9A%20%E0%B8%9B%E0%B8%AD%E0%B8%87%E0%B8%81%E0%B8%B9%E0%B8%A5/HUMAN%20ERROR%20-%20EP/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%AA%E0%B8%A5%E0%B8%B1%E0%B8%81%E0%B8%88%E0%B8%B4%E0%B8%95%20(feat.%20%E0%B8%94%E0%B8%B2%20%E0%B9%80%E0%B8%AD%E0%B9%87%E0%B8%99%E0%B9%82%E0%B8%94%E0%B8%A3%E0%B8%9F%E0%B8%B4%E0%B8%99).flac&metadata=false Nov 02 19:07:26 volumio volumio[992]: info: URI /mnt/INTERNAL/สลักจิต (feat. ดา เอ็นโดรฟิน).flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ถ้าเราเจอกันอีก (Until Then).flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Tilly%20Birds/It's%20Gonna%20Be%20OK/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%96%E0%B9%89%E0%B8%B2%E0%B9%80%E0%B8%A3%E0%B8%B2%E0%B9%80%E0%B8%88%E0%B8%AD%E0%B8%81%E0%B8%B1%E0%B8%99%E0%B8%AD%E0%B8%B5%E0%B8%81%20(Until%20Then).flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/ถ้าเราเจอกันอีก (Until Then).flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ความพยายาม.wav in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=No%20More%20Tear/Look%20at%20the%20Sky/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%84%E0%B8%A7%E0%B8%B2%E0%B8%A1%E0%B8%9E%E0%B8%A2%E0%B8%B2%E0%B8%A2%E0%B8%B2%E0%B8%A1.wav&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/ความพยายาม.wav Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/รักฉันเรียกว่าเธอ.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Kamikaze/Love%20%E0%B8%88%E0%B8%A3%E0%B8%B4%E0%B8%87/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B9%80%E0%B8%A3%E0%B8%B5%E0%B8%A2%E0%B8%81%E0%B8%A7%E0%B9%88%E0%B8%B2%E0%B9%80%E0%B8%98%E0%B8%AD.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/รักฉันเรียกว่าเธอ.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ฉันจะมีเธออยู่.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=%E0%B8%AA%E0%B8%B4%E0%B8%87%E0%B9%82%E0%B8%95%20%E0%B8%99%E0%B8%B3%E0%B9%82%E0%B8%8A%E0%B8%84/Lucky/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B8%88%E0%B8%B0%E0%B8%A1%E0%B8%B5%E0%B9%80%E0%B8%98%E0%B8%AD%E0%B8%AD%E0%B8%A2%E0%B8%B9%E0%B9%88.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/ฉันจะมีเธออยู่.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ดาว.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Mild/Master%20Peace/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%94%E0%B8%B2%E0%B8%A7.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/ดาว.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/กรรมตามสนอง.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Mild/Master%20Peace/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%81%E0%B8%A3%E0%B8%A3%E0%B8%A1%E0%B8%95%E0%B8%B2%E0%B8%A1%E0%B8%AA%E0%B8%99%E0%B8%AD%E0%B8%87.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/กรรมตามสนอง.flac Nov 02 19:07:27 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 02 19:07:27 volumio volumio[992]: info: Received Get System Info Nov 02 19:07:27 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:27 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:27 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:27 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:27 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เหนื่อยเกินไปหรือเปล่า.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Mild/Master%20Peace/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%AB%E0%B8%99%E0%B8%B7%E0%B9%88%E0%B8%AD%E0%B8%A2%E0%B9%80%E0%B8%81%E0%B8%B4%E0%B8%99%E0%B9%84%E0%B8%9B%E0%B8%AB%E0%B8%A3%E0%B8%B7%E0%B8%AD%E0%B9%80%E0%B8%9B%E0%B8%A5%E0%B9%88%E0%B8%B2.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/เหนื่อยเกินไปหรือเปล่า.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/Me Too.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=3.2.1/Me%20Too%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2FMe%20Too.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/Me Too.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/B.Y.O.B..flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=System%20Of%20A%20Down/Mezmerize/mega&path=%2Fmnt%2FINTERNAL%2FB.Y.O.B..flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/B.Y.O.B..flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ได้แต่นึกถึง.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Only%20Monday/Only%20Monday/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%84%E0%B8%94%E0%B9%89%E0%B9%81%E0%B8%95%E0%B9%88%E0%B8%99%E0%B8%B6%E0%B8%81%E0%B8%96%E0%B8%B6%E0%B8%87.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/ได้แต่นึกถึง.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/คนแปลกหน้าคนนี้.aiff in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Playground/Playground%2010%20Years%20Anniversary/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%84%E0%B8%99%E0%B9%81%E0%B8%9B%E0%B8%A5%E0%B8%81%E0%B8%AB%E0%B8%99%E0%B9%89%E0%B8%B2%E0%B8%84%E0%B8%99%E0%B8%99%E0%B8%B5%E0%B9%89.aiff&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/คนแปลกหน้าคนนี้.aiff Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ฝาก.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Q%20%E0%B8%84%E0%B8%B4%E0%B8%A7/Q%20%E0%B8%84%E0%B8%B4%E0%B8%A7/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%9D%E0%B8%B2%E0%B8%81.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/ฝาก.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/2. Red (Taylor's Version).flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Taylor%20Swift/Red%20(Taylor's%20Version)%20-%20Dolby%20Atmos/mega&path=%2Fmnt%2FINTERNAL%2F2.%20Red%20(Taylor's%20Version).flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/2. Red (Taylor's Version).flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/Still Shred.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Bernth/Still%20Shred/mega&path=%2Fmnt%2FINTERNAL%2FStill%20Shred.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/Still Shred.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ต่าง.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Catherine/Tang%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%95%E0%B9%88%E0%B8%B2%E0%B8%87.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/ต่าง.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/The Raven.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Rotting%20Christ/The%20Heretics/mega&path=%2Fmnt%2FINTERNAL%2FThe%20Raven.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/The Raven.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ยิ่งใกล้ยิ่งเจ็บ.wav in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Inca/The%20Very%20Best%20of%20Inca/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A2%E0%B8%B4%E0%B9%88%E0%B8%87%E0%B9%83%E0%B8%81%E0%B8%A5%E0%B9%89%E0%B8%A2%E0%B8%B4%E0%B9%88%E0%B8%87%E0%B9%80%E0%B8%88%E0%B9%87%E0%B8%9A.wav&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/ยิ่งใกล้ยิ่งเจ็บ.wav Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/หมากเกมนี้.wav in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Inca/The%20Very%20Best%20of%20Inca/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%AB%E0%B8%A1%E0%B8%B2%E0%B8%81%E0%B9%80%E0%B8%81%E0%B8%A1%E0%B8%99%E0%B8%B5%E0%B9%89.wav&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/หมากเกมนี้.wav Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เจ็บจนไม่เข้าใจ.flac in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Portrait/Thousand%20Shades%20of%20Tears/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%88%E0%B9%87%E0%B8%9A%E0%B8%88%E0%B8%99%E0%B9%84%E0%B8%A1%E0%B9%88%E0%B9%80%E0%B8%82%E0%B9%89%E0%B8%B2%E0%B9%83%E0%B8%88.flac&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/เจ็บจนไม่เข้าใจ.flac Nov 02 19:07:27 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/Undo.wav in service mpd Nov 02 19:07:27 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Wonderframe%20%26%20Pop%20Pongkool/Undo%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2FUndo.wav&metadata=false Nov 02 19:07:27 volumio volumio[992]: info: URI /mnt/INTERNAL/Undo.wav Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ขี้หึง.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=%E0%B8%A3%E0%B8%A7%E0%B8%A1%E0%B8%A8%E0%B8%B4%E0%B8%A5%E0%B8%9B%E0%B8%B4%E0%B8%99/YES!%204/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%82%E0%B8%B5%E0%B9%89%E0%B8%AB%E0%B8%B6%E0%B8%87.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/ขี้หึง.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/มนุษย์ค้างคาว.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=%E0%B8%A3%E0%B8%A7%E0%B8%A1%E0%B8%A8%E0%B8%B4%E0%B8%A5%E0%B8%9B%E0%B8%B4%E0%B8%99/YES!%204/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A1%E0%B8%99%E0%B8%B8%E0%B8%A9%E0%B8%A2%E0%B9%8C%E0%B8%84%E0%B9%89%E0%B8%B2%E0%B8%87%E0%B8%84%E0%B8%B2%E0%B8%A7.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/มนุษย์ค้างคาว.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/หวาน.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=%E0%B8%A3%E0%B8%A7%E0%B8%A1%E0%B8%A8%E0%B8%B4%E0%B8%A5%E0%B8%9B%E0%B8%B4%E0%B8%99/YES!%204/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%AB%E0%B8%A7%E0%B8%B2%E0%B8%99.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/หวาน.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ก็ยังเป็นเธอ.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=ACTART/%E0%B8%81%E0%B9%87%E0%B8%A2%E0%B8%B1%E0%B8%87%E0%B9%80%E0%B8%9B%E0%B9%87%E0%B8%99%E0%B9%80%E0%B8%98%E0%B8%AD%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%81%E0%B9%87%E0%B8%A2%E0%B8%B1%E0%B8%87%E0%B9%80%E0%B8%9B%E0%B9%87%E0%B8%99%E0%B9%80%E0%B8%98%E0%B8%AD.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/ก็ยังเป็นเธอ.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/กลิ่นดอกไม้.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Newery/%E0%B8%81%E0%B8%A5%E0%B8%B4%E0%B9%88%E0%B8%99%E0%B8%94%E0%B8%AD%E0%B8%81%E0%B9%84%E0%B8%A1%E0%B9%89%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%81%E0%B8%A5%E0%B8%B4%E0%B9%88%E0%B8%99%E0%B8%94%E0%B8%AD%E0%B8%81%E0%B9%84%E0%B8%A1%E0%B9%89.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/กลิ่นดอกไม้.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เกินความจำเป็น.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Night%20Tingle/%E0%B9%80%E0%B8%81%E0%B8%B4%E0%B8%99%E0%B8%84%E0%B8%A7%E0%B8%B2%E0%B8%A1%E0%B8%88%E0%B8%B3%E0%B9%80%E0%B8%9B%E0%B9%87%E0%B8%99%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%81%E0%B8%B4%E0%B8%99%E0%B8%84%E0%B8%A7%E0%B8%B2%E0%B8%A1%E0%B8%88%E0%B8%B3%E0%B9%80%E0%B8%9B%E0%B9%87%E0%B8%99.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/เกินความจำเป็น.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ขอโทษในสิ่งที่เธอไม่รู้.m4a in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Sweet%20Mullet/%E0%B8%82%E0%B8%AD%E0%B9%82%E0%B8%97%E0%B8%A9%E0%B9%83%E0%B8%99%E0%B8%AA%E0%B8%B4%E0%B9%88%E0%B8%87%E0%B8%97%E0%B8%B5%E0%B9%88%E0%B9%80%E0%B8%98%E0%B8%AD%E0%B9%84%E0%B8%A1%E0%B9%88%E0%B8%A3%E0%B8%B9%E0%B9%89/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%82%E0%B8%AD%E0%B9%82%E0%B8%97%E0%B8%A9%E0%B9%83%E0%B8%99%E0%B8%AA%E0%B8%B4%E0%B9%88%E0%B8%87%E0%B8%97%E0%B8%B5%E0%B9%88%E0%B9%80%E0%B8%98%E0%B8%AD%E0%B9%84%E0%B8%A1%E0%B9%88%E0%B8%A3%E0%B8%B9%E0%B9%89.m4a&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/ขอโทษในสิ่งที่เธอไม่รู้.m4a Nov 02 19:07:28 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:28 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:28 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:28 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:28 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:28 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ดอกไม้กับหัวใจ.wav in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=I-Zax/%E0%B8%84%E0%B8%99%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B8%81%E0%B8%B1%E0%B8%99/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%94%E0%B8%AD%E0%B8%81%E0%B9%84%E0%B8%A1%E0%B9%89%E0%B8%81%E0%B8%B1%E0%B8%9A%E0%B8%AB%E0%B8%B1%E0%B8%A7%E0%B9%83%E0%B8%88.wav&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/ดอกไม้กับหัวใจ.wav Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/คำอวยพร.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=SPF/%E0%B8%84%E0%B8%B3%E0%B8%AD%E0%B8%A7%E0%B8%A2%E0%B8%9E%E0%B8%A3%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%84%E0%B8%B3%E0%B8%AD%E0%B8%A7%E0%B8%A2%E0%B8%9E%E0%B8%A3.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/คำอวยพร.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เจ็บช้ำ.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=%E0%B8%A7%E0%B8%87%E0%B9%80%E0%B8%9A%E0%B8%A5%E0%B8%B2%E0%B8%99/%E0%B9%80%E0%B8%88%E0%B9%87%E0%B8%9A%E0%B8%8A%E0%B9%89%E0%B8%B3/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%88%E0%B9%87%E0%B8%9A%E0%B8%8A%E0%B9%89%E0%B8%B3.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/เจ็บช้ำ.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ชีวิตเธอดีอยู่แล้ว.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=The%20Kastle/%E0%B8%8A%E0%B8%B5%E0%B8%A7%E0%B8%B4%E0%B8%95%E0%B9%80%E0%B8%98%E0%B8%AD%E0%B8%94%E0%B8%B5%E0%B8%AD%E0%B8%A2%E0%B8%B9%E0%B9%88%E0%B9%81%E0%B8%A5%E0%B9%89%E0%B8%A7%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%8A%E0%B8%B5%E0%B8%A7%E0%B8%B4%E0%B8%95%E0%B9%80%E0%B8%98%E0%B8%AD%E0%B8%94%E0%B8%B5%E0%B8%AD%E0%B8%A2%E0%B8%B9%E0%B9%88%E0%B9%81%E0%B8%A5%E0%B9%89%E0%B8%A7.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/ชีวิตเธอดีอยู่แล้ว.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ดวงเดือน.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Joey%20Phuwasit/%E0%B8%94%E0%B8%A7%E0%B8%87%E0%B9%80%E0%B8%94%E0%B8%B7%E0%B8%AD%E0%B8%99%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%94%E0%B8%A7%E0%B8%87%E0%B9%80%E0%B8%94%E0%B8%B7%E0%B8%AD%E0%B8%99.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/ดวงเดือน.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เตลิด.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Zeal/%E0%B9%80%E0%B8%95%E0%B8%A5%E0%B8%B4%E0%B8%94/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%95%E0%B8%A5%E0%B8%B4%E0%B8%94.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/เตลิด.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ถ้าฉันเป็นเขา.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Indigo/%E0%B8%96%E0%B9%89%E0%B8%B2%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B9%80%E0%B8%9B%E0%B9%87%E0%B8%99%E0%B9%80%E0%B8%82%E0%B8%B2%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%96%E0%B9%89%E0%B8%B2%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B9%80%E0%B8%9B%E0%B9%87%E0%B8%99%E0%B9%80%E0%B8%82%E0%B8%B2.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/ถ้าฉันเป็นเขา.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เธอมีเขา.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=3.2.1/%E0%B9%80%E0%B8%98%E0%B8%AD%E0%B8%A1%E0%B8%B5%E0%B9%80%E0%B8%82%E0%B8%B2%20(White%20Flag)%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%98%E0%B8%AD%E0%B8%A1%E0%B8%B5%E0%B9%80%E0%B8%82%E0%B8%B2.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/เธอมีเขา.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/นอกจากชื่อฉัน.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=ACTART/%E0%B8%99%E0%B8%AD%E0%B8%81%E0%B8%88%E0%B8%B2%E0%B8%81%E0%B8%8A%E0%B8%B7%E0%B9%88%E0%B8%AD%E0%B8%89%E0%B8%B1%E0%B8%99%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%99%E0%B8%AD%E0%B8%81%E0%B8%88%E0%B8%B2%E0%B8%81%E0%B8%8A%E0%B8%B7%E0%B9%88%E0%B8%AD%E0%B8%89%E0%B8%B1%E0%B8%99.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/นอกจากชื่อฉัน.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/นาทีนี้.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Justin/%E0%B8%99%E0%B8%B2%E0%B8%97%E0%B8%B5%E0%B8%99%E0%B8%B5%E0%B9%89%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%99%E0%B8%B2%E0%B8%97%E0%B8%B5%E0%B8%99%E0%B8%B5%E0%B9%89.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/นาทีนี้.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/บรรยากาศ.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Only%20Monday/%E0%B8%9A%E0%B8%A3%E0%B8%A3%E0%B8%A2%E0%B8%B2%E0%B8%81%E0%B8%B2%E0%B8%A8%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%9A%E0%B8%A3%E0%B8%A3%E0%B8%A2%E0%B8%B2%E0%B8%81%E0%B8%B2%E0%B8%A8.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/บรรยากาศ.flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/บานปลาย (best wishes).flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=BOWKYLION/%E0%B8%9A%E0%B8%B2%E0%B8%99%E0%B8%9B%E0%B8%A5%E0%B8%B2%E0%B8%A2%20(best%20wishes)/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%9A%E0%B8%B2%E0%B8%99%E0%B8%9B%E0%B8%A5%E0%B8%B2%E0%B8%A2%20(best%20wishes).flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/บานปลาย (best wishes).flac Nov 02 19:07:28 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ปล่อย.flac in service mpd Nov 02 19:07:28 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=%E0%B8%9B%E0%B9%8A%E0%B8%AD%E0%B8%9A%20%E0%B8%9B%E0%B8%AD%E0%B8%87%E0%B8%81%E0%B8%B9%E0%B8%A5/%E0%B8%9B%E0%B8%A5%E0%B9%88%E0%B8%AD%E0%B8%A2%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%9B%E0%B8%A5%E0%B9%88%E0%B8%AD%E0%B8%A2.flac&metadata=false Nov 02 19:07:28 volumio volumio[992]: info: URI /mnt/INTERNAL/ปล่อย.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ปลิว.aiff in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Ploychompoo/%E0%B8%9B%E0%B8%A5%E0%B8%B4%E0%B8%A7%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%9B%E0%B8%A5%E0%B8%B4%E0%B8%A7.aiff&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/ปลิว.aiff Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/นานานานานา.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=%E0%B8%97%E0%B8%A3%E0%B8%87%E0%B9%84%E0%B8%97%E0%B8%A2/%E0%B8%9C%E0%B8%A5%E0%B8%B4%E0%B8%95%E0%B9%83%E0%B8%99%E0%B8%9B%E0%B8%A3%E0%B8%B0%E0%B9%80%E0%B8%97%E0%B8%A8%E0%B9%84%E0%B8%97%E0%B8%A2%E0%B9%80%E0%B8%97%E0%B9%88%E0%B8%B2%E0%B8%99%E0%B8%B1%E0%B9%89%E0%B8%99/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%99%E0%B8%B2%E0%B8%99%E0%B8%B2%E0%B8%99%E0%B8%B2%E0%B8%99%E0%B8%B2%E0%B8%99%E0%B8%B2.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/นานานานานา.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ฝนตกไหม.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Three%20Man%20Down/%E0%B8%9D%E0%B8%99%E0%B8%95%E0%B8%81%E0%B9%84%E0%B8%AB%E0%B8%A1%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%9D%E0%B8%99%E0%B8%95%E0%B8%81%E0%B9%84%E0%B8%AB%E0%B8%A1.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/ฝนตกไหม.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/รักสามเศร้า.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Phrikthai/%E0%B8%9E%E0%B8%A3%E0%B8%B4%E0%B8%81%E0%B9%84%E0%B8%97%E0%B8%A2%20-%20AFTER%20SIX/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B8%AA%E0%B8%B2%E0%B8%A1%E0%B9%80%E0%B8%A8%E0%B8%A3%E0%B9%89%E0%B8%B2.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/รักสามเศร้า.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/มีสิทธิ์อะไร.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=SPF/%E0%B8%A1%E0%B8%B5%E0%B8%AA%E0%B8%B4%E0%B8%97%E0%B8%98%E0%B8%B4%E0%B9%8C%E0%B8%AD%E0%B8%B0%E0%B9%84%E0%B8%A3%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A1%E0%B8%B5%E0%B8%AA%E0%B8%B4%E0%B8%97%E0%B8%98%E0%B8%B4%E0%B9%8C%E0%B8%AD%E0%B8%B0%E0%B9%84%E0%B8%A3.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/มีสิทธิ์อะไร.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/เหตุเกิดที่รัฐฉาน.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=%E0%B8%9E%E0%B8%87%E0%B8%A9%E0%B9%8C%E0%B8%AA%E0%B8%B4%E0%B8%97%E0%B8%98%E0%B8%B4%E0%B9%8C%20%E0%B8%84%E0%B8%B3%E0%B8%A0%E0%B8%B5%E0%B8%A3%E0%B9%8C/%E0%B8%A3%E0%B8%A7%E0%B8%A1%E0%B8%AE%E0%B8%B4%E0%B8%95%2025%20%E0%B8%9B%E0%B8%B5%20%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B8%81%E0%B8%B1%E0%B8%99...%E0%B8%95%E0%B8%A5%E0%B8%AD%E0%B8%94%E0%B9%80%E0%B8%A7%E0%B8%A5%E0%B8%B2/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B9%80%E0%B8%AB%E0%B8%95%E0%B8%B8%E0%B9%80%E0%B8%81%E0%B8%B4%E0%B8%94%E0%B8%97%E0%B8%B5%E0%B9%88%E0%B8%A3%E0%B8%B1%E0%B8%90%E0%B8%89%E0%B8%B2%E0%B8%99.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/เหตุเกิดที่รัฐฉาน.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/รักฉันเพราะอะไร.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Blue%20Shade/%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B9%80%E0%B8%9E%E0%B8%A3%E0%B8%B2%E0%B8%B0%E0%B8%AD%E0%B8%B0%E0%B9%84%E0%B8%A3/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B9%80%E0%B8%9E%E0%B8%A3%E0%B8%B2%E0%B8%B0%E0%B8%AD%E0%B8%B0%E0%B9%84%E0%B8%A3.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/รักฉันเพราะอะไร.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/รักแรก (เพลงประกอบภาพยนตร์ รักแรกโคตรลืมยาก My Precious).flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=NONT%20TANONT/%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B9%81%E0%B8%A3%E0%B8%81%20(%E0%B9%80%E0%B8%9E%E0%B8%A5%E0%B8%87%E0%B8%9B%E0%B8%A3%E0%B8%B0%E0%B8%81%E0%B8%AD%E0%B8%9A%E0%B8%A0%E0%B8%B2%E0%B8%9E%E0%B8%A2%E0%B8%99%E0%B8%95%E0%B8%A3%E0%B9%8C%20%E2%80%9C%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B9%81%E0%B8%A3%E0%B8%81%E0%B9%82%E0%B8%84%E0%B8%95%E0%B8%A3%E0%B8%A5%E0%B8%B7%E0%B8%A1%E0%B8%A2%E0%B8%B2%E0%B8%81%20My%20Precious%E2%80%9D)%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B9%81%E0%B8%A3%E0%B8%81%20(%E0%B9%80%E0%B8%9E%E0%B8%A5%E0%B8%87%E0%B8%9B%E0%B8%A3%E0%B8%B0%E0%B8%81%E0%B8%AD%E0%B8%9A%E0%B8%A0%E0%B8%B2%E0%B8%9E%E0%B8%A2%E0%B8%99%E0%B8%95%E0%B8%A3%E0%B9%8C%20%E0%B8%A3%E0%B8%B1%E0%B8%81%E0%B9%81%E0%B8%A3%E0%B8%81%E0%B9%82%E0%B8%84%E0%B8%95%E0%B8%A3%E0%B8%A5%E0%B8%B7%E0%B8%A1%E0%B8%A2%E0%B8%B2%E0%B8%81%20My%20Precious).flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/รักแรก (เพลงประกอบภาพยนตร์ รักแรกโคตรลืมยาก My Precious).flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ฤดูที่ฉันเหงา.wav in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=NICECNX/%E0%B8%A4%E0%B8%94%E0%B8%B9%E0%B8%97%E0%B8%B5%E0%B9%88%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B9%80%E0%B8%AB%E0%B8%87%E0%B8%B2%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A4%E0%B8%94%E0%B8%B9%E0%B8%97%E0%B8%B5%E0%B9%88%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B9%80%E0%B8%AB%E0%B8%87%E0%B8%B2.wav&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/ฤดูที่ฉันเหงา.wav Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/วาดไว้.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=BOWKYLION/%E0%B8%A7%E0%B8%B2%E0%B8%94%E0%B9%84%E0%B8%A7%E0%B9%89/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A7%E0%B8%B2%E0%B8%94%E0%B9%84%E0%B8%A7%E0%B9%89.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/วาดไว้.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/วาสนาผู้ใด.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Parkmalody/%E0%B8%A7%E0%B8%B2%E0%B8%AA%E0%B8%99%E0%B8%B2%E0%B8%9C%E0%B8%B9%E0%B9%89%E0%B9%83%E0%B8%94/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%A7%E0%B8%B2%E0%B8%AA%E0%B8%99%E0%B8%B2%E0%B8%9C%E0%B8%B9%E0%B9%89%E0%B9%83%E0%B8%94.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/วาสนาผู้ใด.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/การเดินทาง.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Chart%20Suchart/%E0%B8%AA%E0%B8%B2%E0%B8%A1%E0%B8%B1%E0%B8%8D/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%81%E0%B8%B2%E0%B8%A3%E0%B9%80%E0%B8%94%E0%B8%B4%E0%B8%99%E0%B8%97%E0%B8%B2%E0%B8%87.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/การเดินทาง.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/หลอกให้รัก.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=The%20Mousses/%E0%B8%AB%E0%B8%A5%E0%B8%AD%E0%B8%81%E0%B9%83%E0%B8%AB%E0%B9%89%E0%B8%A3%E0%B8%B1%E0%B8%81%20-%20Single/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%AB%E0%B8%A5%E0%B8%AD%E0%B8%81%E0%B9%83%E0%B8%AB%E0%B9%89%E0%B8%A3%E0%B8%B1%E0%B8%81.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/หลอกให้รัก.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/หากฉันตาย.flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=60Miles/%E0%B8%AB%E0%B8%B2%E0%B8%81%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B8%95%E0%B8%B2%E0%B8%A2/mega&path=%2Fmnt%2FINTERNAL%2F%E0%B8%AB%E0%B8%B2%E0%B8%81%E0%B8%89%E0%B8%B1%E0%B8%99%E0%B8%95%E0%B8%B2%E0%B8%A2.flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/หากฉันตาย.flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ຕື່ນຈາກຝັນ (ตื่นจากฝัน).flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Bay6ix/%E0%BA%95%E0%BA%B7%E0%BB%88%E0%BA%99%E0%BA%88%E0%BA%B2%E0%BA%81%E0%BA%9D%E0%BA%B1%E0%BA%99%20(%E0%B8%95%E0%B8%B7%E0%B9%88%E0%B8%99%E0%B8%88%E0%B8%B2%E0%B8%81%E0%B8%9D%E0%B8%B1%E0%B8%99)/mega&path=%2Fmnt%2FINTERNAL%2F%E0%BA%95%E0%BA%B7%E0%BB%88%E0%BA%99%E0%BA%88%E0%BA%B2%E0%BA%81%E0%BA%9D%E0%BA%B1%E0%BA%99%20(%E0%B8%95%E0%B8%B7%E0%B9%88%E0%B8%99%E0%B8%88%E0%B8%B2%E0%B8%81%E0%B8%9D%E0%B8%B1%E0%B8%99).flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/ຕື່ນຈາກຝັນ (ตื่นจากฝัน).flac Nov 02 19:07:29 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/ແພງອ້າຍ ( แพงอ้าย ).flac in service mpd Nov 02 19:07:29 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Sophana/%E0%BB%81%E0%BA%9E%E0%BA%87%E0%BA%AD%E0%BB%89%E0%BA%B2%E0%BA%8D%20(%20%E0%B9%81%E0%B8%9E%E0%B8%87%E0%B8%AD%E0%B9%89%E0%B8%B2%E0%B8%A2%20)/mega&path=%2Fmnt%2FINTERNAL%2F%E0%BB%81%E0%BA%9E%E0%BA%87%E0%BA%AD%E0%BB%89%E0%BA%B2%E0%BA%8D%20(%20%E0%B9%81%E0%B8%9E%E0%B8%87%E0%B8%AD%E0%B9%89%E0%B8%B2%E0%B8%A2%20).flac&metadata=false Nov 02 19:07:29 volumio volumio[992]: info: URI /mnt/INTERNAL/ແພງອ້າຍ ( แพงอ้าย ).flac Nov 02 19:07:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 02 19:07:30 volumio volumio[992]: info: CURURI: music-library/INTERNAL/DSF Nov 02 19:07:30 volumio volumio[992]: info: Preload queue cleared Nov 02 19:07:34 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 02 19:07:42 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 02 19:07:42 volumio volumio[992]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 02 19:07:42 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 02 19:07:42 volumio volumio[992]: info: Received Get System Version Nov 02 19:07:42 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 02 19:07:42 volumio volumio[992]: info: Received Get System Info Nov 02 19:07:42 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:42 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:42 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:42 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:42 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:42 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::ClearQueue Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::stop Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::clearPlayQueue Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::saveQueue Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::addQueueItems Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::addQueueItems Nov 02 19:07:43 volumio volumio[992]: info: Preload queue cleared Nov 02 19:07:43 volumio volumio[992]: info: Adding Item to queue: music-library/INTERNAL/DSF/Savage Amusement Nov 02 19:07:43 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/DSF/Savage Amusement in service mpd Nov 02 19:07:43 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Scorpions/Savage%20Amusement%20%5B50th%20Anniversary%20Deluxe%20Editions%5D/mega&path=%2Fmnt%2FINTERNAL%2FDSF%2FSavage%20Amusement%2FRhythm%20Of%20Love.dsf&metadata=false Nov 02 19:07:43 volumio volumio[992]: info: URI /mnt/INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::saveQueue Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::updateTrackBlock Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrackBlock Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPlay Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::play index 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::stop Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::play index undefined Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::startPlaybackTimer Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioGetVisibleSources Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand stop took 0 milliseconds Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:43 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand clear took 0 milliseconds Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf" Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:43 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:43 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:43 volumio volumio[992]: error: updateQueue error: null Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:43 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:43 volumio volumio[992]: info: ------------------------------ 2ms Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand add "INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf" took 1 milliseconds Nov 02 19:07:43 volumio volumio[992]: info: ------------------------------ 1ms Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand play Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:43 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:43 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:43 volumio volumio[992]: info: ------------------------------ 2ms Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand play took 2 milliseconds Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:43 volumio volumio[992]: info: ------------------------------ 2ms Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand status took 329 milliseconds Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:43 volumio volumio[992]: info: Nov 02 19:07:43 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand status took 458 milliseconds Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand status took 129 milliseconds Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand playlistinfo took 129 milliseconds Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:43 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:07:43 volumio volumio[992]: info: ------------------------------ 459ms Nov 02 19:07:43 volumio volumio[992]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 02 19:07:43 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:43 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:43 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:43 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:43 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:43 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:43 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:43 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:43 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:43 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:43 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:43 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:43 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:43 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:43 volumio volumio[992]: info: ------------------------------ 507ms Nov 02 19:07:43 volumio volumio[992]: info: ------------------------------ 507ms Nov 02 19:07:43 volumio volumio[992]: info: ------------------------------ 179ms Nov 02 19:07:43 volumio volumio[992]: info: ------------------------------ 56ms Nov 02 19:07:45 volumio kernel: sched: RT throttling activated Nov 02 19:07:45 volumio volumio[992]: info: Executing endpoint metavolumio Nov 02 19:07:45 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 02 19:07:45 volumio volumio[992]: info: Executing endpoint metavolumio Nov 02 19:07:45 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 02 19:07:45 volumio volumio[992]: info: Executing endpoint metavolumio Nov 02 19:07:45 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 02 19:07:55 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 02 19:07:55 volumio volumio[992]: info: CURURI: music-library/INTERNAL/DSF/Savage Amusement Nov 02 19:07:55 volumio volumio[992]: info: Preload queue cleared Nov 02 19:07:55 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf Nov 02 19:07:55 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf in service mpd Nov 02 19:07:55 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Scorpions/Savage%20Amusement%20%5B50th%20Anniversary%20Deluxe%20Editions%5D/mega&path=%2Fmnt%2FINTERNAL%2FDSF%2FSavage%20Amusement%2FRhythm%20Of%20Love.dsf&metadata=false Nov 02 19:07:55 volumio volumio[992]: info: URI /mnt/INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::ClearQueue Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::stop Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::updateTrackBlock Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrackBlock Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::serviceStop Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::serviceStop Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::stop Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::clearPlayQueue Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::saveQueue Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::addQueueItems Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::addQueueItems Nov 02 19:07:57 volumio volumio[992]: info: Preload queue cleared Nov 02 19:07:57 volumio volumio[992]: info: Adding Item to queue: music-library/INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf Nov 02 19:07:57 volumio volumio[992]: info: Using cached record of: music-library/INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::saveQueue Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::updateTrackBlock Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrackBlock Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPlay Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::play index 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::stop Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::play index undefined Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::startPlaybackTimer Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioGetVisibleSources Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand stop took 21 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand stop took 10 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:57 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand status took 2 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand clear took 1 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf" Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: 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} Nov 02 19:07:57 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: No code Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: 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} Nov 02 19:07:57 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: No code Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 24ms Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 24ms Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:57 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:57 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:57 volumio volumio[992]: error: updateQueue error: null Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:57 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 25ms Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand playlistinfo took 25 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand add "INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf" took 25 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 1ms Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand play Nov 02 19:07:57 volumio volumio[992]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 27ms Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:57 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:07:57 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 8ms Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand play took 7 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 7ms Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand status took 121 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand status took 121 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand status took 121 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:57 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 122ms Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:57 volumio volumio[992]: info: Nov 02 19:07:57 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand status took 0 milliseconds Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:57 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:57 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:57 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:57 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:57 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:57 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 207ms Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 87ms Nov 02 19:07:57 volumio volumio[992]: info: sendMpdCommand playlistinfo took 85 milliseconds Nov 02 19:07:57 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:57 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:57 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:07:57 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:07:57 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:07:57 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:57 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:07:57 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 113ms Nov 02 19:07:57 volumio volumio[992]: info: ------------------------------ 114ms Nov 02 19:07:58 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:07:58 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:07:58 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:07:58 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:07:58 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:07:58 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:08:08 volumio volumio[992]: info: CoreCommandRouter::volumioPause Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::pause Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::servicePause Nov 02 19:08:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:08 volumio volumio[992]: info: CoreCommandRouter::servicePause Nov 02 19:08:08 volumio volumio[992]: info: ControllerMpd::pause Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand pause Nov 02 19:08:08 volumio volumio[992]: info: Nov 02 19:08:08 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:08 volumio volumio[992]: info: sendMpdCommand pause took 4 milliseconds Nov 02 19:08:08 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:08 volumio volumio[992]: info: Nov 02 19:08:08 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:08 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:08 volumio volumio[992]: info: Nov 02 19:08:08 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:08 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:08 volumio volumio[992]: info: sendMpdCommand status took 0 milliseconds Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:08 volumio volumio[992]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 02 19:08:08 volumio volumio[992]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:08 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:08 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:08 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:08 volumio volumio[992]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":911,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:08:08 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::syncState stateService pause Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus pause Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:08 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:08 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:08 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:08 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:08 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:08 volumio volumio[992]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":911,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:08:08 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::syncState stateService pause Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus pause Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:08 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:08 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:08 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:08 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:08 volumio volumio[992]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":911,"duration":229,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"Rhythm Of Love","artist":"Scorpions","album":"Savage Amusement [50th Anniversary Deluxe Editions]","uri":"INTERNAL/DSF/Savage Amusement/Rhythm Of Love.dsf","trackType":"dsf"} Nov 02 19:08:08 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::syncState stateService pause Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus pause Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:08 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:08 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:08 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:08 volumio volumio[992]: info: ------------------------------ 18ms Nov 02 19:08:08 volumio volumio[992]: info: ------------------------------ 17ms Nov 02 19:08:08 volumio volumio[992]: info: ------------------------------ 17ms Nov 02 19:08:11 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 02 19:08:11 volumio volumio[992]: info: CURURI: music-library/INTERNAL/DSF/Nevermind Nov 02 19:08:11 volumio volumio[992]: info: Preload queue cleared Nov 02 19:08:11 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/DSF/Nevermind/Smells Like Teen Spirit.dsf Nov 02 19:08:11 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/DSF/Nevermind/Come As You Are.dsf Nov 02 19:08:11 volumio volumio[992]: info: Preloading song: music-library/INTERNAL/DSF/Nevermind/In Bloom.dsf Nov 02 19:08:11 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/DSF/Nevermind/Smells Like Teen Spirit.dsf in service mpd Nov 02 19:08:11 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Nirvana/Nevermind/mega&path=%2Fmnt%2FINTERNAL%2FDSF%2FNevermind%2FSmells%20Like%20Teen%20Spirit.dsf&metadata=false Nov 02 19:08:11 volumio volumio[992]: info: URI /mnt/INTERNAL/DSF/Nevermind/Smells Like Teen Spirit.dsf Nov 02 19:08:11 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/DSF/Nevermind/Come As You Are.dsf in service mpd Nov 02 19:08:11 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Nirvana/Nevermind/mega&path=%2Fmnt%2FINTERNAL%2FDSF%2FNevermind%2FCome%20As%20You%20Are.dsf&metadata=false Nov 02 19:08:11 volumio volumio[992]: info: URI /mnt/INTERNAL/DSF/Nevermind/Come As You Are.dsf Nov 02 19:08:11 volumio volumio[992]: info: Exploding uri music-library/INTERNAL/DSF/Nevermind/In Bloom.dsf in service mpd Nov 02 19:08:11 volumio volumio[992]: info: ALBUMART /albumart?cacheid=102&web=Nirvana/Nevermind/mega&path=%2Fmnt%2FINTERNAL%2FDSF%2FNevermind%2FIn%20Bloom.dsf&metadata=false Nov 02 19:08:11 volumio volumio[992]: info: URI /mnt/INTERNAL/DSF/Nevermind/In Bloom.dsf Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::ClearQueue Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::stop Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::updateTrackBlock Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrackBlock Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::serviceStop Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::serviceStop Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::stop Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::clearPlayQueue Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::saveQueue Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::addQueueItems Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::addQueueItems Nov 02 19:08:13 volumio volumio[992]: info: Preload queue cleared Nov 02 19:08:13 volumio volumio[992]: info: Adding Item to queue: music-library/INTERNAL/DSF/Nevermind/Come As You Are.dsf Nov 02 19:08:13 volumio volumio[992]: info: Using cached record of: music-library/INTERNAL/DSF/Nevermind/Come As You Are.dsf Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::saveQueue Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::updateTrackBlock Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrackBlock Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPlay Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::play index 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::stop Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::play index undefined Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::startPlaybackTimer Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioGetVisibleSources Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/DSF/Nevermind/Come As You Are.dsf Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand stop took 9 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand stop took 2 milliseconds Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:08:13 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand clear took 1 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand status took 0 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand status took 0 milliseconds Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/DSF/Nevermind/Come As You Are.dsf" Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: 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} Nov 02 19:08:13 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: No code Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: 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} Nov 02 19:08:13 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: No code Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 17ms Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 16ms Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:08:13 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:08:13 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:08:13 volumio volumio[992]: error: updateQueue error: null Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:08:13 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 17ms Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand playlistinfo took 17 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand add "INTERNAL/DSF/Nevermind/Come As You Are.dsf" took 17 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 1ms Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 1ms Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand play Nov 02 19:08:13 volumio volumio[992]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 18ms Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:08:13 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces system playlist update Nov 02 19:08:13 volumio volumio[992]: info: Ignoring MPD Status Update Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 8ms Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand play took 9 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 9ms Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 8ms Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand status took 17 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand status took 17 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand status took 17 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:13 volumio volumio[992]: info: Nov 02 19:08:13 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand status took 0 milliseconds Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:13 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:13 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:08:13 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:13 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:08:13 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 24ms Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 25ms Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 25ms Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 02 19:08:13 volumio volumio[992]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 02 19:08:13 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:13 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:08:13 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:13 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:08:13 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:13 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Nov 02 19:08:13 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:13 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:13 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:13 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 22ms Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 22ms Nov 02 19:08:13 volumio volumio[992]: info: ------------------------------ 21ms Nov 02 19:08:15 volumio volumio[992]: info: Executing endpoint metavolumio Nov 02 19:08:15 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 02 19:08:15 volumio volumio[992]: info: Executing endpoint metavolumio Nov 02 19:08:15 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 02 19:08:15 volumio volumio[992]: info: Executing endpoint metavolumio Nov 02 19:08:15 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 02 19:08:20 volumio volumio[992]: info: CoreCommandRouter::volumioPause Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::pause Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::servicePause Nov 02 19:08:20 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:20 volumio volumio[992]: info: CoreCommandRouter::servicePause Nov 02 19:08:20 volumio volumio[992]: info: ControllerMpd::pause Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand pause Nov 02 19:08:20 volumio volumio[992]: info: Nov 02 19:08:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:20 volumio volumio[992]: info: sendMpdCommand pause took 61 milliseconds Nov 02 19:08:20 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:20 volumio volumio[992]: info: Nov 02 19:08:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:20 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:20 volumio volumio[992]: info: Nov 02 19:08:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:20 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:20 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 02 19:08:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 02 19:08:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:20 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:20 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1136,"duration":219,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService pause Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus pause Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:20 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:20 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:20 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:20 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:20 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1136,"duration":219,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService pause Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus pause Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:20 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:20 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:20 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:20 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:20 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1136,"duration":219,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService pause Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus pause Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:20 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:20 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:20 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:20 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:20 volumio volumio[992]: info: ------------------------------ 13ms Nov 02 19:08:20 volumio volumio[992]: info: ------------------------------ 14ms Nov 02 19:08:20 volumio volumio[992]: info: ------------------------------ 15ms Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioClearQueue Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::ClearQueue Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::stop Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::updateTrackBlock Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrackBlock Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::serviceStop Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::serviceStop Nov 02 19:08:27 volumio volumio[992]: info: ControllerMpd::stop Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::clearPlayQueue Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::saveQueue Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Nov 02 19:08:27 volumio volumio[992]: info: Nov 02 19:08:27 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:27 volumio volumio[992]: info: sendMpdCommand stop took 7 milliseconds Nov 02 19:08:27 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:27 volumio volumio[992]: info: Nov 02 19:08:27 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:27 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:27 volumio volumio[992]: info: Nov 02 19:08:27 volumio volumio[992]: ---------------------------- MPD announces state update: player Nov 02 19:08:27 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:27 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:08:27 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:08:27 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 19:08:27 volumio volumio[992]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 02 19:08:27 volumio volumio[992]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 02 19:08:27 volumio volumio[992]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:27 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Nov 02 19:08:27 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:27 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: No code Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:27 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: No code Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come As You Are","artist":"Nirvana","album":"Nevermind","uri":"INTERNAL/DSF/Nevermind/Come As You Are.dsf","trackType":"dsf"} Nov 02 19:08:27 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: No code Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: ------------------------------ 16ms Nov 02 19:08:27 volumio volumio[992]: info: ------------------------------ 15ms Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioClearQueue Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::ClearQueue Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::stop Nov 02 19:08:27 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::clearPlayQueue Nov 02 19:08:27 volumio volumio[992]: info: CorePlayQueue::saveQueue Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:27 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:27 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Nov 02 19:08:28 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 19:08:28 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 19:08:28 volumio volumio[992]: info: Discovery: Getting this device information Nov 02 19:08:28 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:28 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:28 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 19:08:29 volumio volumio[992]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 19:08:30 volumio volumio[992]: No protocol specified Nov 02 19:08:30 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 02 19:08:30 volumio volumio[992]: No protocol specified Nov 02 19:08:30 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 02 19:08:30 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 02 19:08:32 volumio volumio[992]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Nov 02 19:08:32 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Nov 02 19:08:32 volumio volumio[992]: info: Preparing to save Alsa Options, stopping services first Nov 02 19:08:32 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:32 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:32 volumio volumio[992]: info: CoreCommandRouter::volumioPause Nov 02 19:08:32 volumio volumio[992]: info: CoreStateMachine::pause Nov 02 19:08:32 volumio volumio[992]: info: Saving Audio Output to: {"output_device":{"value":"0,3","label":"HDMI"}} Nov 02 19:08:32 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 02 19:08:32 volumio volumio[992]: No protocol specified Nov 02 19:08:32 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 02 19:08:33 volumio volumio[992]: info: Found match in Cards Database: setting mixer for card HDMI Nov 02 19:08:33 volumio vtcs[2171]: [2024-11-02 19:08:33.007] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Nov 02 19:08:33 volumio vtcs[2171]: [2024-11-02 19:08:33.007] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Nov 02 19:08:33 volumio sudo[9502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:33 volumio sudo[9502]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Nov 02 19:08:33 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Nov 02 19:08:33 volumio systemd[1]: vtcs.service: Succeeded. Nov 02 19:08:33 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Nov 02 19:08:33 volumio sudo[9502]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: Setting mixer Master for card HDMI Nov 02 19:08:33 volumio sudo[9508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:33 volumio sudo[9508]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio sudo[9508]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 02 19:08:33 volumio volumio[992]: info: Updating Volume Controller Parameters: Device: 0,3 Name: HDMI Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 02 19:08:33 volumio volumio[992]: info: Disabling external Volume Control Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 19:08:33 volumio volumio[992]: info: Preparing to generate the ALSA configuration file Nov 02 19:08:33 volumio sudo[9515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:33 volumio sudo[9515]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:33 volumio sudo[9515]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Nov 02 19:08:33 volumio volumio[992]: info: Reading ALSA contributions from plugins. Nov 02 19:08:33 volumio volumio[992]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio sudo[9518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:33 volumio sudo[9518]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio sudo[9518]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 02 19:08:33 volumio volumio[992]: info: VolumeController:: Volume=undefined Mute =false Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:33 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:33 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:33 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:33 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:33 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:33 volumio volumio[992]: info: Asound.conf file unchanged, so no further update is needed Nov 02 19:08:33 volumio volumio[992]: info: Output device has changed, restarting MPD Nov 02 19:08:33 volumio sudo[9528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 02 19:08:33 volumio sudo[9528]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio sudo[9528]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: info: Output device has changed, restarting Shairport Sync Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 02 19:08:33 volumio sudo[9531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 02 19:08:33 volumio sudo[9531]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio systemd[1]: musicservicesshield.service: Succeeded. Nov 02 19:08:33 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 02 19:08:33 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 02 19:08:33 volumio systemd[1]: Stopping Music Player Daemon... Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio sudo[9539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:33 volumio sudo[9539]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:08:33 volumio volumio[992]: info: MPD Permissions set Nov 02 19:08:33 volumio sudo[9539]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio sudo[9542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:33 volumio sudo[9542]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio sudo[9542]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: VolumeController::SetAlsaVolume0 Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:33 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:33 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:33 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:33 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:33 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:33 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:33 volumio volumio[992]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: Starting Shairport Sync Nov 02 19:08:33 volumio volumio[992]: info: Preparing to generate the ALSA configuration file Nov 02 19:08:33 volumio volumio[992]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Nov 02 19:08:33 volumio volumio[992]: info: Reading ALSA contributions from plugins. Nov 02 19:08:33 volumio volumio[992]: info: Asound.conf file written Nov 02 19:08:33 volumio sudo[9556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 02 19:08:33 volumio sudo[9554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 02 19:08:33 volumio sudo[9554]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio sudo[9556]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio sudo[9556]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 02 19:08:33 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 02 19:08:33 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: Output device has changed, restarting MPD Nov 02 19:08:33 volumio sudo[9563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 02 19:08:33 volumio sudo[9563]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 02 19:08:33 volumio sudo[9554]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio sudo[9563]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: info: Output device has changed, restarting Shairport Sync Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 02 19:08:33 volumio sudo[9566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 02 19:08:33 volumio sudo[9566]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 02 19:08:33 volumio volumio[992]: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:33 volumio volumio[992]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio sudo[9576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:33 volumio sudo[9576]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio sudo[9576]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:08:33 volumio volumio[992]: info: MPD Permissions set Nov 02 19:08:33 volumio volumio[992]: info: Shairport-Sync Started Nov 02 19:08:33 volumio sudo[9579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:33 volumio sudo[9579]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio sudo[9579]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 02 19:08:33 volumio systemd[1]: mpd.service: Succeeded. Nov 02 19:08:33 volumio systemd[1]: Stopped Music Player Daemon. Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:08:33 volumio volumio[992]: info: Starting Shairport Sync Nov 02 19:08:33 volumio sudo[9591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 02 19:08:33 volumio sudo[9591]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio systemd[1]: Starting Music Player Daemon... Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:33 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 02 19:08:33 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 02 19:08:33 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:33 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:08:33 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 02 19:08:33 volumio sudo[9591]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: info: Shairport-Sync Started Nov 02 19:08:33 volumio sudo[9588]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 02 19:08:33 volumio sudo[9588]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:33 volumio sudo[9588]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:33 volumio volumio[992]: info: VolumeController::SetAlsaVolume0 Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:33 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:33 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:33 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:33 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:33 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:33 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:33 volumio volumio[992]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Nov 02 19:08:33 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:34 volumio mpd[9597]: Nov 02 19:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 02 19:08:34 volumio systemd[1]: Started Music Player Daemon. Nov 02 19:08:34 volumio sudo[9566]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:34 volumio sudo[9531]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:34 volumio volumio[992]: error: MPD error: The expression evaluated to a falsy value: Nov 02 19:08:34 volumio volumio[992]: assert.ok(self.idling) Nov 02 19:08:34 volumio volumio[992]: error: The expression evaluated to a falsy value: Nov 02 19:08:34 volumio volumio[992]: assert.ok(self.idling) Nov 02 19:08:34 volumio volumio[992]: error: updateQueue error: null Nov 02 19:08:34 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 02 19:08:34 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:36 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:36 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:36 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:36 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:36 volumio volumio[992]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:36 volumio volumio[992]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:36 volumio volumio[992]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:36 volumio volumio[992]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:36 volumio sudo[9627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Nov 02 19:08:36 volumio sudo[9627]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:36 volumio sudo[9630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Nov 02 19:08:36 volumio sudo[9630]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:36 volumio systemd[1]: Started Volumio Tidal Connect Service. Nov 02 19:08:36 volumio sudo[9627]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:36 volumio sudo[9630]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:36 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:36 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:36 volumio volumio[992]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:36 volumio volumio[992]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:36 volumio sudo[9645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Nov 02 19:08:36 volumio sudo[9645]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:36 volumio sudo[9645]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:36 volumio volumio[992]: info: Executing endpoint tc_getconfig Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Nov 02 19:08:36 volumio vtcs[9631]: STARTING TidalConnect services, version: 1.4.0.34 Nov 02 19:08:36 volumio vtcs[9631]: STARTED TidalConnect services. Nov 02 19:08:36 volumio volumio[992]: info: Executing endpoint tc_connect Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Nov 02 19:08:36 volumio volumio[992]: info: Connecting to TidalConnect Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:36 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:36 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:36 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Nov 02 19:08:36 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:36 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:36 volumio volumio[992]: info: No code Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:36 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:36 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:36 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:36 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Nov 02 19:08:36 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:36 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:36 volumio volumio[992]: info: No code Nov 02 19:08:36 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:36 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:36 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:36 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:36 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:36 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:36 volumio volumio[992]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:36 volumio volumio[992]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:36 volumio sudo[9673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Nov 02 19:08:36 volumio sudo[9673]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:36 volumio sudo[9673]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:37 volumio volumio[992]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 02 19:08:37 volumio volumio[992]: info: CoreStateMachine::getcurrentVolume Nov 02 19:08:37 volumio volumio[992]: info: CoreCommandRouter::volumioRetrievevolume Nov 02 19:08:37 volumio volumio[992]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Nov 02 19:08:37 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:37 volumio volumio[992]: info: VolumeController:: Volume=undefined Mute =false Nov 02 19:08:37 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:37 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:37 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:37 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:37 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:37 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:37 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:37 volumio volumio[992]: info: CoreStateMachine::updateTrackBlock Nov 02 19:08:37 volumio volumio[992]: info: CorePlayQueue::getTrackBlock Nov 02 19:08:37 volumio volumio[992]: info: CoreCommandRouter::volumioRetrievevolume Nov 02 19:08:37 volumio volumio[992]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Nov 02 19:08:37 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:37 volumio volumio[992]: info: VolumeController:: Volume=undefined Mute =false Nov 02 19:08:37 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:37 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:37 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:37 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:37 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:37 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:37 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:38 volumio sudo[9685]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/cset shield -r Nov 02 19:08:38 volumio sudo[9685]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:38 volumio sudo[9685]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:38 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:38 volumio volumio[992]: info: VolumeController:: Setting startup Volume 100 Nov 02 19:08:38 volumio volumio[992]: info: VolumeController::SetAlsaVolume100 Nov 02 19:08:38 volumio volumio[9601]: cset: **> shielding not active on system Nov 02 19:08:38 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 02 19:08:38 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:38 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:38 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:38 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:38 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:38 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:38 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:38 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:38 volumio volumio[992]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 02 19:08:38 volumio volumio[992]: SPOTIFY: SPOTIFY VOLUME undefined Nov 02 19:08:38 volumio volumio[992]: SPOTIFY: VOLUMIO VOLUME 100 Nov 02 19:08:38 volumio volumio[992]: info: Aligning Spotify Volume to Volumio Volume Nov 02 19:08:38 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:38 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:38 volumio volumio[992]: info: Setting Spotify Volume from Volumio: 100 Nov 02 19:08:38 volumio volumio[992]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Nov 02 19:08:38 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:39 volumio volumio[992]: info: TidalConnect service started! Nov 02 19:08:39 volumio volumio[992]: info: TidalConnect service started! Nov 02 19:08:39 volumio volumio[992]: info: TidalConnect service started! Nov 02 19:08:39 volumio volumio[992]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Nov 02 19:08:39 volumio volumio[992]: info: Sending Spotify command with payload to local API: /player/volume Nov 02 19:08:39 volumio volumio[992]: info: TidalConnect service started! Nov 02 19:08:41 volumio volumio[992]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:41 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:41 volumio volumio[992]: info: Restoring Previous Volume level: 100 false false Nov 02 19:08:41 volumio volumio[992]: info: Output device has changed, restarting MPD Nov 02 19:08:41 volumio sudo[9690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 02 19:08:41 volumio sudo[9690]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:41 volumio sudo[9690]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:41 volumio volumio[992]: info: Output device has changed, restarting Shairport Sync Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 02 19:08:41 volumio sudo[9693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 02 19:08:41 volumio sudo[9693]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:41 volumio systemd[1]: musicservicesshield.service: Succeeded. Nov 02 19:08:41 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 02 19:08:41 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 02 19:08:41 volumio systemd[1]: Stopping Music Player Daemon... Nov 02 19:08:41 volumio systemd[1]: mpd.service: Succeeded. Nov 02 19:08:41 volumio systemd[1]: Stopped Music Player Daemon. Nov 02 19:08:41 volumio volumio[992]: No protocol specified Nov 02 19:08:41 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:41 volumio volumio[992]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 02 19:08:41 volumio volumio[992]: No protocol specified Nov 02 19:08:41 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:41 volumio volumio[992]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:41 volumio vtcs[9631]: [2024-11-02 19:08:41.673] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Nov 02 19:08:41 volumio vtcs[9631]: [2024-11-02 19:08:41.673] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Nov 02 19:08:41 volumio volumio[992]: info: Volume configurations have been set Nov 02 19:08:41 volumio systemd[1]: Starting Music Player Daemon... Nov 02 19:08:41 volumio sudo[9702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:41 volumio sudo[9702]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:41 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Nov 02 19:08:41 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Nov 02 19:08:41 volumio sudo[9705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:41 volumio sudo[9705]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:41 volumio systemd[1]: vtcs.service: Succeeded. Nov 02 19:08:41 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Nov 02 19:08:41 volumio sudo[9702]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:41 volumio sudo[9705]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:41 volumio sudo[9698]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 02 19:08:41 volumio sudo[9698]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:41 volumio sudo[9698]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:41 volumio volumio[992]: No protocol specified Nov 02 19:08:41 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 02 19:08:41 volumio volumio[992]: info: Updating Volume Controller Parameters: Device: 0,3 Name: HDMI Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 02 19:08:41 volumio volumio[992]: info: Disabling external Volume Control Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:41 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:41 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:41 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:41 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:41 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:41 volumio sudo[9715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:41 volumio sudo[9715]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:41 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:41 volumio sudo[9715]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:41 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:08:41 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:08:41 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:41 volumio sudo[9718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 02 19:08:41 volumio sudo[9718]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:41 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:41 volumio volumio[992]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Nov 02 19:08:41 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:41 volumio sudo[9718]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:41 volumio volumio[992]: info: MPD Permissions set Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:41 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 02 19:08:41 volumio volumio[992]: No protocol specified Nov 02 19:08:41 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 02 19:08:41 volumio volumio[992]: No protocol specified Nov 02 19:08:41 volumio volumio[992]: xcb_connection_has_error() returned true Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 02 19:08:41 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 02 19:08:41 volumio volumio[992]: info: Starting Shairport Sync Nov 02 19:08:41 volumio sudo[9733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 02 19:08:41 volumio sudo[9733]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:41 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 02 19:08:41 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:41 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 02 19:08:41 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 19:08:41 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 02 19:08:41 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 02 19:08:41 volumio sudo[9733]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:41 volumio volumio[992]: info: Shairport-Sync Started Nov 02 19:08:41 volumio mpd[9712]: Nov 02 19:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 02 19:08:41 volumio systemd[1]: Started Music Player Daemon. Nov 02 19:08:41 volumio sudo[9693]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:41 volumio volumio[992]: error: updateQueue error: null Nov 02 19:08:41 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 02 19:08:41 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:44 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:44 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:44 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:44 volumio volumio[992]: info: TidalConnect service stoped! Nov 02 19:08:44 volumio volumio[992]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:44 volumio volumio[992]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:44 volumio sudo[9764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Nov 02 19:08:44 volumio sudo[9764]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:44 volumio volumio[992]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:44 volumio volumio[992]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Nov 02 19:08:44 volumio sudo[9772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Nov 02 19:08:44 volumio sudo[9772]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:44 volumio systemd[1]: Started Volumio Tidal Connect Service. Nov 02 19:08:44 volumio sudo[9764]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:44 volumio sudo[9772]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:44 volumio volumio[992]: info: Executing endpoint tc_getconfig Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Nov 02 19:08:44 volumio vtcs[9770]: STARTING TidalConnect services, version: 1.4.0.34 Nov 02 19:08:44 volumio vtcs[9770]: STARTED TidalConnect services. Nov 02 19:08:44 volumio volumio[992]: info: Executing endpoint tc_connect Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Nov 02 19:08:44 volumio volumio[992]: info: Connecting to TidalConnect Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:44 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:44 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:44 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Nov 02 19:08:44 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:44 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:44 volumio volumio[992]: info: No code Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:44 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:44 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:44 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:44 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Nov 02 19:08:44 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:44 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:44 volumio volumio[992]: info: No code Nov 02 19:08:44 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:44 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:44 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:44 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:45 volumio sudo[9798]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/cset shield -r Nov 02 19:08:45 volumio sudo[9798]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:45 volumio sudo[9798]: pam_unix(sudo:session): session closed for user root Nov 02 19:08:45 volumio volumio[9740]: cset: **> shielding not active on system Nov 02 19:08:45 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 02 19:08:46 volumio volumio[992]: info: VolumeController::SetAlsaVolume100 Nov 02 19:08:46 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Nov 02 19:08:46 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:46 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:46 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:46 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:46 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:46 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 19:08:47 volumio volumio[992]: info: Retrieving Cloud Streaming UI Nov 02 19:08:47 volumio volumio[992]: info: Getting Tidal Cloud Configuration Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 19:08:47 volumio volumio[992]: info: Getting Qobuz Cloud Configuration Nov 02 19:08:47 volumio volumio[992]: info: Asking plugin for UI Config Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 19:08:47 volumio volumio[992]: info: Getting Spotify Cloud Configuration Nov 02 19:08:47 volumio volumio[992]: info: Asking plugin for UI Config Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 19:08:47 volumio volumio[992]: info: Saving Spotify Acccount Nov 02 19:08:47 volumio volumio[992]: info: Got it Nov 02 19:08:47 volumio volumio[992]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 02 19:08:47 volumio volumio[992]: info: Got Tidal Cloud Configuration Nov 02 19:08:47 volumio volumio[992]: info: Got it Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::volumioGetBrowseSources Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::volumioGetBrowseSources Nov 02 19:08:47 volumio volumio[992]: info: CoreCommandRouter::volumioGetBrowseSources Nov 02 19:08:47 volumio volumio[992]: info: TidalConnect service started! Nov 02 19:08:47 volumio volumio[992]: info: TidalConnect service started! Nov 02 19:08:48 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 19:08:48 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 02 19:08:50 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand update Nov 02 19:08:50 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:50 volumio volumio[992]: info: Nov 02 19:08:50 volumio volumio[992]: ---------------------------- MPD announces state update: update Nov 02 19:08:50 volumio volumio[992]: info: sendMpdCommand update took 1 milliseconds Nov 02 19:08:50 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:50 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:50 volumio volumio[992]: info: sendMpdCommand status took 8 milliseconds Nov 02 19:08:50 volumio volumio[992]: info: sendMpdCommand status took 8 milliseconds Nov 02 19:08:50 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:50 volumio volumio[992]: info: Command Router : Notfying DB Updatetrue Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::Close All Modals sent Nov 02 19:08:50 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:50 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:50 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:50 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:50 volumio volumio[992]: 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} Nov 02 19:08:50 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:50 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:50 volumio volumio[992]: info: No code Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:50 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:50 volumio volumio[992]: info: ------------------------------ 415ms Nov 02 19:08:50 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:50 volumio volumio[992]: info: Nov 02 19:08:50 volumio volumio[992]: ---------------------------- MPD announces state update: update Nov 02 19:08:50 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:50 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:50 volumio volumio[992]: info: sendMpdCommand status took 7 milliseconds Nov 02 19:08:50 volumio volumio[992]: info: sendMpdCommand status took 7 milliseconds Nov 02 19:08:50 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:50 volumio volumio[992]: info: Command Router : Notfying DB Updatefalse Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::Close All Modals sent Nov 02 19:08:50 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:50 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:50 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:50 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:50 volumio volumio[992]: 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} Nov 02 19:08:50 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:50 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:50 volumio volumio[992]: info: No code Nov 02 19:08:50 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:50 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:50 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:50 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:50 volumio volumio[992]: info: ------------------------------ 52ms Nov 02 19:08:51 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Nov 02 19:08:51 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand rescan Nov 02 19:08:51 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:51 volumio volumio[992]: info: Nov 02 19:08:51 volumio volumio[992]: ---------------------------- MPD announces state update: update Nov 02 19:08:51 volumio volumio[992]: info: sendMpdCommand rescan took 1 milliseconds Nov 02 19:08:51 volumio volumio[992]: info: ControllerMpd::getState Nov 02 19:08:51 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Nov 02 19:08:51 volumio volumio[992]: info: sendMpdCommand status took 1 milliseconds Nov 02 19:08:51 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:52 volumio volumio[992]: info: Command Router : Notfying DB Updatetrue Nov 02 19:08:52 volumio volumio[992]: info: CoreCommandRouter::Close All Modals sent Nov 02 19:08:52 volumio volumio[992]: verbose: ControllerMpd::parseState Nov 02 19:08:52 volumio volumio[992]: info: ControllerMpd::pushState Nov 02 19:08:52 volumio volumio[992]: info: CoreCommandRouter::servicePushState Nov 02 19:08:52 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:52 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:52 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:52 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:52 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:52 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:52 volumio volumio[992]: 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} Nov 02 19:08:52 volumio volumio[992]: verbose: CURRENT POSITION 0 Nov 02 19:08:52 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Nov 02 19:08:52 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Nov 02 19:08:52 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:52 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:52 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 19:08:52 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:52 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:52 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:52 volumio volumio[992]: info: No code Nov 02 19:08:52 volumio volumio[992]: info: CoreStateMachine::pushState Nov 02 19:08:52 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Nov 02 19:08:52 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Nov 02 19:08:52 volumio volumio[992]: info: MRS: Pushing multiroomSync output update for this device Nov 02 19:08:52 volumio volumio[992]: info: MRS: Pushing multiroomSync output Nov 02 19:08:52 volumio volumio[992]: info: ------------------------------ 145ms Nov 02 19:08:52 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 19:08:54 volumio volumio[992]: info: Disabling MyMusic plugin upnp Nov 02 19:08:54 volumio sudo[9811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Nov 02 19:08:54 volumio sudo[9811]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 19:08:54 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Nov 02 19:08:54 volumio volumio[992]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 19:08:54 volumio volumio[992]: error: Upnp client error: Error: This socket has been ended by the other party Nov 02 19:08:55 volumio volumio[992]: info: Enabling MyMusic plugin upnp Nov 02 19:08:55 volumio volumio[992]: info: Enabling plugin upnp Nov 02 19:08:55 volumio volumio[992]: info: Loading plugin "upnp"... Nov 02 19:08:55 volumio volumio[992]: info: [1730549335372] Starting Upmpd Daemon Nov 02 19:08:55 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 02 19:08:55 volumio volumio[992]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 19:08:55 volumio volumio[992]: Error: listen EADDRINUSE: address already in use :::6599 Nov 02 19:08:55 volumio volumio[992]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Nov 02 19:08:55 volumio volumio[992]: at listenInCluster (net.js:1379:12) Nov 02 19:08:55 volumio volumio[992]: at Server.listen (net.js:1465:7) Nov 02 19:08:55 volumio volumio[992]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Nov 02 19:08:55 volumio volumio[992]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Nov 02 19:08:55 volumio volumio[992]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Nov 02 19:08:55 volumio volumio[992]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Nov 02 19:08:55 volumio volumio[992]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Nov 02 19:08:55 volumio volumio[992]: code: 'EADDRINUSE', Nov 02 19:08:55 volumio volumio[992]: errno: -98, Nov 02 19:08:55 volumio volumio[992]: syscall: 'listen', Nov 02 19:08:55 volumio volumio[992]: address: '::', Nov 02 19:08:55 volumio volumio[992]: port: 6599 Nov 02 19:08:55 volumio volumio[992]: } Nov 02 19:08:55 volumio volumio[992]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 19:08:55 volumio sudo[9822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-02 19:07 Nov 02 19:08:55 volumio sudo[9822]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"