Jan 28 15:18:02 volumio volumio[4799]: info: BOOT COMPLETED
Jan 28 15:18:05 volumio volumio[4799]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jan 28 15:18:05 volumio volumio[4799]: info: Retrying Login Due to Network Error
Jan 28 15:18:15 volumio volumio[4799]: info: MyVolumio login type: Token
Jan 28 15:18:24 volumio volumio[4799]: info: UPDATER: Scheduling automatic update
Jan 28 15:18:24 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Jan 28 15:18:24 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Jan 28 15:18:24 volumio volumio[4799]: info: UPDATER: Auto update will take place at: Thu Jan 29 2026 03:19:55 GMT+0800 (Hong Kong Standard Time)
Jan 28 15:18:28 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 28 15:18:36 volumio volumio[4799]: info: CoreCommandRouter::Close All Modals sent
Jan 28 15:18:38 volumio ntpd[917]: PROTO: 119.28.206.193 unlink local addr 192.168.1.50 ->
Jan 28 15:18:45 volumio volumio[4799]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jan 28 15:18:45 volumio volumio[4799]: info: Retrying Login Due to Network Error
Jan 28 15:18:45 volumio systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories...
Jan 28 15:18:45 volumio systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully.
Jan 28 15:18:45 volumio systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories.
Jan 28 15:18:45 volumio systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully.
Jan 28 15:18:55 volumio volumio[4799]: info: MyVolumio login type: Token
Jan 28 15:18:56 volumio sudo[5308]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 28 15:18:56 volumio sudo[5308]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 28 15:18:56 volumio sudo[5308]: pam_unix(sudo:session): session closed for user root
Jan 28 15:18:56 volumio sudo[5310]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 28 15:18:56 volumio sudo[5310]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 28 15:18:56 volumio sudo[5310]: pam_unix(sudo:session): session closed for user root
Jan 28 15:18:56 volumio volumio[4799]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.27 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_7_12 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6.1 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 8
Jan 28 15:18:56 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 15:18:56 volumio volumio[4799]: verbose: New Socket.io Connection to 192.168.1.50:3000 from 192.168.1.13 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9
Jan 28 15:18:56 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:18:56 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:18:56 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:18:56 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:18:56 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:18:56 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:18:57 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 15:18:57 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:18:57 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:18:57 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:18:57 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:18:57 volumio volumio[4799]: info: Listing playlists
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 15:18:57 volumio volumio[4799]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.13 UA: Mozilla/5.0 (Linux; Android 16; SM-S9180 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.59 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:18:57 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 15:18:57 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:18:57 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:18:57 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:18:57 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:18:57 volumio volumio[4799]: info: Listing playlists
Jan 28 15:18:57 volumio volumio[4799]: info: CoreCommandRouter::volumioGetQueue
Jan 28 15:18:57 volumio volumio[4799]: info: CoreStateMachine::getQueue
Jan 28 15:18:57 volumio volumio[4799]: info: CorePlayQueue::getQueue
Jan 28 15:18:58 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPlay
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::play index undefined
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::startPlaybackTimer
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::clearAddPlayTracks USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand stop
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand stop took 1 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand clear
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:01 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand clear took 1 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav"
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:01 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:01 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:01 volumio volumio[4799]: error: updateQueue error: null
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:01 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 4ms
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav" took 3 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand play
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:01 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:01 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand play took 3 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand status took 7 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand status took 7 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand status took 6 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:01 volumio volumio[4799]: info:
Jan 28 15:19:01 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand status took 6 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav","trackType":"wav"}
Jan 28 15:19:01 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav","trackType":"wav"}
Jan 28 15:19:01 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:01 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":90,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav","trackType":"wav"}
Jan 28 15:19:01 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:01 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 31ms
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 36ms
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 36ms
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand status took 24 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand status took 25 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 23 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav","trackType":"wav"}
Jan 28 15:19:01 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:01 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 72ms
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 55 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 51 milliseconds
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:01 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav","trackType":"wav"}
Jan 28 15:19:01 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:01 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav","trackType":"wav"}
Jan 28 15:19:01 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:01 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:01 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:01 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 111ms
Jan 28 15:19:01 volumio volumio[4799]: info: ------------------------------ 112ms
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:01 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:04 volumio ntpd[917]: PROTO: 139.199.214.202 unlink local addr 192.168.1.50 ->
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 1
Jan 28 15:19:04 volumio volumio[4799]: info: Prefetching next song
Jan 28 15:19:04 volumio volumio[4799]: info: DOING PREFETCH IN MPD
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.wav"
Jan 28 15:19:04 volumio volumio[4799]: info:
Jan 28 15:19:04 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:04 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:04 volumio volumio[4799]: info: sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.wav" took 1 milliseconds
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand consume 1
Jan 28 15:19:04 volumio volumio[4799]: info:
Jan 28 15:19:04 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:04 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:04 volumio volumio[4799]: info:
Jan 28 15:19:04 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:04 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:04 volumio volumio[4799]: info:
Jan 28 15:19:04 volumio volumio[4799]: ---------------------------- MPD announces state update: options
Jan 28 15:19:04 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:04 volumio volumio[4799]: info: sendMpdCommand consume 1 took 2 milliseconds
Jan 28 15:19:04 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:04 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:04 volumio volumio[4799]: info:
Jan 28 15:19:04 volumio volumio[4799]: ---------------------------- MPD announces state update: options
Jan 28 15:19:04 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:04 volumio volumio[4799]: info:
Jan 28 15:19:04 volumio volumio[4799]: ---------------------------- MPD announces state update: options
Jan 28 15:19:04 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:04 volumio volumio[4799]: info: ------------------------------ 4ms
Jan 28 15:19:04 volumio volumio[4799]: info: sendMpdCommand status took 3 milliseconds
Jan 28 15:19:04 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:04 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:04 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:04 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4083,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav","trackType":"wav"}
Jan 28 15:19:04 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:04 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:04 volumio volumio[4799]: info: ------------------------------ 14ms
Jan 28 15:19:04 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 28 15:19:04 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:04 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:04 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4083,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav","trackType":"wav"}
Jan 28 15:19:04 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:04 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:04 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4083,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.2.wav","trackType":"wav"}
Jan 28 15:19:04 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:04 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:04 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:04 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:04 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:04 volumio volumio[4799]: info: ------------------------------ 31ms
Jan 28 15:19:04 volumio volumio[4799]: info: ------------------------------ 33ms
Jan 28 15:19:04 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:04 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:04 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:04 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:04 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:04 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:07 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 28 15:19:07 volumio volumio[4799]: info: VolumeController::SetAlsaVolume55
Jan 28 15:19:07 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:07 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:07 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:07 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:07 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 55
Jan 28 15:19:07 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 51
Jan 28 15:19:07 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 55
Jan 28 15:19:07 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:07 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 55
Jan 28 15:19:07 volumio ntpd[917]: PROTO: 193.182.111.142 unlink local addr 192.168.1.50 ->
Jan 28 15:19:07 volumio ntpd[917]: PROTO: 185.209.85.222 unlink local addr 192.168.1.50 ->
Jan 28 15:19:07 volumio volumio[4799]: info: VolumeController::SetAlsaVolume60
Jan 28 15:19:07 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:07 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:07 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:07 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:07 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60
Jan 28 15:19:07 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 55
Jan 28 15:19:07 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 60
Jan 28 15:19:07 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:07 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 60
Jan 28 15:19:07 volumio volumio[4799]: info: VolumeController::SetAlsaVolume55
Jan 28 15:19:08 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:08 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 55
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 60
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 55
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:08 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 55
Jan 28 15:19:08 volumio volumio[4799]: info: VolumeController::SetAlsaVolume51
Jan 28 15:19:08 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:08 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 55
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 51
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:08 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 51
Jan 28 15:19:08 volumio volumio[4799]: info: VolumeController::SetAlsaVolume41
Jan 28 15:19:08 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:08 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 51
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 41
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:08 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 41
Jan 28 15:19:08 volumio volumio[4799]: info: VolumeController::SetAlsaVolume36
Jan 28 15:19:08 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:08 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 41
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 36
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:08 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 36
Jan 28 15:19:08 volumio volumio[4799]: info: VolumeController::SetAlsaVolume31
Jan 28 15:19:08 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:08 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:08 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 36
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 31
Jan 28 15:19:08 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:08 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 31
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::startPlaybackTimer
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 1
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 1
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: info: Prefetching next song
Jan 28 15:19:09 volumio volumio[4799]: info: DOING PREFETCH IN MPD
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/2.2.wav"
Jan 28 15:19:09 volumio volumio[4799]: info:
Jan 28 15:19:09 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:09 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:09 volumio volumio[4799]: info: sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/2.2.wav" took 1 milliseconds
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand consume 1
Jan 28 15:19:09 volumio volumio[4799]: info:
Jan 28 15:19:09 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:09 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:09 volumio volumio[4799]: info:
Jan 28 15:19:09 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:09 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:09 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:09 volumio volumio[4799]: info: sendMpdCommand consume 1 took 2 milliseconds
Jan 28 15:19:09 volumio volumio[4799]: info: ------------------------------ 1ms
Jan 28 15:19:09 volumio volumio[4799]: info: ------------------------------ 1ms
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 1
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::startPlaybackTimer
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: info:
Jan 28 15:19:09 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:09 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:09 volumio volumio[4799]: info:
Jan 28 15:19:09 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:09 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:09 volumio volumio[4799]: info:
Jan 28 15:19:09 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:09 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:09 volumio volumio[4799]: info:
Jan 28 15:19:09 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:09 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:09 volumio volumio[4799]: info:
Jan 28 15:19:09 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:09 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:09 volumio volumio[4799]: info:
Jan 28 15:19:09 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:09 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:09 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:09 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:09 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:09 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:09 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:09 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:09 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:09 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.wav","trackType":"wav"}
Jan 28 15:19:09 volumio volumio[4799]: verbose: CURRENT POSITION 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:09 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:09 volumio volumio[4799]: info: ------------------------------ 12ms
Jan 28 15:19:09 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jan 28 15:19:09 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:09 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:09 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.wav","trackType":"wav"}
Jan 28 15:19:09 volumio volumio[4799]: verbose: CURRENT POSITION 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:09 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:09 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/1.wav","trackType":"wav"}
Jan 28 15:19:09 volumio volumio[4799]: verbose: CURRENT POSITION 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:09 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:09 volumio volumio[4799]: info: ------------------------------ 34ms
Jan 28 15:19:09 volumio volumio[4799]: info: ------------------------------ 34ms
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Jan 28 15:19:09 volumio volumio[4799]: info: VolumeController::SetAlsaVolume36
Jan 28 15:19:09 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:09 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:09 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 31
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 36
Jan 28 15:19:09 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:09 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 36
Jan 28 15:19:10 volumio sudo[5370]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 28 15:19:10 volumio sudo[5370]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 28 15:19:10 volumio sudo[5370]: pam_unix(sudo:session): session closed for user root
Jan 28 15:19:10 volumio sudo[5372]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 28 15:19:10 volumio sudo[5372]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 28 15:19:10 volumio sudo[5372]: pam_unix(sudo:session): session closed for user root
Jan 28 15:19:10 volumio volumio[4799]: info: VolumeController::SetAlsaVolume41
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 36
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:10 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 41
Jan 28 15:19:10 volumio volumio[4799]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.13 UA: Mozilla/5.0 (Linux; Android 16; SM-S9180 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.59 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:10 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:19:10 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 15:19:10 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:19:10 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: Listing playlists
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioGetQueue
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::getQueue
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getQueue
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 15:19:10 volumio volumio[4799]: info:
Jan 28 15:19:10 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:10 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:10 volumio volumio[4799]: info:
Jan 28 15:19:10 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:10 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:10 volumio volumio[4799]: info:
Jan 28 15:19:10 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:10 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:10 volumio volumio[4799]: info:
Jan 28 15:19:10 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:10 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:10 volumio volumio[4799]: info:
Jan 28 15:19:10 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:10 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:10 volumio volumio[4799]: info:
Jan 28 15:19:10 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:10 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:10 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:10 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:10 volumio volumio[4799]: info: ------------------------------ 1ms
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:10 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:10 volumio volumio[4799]: info: ------------------------------ 1ms
Jan 28 15:19:10 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:10 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:10 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":10,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/2.2.wav","trackType":"wav"}
Jan 28 15:19:10 volumio volumio[4799]: verbose: CURRENT POSITION 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:10 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:10 volumio volumio[4799]: info: ------------------------------ 14ms
Jan 28 15:19:10 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jan 28 15:19:10 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:10 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:10 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":10,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/2.2.wav","trackType":"wav"}
Jan 28 15:19:10 volumio volumio[4799]: verbose: CURRENT POSITION 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:10 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:10 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":10,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/2.2.wav","trackType":"wav"}
Jan 28 15:19:10 volumio volumio[4799]: verbose: CURRENT POSITION 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:10 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:10 volumio volumio[4799]: info: ------------------------------ 32ms
Jan 28 15:19:10 volumio volumio[4799]: info: ------------------------------ 31ms
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: info: VolumeController::SetAlsaVolume51
Jan 28 15:19:10 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:10 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:10 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: SPOTIFY VOLUME 41
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: VOLUMIO VOLUME 51
Jan 28 15:19:10 volumio volumio[4799]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jan 28 15:19:10 volumio volumio[4799]: info: Setting Spotify Volume from Volumio: 51
Jan 28 15:19:12 volumio volumio[4799]: SPOTIFY: SETTING SPOTIFY VOLUME 51
Jan 28 15:19:12 volumio volumio[4799]: info: Sending Spotify command with payload to local API: /player/volume
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioNext
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::next
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::stop
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::stPlaybackTimer
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::updateTrackBlock
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrackBlock
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::serviceStop
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 2
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::serviceStop
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::stop
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand stop
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand stop took 23 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::play index undefined
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::startPlaybackTimer
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::clearAddPlayTracks USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand stop
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::updateTrackBlock
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrackBlock
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand stop took 3 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand status took 3 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand clear
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: 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":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/2.2.wav","trackType":"wav"}
Jan 28 15:19:15 volumio volumio[4799]: verbose: CURRENT POSITION 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState stateService stop
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: No code
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 15ms
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:15 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand clear took 11 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav"
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:15 volumio volumio[4799]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 28 15:19:15 volumio volumio[4799]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 16ms
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 15ms
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:15 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:15 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: error: updateQueue error: null
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:15 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 7ms
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav" took 6 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 5ms
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 5ms
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand play
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:15 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:15 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand play took 2 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 1ms
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:15 volumio volumio[4799]: info:
Jan 28 15:19:15 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand status took 3 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand status took 5 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand status took 4 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":10,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav","trackType":"wav"}
Jan 28 15:19:15 volumio volumio[4799]: verbose: CURRENT POSITION 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":10,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav","trackType":"wav"}
Jan 28 15:19:15 volumio volumio[4799]: verbose: CURRENT POSITION 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:15 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 12ms
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 29ms
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 23 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 25 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 26 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 26 milliseconds
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:15 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":10,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav","trackType":"wav"}
Jan 28 15:19:15 volumio volumio[4799]: verbose: CURRENT POSITION 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:15 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":10,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav","trackType":"wav"}
Jan 28 15:19:15 volumio volumio[4799]: verbose: CURRENT POSITION 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:15 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":10,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav","trackType":"wav"}
Jan 28 15:19:15 volumio volumio[4799]: verbose: CURRENT POSITION 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:15 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":10,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav","trackType":"wav"}
Jan 28 15:19:15 volumio volumio[4799]: verbose: CURRENT POSITION 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:15 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:15 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:15 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 57ms
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 58ms
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 56ms
Jan 28 15:19:15 volumio volumio[4799]: info: ------------------------------ 61ms
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:15 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioNext
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::next
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::stop
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::stPlaybackTimer
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::updateTrackBlock
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrackBlock
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::serviceStop
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 3
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::serviceStop
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::stop
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand stop
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand stop took 26 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::play index undefined
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::startPlaybackTimer
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::clearAddPlayTracks USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand stop
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::updateTrackBlock
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrackBlock
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand stop took 3 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand clear
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: 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":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/4.2.wav","trackType":"wav"}
Jan 28 15:19:18 volumio volumio[4799]: verbose: CURRENT POSITION 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState stateService stop
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: No code
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 15ms
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:18 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand status took 13 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand clear took 10 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav"
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:18 volumio volumio[4799]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 16ms
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:18 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:18 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: error: updateQueue error: null
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:18 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 8ms
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav" took 8 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 7ms
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 7ms
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand play
Jan 28 15:19:18 volumio volumio[4799]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 23ms
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:18 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:18 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 4ms
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand play took 4 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:18 volumio volumio[4799]: info:
Jan 28 15:19:18 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand status took 3 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand status took 3 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":12,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav","trackType":"wav"}
Jan 28 15:19:18 volumio volumio[4799]: verbose: CURRENT POSITION 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":12,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav","trackType":"wav"}
Jan 28 15:19:18 volumio volumio[4799]: verbose: CURRENT POSITION 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:18 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 12ms
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 16ms
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:18 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":12,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav","trackType":"wav"}
Jan 28 15:19:18 volumio volumio[4799]: verbose: CURRENT POSITION 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:18 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":12,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav","trackType":"wav"}
Jan 28 15:19:18 volumio volumio[4799]: verbose: CURRENT POSITION 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:18 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":12,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav","trackType":"wav"}
Jan 28 15:19:18 volumio volumio[4799]: verbose: CURRENT POSITION 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:18 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":12,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav","trackType":"wav"}
Jan 28 15:19:18 volumio volumio[4799]: verbose: CURRENT POSITION 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:18 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:18 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:18 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 65ms
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 66ms
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 64ms
Jan 28 15:19:18 volumio volumio[4799]: info: ------------------------------ 64ms
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:18 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:20 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioNext
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::next
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::stop
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::stPlaybackTimer
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::updateTrackBlock
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrackBlock
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::serviceStop
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 4
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::serviceStop
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::stop
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand stop
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand stop took 30 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::play index undefined
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::startPlaybackTimer
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::clearAddPlayTracks USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/6.2.wav
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand stop
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::updateTrackBlock
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrackBlock
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand stop took 1 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand status took 0 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand clear
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:24 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand status took 3 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand clear took 2 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/6.2.wav"
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: 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":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/5.2.wav","trackType":"wav"}
Jan 28 15:19:24 volumio volumio[4799]: verbose: CURRENT POSITION 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState stateService stop
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: No code
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 17ms
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 16ms
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:24 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:24 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:24 volumio volumio[4799]: error: updateQueue error: null
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:24 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 17ms
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/6.2.wav" took 17 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 4ms
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 4ms
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand play
Jan 28 15:19:24 volumio volumio[4799]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 26ms
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:24 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:24 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 12ms
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand play took 10 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 5ms
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 5ms
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:24 volumio volumio[4799]: info:
Jan 28 15:19:24 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/6.2.wav","trackType":"wav"}
Jan 28 15:19:24 volumio volumio[4799]: verbose: CURRENT POSITION 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 9ms
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand status took 8 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/6.2.wav","trackType":"wav"}
Jan 28 15:19:24 volumio volumio[4799]: verbose: CURRENT POSITION 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:24 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/6.2.wav","trackType":"wav"}
Jan 28 15:19:24 volumio volumio[4799]: verbose: CURRENT POSITION 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:24 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/6.2.wav","trackType":"wav"}
Jan 28 15:19:24 volumio volumio[4799]: verbose: CURRENT POSITION 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:24 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/6.2.wav","trackType":"wav"}
Jan 28 15:19:24 volumio volumio[4799]: verbose: CURRENT POSITION 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:24 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 37ms
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 37ms
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 37ms
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 36ms
Jan 28 15:19:24 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 30 milliseconds
Jan 28 15:19:24 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:24 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":9,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/6.2.wav","trackType":"wav"}
Jan 28 15:19:24 volumio volumio[4799]: verbose: CURRENT POSITION 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:24 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:24 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:24 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:24 volumio volumio[4799]: info: ------------------------------ 46ms
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:24 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:25 volumio volumio[4799]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jan 28 15:19:25 volumio volumio[4799]: info: Retrying Login Due to Network Error
Jan 28 15:19:27 volumio volumio[4799]: info: CorePlayQueue::getTrack 5
Jan 28 15:19:27 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:27 volumio volumio[4799]: info: Prefetching next song
Jan 28 15:19:27 volumio volumio[4799]: info: DOING PREFETCH IN MPD
Jan 28 15:19:27 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/7.2.wav"
Jan 28 15:19:27 volumio volumio[4799]: info:
Jan 28 15:19:27 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:27 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:27 volumio volumio[4799]: info: sendMpdCommand add "USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/7.2.wav" took 1 milliseconds
Jan 28 15:19:27 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand consume 1
Jan 28 15:19:27 volumio volumio[4799]: info:
Jan 28 15:19:27 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:27 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:27 volumio volumio[4799]: info:
Jan 28 15:19:27 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:27 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:27 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:27 volumio volumio[4799]: info: sendMpdCommand consume 1 took 3 milliseconds
Jan 28 15:19:27 volumio volumio[4799]: info: ------------------------------ 3ms
Jan 28 15:19:27 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::startPlaybackTimer
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: info:
Jan 28 15:19:31 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:31 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:31 volumio volumio[4799]: info:
Jan 28 15:19:31 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:31 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:31 volumio volumio[4799]: info:
Jan 28 15:19:31 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:31 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:31 volumio volumio[4799]: info:
Jan 28 15:19:31 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:31 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:31 volumio volumio[4799]: info:
Jan 28 15:19:31 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:31 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:31 volumio volumio[4799]: info:
Jan 28 15:19:31 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:31 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:31 volumio volumio[4799]: info: ------------------------------ 1ms
Jan 28 15:19:31 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:31 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:31 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:31 volumio volumio[4799]: info: ------------------------------ 1ms
Jan 28 15:19:31 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:31 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:31 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":90,"duration":8,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/7.2.wav","trackType":"wav"}
Jan 28 15:19:31 volumio volumio[4799]: verbose: CURRENT POSITION 6
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:31 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:31 volumio volumio[4799]: info: ------------------------------ 8ms
Jan 28 15:19:31 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 28 15:19:31 volumio volumio[4799]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:31 volumio volumio[4799]: verbose: ControllerMpd::parseTrackInfo
Jan 28 15:19:31 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":90,"duration":8,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/7.2.wav","trackType":"wav"}
Jan 28 15:19:31 volumio volumio[4799]: verbose: CURRENT POSITION 6
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:31 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:31 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":90,"duration":8,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Fowl, Chicken - Chick; Chirp","artist":"48","album":null,"uri":"USB/音乐盘6/$RECYCLE.BIN/S-1-5-21-2428116299-3772831545-3104743612-500/$RT9UMDS/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机/GRC-YS-005 希腊数数手机 音源说明/GRC-YS-005 希腊数数手机/希腊数数手机音源_250秒(2023.5.28)/7.2.wav","trackType":"wav"}
Jan 28 15:19:31 volumio volumio[4799]: verbose: CURRENT POSITION 6
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::syncState stateService play
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:31 volumio volumio[4799]: info: Received an update from plugin. extracting info from payload
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:31 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:31 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:31 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:31 volumio volumio[4799]: info: ------------------------------ 18ms
Jan 28 15:19:31 volumio volumio[4799]: info: ------------------------------ 17ms
Jan 28 15:19:31 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:31 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:31 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:31 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:31 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:31 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:32 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:32 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:32 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:32 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:32 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:32 volumio sudo[5449]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 28 15:19:32 volumio sudo[5449]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 28 15:19:32 volumio sudo[5451]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 28 15:19:32 volumio sudo[5451]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 28 15:19:32 volumio sudo[5449]: pam_unix(sudo:session): session closed for user root
Jan 28 15:19:32 volumio sudo[5451]: pam_unix(sudo:session): session closed for user root
Jan 28 15:19:32 volumio volumio[4799]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.27 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_7_12 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:33 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 15:19:33 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:19:33 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:33 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:33 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:33 volumio volumio[4799]: info: Listing playlists
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 15:19:33 volumio sudo[5457]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 28 15:19:33 volumio sudo[5457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 28 15:19:33 volumio sudo[5458]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 28 15:19:33 volumio sudo[5457]: pam_unix(sudo:session): session closed for user root
Jan 28 15:19:33 volumio sudo[5458]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 28 15:19:33 volumio sudo[5458]: pam_unix(sudo:session): session closed for user root
Jan 28 15:19:33 volumio volumio[4799]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.27 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_7_12 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:33 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 15:19:33 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:19:33 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:33 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:33 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:33 volumio volumio[4799]: info: Listing playlists
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 28 15:19:33 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 15:19:34 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:34 volumio volumio[4799]: info: CorePlayQueue::getTrack 7
Jan 28 15:19:35 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jan 28 15:19:35 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 28 15:19:35 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:19:35 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:19:35 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:19:35 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:19:35 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:35 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:35 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:19:35 volumio volumio[4799]: info: MyVolumio login type: Token
Jan 28 15:19:37 volumio volumio[4799]: verbose: New Socket.io Connection to 192.168.1.50:3000 from 192.168.1.13 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10
Jan 28 15:19:37 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:19:37 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:19:37 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:19:37 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:37 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:37 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:19:37 volumio volumio[4799]: info: CoreCommandRouter::volumioGetQueue
Jan 28 15:19:37 volumio volumio[4799]: info: CoreStateMachine::getQueue
Jan 28 15:19:37 volumio volumio[4799]: info: CorePlayQueue::getQueue
Jan 28 15:19:38 volumio volumio[4799]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.13 UA: Mozilla/5.0 (Linux; Android 16; SM-S9180 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.59 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Jan 28 15:19:38 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:19:38 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 15:19:38 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:19:38 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:38 volumio volumio[4799]: info: Listing playlists
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetQueue
Jan 28 15:19:38 volumio volumio[4799]: info: CoreStateMachine::getQueue
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getQueue
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 15:19:38 volumio volumio[4799]: info: Received Get System Info
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 15:19:38 volumio volumio[4799]: info: Discovery: Getting this device information
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetState
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:38 volumio volumio[4799]: info: Listing playlists
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::volumioGetQueue
Jan 28 15:19:38 volumio volumio[4799]: info: CoreStateMachine::getQueue
Jan 28 15:19:38 volumio volumio[4799]: info: CorePlayQueue::getQueue
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 15:19:38 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 15:19:40 volumio volumio[4799]: info:
Jan 28 15:19:40 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:40 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:40 volumio volumio[4799]: info:
Jan 28 15:19:40 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:40 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:40 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:40 volumio volumio[4799]: info:
Jan 28 15:19:40 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:40 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:40 volumio volumio[4799]: info:
Jan 28 15:19:40 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:40 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:40 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:40 volumio volumio[4799]: info:
Jan 28 15:19:40 volumio volumio[4799]: ---------------------------- MPD announces system playlist update
Jan 28 15:19:40 volumio volumio[4799]: info: Ignoring MPD Status Update
Jan 28 15:19:40 volumio volumio[4799]: info:
Jan 28 15:19:40 volumio volumio[4799]: ---------------------------- MPD announces state update: player
Jan 28 15:19:40 volumio volumio[4799]: info: ControllerMpd::getState
Jan 28 15:19:40 volumio volumio[4799]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 15:19:40 volumio volumio[4799]: error: updateQueue error: null
Jan 28 15:19:40 volumio volumio[4799]: error: updateQueue error: null
Jan 28 15:19:40 volumio volumio[4799]: error: updateQueue error: null
Jan 28 15:19:40 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:40 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:40 volumio volumio[4799]: info: ------------------------------ 2ms
Jan 28 15:19:40 volumio volumio[4799]: info: sendMpdCommand status took 2 milliseconds
Jan 28 15:19:40 volumio volumio[4799]: info: ------------------------------ 1ms
Jan 28 15:19:40 volumio volumio[4799]: info: sendMpdCommand status took 1 milliseconds
Jan 28 15:19:40 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:40 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:40 volumio volumio[4799]: verbose: ControllerMpd::parseState
Jan 28 15:19:40 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 6
Jan 28 15:19:40 volumio volumio[4799]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 28 15:19:40 volumio volumio[4799]: verbose: CURRENT POSITION 6
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::syncState stateService stop
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus play
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::stPlaybackTimer
Jan 28 15:19:40 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:40 volumio volumio[4799]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 28 15:19:40 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::syncState stateService stop
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:40 volumio volumio[4799]: info: No code
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:40 volumio volumio[4799]: info: ControllerMpd::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::servicePushState
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:40 volumio volumio[4799]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 28 15:19:40 volumio volumio[4799]: verbose: CURRENT POSITION 0
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::syncState stateService stop
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:40 volumio volumio[4799]: info: No code
Jan 28 15:19:40 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:40 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:40 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:40 volumio volumio[4799]: info: ------------------------------ 20ms
Jan 28 15:19:40 volumio volumio[4799]: info: ------------------------------ 20ms
Jan 28 15:19:40 volumio volumio[4799]: info: ------------------------------ 20ms
Jan 28 15:19:40 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:40 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:40 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:40 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:40 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:40 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:40 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:40 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:42 volumio volumio[4799]: info: CoreCommandRouter::volumioRandom
Jan 28 15:19:42 volumio volumio[4799]: info: CoreCommandRouter::writePlayerControls
Jan 28 15:19:42 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:42 volumio volumio[4799]: info: CoreStateMachine::setRepeat true single false
Jan 28 15:19:42 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:42 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:42 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:42 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:42 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:43 volumio volumio[4799]: info: CoreCommandRouter::volumioRandom
Jan 28 15:19:43 volumio volumio[4799]: info: CoreCommandRouter::writePlayerControls
Jan 28 15:19:43 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:43 volumio volumio[4799]: info: CoreStateMachine::setRepeat true single true
Jan 28 15:19:43 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:43 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:43 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:43 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:43 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:43 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 28 15:19:44 volumio volumio[4799]: info: CoreCommandRouter::volumioRandom
Jan 28 15:19:44 volumio volumio[4799]: info: CoreCommandRouter::writePlayerControls
Jan 28 15:19:44 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:44 volumio volumio[4799]: info: CoreStateMachine::setRepeat false single false
Jan 28 15:19:44 volumio volumio[4799]: info: CoreStateMachine::pushState
Jan 28 15:19:44 volumio volumio[4799]: info: CorePlayQueue::getTrack 0
Jan 28 15:19:44 volumio volumio[4799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 15:19:44 volumio volumio[4799]: info: CoreCommandRouter::volumioPushState
Jan 28 15:19:44 volumio volumio[4799]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jan 28 15:19:49 volumio volumio[4799]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 28 15:19:49 volumio volumio[4799]: Error: connect ETIMEDOUT 157.240.12.50:443
Jan 28 15:19:49 volumio volumio[4799]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Jan 28 15:19:49 volumio volumio[4799]: errno: -110,
Jan 28 15:19:49 volumio volumio[4799]: code: 'ETIMEDOUT',
Jan 28 15:19:49 volumio volumio[4799]: syscall: 'connect',
Jan 28 15:19:49 volumio volumio[4799]: address: '157.240.12.50',
Jan 28 15:19:49 volumio volumio[4799]: port: 443
Jan 28 15:19:49 volumio volumio[4799]: }
Jan 28 15:19:49 volumio volumio[4799]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 28 15:19:49 volumio sudo[5509]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-28 15:18'
Jan 28 15:19:49 volumio sudo[5509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"