-- Logs begin at Fri 2025-03-14 22:08:10 CST, end at Fri 2025-03-14 22:10:49 CST. --
Mar 14 22:09:01 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Mar 14 22:09:01 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Mar 14 22:09:01 volumio sudo[1909]: pam_unix(sudo:session): session closed for user root
Mar 14 22:09:01 volumio volumio[1019]: info: Cannot mount NAS istoreOS at system boot, trial number 4 ,retrying in 5 seconds
Mar 14 22:09:05 volumio volumio[1019]: info: BOOT COMPLETED
Mar 14 22:09:06 volumio sudo[1940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=wyzsam1988@outlook.com,password=WYZsam1988,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.150/share\music /mnt/NAS/istoreOS
Mar 14 22:09:06 volumio sudo[1940]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 14 22:09:06 volumio kernel: CIFS: Attempting to mount //192.168.3.150/share/music
Mar 14 22:09:07 volumio volumio[1019]: info: Preload queue cleared
Mar 14 22:09:07 volumio volumio[1019]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::ClearQueue
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::stop
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:09:07 volumio volumio[1019]: info: CorePlayQueue::clearPlayQueue
Mar 14 22:09:07 volumio volumio[1019]: info: CorePlayQueue::saveQueue
Mar 14 22:09:07 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::addQueueItems
Mar 14 22:09:07 volumio volumio[1019]: info: CorePlayQueue::addQueueItems
Mar 14 22:09:07 volumio volumio[1019]: info: Preload queue cleared
Mar 14 22:09:07 volumio volumio[1019]: info: Adding Item to queue: music-library/NAS/istoreOS/1982 Bluebird
Mar 14 22:09:07 volumio volumio[1019]: info: Exploding uri music-library/NAS/istoreOS/1982 Bluebird in service mpd
Mar 14 22:09:07 volumio volumio[1019]: error: scanFolder - failure to stat '/mnt/NAS/istoreOS/1982 Bluebird'
Mar 14 22:09:07 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue
Mar 14 22:09:07 volumio volumio[1019]: info: CorePlayQueue::saveQueue
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock
Mar 14 22:09:07 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock
Mar 14 22:09:07 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::play index 0
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::stop
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::play index undefined
Mar 14 22:09:07 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:09:07 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:09:08 volumio volumio[1019]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 14 22:09:08 volumio volumio[1019]: info: Retrying Login Due to Network Error
Mar 14 22:09:11 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState
Mar 14 22:09:11 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:09:12 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Mar 14 22:09:12 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Mar 14 22:09:12 volumio sudo[1940]: pam_unix(sudo:session): session closed for user root
Mar 14 22:09:12 volumio volumio[1019]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Mar 14 22:09:15 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Mar 14 22:09:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Mar 14 22:09:18 volumio volumio[1019]: info: MyVolumio login type: Token
Mar 14 22:09:20 volumio ntpd[1001]: Soliciting pool server 116.203.151.74
Mar 14 22:09:21 volumio ntpd[1001]: Soliciting pool server 5.79.108.34
Mar 14 22:09:21 volumio ntpd[1001]: Soliciting pool server 193.182.111.143
Mar 14 22:09:22 volumio ntpd[1001]: Soliciting pool server 81.16.177.123
Mar 14 22:09:22 volumio ntpd[1001]: Soliciting pool server 95.111.202.5
Mar 14 22:09:22 volumio ntpd[1001]: Soliciting pool server 193.182.111.142
Mar 14 22:09:23 volumio ntpd[1001]: Soliciting pool server 185.209.85.222
Mar 14 22:09:24 volumio ntpd[1001]: Soliciting pool server 162.159.200.123
Mar 14 22:09:25 volumio ntpd[1001]: Soliciting pool server 113.207.49.85
Mar 14 22:09:26 volumio ntpd[1001]: Soliciting pool server 193.182.111.12
Mar 14 22:09:27 volumio ntpd[1001]: Soliciting pool server 172.105.240.243
Mar 14 22:09:28 volumio ntpd[1001]: Soliciting pool server 193.182.111.142
Mar 14 22:09:28 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState
Mar 14 22:09:28 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:09:29 volumio systemd[1]: Starting Daily apt download activities...
Mar 14 22:09:29 volumio ntpd[1001]: receive: Unexpected origin timestamp 0xeb7eb718.e204c682 does not match aorg 0000000000.00000000 from server@95.111.202.5 xmt 0xeb7eb719.86c9db12
Mar 14 22:09:29 volumio ntpd[1001]: receive: Unexpected origin timestamp 0xeb7eb718.e1fe2893 does not match aorg 0000000000.00000000 from server@81.16.177.123 xmt 0xeb7eb719.972b29ab
Mar 14 22:09:30 volumio ntpd[1001]: Soliciting pool server 84.16.67.12
Mar 14 22:09:30 volumio systemd[1]: apt-daily.service: Succeeded.
Mar 14 22:09:30 volumio systemd[1]: Started Daily apt download activities.
Mar 14 22:09:34 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 14 22:09:34 volumio volumio[1019]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory
Mar 14 22:09:34 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Mar 14 22:09:34 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Mar 14 22:09:34 volumio sudo[2088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Mar 14 22:09:34 volumio sudo[2088]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 14 22:09:34 volumio sudo[2094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Mar 14 22:09:34 volumio sudo[2094]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 14 22:09:34 volumio sudo[2088]: pam_unix(sudo:session): session closed for user root
Mar 14 22:09:34 volumio sudo[2100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Mar 14 22:09:34 volumio sudo[2100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 14 22:09:34 volumio sudo[2094]: pam_unix(sudo:session): session closed for user root
Mar 14 22:09:34 volumio sudo[2108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Mar 14 22:09:34 volumio sudo[2108]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 14 22:09:34 volumio sudo[2118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 14 22:09:34 volumio sudo[2100]: pam_unix(sudo:session): session closed for user root
Mar 14 22:09:34 volumio sudo[2118]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 14 22:09:34 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Mar 14 22:09:34 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Mar 14 22:09:34 volumio sudo[2118]: pam_unix(sudo:session): session closed for user root
Mar 14 22:09:34 volumio sudo[2108]: pam_unix(sudo:session): session closed for user root
Mar 14 22:09:34 volumio sudo[2126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 14 22:09:34 volumio sudo[2126]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 14 22:09:34 volumio sudo[2126]: pam_unix(sudo:session): session closed for user root
Mar 14 22:09:41 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState
Mar 14 22:09:41 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:09:44 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 14 22:09:44 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 14 22:09:44 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 14 22:09:44 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 14 22:09:44 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Mar 14 22:09:44 volumio volumio[1019]: info: Received Get System Version
Mar 14 22:09:44 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 14 22:09:49 volumio volumio[1019]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 14 22:09:49 volumio volumio[1019]: info: Retrying Login Due to Network Error
Mar 14 22:09:50 volumio volumio-remote-updater[739]: No test mode
Mar 14 22:09:50 volumio volumio-remote-updater[739]: No alpha test mode
Mar 14 22:09:51 volumio volumio[1019]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Mar 14 22:09:51 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 14 22:09:52 volumio volumio[1019]: info: CoreCommandRouter::Close All Modals sent
Mar 14 22:09:59 volumio volumio[1019]: info: MyVolumio login type: Token
Mar 14 22:10:01 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState
Mar 14 22:10:01 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:02 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay
Mar 14 22:10:02 volumio volumio[1019]: info: CoreStateMachine::play index undefined
Mar 14 22:10:02 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:02 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:07 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 14 22:10:07 volumio volumio[1019]: info: CURURI: albums://
Mar 14 22:10:07 volumio volumio[1019]: info: listAlbums - loading Albums from cache
Mar 14 22:10:07 volumio volumio[1019]: info: Preload queue cleared
Mar 14 22:10:10 volumio volumio[1019]: info: Preload queue cleared
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::ClearQueue
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::stop
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::clearPlayQueue
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::saveQueue
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::addQueueItems
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::addQueueItems
Mar 14 22:10:10 volumio volumio[1019]: info: Preload queue cleared
Mar 14 22:10:10 volumio volumio[1019]: info: Adding Item to queue: albums://Backstreet%20Boys/Backstreet%20Boys
Mar 14 22:10:10 volumio volumio[1019]: info: Exploding uri albums://Backstreet%20Boys/Backstreet%20Boys in service mpd
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::saveQueue
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::play index 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::stop
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::play index undefined
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::clearAddPlayTracks NAS/istoreOS/Backstreet Boys/Backstreet Boys/01 We've Got It Goin' On (Radio Edit.m4a
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand stop took 5 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clear
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand clear took 1 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand add "NAS/istoreOS/Backstreet Boys/Backstreet Boys/01 We've Got It Goin' On (Radio Edit.m4a"
Mar 14 22:10:10 volumio volumio[1019]: info:
Mar 14 22:10:10 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:10 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:10 volumio volumio[1019]: info:
Mar 14 22:10:10 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:10 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand add "NAS/istoreOS/Backstreet Boys/Backstreet Boys/01 We've Got It Goin' On (Radio Edit.m4a" took 10 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand play
Mar 14 22:10:10 volumio volumio[1019]: info:
Mar 14 22:10:10 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:10 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:10 volumio volumio[1019]: info:
Mar 14 22:10:10 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:10 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:10 volumio volumio[1019]: info:
Mar 14 22:10:10 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:10 volumio volumio[1019]: info: ------------------------------ 24ms
Mar 14 22:10:10 volumio volumio[1019]: info: ------------------------------ 23ms
Mar 14 22:10:10 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:10 volumio volumio[1019]: info: ------------------------------ 12ms
Mar 14 22:10:10 volumio volumio[1019]: info: ------------------------------ 10ms
Mar 14 22:10:10 volumio volumio[1019]: info:
Mar 14 22:10:10 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:10 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:10 volumio volumio[1019]: info:
Mar 14 22:10:10 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:10 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:10 volumio volumio[1019]: info:
Mar 14 22:10:10 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:10 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:10 volumio volumio[1019]: info:
Mar 14 22:10:10 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:10 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:10 volumio volumio[1019]: error: Upnp client error: Error: This socket has been ended by the other party
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand status took 24 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: info: ------------------------------ 22ms
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand status took 20 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: info: ------------------------------ 20ms
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand status took 18 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand clearerror took 19 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand clearerror took 17 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand clearerror took 16 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 5 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 5 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:10 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:10 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: 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":"We've Got It Goin' On (Radio Edit)","artist":"Backstreet Boys","album":"Backstreet Boys","uri":"NAS/istoreOS/Backstreet Boys/Backstreet Boys/01 We've Got It Goin' On (Radio Edit.m4a","trackType":"m4a"}
Mar 14 22:10:10 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::syncState stateService stop
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:10 volumio volumio[1019]: info: No code
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:10 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: 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":"We've Got It Goin' On (Radio Edit)","artist":"Backstreet Boys","album":"Backstreet Boys","uri":"NAS/istoreOS/Backstreet Boys/Backstreet Boys/01 We've Got It Goin' On (Radio Edit.m4a","trackType":"m4a"}
Mar 14 22:10:10 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::syncState stateService stop
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:10 volumio volumio[1019]: info: No code
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:10 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: 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":"We've Got It Goin' On (Radio Edit)","artist":"Backstreet Boys","album":"Backstreet Boys","uri":"NAS/istoreOS/Backstreet Boys/Backstreet Boys/01 We've Got It Goin' On (Radio Edit.m4a","trackType":"m4a"}
Mar 14 22:10:10 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::syncState stateService stop
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:10 volumio volumio[1019]: info: No code
Mar 14 22:10:10 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:10 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:10 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:10 volumio volumio[1019]: info: ------------------------------ 147ms
Mar 14 22:10:10 volumio volumio[1019]: info: ------------------------------ 147ms
Mar 14 22:10:10 volumio volumio[1019]: info: ------------------------------ 143ms
Mar 14 22:10:18 volumio volumio[1019]: info: Preload queue cleared
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::ClearQueue
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::stop
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::clearPlayQueue
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::saveQueue
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::addQueueItems
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::addQueueItems
Mar 14 22:10:18 volumio volumio[1019]: info: Preload queue cleared
Mar 14 22:10:18 volumio volumio[1019]: info: Adding Item to queue: albums://Backstreet%20Boys/DNA
Mar 14 22:10:18 volumio volumio[1019]: info: Exploding uri albums://Backstreet%20Boys/DNA in service mpd
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::saveQueue
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::play index 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::stop
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::play index undefined
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::clearAddPlayTracks NAS/istoreOS/Backstreet Boys/DNA/01 Don't Go Breaking My Heart.m4a
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand stop took 9 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clear
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand clear took 2 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand add "NAS/istoreOS/Backstreet Boys/DNA/01 Don't Go Breaking My Heart.m4a"
Mar 14 22:10:18 volumio volumio[1019]: info:
Mar 14 22:10:18 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:18 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:18 volumio volumio[1019]: info:
Mar 14 22:10:18 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:18 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand add "NAS/istoreOS/Backstreet Boys/DNA/01 Don't Go Breaking My Heart.m4a" took 3 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand play
Mar 14 22:10:18 volumio volumio[1019]: info:
Mar 14 22:10:18 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:18 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:18 volumio volumio[1019]: info:
Mar 14 22:10:18 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:18 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:18 volumio volumio[1019]: info:
Mar 14 22:10:18 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:18 volumio volumio[1019]: info: ------------------------------ 11ms
Mar 14 22:10:18 volumio volumio[1019]: info: ------------------------------ 11ms
Mar 14 22:10:18 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:18 volumio volumio[1019]: info: ------------------------------ 8ms
Mar 14 22:10:18 volumio volumio[1019]: info: ------------------------------ 6ms
Mar 14 22:10:18 volumio volumio[1019]: info:
Mar 14 22:10:18 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:18 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:18 volumio volumio[1019]: info:
Mar 14 22:10:18 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:18 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:18 volumio volumio[1019]: info:
Mar 14 22:10:18 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:18 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:18 volumio volumio[1019]: info:
Mar 14 22:10:18 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:18 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand status took 18 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: info: ------------------------------ 17ms
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand status took 17 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: info: ------------------------------ 17ms
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand status took 16 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand clearerror took 22 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand clearerror took 20 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand clearerror took 18 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 5 milliseconds
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:18 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:18 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: 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":"Don't Go Breaking My Heart","artist":"Backstreet Boys","album":"DNA","uri":"NAS/istoreOS/Backstreet Boys/DNA/01 Don't Go Breaking My Heart.m4a","trackType":"m4a"}
Mar 14 22:10:18 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::syncState stateService stop
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:18 volumio volumio[1019]: info: No code
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:18 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: 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":"Don't Go Breaking My Heart","artist":"Backstreet Boys","album":"DNA","uri":"NAS/istoreOS/Backstreet Boys/DNA/01 Don't Go Breaking My Heart.m4a","trackType":"m4a"}
Mar 14 22:10:18 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::syncState stateService stop
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:18 volumio volumio[1019]: info: No code
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:18 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: 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":"Don't Go Breaking My Heart","artist":"Backstreet Boys","album":"DNA","uri":"NAS/istoreOS/Backstreet Boys/DNA/01 Don't Go Breaking My Heart.m4a","trackType":"m4a"}
Mar 14 22:10:18 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::syncState stateService stop
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:18 volumio volumio[1019]: info: No code
Mar 14 22:10:18 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:18 volumio volumio[1019]: info: ------------------------------ 146ms
Mar 14 22:10:18 volumio volumio[1019]: info: ------------------------------ 144ms
Mar 14 22:10:18 volumio volumio[1019]: info: ------------------------------ 142ms
Mar 14 22:10:22 volumio volumio[1019]: info: Preload queue cleared
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::ClearQueue
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::stop
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::clearPlayQueue
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::saveQueue
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::addQueueItems
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::addQueueItems
Mar 14 22:10:22 volumio volumio[1019]: info: Preload queue cleared
Mar 14 22:10:22 volumio volumio[1019]: info: Adding Item to queue: albums://Maksim/Mezzo%20E%20Mezzo
Mar 14 22:10:22 volumio volumio[1019]: info: Exploding uri albums://Maksim/Mezzo%20E%20Mezzo in service mpd
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::saveQueue
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::play index 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::stop
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::play index undefined
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Maksim/Mezzo E Mezzo/01 Ballet Moderne.m4a
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand stop took 3 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clear
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand clear took 0 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Maksim/Mezzo E Mezzo/01 Ballet Moderne.m4a"
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:22 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:22 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand add "INTERNAL/Maksim/Mezzo E Mezzo/01 Ballet Moderne.m4a" took 2 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand play
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:22 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:22 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 9ms
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 10ms
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand play took 8 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 7ms
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:22 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces system playlist update
Mar 14 22:10:22 volumio volumio[1019]: info: Ignoring MPD Status Update
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 6ms
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 4ms
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 3ms
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand status took 239 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand status took 239 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand status took 239 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:22 volumio volumio[1019]: info:
Mar 14 22:10:22 volumio volumio[1019]: ---------------------------- MPD announces state update: player
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::getState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand status took 7 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 9 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 8 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 7 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand status took 7 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand status took 6 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseState
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"281 Kbps","isStreaming":false,"title":"Ballet Moderne","artist":"Maksim","album":"Mezzo E Mezzo","uri":"INTERNAL/Maksim/Mezzo E Mezzo/01 Ballet Moderne.m4a","trackType":"m4a"}
Mar 14 22:10:22 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":33,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"281 Kbps","isStreaming":false,"title":"Ballet Moderne","artist":"Maksim","album":"Mezzo E Mezzo","uri":"INTERNAL/Maksim/Mezzo E Mezzo/01 Ballet Moderne.m4a","trackType":"m4a"}
Mar 14 22:10:22 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play
Mar 14 22:10:22 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":147,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"281 Kbps","isStreaming":false,"title":"Ballet Moderne","artist":"Maksim","album":"Mezzo E Mezzo","uri":"INTERNAL/Maksim/Mezzo E Mezzo/01 Ballet Moderne.m4a","trackType":"m4a"}
Mar 14 22:10:22 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play
Mar 14 22:10:22 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"281 Kbps","isStreaming":false,"title":"Ballet Moderne","artist":"Maksim","album":"Mezzo E Mezzo","uri":"INTERNAL/Maksim/Mezzo E Mezzo/01 Ballet Moderne.m4a","trackType":"m4a"}
Mar 14 22:10:22 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play
Mar 14 22:10:22 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 279ms
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 309ms
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 308ms
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 73ms
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 60 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 60 milliseconds
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:22 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"281 Kbps","isStreaming":false,"title":"Ballet Moderne","artist":"Maksim","album":"Mezzo E Mezzo","uri":"INTERNAL/Maksim/Mezzo E Mezzo/01 Ballet Moderne.m4a","trackType":"m4a"}
Mar 14 22:10:22 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play
Mar 14 22:10:22 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: ControllerMpd::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::servicePushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"281 Kbps","isStreaming":false,"title":"Ballet Moderne","artist":"Maksim","album":"Mezzo E Mezzo","uri":"INTERNAL/Maksim/Mezzo E Mezzo/01 Ballet Moderne.m4a","trackType":"m4a"}
Mar 14 22:10:22 volumio volumio[1019]: verbose: CURRENT POSITION 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play
Mar 14 22:10:22 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: CoreStateMachine::pushState
Mar 14 22:10:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 117ms
Mar 14 22:10:22 volumio volumio[1019]: info: ------------------------------ 116ms
Mar 14 22:10:27 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState
Mar 14 22:10:27 volumio volumio[1019]: info: CorePlayQueue::getTrack 0
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 14 22:10:28 volumio volumio[1019]: info: Retrieving Cloud Streaming UI
Mar 14 22:10:28 volumio volumio[1019]: info: Getting Tidal Cloud Configuration
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 14 22:10:28 volumio volumio[1019]: info: Getting Qobuz Cloud Configuration
Mar 14 22:10:28 volumio volumio[1019]: info: Asking plugin for UI Config
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 14 22:10:28 volumio volumio[1019]: info: Getting Spotify Cloud Configuration
Mar 14 22:10:28 volumio volumio[1019]: info: Asking plugin for UI Config
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 14 22:10:28 volumio volumio[1019]: info: Saving Spotify Acccount
Mar 14 22:10:28 volumio volumio[1019]: info: Got Tidal Cloud Configuration
Mar 14 22:10:28 volumio volumio[1019]: info: Got it
Mar 14 22:10:28 volumio volumio[1019]: info: Got it
Mar 14 22:10:28 volumio volumio[1019]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 14 22:10:28 volumio volumio[1019]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 14 22:10:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Mar 14 22:10:29 volumio volumio[1019]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 14 22:10:29 volumio volumio[1019]: info: Retrying Login Due to Network Error
Mar 14 22:10:32 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 14 22:10:36 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 14 22:10:39 volumio volumio[1019]: info: MyVolumio login type: Token
Mar 14 22:10:40 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 14 22:10:45 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 14 22:10:48 volumio volumio[1019]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 14 22:10:48 volumio volumio[1019]: Error: connect ETIMEDOUT 199.16.158.104:443
Mar 14 22:10:48 volumio volumio[1019]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Mar 14 22:10:48 volumio volumio[1019]: errno: -110,
Mar 14 22:10:48 volumio volumio[1019]: code: 'ETIMEDOUT',
Mar 14 22:10:48 volumio volumio[1019]: syscall: 'connect',
Mar 14 22:10:48 volumio volumio[1019]: address: '199.16.158.104',
Mar 14 22:10:48 volumio volumio[1019]: port: 443
Mar 14 22:10:48 volumio volumio[1019]: }
Mar 14 22:10:48 volumio volumio[1019]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 14 22:10:49 volumio sudo[2382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-14 22:09
Mar 14 22:10:49 volumio sudo[2382]: 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="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:15:38 PM CET"
VOLUMIO_VERSION="3.795"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="9e0e048b157c8fb0f19240808f3da58b"