-- Logs begin at Mon 2025-02-17 22:29:56 +09, end at Mon 2025-02-17 22:50:44 +09. --
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:03 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 17 22:49:05 volumio volumio[906]: info: Discovery: Getting this device information
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 17 22:49:05 volumio volumio[906]: verbose: New Socket.io Connection to 192.168.5.18:3000 from 192.168.5.40 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 17 22:49:05 volumio volumio[906]: info: Discovery: Getting this device information
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:05 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:07 volumio sudo[6000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 17 22:49:07 volumio sudo[6000]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:49:07 volumio sudo[6000]: pam_unix(sudo:session): session closed for user root
Feb 17 22:49:07 volumio sudo[6002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 17 22:49:07 volumio sudo[6002]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:49:07 volumio sudo[6002]: pam_unix(sudo:session): session closed for user root
Feb 17 22:49:07 volumio volumio[906]: verbose: New Socket.io Connection to 192.168.5.18 from 192.168.5.40 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 17 22:49:07 volumio volumio[906]: info: Received Get System Info
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 17 22:49:07 volumio volumio[906]: info: Discovery: Getting this device information
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:07 volumio volumio[906]: info: Listing playlists
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 17 22:49:07 volumio sudo[6008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 17 22:49:07 volumio sudo[6008]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:49:07 volumio sudo[6008]: pam_unix(sudo:session): session closed for user root
Feb 17 22:49:07 volumio sudo[6010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 17 22:49:07 volumio sudo[6010]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:49:07 volumio sudo[6010]: pam_unix(sudo:session): session closed for user root
Feb 17 22:49:07 volumio volumio[906]: verbose: New Socket.io Connection to 192.168.5.18 from 192.168.5.40 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 17 22:49:07 volumio volumio[906]: info: Received Get System Info
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 17 22:49:07 volumio volumio[906]: info: Discovery: Getting this device information
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:07 volumio volumio[906]: info: Listing playlists
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 17 22:49:07 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 17 22:49:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Feb 17 22:49:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 17 22:49:09 volumio volumio[906]: info: Received Get System Info
Feb 17 22:49:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 17 22:49:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 17 22:49:09 volumio volumio[906]: info: Discovery: Getting this device information
Feb 17 22:49:09 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:17 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:20 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:21 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:21 volumio volumio[906]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Era/The%20Mass/3de175d5-3872-4417-b96e-ab9931cbd19c.png'
Feb 17 22:49:21 volumio volumio[906]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Era/The%20Mass/3de175d5-3872-4417-b96e-ab9931cbd19c.png'
Feb 17 22:49:24 volumio volumio[906]: info: CoreCommandRouter::volumioGetQueue
Feb 17 22:49:24 volumio volumio[906]: info: CoreStateMachine::getQueue
Feb 17 22:49:24 volumio volumio[906]: info: CorePlayQueue::getQueue
Feb 17 22:49:25 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 17 22:49:25 volumio volumio[906]: info: CURURI: music-library
Feb 17 22:49:25 volumio volumio[906]: info: Preload queue cleared
Feb 17 22:49:26 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 17 22:49:26 volumio volumio[906]: info: CURURI: music-library/INTERNAL
Feb 17 22:49:26 volumio volumio[906]: info: Preload queue cleared
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:27 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:27 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:27 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:27 volumio shairport-sync[1390]: {"time":1739799701777,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current
Feb 17 22:49:27 volumio shairport-sync[1390]: Dload Upload Total Spent Left Speed
Feb 17 22:49:27 volumio volumio[906]: info:
Feb 17 22:49:27 volumio volumio[906]: ---------------------------- Client requests Stop Airplay Playback
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback
Feb 17 22:49:27 volumio volumio[906]: info: Airplay playback stop
Feb 17 22:49:27 volumio volumio[906]: info: Airplay Playback Stopped, clearing state
Feb 17 22:49:27 volumio volumio[906]: info: CoreStateMachine::resetVolumioState
Feb 17 22:49:27 volumio volumio[906]: info: CoreStateMachine::getcurrentVolume
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::volumioRetrievevolume
Feb 17 22:49:27 volumio shairport-sync[1390]: [158B blob data]
Feb 17 22:49:27 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:27 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:30 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 17 22:49:30 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 17 22:49:30 volumio volumio[906]: info: Discovery: Getting this device information
Feb 17 22:49:30 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:49:30 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 17 22:49:31 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 17 22:49:31 volumio volumio[906]: info: CURURI: music-library/INTERNAL/ERA - The Mass (Universal.2003)
Feb 17 22:49:31 volumio volumio[906]: info: Preload queue cleared
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/02 - Looking For Something - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/03 - Don't Go Away - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/05 - If You Shout - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/06 - Avemano Orchestral - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/07 - Enae Volare - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/08 - Sombre Day - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/09 - Voxifera - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/10 - The Champions - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/11 - If You Shout - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Preloading song: music-library/INTERNAL/ERA - The Mass (Universal.2003)/04 - Don't You Forget - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F01%20-%20The%20Mass%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/02 - Looking For Something - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F02%20-%20Looking%20For%20Something%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/02 - Looking For Something - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/03 - Don't Go Away - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F03%20-%20Don't%20Go%20Away%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/03 - Don't Go Away - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/05 - If You Shout - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F05%20-%20If%20You%20Shout%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/05 - If You Shout - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/06 - Avemano Orchestral - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F06%20-%20Avemano%20Orchestral%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/06 - Avemano Orchestral - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/07 - Enae Volare - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F07%20-%20Enae%20Volare%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/07 - Enae Volare - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/08 - Sombre Day - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F08%20-%20Sombre%20Day%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/08 - Sombre Day - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/09 - Voxifera - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F09%20-%20Voxifera%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/09 - Voxifera - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/10 - The Champions - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F10%20-%20The%20Champions%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/10 - The Champions - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/11 - If You Shout - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F11%20-%20If%20You%20Shout%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/11 - If You Shout - ERA.dff
Feb 17 22:49:31 volumio volumio[906]: info: Exploding uri music-library/INTERNAL/ERA - The Mass (Universal.2003)/04 - Don't You Forget - ERA.dff in service mpd
Feb 17 22:49:31 volumio volumio[906]: info: ALBUMART /albumart?cacheid=192&web=Don't%20You%20Forget/The%20Mass/extralarge&path=%2Fmnt%2FINTERNAL%2FERA%20-%20The%20Mass%20(Universal.2003)%2F04%20-%20Don't%20You%20Forget%20-%20ERA.dff&metadata=false
Feb 17 22:49:31 volumio volumio[906]: info: URI /mnt/INTERNAL/ERA - The Mass (Universal.2003)/04 - Don't You Forget - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Preload queue cleared
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::ClearQueue
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::stop
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::serviceStop
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::serviceStop
Feb 17 22:49:33 volumio volumio[906]: info: Airplay Stop
Feb 17 22:49:33 volumio volumio[906]: info: Stopping Airplay Playback and sending pause command to client via USR2
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::clearPlayQueue
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::saveQueue
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::addQueueItems
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::addQueueItems
Feb 17 22:49:33 volumio volumio[906]: info: Preload queue cleared
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::saveQueue
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::updateTrackBlock
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrackBlock
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPlay
Feb 17 22:49:33 volumio volumio[906]: verbose: UNSET VOLATILE: Service: airplay_emulation
Feb 17 22:49:33 volumio volumio[906]: info: Stopping Airplay Playback and sending pause command to client via USR2
Feb 17 22:49:33 volumio sudo[6069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 1390
Feb 17 22:49:33 volumio sudo[6069]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::play index 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::addQueueItems
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::addQueueItems
Feb 17 22:49:33 volumio volumio[906]: info: Preload queue cleared
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/02 - Looking For Something - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/02 - Looking For Something - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/03 - Don't Go Away - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/03 - Don't Go Away - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/05 - If You Shout - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/05 - If You Shout - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/06 - Avemano Orchestral - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/06 - Avemano Orchestral - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/07 - Enae Volare - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/07 - Enae Volare - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/08 - Sombre Day - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/08 - Sombre Day - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/09 - Voxifera - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/09 - Voxifera - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/10 - The Champions - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/10 - The Champions - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/11 - If You Shout - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/11 - If You Shout - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)/04 - Don't You Forget - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)/04 - Don't You Forget - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::stop
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue
Feb 17 22:49:33 volumio sudo[6069]: pam_unix(sudo:session): session closed for user root
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::saveQueue
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::play index undefined
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::updateTrackBlock
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrackBlock
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::startPlaybackTimer
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand stop
Feb 17 22:49:33 volumio volumio[906]: info: Shairport-Sync paused with USR2
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand stop took 2 milliseconds
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand clear
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:49:33 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand clear took 1 milliseconds
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff"
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:49:33 volumio sudo[6073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 1390
Feb 17 22:49:33 volumio sudo[6073]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:49:33 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:49:33 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:49:33 volumio volumio[906]: error: updateQueue error: null
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:49:33 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 4ms
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand add "INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff" took 3 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 3ms
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 1ms
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand play
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:49:33 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:49:33 volumio sudo[6073]: pam_unix(sudo:session): session closed for user root
Feb 17 22:49:33 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:49:33 volumio volumio[906]: error: Upnp client error: Error: This socket has been ended by the other party
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 4ms
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand play took 3 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 2ms
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:49:33 volumio volumio[906]: info: Shairport-Sync paused with USR2
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand status took 21 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand status took 21 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand status took 21 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand status took 0 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand playlistinfo took 0 milliseconds
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - The Mass - ERA.dff","artist":null,"album":null,"uri":"INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff","trackType":"dff"}
Feb 17 22:49:33 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 23ms
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:49:33 volumio volumio[906]: info:
Feb 17 22:49:33 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand status took 2 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand status took 2 milliseconds
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":836,"duration":219,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - The Mass - ERA.dff","artist":null,"album":null,"uri":"INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff","trackType":"dff"}
Feb 17 22:49:33 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:49:33 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":990,"duration":219,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - The Mass - ERA.dff","artist":null,"album":null,"uri":"INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff","trackType":"dff"}
Feb 17 22:49:33 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:49:33 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":990,"duration":219,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - The Mass - ERA.dff","artist":null,"album":null,"uri":"INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff","trackType":"dff"}
Feb 17 22:49:33 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:49:33 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 34ms
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 35ms
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 15ms
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand playlistinfo took 11 milliseconds
Feb 17 22:49:33 volumio volumio[906]: info: sendMpdCommand playlistinfo took 11 milliseconds
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:49:33 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":990,"duration":219,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - The Mass - ERA.dff","artist":null,"album":null,"uri":"INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff","trackType":"dff"}
Feb 17 22:49:33 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:49:33 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":990,"duration":219,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - The Mass - ERA.dff","artist":null,"album":null,"uri":"INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff","trackType":"dff"}
Feb 17 22:49:33 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:49:33 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:49:33 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:49:33 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 22ms
Feb 17 22:49:33 volumio volumio[906]: info: ------------------------------ 22ms
Feb 17 22:49:34 volumio volumio[906]: info: Restarting Shairport-Sync after stop
Feb 17 22:49:34 volumio volumio[906]: info: Restarting Shairport-Sync after stop
Feb 17 22:49:34 volumio sudo[6079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 17 22:49:34 volumio sudo[6079]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:49:34 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 17 22:49:34 volumio shairport-sync[1390]: {"time":1739800167889,"response":"stopAirplayPlayback Success"}
Feb 17 22:49:34 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 17 22:49:34 volumio sudo[6082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 17 22:49:34 volumio sudo[6082]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:49:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 17 22:49:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 17 22:49:34 volumio sudo[6079]: pam_unix(sudo:session): session closed for user root
Feb 17 22:49:34 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 17 22:49:34 volumio volumio[906]: info: Shairport-Sync retarted
Feb 17 22:49:34 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Feb 17 22:49:34 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 17 22:49:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 17 22:49:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 17 22:49:34 volumio sudo[6082]: pam_unix(sudo:session): session closed for user root
Feb 17 22:49:34 volumio volumio[906]: info: Shairport-Sync retarted
Feb 17 22:50:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 17 22:50:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 17 22:50:00 volumio volumio[906]: info: Discovery: Getting this device information
Feb 17 22:50:00 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:50:00 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 17 22:50:22 volumio volumio[906]: info: Airplay started streaming, receiving metadatas
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioStop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::stPlaybackTimer
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::updateTrackBlock
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrackBlock
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::serviceStop
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::serviceStop
Feb 17 22:50:22 volumio volumio[906]: info: ControllerMpd::stop
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:22 volumio volumio[906]: info: Airplay started streaming, receiving metadatas
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioStop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:22 volumio volumio[906]: info: Airplay started streaming, receiving metadatas
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioStop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:22 volumio volumio[906]: info: sendMpdCommand stop took 6 milliseconds
Feb 17 22:50:22 volumio volumio[906]: info:
Feb 17 22:50:22 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:22 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:22 volumio volumio[906]: info:
Feb 17 22:50:22 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:22 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:22 volumio volumio[906]: info:
Feb 17 22:50:22 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:22 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:22 volumio volumio[906]: info: sendMpdCommand status took 1 milliseconds
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:22 volumio volumio[906]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 17 22:50:22 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:22 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: 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":"01 - The Mass - ERA.dff","artist":null,"album":null,"uri":"INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff","trackType":"dff"}
Feb 17 22:50:22 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::syncState stateService stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio volumio[906]: info: No code
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: 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":"01 - The Mass - ERA.dff","artist":null,"album":null,"uri":"INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff","trackType":"dff"}
Feb 17 22:50:22 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::syncState stateService stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio shairport-sync[6085]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 17 22:50:22 volumio shairport-sync[6085]: Dload Upload Total Spent Left Speed
Feb 17 22:50:22 volumio volumio[906]: info: No code
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: 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":"01 - The Mass - ERA.dff","artist":null,"album":null,"uri":"INTERNAL/ERA - The Mass (Universal.2003)/01 - The Mass - ERA.dff","trackType":"dff"}
Feb 17 22:50:22 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::syncState stateService stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio volumio[906]: info: No code
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:22 volumio volumio[906]: info: ------------------------------ 25ms
Feb 17 22:50:22 volumio volumio[906]: info: ------------------------------ 25ms
Feb 17 22:50:22 volumio volumio[906]: info: ------------------------------ 25ms
Feb 17 22:50:22 volumio volumio[906]: info:
Feb 17 22:50:22 volumio volumio[906]: ---------------------------- Client requests Start Airplay PlaybackRoutine
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback
Feb 17 22:50:22 volumio volumio[906]: info: Airplay playback start
Feb 17 22:50:22 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:22 volumio volumio[906]: info: CoreCommandRouter::volumioStop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::stop
Feb 17 22:50:22 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:22 volumio shairport-sync[6085]: [158B blob data]
Feb 17 22:50:23 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:23 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:23 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:24 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:26 volumio shairport-sync[6085]: {"time":1739800222611,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current
Feb 17 22:50:26 volumio shairport-sync[6085]: Dload Upload Total Spent Left Speed
Feb 17 22:50:26 volumio volumio[906]: info:
Feb 17 22:50:26 volumio volumio[906]: ---------------------------- Client requests Stop Airplay Playback
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback
Feb 17 22:50:26 volumio volumio[906]: info: Airplay playback stop
Feb 17 22:50:26 volumio volumio[906]: info: Airplay Playback Stopped, clearing state
Feb 17 22:50:26 volumio volumio[906]: info: CoreStateMachine::resetVolumioState
Feb 17 22:50:26 volumio volumio[906]: info: CoreStateMachine::getcurrentVolume
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::volumioRetrievevolume
Feb 17 22:50:26 volumio shairport-sync[6085]: [158B blob data]
Feb 17 22:50:26 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:26 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:30 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 17 22:50:30 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 17 22:50:30 volumio volumio[906]: info: Discovery: Getting this device information
Feb 17 22:50:30 volumio volumio[906]: info: CoreCommandRouter::volumioGetState
Feb 17 22:50:30 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 17 22:50:31 volumio volumio[906]: info: Preload queue cleared
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::ClearQueue
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::stop
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::serviceStop
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::serviceStop
Feb 17 22:50:31 volumio volumio[906]: info: Airplay Stop
Feb 17 22:50:31 volumio volumio[906]: info: Stopping Airplay Playback and sending pause command to client via USR2
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::clearPlayQueue
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::saveQueue
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::addQueueItems
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::addQueueItems
Feb 17 22:50:31 volumio volumio[906]: info: Preload queue cleared
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/(DSD512)Babel Piano Solo.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/(DSD512)Babel Piano Solo.dsf
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::saveQueue
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::updateTrackBlock
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrackBlock
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPlay
Feb 17 22:50:31 volumio volumio[906]: verbose: UNSET VOLATILE: Service: airplay_emulation
Feb 17 22:50:31 volumio volumio[906]: info: Stopping Airplay Playback and sending pause command to client via USR2
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::play index 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::addQueueItems
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::addQueueItems
Feb 17 22:50:31 volumio volumio[906]: info: Preload queue cleared
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/【DSD256】试音歌曲.dff
Feb 17 22:50:31 volumio sudo[6350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 6085
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/【DSD256】试音歌曲.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/Sister-Drum 阿姐鼓.dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/Sister-Drum 阿姐鼓.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/你的眼神.dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/你的眼神.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/再度孤独.dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/再度孤独.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/初恋.dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/初恋.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/恰似你的温柔.dff
Feb 17 22:50:31 volumio sudo[6350]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:50:31 volumio sudo[6350]: pam_unix(sudo:session): session closed for user root
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/恰似你的温柔.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/我曾用心爱你.dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/我曾用心爱你.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/渡口.dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/渡口.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/被遗忘的时光(电影「无间道」插曲).dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/被遗忘的时光(电影「无间道」插曲).dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/邓丽君 - 千言万语.dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/邓丽君 - 千言万语.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/邓丽君 - 月亮代表我的心.dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/邓丽君 - 月亮代表我的心.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/邓丽君 - 甜蜜蜜.dff
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/邓丽君 - 甜蜜蜜.dff
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/陈佳 - 应是故人来.wav
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/陈佳 - 应是故人来.wav
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/關淑怡 - 深夜港灣 [SHM-SACD].dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/關淑怡 - 深夜港灣 [SHM-SACD].dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/天空-王菲.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/天空-王菲.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/宁夏-梁静茹.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/宁夏-梁静茹.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/孤单北半球-梁静茹.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/孤单北半球-梁静茹.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/加州旅馆.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/加州旅馆.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/是不是這樣的夜晚…你才會這樣的想起我-It's All About 彭家麗 (DSD)-彭家麗(DSD).dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/是不是這樣的夜晚…你才會這樣的想起我-It's All About 彭家麗 (DSD)-彭家麗(DSD).dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/昨天•今天•下雨天-It's All About 彭家麗 (DSD)-彭家麗(DSD).dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/昨天•今天•下雨天-It's All About 彭家麗 (DSD)-彭家麗(DSD).dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/【DSD512】Various Artists - Jazz at the Pawnshop.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/【DSD512】Various Artists - Jazz at the Pawnshop.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/MOZART Violin Concerto in A major KV 219, I. Allegro aperto【bbvane0】.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/MOZART Violin Concerto in A major KV 219, I. Allegro aperto【bbvane0】.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/天荒愛未老 (DSD64).dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/天荒愛未老 (DSD64).dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/【DSD256】TrondheimSolistene-REFLECTIONS.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/【DSD256】TrondheimSolistene-REFLECTIONS.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/【DSD256】Concerto in E major, La Primavera (Spring) ,Op. 8-1, RV 269.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/【DSD256】Concerto in E major, La Primavera (Spring) ,Op. 8-1, RV 269.dsf
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/A. Vivaldi - La Stravaganza - Arte dei Suonatori, Rachel Podger (Channel.2003) 2xDisc
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/A. Vivaldi - La Stravaganza - Arte dei Suonatori, Rachel Podger (Channel.2003) 2xDisc
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/Camille Saint-Saens, Cesar Franck, Franz Liszt - Arthur Rubinstein, Alfred Wallenstein 1956,1958 (RCA Living Stereo.2007)
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/Camille Saint-Saens, Cesar Franck, Franz Liszt - Arthur Rubinstein, Alfred Wallenstein 1956,1958 (RCA Living Stereo.2007)
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/Emi Fujita藤田惠美 - Camomile Blend SACD (Foward.2004)
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/Emi Fujita藤田惠美 - Camomile Blend SACD (Foward.2004)
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/ERA - The Mass (Universal.2003)
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/ERA - The Mass (Universal.2003)
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/Josef Wolfl - The Symphonies - Pratum Integrum Orchestra (Caromitis.2005)
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/Josef Wolfl - The Symphonies - Pratum Integrum Orchestra (Caromitis.2005)
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/Kitaro - Daylight, Moonlight - Kitaro Live in Yakushiji (Domo.2002) 2xSACD
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/Kitaro - Daylight, Moonlight - Kitaro Live in Yakushiji (Domo.2002) 2xSACD
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/Kitaro - Kojiki 喜多郞-古事记 1999 (Domo.2003)
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/Kitaro - Kojiki 喜多郞-古事记 1999 (Domo.2003)
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/Michael Jackson - Thriller 1982 (Westlake.1999)
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/Michael Jackson - Thriller 1982 (Westlake.1999)
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/Miyuki Nakajima中岛美雪 - Live at Sony Pictures Studios in L.A (Yamaha.2005)
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/Miyuki Nakajima中岛美雪 - Live at Sony Pictures Studios in L.A (Yamaha.2005)
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/Sergei Prokofiev - Ivan The Terrible Op. 116 - The Saint Louis Symphony Orchestra 1979 (Mobile Fidelity.2003)
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/Sergei Prokofiev - Ivan The Terrible Op. 116 - The Saint Louis Symphony Orchestra 1979 (Mobile Fidelity.2003)
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/W. A. Mozart - Great Mass in C minor KV 427 - J.S. Bach Chorale (Nicol Matt) (Brilliant.2004)
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/W. A. Mozart - Great Mass in C minor KV 427 - J.S. Bach Chorale (Nicol Matt) (Brilliant.2004)
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/W.A. Mozart - Piano Concertos (Derek Han, Paul Freeman & Philharmonia Orchestra) - (Brilliant.2005) 11xDisc
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/W.A. Mozart - Piano Concertos (Derek Han, Paul Freeman & Philharmonia Orchestra) - (Brilliant.2005) 11xDisc
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/巴赫d小调双小提琴协奏曲BWV1043Solisti Filarmonici ltaliani
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/巴赫d小调双小提琴协奏曲BWV1043Solisti Filarmonici ltaliani
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/邓丽君 - あの日 あの街で[WAV+CUE]
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/邓丽君 - あの日 あの街で[WAV+CUE]
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/阿梨粤
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/阿梨粤
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/陈慧娴
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/陈慧娴
Feb 17 22:50:31 volumio volumio[906]: info: Adding Item to queue: music-library/INTERNAL/黄凯芹
Feb 17 22:50:31 volumio volumio[906]: info: Using cached record of: music-library/INTERNAL/黄凯芹
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::stop
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue
Feb 17 22:50:31 volumio sudo[6354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 6085
Feb 17 22:50:31 volumio sudo[6354]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:50:31 volumio sudo[6354]: pam_unix(sudo:session): session closed for user root
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::saveQueue
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::play index undefined
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::updateTrackBlock
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrackBlock
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::startPlaybackTimer
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/(DSD512)Babel Piano Solo.dsf
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand stop
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand stop took 10 milliseconds
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand clear
Feb 17 22:50:31 volumio volumio[906]: info: Shairport-Sync paused with USR2
Feb 17 22:50:31 volumio volumio[906]: info: Shairport-Sync paused with USR2
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:31 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand clear took 4 milliseconds
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/(DSD512)Babel Piano Solo.dsf"
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:31 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:31 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:31 volumio volumio[906]: error: updateQueue error: null
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:31 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 2ms
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand add "INTERNAL/(DSD512)Babel Piano Solo.dsf" took 2 milliseconds
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 1ms
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand play
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:31 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:31 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 2ms
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand play took 1 milliseconds
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 1ms
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand status took 26 milliseconds
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand status took 25 milliseconds
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:31 volumio volumio[906]: info:
Feb 17 22:50:31 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand status took 5 milliseconds
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand status took 2 milliseconds
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:31 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":231,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:31 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:31 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":231,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:31 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:31 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 41ms
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 44ms
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 49ms
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand playlistinfo took 21 milliseconds
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand playlistinfo took 20 milliseconds
Feb 17 22:50:31 volumio volumio[906]: info: sendMpdCommand playlistinfo took 20 milliseconds
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:31 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":325,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:31 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:31 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":337,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:31 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:31 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":341,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:31 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:31 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:31 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 45ms
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 43ms
Feb 17 22:50:31 volumio volumio[906]: info: ------------------------------ 43ms
Feb 17 22:50:32 volumio volumio[906]: info: Restarting Shairport-Sync after stop
Feb 17 22:50:32 volumio volumio[906]: info: Restarting Shairport-Sync after stop
Feb 17 22:50:32 volumio sudo[6363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 17 22:50:32 volumio sudo[6363]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:50:32 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 17 22:50:32 volumio shairport-sync[6085]: {"time":1739800226569,"response":"stopAirplayPlayback Success"}
Feb 17 22:50:32 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 17 22:50:32 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 17 22:50:32 volumio sudo[6366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 17 22:50:32 volumio sudo[6366]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 17 22:50:32 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 17 22:50:32 volumio sudo[6363]: pam_unix(sudo:session): session closed for user root
Feb 17 22:50:32 volumio volumio[906]: info: Shairport-Sync retarted
Feb 17 22:50:32 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 17 22:50:32 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Feb 17 22:50:32 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 17 22:50:32 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 17 22:50:32 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 17 22:50:32 volumio sudo[6366]: pam_unix(sudo:session): session closed for user root
Feb 17 22:50:32 volumio volumio[906]: info: Shairport-Sync retarted
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::volumioSeek
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::seek
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/(DSD512)Babel Piano Solo.dsf","service":"mpd","name":"(DSD512)Babel Piano Solo.dsf","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=192&web=//extralarge&path=%2FINTERNAL&metadata=false","duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","trackType":"dsf","channels":2}
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::startPlaybackTimer
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: info: ControllerMpd::seek
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:36 volumio volumio[906]: error: null
Feb 17 22:50:36 volumio volumio[906]: info:
Feb 17 22:50:36 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:36 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:36 volumio volumio[906]: info:
Feb 17 22:50:36 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:36 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:36 volumio volumio[906]: info:
Feb 17 22:50:36 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:36 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:36 volumio volumio[906]: info: sendMpdCommand status took 2 milliseconds
Feb 17 22:50:36 volumio volumio[906]: info: sendMpdCommand status took 1 milliseconds
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:36 volumio volumio[906]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:36 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63000,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:36 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:36 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:36 volumio volumio[906]: info: ------------------------------ 8ms
Feb 17 22:50:36 volumio volumio[906]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 17 22:50:36 volumio volumio[906]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:36 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:36 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63000,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:36 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:36 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:36 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63000,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:36 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:36 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:36 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:36 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:36 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:36 volumio volumio[906]: info: ------------------------------ 22ms
Feb 17 22:50:36 volumio volumio[906]: info: ------------------------------ 22ms
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::volumioSeek
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::seek
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/(DSD512)Babel Piano Solo.dsf","service":"mpd","name":"(DSD512)Babel Piano Solo.dsf","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=192&web=//extralarge&path=%2FINTERNAL&metadata=false","duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","trackType":"dsf","channels":2}
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::startPlaybackTimer
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: info: ControllerMpd::seek
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:38 volumio volumio[906]: error: null
Feb 17 22:50:38 volumio volumio[906]: info:
Feb 17 22:50:38 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:38 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:38 volumio volumio[906]: info:
Feb 17 22:50:38 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:38 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:38 volumio volumio[906]: info:
Feb 17 22:50:38 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:38 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:38 volumio volumio[906]: info: sendMpdCommand status took 2 milliseconds
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:38 volumio volumio[906]: info: sendMpdCommand status took 3 milliseconds
Feb 17 22:50:38 volumio volumio[906]: info: sendMpdCommand status took 3 milliseconds
Feb 17 22:50:38 volumio volumio[906]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:38 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":190000,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:38 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:38 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:38 volumio volumio[906]: info: ------------------------------ 12ms
Feb 17 22:50:38 volumio volumio[906]: info: sendMpdCommand playlistinfo took 8 milliseconds
Feb 17 22:50:38 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:38 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":190000,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:38 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:38 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:38 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":190000,"duration":377,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"45158 Kbps","isStreaming":false,"title":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:38 volumio volumio[906]: verbose: CURRENT POSITION 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:38 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:38 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:38 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:38 volumio volumio[906]: info: ------------------------------ 20ms
Feb 17 22:50:38 volumio volumio[906]: info: ------------------------------ 21ms
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPlay
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::play index 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::stop
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::stPlaybackTimer
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::updateTrackBlock
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrackBlock
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::serviceStop
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 0
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::serviceStop
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::stop
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand stop
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand stop took 3 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::play index undefined
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::startPlaybackTimer
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/【DSD256】试音歌曲.dff
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand stop
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand status took 2 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand stop took 2 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand status took 2 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand status took 1 milliseconds
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand clear
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:42 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand clear took 1 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/【DSD256】试音歌曲.dff"
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: 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":"(DSD512)Babel Piano Solo.dsf","artist":null,"album":null,"uri":"INTERNAL/(DSD512)Babel Piano Solo.dsf","trackType":"dsf"}
Feb 17 22:50:42 volumio volumio[906]: verbose: CURRENT POSITION 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState stateService stop
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: No code
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Feb 17 22:50:42 volumio volumio[906]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 11ms
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 10ms
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 9ms
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:42 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:42 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:42 volumio volumio[906]: error: updateQueue error: null
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:42 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 13ms
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand add "INTERNAL/【DSD256】试音歌曲.dff" took 12 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 6ms
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 5ms
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand play
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:42 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update
Feb 17 22:50:42 volumio volumio[906]: info: Ignoring MPD Status Update
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 7ms
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand play took 6 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 7ms
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 7ms
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand status took 18 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand status took 19 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand status took 18 milliseconds
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:42 volumio volumio[906]: info:
Feb 17 22:50:42 volumio volumio[906]: ---------------------------- MPD announces state update: player
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::getState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand status took 8 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand playlistinfo took 9 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand status took 9 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand playlistinfo took 8 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand playlistinfo took 8 milliseconds
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":251,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"【DSD256】试音歌曲.dff","artist":null,"album":null,"uri":"INTERNAL/【DSD256】试音歌曲.dff","trackType":"dff"}
Feb 17 22:50:42 volumio volumio[906]: verbose: CURRENT POSITION 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":251,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"【DSD256】试音歌曲.dff","artist":null,"album":null,"uri":"INTERNAL/【DSD256】试音歌曲.dff","trackType":"dff"}
Feb 17 22:50:42 volumio volumio[906]: verbose: CURRENT POSITION 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:42 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":251,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"【DSD256】试音歌曲.dff","artist":null,"album":null,"uri":"INTERNAL/【DSD256】试音歌曲.dff","trackType":"dff"}
Feb 17 22:50:42 volumio volumio[906]: verbose: CURRENT POSITION 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:42 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 37ms
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 40ms
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 40ms
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand status took 16 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand playlistinfo took 13 milliseconds
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand playlistinfo took 13 milliseconds
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseState
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:42 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":196,"duration":251,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"【DSD256】试音歌曲.dff","artist":null,"album":null,"uri":"INTERNAL/【DSD256】试音歌曲.dff","trackType":"dff"}
Feb 17 22:50:42 volumio volumio[906]: verbose: CURRENT POSITION 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:42 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":197,"duration":251,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"【DSD256】试音歌曲.dff","artist":null,"album":null,"uri":"INTERNAL/【DSD256】试音歌曲.dff","trackType":"dff"}
Feb 17 22:50:42 volumio volumio[906]: verbose: CURRENT POSITION 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:42 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:42 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:42 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 30ms
Feb 17 22:50:42 volumio volumio[906]: info: ------------------------------ 29ms
Feb 17 22:50:42 volumio volumio[906]: info: sendMpdCommand playlistinfo took 8 milliseconds
Feb 17 22:50:43 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo
Feb 17 22:50:43 volumio volumio[906]: info: ControllerMpd::pushState
Feb 17 22:50:43 volumio volumio[906]: info: CoreCommandRouter::servicePushState
Feb 17 22:50:43 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:43 volumio volumio[906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":402,"duration":251,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"【DSD256】试音歌曲.dff","artist":null,"album":null,"uri":"INTERNAL/【DSD256】试音歌曲.dff","trackType":"dff"}
Feb 17 22:50:43 volumio volumio[906]: verbose: CURRENT POSITION 1
Feb 17 22:50:43 volumio volumio[906]: info: CoreStateMachine::syncState stateService play
Feb 17 22:50:43 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus play
Feb 17 22:50:43 volumio volumio[906]: info: Received an update from plugin. extracting info from payload
Feb 17 22:50:43 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:43 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:43 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 17 22:50:43 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:43 volumio volumio[906]: info: CoreStateMachine::pushState
Feb 17 22:50:43 volumio volumio[906]: info: CorePlayQueue::getTrack 1
Feb 17 22:50:43 volumio volumio[906]: info: CoreCommandRouter::volumioPushState
Feb 17 22:50:43 volumio volumio[906]: info: ------------------------------ 35ms
Feb 17 22:50:44 volumio volumio[906]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 17 22:50:44 volumio volumio[906]: Error: connect ETIMEDOUT 108.160.166.42:443
Feb 17 22:50:44 volumio volumio[906]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Feb 17 22:50:44 volumio volumio[906]: errno: -110,
Feb 17 22:50:44 volumio volumio[906]: code: 'ETIMEDOUT',
Feb 17 22:50:44 volumio volumio[906]: syscall: 'connect',
Feb 17 22:50:44 volumio volumio[906]: address: '108.160.166.42',
Feb 17 22:50:44 volumio volumio[906]: port: 443
Feb 17 22:50:44 volumio volumio[906]: }
Feb 17 22:50:44 volumio volumio[906]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 17 22:50:44 volumio sudo[6480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-17 22:49
Feb 17 22:50:44 volumio sudo[6480]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"