-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Fri 2024-08-23 17:49:24 CST. --
Aug 23 17:48:11 volumio sudo[8509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 23 17:48:11 volumio sudo[8509]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 17:48:11 volumio sudo[8509]: pam_unix(sudo:session): session closed for user root
Aug 23 17:48:11 volumio sudo[8512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 23 17:48:11 volumio sudo[8512]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 17:48:11 volumio sudo[8512]: pam_unix(sudo:session): session closed for user root
Aug 23 17:48:11 volumio volumio[8196]: verbose: New Socket.io Connection to 192.168.2.67 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Edg/127.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
Aug 23 17:48:11 volumio volumio[8196]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 23 17:48:11 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 23 17:48:11 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 23 17:48:11 volumio volumio[8196]: info: CoreCommandRouter::volumioGetState
Aug 23 17:48:11 volumio volumio[8196]: info: CorePlayQueue::getTrack 180
Aug 23 17:48:11 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 23 17:48:11 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 23 17:48:11 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 23 17:48:11 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 23 17:48:11 volumio sudo[8515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 23 17:48:11 volumio sudo[8515]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 17:48:11 volumio sudo[8515]: pam_unix(sudo:session): session closed for user root
Aug 23 17:48:11 volumio sudo[8518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 23 17:48:11 volumio sudo[8518]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 17:48:11 volumio sudo[8518]: pam_unix(sudo:session): session closed for user root
Aug 23 17:48:11 volumio volumio[8196]: verbose: New Socket.io Connection to 192.168.2.67 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Edg/127.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
Aug 23 17:48:12 volumio volumio[8196]: info: CoreCommandRouter::volumioGetState
Aug 23 17:48:12 volumio volumio[8196]: info: CorePlayQueue::getTrack 180
Aug 23 17:48:12 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 23 17:48:12 volumio volumio[8196]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 23 17:48:12 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 23 17:48:12 volumio volumio[8196]: info: Listing playlists
Aug 23 17:48:12 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 23 17:48:12 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 23 17:48:12 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 23 17:48:12 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 23 17:48:12 volumio volumio[8196]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%9D%B0%E5%80%AB/%E4%BE%9D%E7%84%B6%E8%8C%83%E7%89%B9%E8%A5%BF/b705dc0a-9416-4ea7-85fd-e89518b24b39.jpg'
Aug 23 17:48:13 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 17:48:13 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 17:48:13 volumio volumio[8196]: info: Discovery: Getting this device information
Aug 23 17:48:13 volumio volumio[8196]: info: CoreCommandRouter::volumioGetState
Aug 23 17:48:13 volumio volumio[8196]: info: CorePlayQueue::getTrack 180
Aug 23 17:48:13 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 17:48:14 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 23 17:48:14 volumio volumio[8196]: info: Received Get System Info
Aug 23 17:48:14 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 17:48:14 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 17:48:14 volumio volumio[8196]: info: Discovery: Getting this device information
Aug 23 17:48:14 volumio volumio[8196]: info: CoreCommandRouter::volumioGetState
Aug 23 17:48:14 volumio volumio[8196]: info: CorePlayQueue::getTrack 180
Aug 23 17:48:14 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::volumioNext
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::next
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::stop
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::stPlaybackTimer
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::updateTrackBlock
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrackBlock
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 180
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::serviceStop
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 180
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::serviceStop
Aug 23 17:48:19 volumio volumio[8196]: info: ControllerMpd::stop
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:48:19 volumio volumio[8196]: info: sendMpdCommand stop took 19 milliseconds
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::play index undefined
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::startPlaybackTimer
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[SQ]/花澤香菜-【KANAight ~花澤香菜キャラソン ハイパークロニクルミックス~ [Disc 2]】-SQ-flac/33. 恋愛サーキュレーション.flac
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::updateTrackBlock
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrackBlock
Aug 23 17:48:19 volumio volumio[8196]: info:
Aug 23 17:48:19 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:19 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:19 volumio volumio[8196]: info: sendMpdCommand stop took 2 milliseconds
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand clear
Aug 23 17:48:19 volumio volumio[8196]: info:
Aug 23 17:48:19 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:19 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:19 volumio volumio[8196]: info:
Aug 23 17:48:19 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:19 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:19 volumio volumio[8196]: info:
Aug 23 17:48:19 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:19 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:19 volumio volumio[8196]: info: sendMpdCommand status took 4 milliseconds
Aug 23 17:48:19 volumio volumio[8196]: info: sendMpdCommand clear took 4 milliseconds
Aug 23 17:48:19 volumio volumio[8196]: info: sendMpdCommand status took 3 milliseconds
Aug 23 17:48:19 volumio volumio[8196]: info: sendMpdCommand status took 2 milliseconds
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/花澤香菜-【KANAight ~花澤香菜キャラソン ハイパークロニクルミックス~ [Disc 2]】-SQ-flac/33. 恋愛サーキュレーション.flac"
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:19 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: 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}
Aug 23 17:48:19 volumio volumio[8196]: verbose: CURRENT POSITION 289
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:19 volumio volumio[8196]: info: No code
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:19 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: 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}
Aug 23 17:48:19 volumio volumio[8196]: verbose: CURRENT POSITION 289
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:19 volumio volumio[8196]: info: No code
Aug 23 17:48:19 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:19 volumio volumio[8196]: info: CorePlayQueue::getTrack 289
Aug 23 17:48:19 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:19 volumio volumio[8196]: info: ------------------------------ 49ms
Aug 23 17:48:19 volumio volumio[8196]: info: ------------------------------ 49ms
Aug 23 17:48:19 volumio volumio[8196]: info:
Aug 23 17:48:19 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:19 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:19 volumio volumio[8196]: info:
Aug 23 17:48:19 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:19 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:19 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:48:19 volumio volumio[8196]: info:
Aug 23 17:48:19 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:19 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:19 volumio volumio[8196]: info: ------------------------------ 54ms
Aug 23 17:48:19 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 52 milliseconds
Aug 23 17:48:19 volumio volumio[8196]: info: sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/花澤香菜-【KANAight ~花澤香菜キャラソン ハイパークロニクルミックス~ [Disc 2]】-SQ-flac/33. 恋愛サーキュレーション.flac" took 52 milliseconds
Aug 23 17:48:19 volumio volumio[8196]: info: ------------------------------ 5ms
Aug 23 17:48:19 volumio volumio[8196]: info: ------------------------------ 4ms
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:19 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand play
Aug 23 17:48:19 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:19 volumio volumio[8196]: info: ------------------------------ 61ms
Aug 23 17:48:19 volumio volumio[8196]: info:
Aug 23 17:48:19 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:19 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:19 volumio volumio[8196]: info:
Aug 23 17:48:19 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:19 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:19 volumio volumio[8196]: info: ------------------------------ 14ms
Aug 23 17:48:19 volumio volumio[8196]: info: sendMpdCommand play took 11 milliseconds
Aug 23 17:48:19 volumio volumio[8196]: info: ------------------------------ 9ms
Aug 23 17:48:19 volumio volumio[8196]: info: ------------------------------ 9ms
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioNext
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::next
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::stop
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioNext
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::next
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::stop
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::play index undefined
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::play index undefined
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::startPlaybackTimer
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【TVアニメーション スラムダンク テーマソング集】-SQ-flac/01. 君が好きだと叫びたい.flac
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::startPlaybackTimer
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【TVアニメーション スラムダンク テーマソング集】-SQ-flac/01. 君が好きだと叫びたい.flac
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::updateTrackBlock
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrackBlock
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::updateTrackBlock
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrackBlock
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand status took 16 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand status took 15 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand status took 14 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand stop took 25 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand clear
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:26 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand stop took 26 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand status took 23 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 21 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 21 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 21 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand status took 19 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand status took 17 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand clear took 6 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand clear
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【TVアニメーション スラムダンク テーマソング集】-SQ-flac/01. 君が好きだと叫びたい.flac"
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7207,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"730 Kbps","isStreaming":false,"title":"恋愛サーキュレーション","artist":"花澤香菜","album":"KANAight ~花澤香菜キャラソン ハイパークロニクルミックス~ [Disc 2]","uri":"NAS/PC-MUSIC/FLAC-[SQ]/花澤香菜-【KANAight ~花澤香菜キャラソン ハイパークロニクルミックス~ [Disc 2]】-SQ-flac/33. 恋愛サーキュレーション.flac","trackType":"flac"}
Aug 23 17:48:26 volumio volumio[8196]: verbose: CURRENT POSITION 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7207,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"867 Kbps","isStreaming":false,"title":"恋愛サーキュレーション","artist":"花澤香菜","album":"KANAight ~花澤香菜キャラソン ハイパークロニクルミックス~ [Disc 2]","uri":"NAS/PC-MUSIC/FLAC-[SQ]/花澤香菜-【KANAight ~花澤香菜キャラソン ハイパークロニクルミックス~ [Disc 2]】-SQ-flac/33. 恋愛サーキュレーション.flac","trackType":"flac"}
Aug 23 17:48:26 volumio volumio[8196]: verbose: CURRENT POSITION 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:26 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7207,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"867 Kbps","isStreaming":false,"title":"恋愛サーキュレーション","artist":"花澤香菜","album":"KANAight ~花澤香菜キャラソン ハイパークロニクルミックス~ [Disc 2]","uri":"NAS/PC-MUSIC/FLAC-[SQ]/花澤香菜-【KANAight ~花澤香菜キャラソン ハイパークロニクルミックス~ [Disc 2]】-SQ-flac/33. 恋愛サーキュレーション.flac","trackType":"flac"}
Aug 23 17:48:26 volumio volumio[8196]: verbose: CURRENT POSITION 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:26 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 68ms
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 81ms
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 79ms
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:26 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:26 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand status took 51 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 52ms
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand clear took 48 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 47 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 45 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 46 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【TVアニメーション スラムダンク テーマソング集】-SQ-flac/01. 君が好きだと叫びたい.flac" took 46 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand status took 7 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand status took 7 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【TVアニメーション スラムダンク テーマソング集】-SQ-flac/01. 君が好きだと叫びたい.flac"
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand play
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: 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}
Aug 23 17:48:26 volumio volumio[8196]: verbose: CURRENT POSITION 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::play index undefined
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:26 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:26 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: 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}
Aug 23 17:48:26 volumio volumio[8196]: verbose: CURRENT POSITION 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: No code
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: 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}
Aug 23 17:48:26 volumio volumio[8196]: verbose: CURRENT POSITION 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: No code
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::startPlaybackTimer
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【TVアニメーション スラムダンク テーマソング集】-SQ-flac/01. 君が好きだと叫びたい.flac
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 128ms
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 149ms
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 144ms
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 143ms
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 84ms
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 83ms
Aug 23 17:48:26 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:26 volumio volumio[8196]: info: CorePlayQueue::getTrack 120
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:26 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:26 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:26 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:26 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:26 volumio volumio[8196]: info:
Aug 23 17:48:26 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 116ms
Aug 23 17:48:26 volumio volumio[8196]: info: ------------------------------ 115ms
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【TVアニメーション スラムダンク テーマソング集】-SQ-flac/01. 君が好きだと叫びたい.flac" took 110 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: sendMpdCommand play took 108 milliseconds
Aug 23 17:48:26 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:26 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand play
Aug 23 17:48:26 volumio kernel: CIFS: __readahead_batch() returned 8/1024
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand stop took 4499 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 4486ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 4476ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 4461ms
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand status took 4459 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand play took 4459 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand clear
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioNext
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::next
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::play index undefined
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::startPlaybackTimer
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[SQ]/Joan Jett & The Blackhearts-【Greatest Hits】-SQ-flac/08. I Love Rock N' Roll.flac
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::updateTrackBlock
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrackBlock
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand status took 11 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand status took 10 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand clear took 31 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【TVアニメーション スラムダンク テーマソング集】-SQ-flac/01. 君が好きだと叫びたい.flac"
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:30 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:48:30 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 33 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 32ms
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand status took 31 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 31ms
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand status took 31 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand stop took 28 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand status took 25 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 24 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 24 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【TVアニメーション スラムダンク テーマソング集】-SQ-flac/01. 君が好きだと叫びたい.flac" took 3 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand clear
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand play
Aug 23 17:48:30 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: 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}
Aug 23 17:48:30 volumio volumio[8196]: verbose: CURRENT POSITION 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: No code
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: 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}
Aug 23 17:48:30 volumio volumio[8196]: verbose: CURRENT POSITION 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: No code
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: 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}
Aug 23 17:48:30 volumio volumio[8196]: verbose: CURRENT POSITION 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: No code
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:30 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 4517ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 97ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 96ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 91ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 102ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 103ms
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:48:30 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 74ms
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand status took 72 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 73ms
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand clear took 69 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand play took 68 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 5ms
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand status took 4 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 4ms
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand status took 4 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Joan Jett & The Blackhearts-【Greatest Hits】-SQ-flac/08. I Love Rock N' Roll.flac"
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: 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}
Aug 23 17:48:30 volumio volumio[8196]: verbose: CURRENT POSITION 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: No code
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: 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}
Aug 23 17:48:30 volumio volumio[8196]: verbose: CURRENT POSITION 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: No code
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: 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}
Aug 23 17:48:30 volumio volumio[8196]: verbose: CURRENT POSITION 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: No code
Aug 23 17:48:30 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:30 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:30 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 124ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 56ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 55ms
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 70ms
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Joan Jett & The Blackhearts-【Greatest Hits】-SQ-flac/08. I Love Rock N' Roll.flac" took 68 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 16ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 15ms
Aug 23 17:48:30 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand play
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info:
Aug 23 17:48:30 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:30 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 6ms
Aug 23 17:48:30 volumio volumio[8196]: info: sendMpdCommand play took 6 milliseconds
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 5ms
Aug 23 17:48:30 volumio volumio[8196]: info: ------------------------------ 4ms
Aug 23 17:48:32 volumio kernel: CIFS: __readahead_batch() returned 140/1024
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 23 17:48:34 volumio volumio[8196]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Aug 23 17:48:34 volumio volumio[8196]: info: Received Get System Version
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 23 17:48:34 volumio volumio[8196]: info: Received Get System Info
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 17:48:34 volumio volumio[8196]: info: Discovery: Getting this device information
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioGetState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 43
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioNext
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::next
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::stop
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::play index undefined
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::startPlaybackTimer
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::updateTrackBlock
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrackBlock
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand status took 16 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand status took 15 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand status took 14 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand stop took 24 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand clear
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:34 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand status took 24 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 23 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 24 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 24 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand status took 23 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand status took 22 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand clear took 2 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac"
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4461,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"933 Kbps","isStreaming":false,"title":"I Love Rock N' Roll","artist":"Joan Jett & The Blackhearts","album":"Greatest Hits","uri":"NAS/PC-MUSIC/FLAC-[SQ]/Joan Jett & The Blackhearts-【Greatest Hits】-SQ-flac/08. I Love Rock N' Roll.flac","trackType":"flac"}
Aug 23 17:48:34 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4461,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"933 Kbps","isStreaming":false,"title":"I Love Rock N' Roll","artist":"Joan Jett & The Blackhearts","album":"Greatest Hits","uri":"NAS/PC-MUSIC/FLAC-[SQ]/Joan Jett & The Blackhearts-【Greatest Hits】-SQ-flac/08. I Love Rock N' Roll.flac","trackType":"flac"}
Aug 23 17:48:34 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:34 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4461,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"933 Kbps","isStreaming":false,"title":"I Love Rock N' Roll","artist":"Joan Jett & The Blackhearts","album":"Greatest Hits","uri":"NAS/PC-MUSIC/FLAC-[SQ]/Joan Jett & The Blackhearts-【Greatest Hits】-SQ-flac/08. I Love Rock N' Roll.flac","trackType":"flac"}
Aug 23 17:48:34 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:34 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 55ms
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 69ms
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 69ms
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:34 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:34 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand status took 35 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 35ms
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 33 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 32 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 32 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac" took 33 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand status took 15 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand status took 14 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand play
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: 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}
Aug 23 17:48:34 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::play index undefined
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:34 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:34 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: 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}
Aug 23 17:48:34 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: No code
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: 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}
Aug 23 17:48:34 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: No code
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::startPlaybackTimer
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 113ms
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 137ms
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 135ms
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 134ms
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 82ms
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 82ms
Aug 23 17:48:34 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:34 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:34 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:34 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:34 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:34 volumio volumio[8196]: info:
Aug 23 17:48:34 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:34 volumio volumio[8196]: info: ------------------------------ 103ms
Aug 23 17:48:34 volumio volumio[8196]: info: sendMpdCommand play took 88 milliseconds
Aug 23 17:48:34 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:34 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand stop took 579 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 568ms
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 567ms
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 555 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand clear
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:35 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 9 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand clear took 9 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 8 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 7 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 5 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac"
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: 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}
Aug 23 17:48:35 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: No code
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: 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}
Aug 23 17:48:35 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState stateService stop
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: No code
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 584ms
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 48ms
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 48ms
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:35 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:35 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:35 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:35 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 47ms
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 45 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac" took 45 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 4ms
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 3ms
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand play
Aug 23 17:48:35 volumio volumio[8196]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 58ms
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:35 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:48:35 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 15ms
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand play took 13 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 12ms
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 12ms
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 5 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 5 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 4 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 3 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info:
Aug 23 17:48:35 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 17 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 17 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 16 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 17 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 15 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand status took 14 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":402,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"577 Kbps","isStreaming":false,"title":"Una Mattina","artist":"Ludovico Einaudi","album":"The Intouchables","uri":"NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac","trackType":"flac"}
Aug 23 17:48:35 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":402,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"577 Kbps","isStreaming":false,"title":"Una Mattina","artist":"Ludovico Einaudi","album":"The Intouchables","uri":"NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac","trackType":"flac"}
Aug 23 17:48:35 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:35 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":402,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"577 Kbps","isStreaming":false,"title":"Una Mattina","artist":"Ludovico Einaudi","album":"The Intouchables","uri":"NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac","trackType":"flac"}
Aug 23 17:48:35 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:35 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":402,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"577 Kbps","isStreaming":false,"title":"Una Mattina","artist":"Ludovico Einaudi","album":"The Intouchables","uri":"NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac","trackType":"flac"}
Aug 23 17:48:35 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:35 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 49ms
Aug 23 17:48:35 volumio kernel: CIFS: __readahead_batch() returned 8/1024
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 76ms
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 74ms
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 74ms
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 50 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 50 milliseconds
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:35 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":402,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"577 Kbps","isStreaming":false,"title":"Una Mattina","artist":"Ludovico Einaudi","album":"The Intouchables","uri":"NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac","trackType":"flac"}
Aug 23 17:48:35 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:35 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":402,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"577 Kbps","isStreaming":false,"title":"Una Mattina","artist":"Ludovico Einaudi","album":"The Intouchables","uri":"NAS/PC-MUSIC/FLAC-[SQ]/Various Artists-【The Intouchables】-SQ-flac/11. Una Mattina.flac","trackType":"flac"}
Aug 23 17:48:35 volumio volumio[8196]: verbose: CURRENT POSITION 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:48:35 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:48:35 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:35 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 97ms
Aug 23 17:48:35 volumio volumio[8196]: info: ------------------------------ 96ms
Aug 23 17:48:37 volumio volumio[8196]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 23 17:48:37 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 23 17:48:37 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 23 17:48:37 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 23 17:48:37 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Aug 23 17:48:37 volumio volumio[8196]: info: Received Get System Version
Aug 23 17:48:37 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 23 17:48:37 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds
Aug 23 17:48:43 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 17:48:43 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 17:48:43 volumio volumio[8196]: info: Discovery: Getting this device information
Aug 23 17:48:43 volumio volumio[8196]: info: CoreCommandRouter::volumioGetState
Aug 23 17:48:43 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:48:43 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Aug 23 17:48:45 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Aug 23 17:48:58 volumio volumio[8196]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object]
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions
Aug 23 17:48:58 volumio sudo[8587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 23 17:48:58 volumio sudo[8587]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 17:48:58 volumio sudo[8587]: pam_unix(sudo:session): session closed for user root
Aug 23 17:48:58 volumio volumio[8196]: info: MPD Permissions set
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 17:48:58 volumio sudo[8590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 23 17:48:58 volumio sudo[8590]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 17:48:58 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 17:48:58 volumio systemd[1]: Stopping Music Player Daemon...
Aug 23 17:48:58 volumio systemd[1]: mpd.service: Succeeded.
Aug 23 17:48:58 volumio systemd[1]: Stopped Music Player Daemon.
Aug 23 17:48:58 volumio systemd[1]: Starting Music Player Daemon...
Aug 23 17:48:58 volumio sudo[8596]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 23 17:48:58 volumio sudo[8596]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 17:48:58 volumio sudo[8596]: pam_unix(sudo:session): session closed for user root
Aug 23 17:48:59 volumio mpd[8599]: Aug 23 17:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 23 17:48:59 volumio systemd[1]: Started Music Player Daemon.
Aug 23 17:48:59 volumio sudo[8590]: pam_unix(sudo:session): session closed for user root
Aug 23 17:48:59 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:49:07 volumio volumio[8196]: info: CoreCommandRouter::volumioNext
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::next
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::stop
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::stPlaybackTimer
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::updateTrackBlock
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrackBlock
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:49:07 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:49:07 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::serviceStop
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrack 121
Aug 23 17:49:07 volumio volumio[8196]: info: CoreCommandRouter::serviceStop
Aug 23 17:49:07 volumio volumio[8196]: info: ControllerMpd::stop
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:49:07 volumio volumio[8196]: info: sendMpdCommand stop took 5 milliseconds
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::play index undefined
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrack 85
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::startPlaybackTimer
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrack 85
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[SQ]/S.E.N.S.-【Sound. Earth. Nature. Spirit. ~vol. NATURE】-SQ-flac/05. 風待ち.flac
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::updateTrackBlock
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrackBlock
Aug 23 17:49:07 volumio volumio[8196]: info: sendMpdCommand stop took 1 milliseconds
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand clear
Aug 23 17:49:07 volumio volumio[8196]: info:
Aug 23 17:49:07 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:49:07 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:49:07 volumio volumio[8196]: info: sendMpdCommand clear took 1 milliseconds
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/S.E.N.S.-【Sound. Earth. Nature. Spirit. ~vol. NATURE】-SQ-flac/05. 風待ち.flac"
Aug 23 17:49:07 volumio volumio[8196]: error: updateQueue error: null
Aug 23 17:49:07 volumio volumio[8196]: info:
Aug 23 17:49:07 volumio volumio[8196]: ---------------------------- MPD announces system playlist update
Aug 23 17:49:07 volumio volumio[8196]: info: Ignoring MPD Status Update
Aug 23 17:49:07 volumio volumio[8196]: info: ------------------------------ 2ms
Aug 23 17:49:07 volumio volumio[8196]: info: sendMpdCommand add "NAS/PC-MUSIC/FLAC-[SQ]/S.E.N.S.-【Sound. Earth. Nature. Spirit. ~vol. NATURE】-SQ-flac/05. 風待ち.flac" took 2 milliseconds
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand play
Aug 23 17:49:07 volumio volumio[8196]: info: ------------------------------ 2ms
Aug 23 17:49:07 volumio volumio[8196]: info: sendMpdCommand play took 1 milliseconds
Aug 23 17:49:07 volumio volumio[8196]: info:
Aug 23 17:49:07 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:49:07 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:49:07 volumio volumio[8196]: info:
Aug 23 17:49:07 volumio volumio[8196]: ---------------------------- MPD announces state update: player
Aug 23 17:49:07 volumio volumio[8196]: info: sendMpdCommand status took 10 milliseconds
Aug 23 17:49:07 volumio volumio[8196]: info: ControllerMpd::getState
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:49:07 volumio volumio[8196]: info: sendMpdCommand status took 1 milliseconds
Aug 23 17:49:07 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::parseState
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:49:07 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:49:07 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrack 85
Aug 23 17:49:07 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"風待ち","artist":"S.E.N.S.","album":"Sound. Earth. Nature. Spirit. ~vol. NATURE","uri":"NAS/PC-MUSIC/FLAC-[SQ]/S.E.N.S.-【Sound. Earth. Nature. Spirit. ~vol. NATURE】-SQ-flac/05. 風待ち.flac","trackType":"flac"}
Aug 23 17:49:07 volumio volumio[8196]: verbose: CURRENT POSITION 85
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 17:49:07 volumio volumio[8196]: info: ------------------------------ 14ms
Aug 23 17:49:07 volumio volumio[8196]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 23 17:49:07 volumio volumio[8196]: verbose: ControllerMpd::parseTrackInfo
Aug 23 17:49:07 volumio volumio[8196]: info: ControllerMpd::pushState
Aug 23 17:49:07 volumio volumio[8196]: info: CoreCommandRouter::servicePushState
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrack 85
Aug 23 17:49:07 volumio volumio[8196]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"風待ち","artist":"S.E.N.S.","album":"Sound. Earth. Nature. Spirit. ~vol. NATURE","uri":"NAS/PC-MUSIC/FLAC-[SQ]/S.E.N.S.-【Sound. Earth. Nature. Spirit. ~vol. NATURE】-SQ-flac/05. 風待ち.flac","trackType":"flac"}
Aug 23 17:49:07 volumio volumio[8196]: verbose: CURRENT POSITION 85
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::syncState stateService play
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::syncState currentStatus play
Aug 23 17:49:07 volumio volumio[8196]: info: Received an update from plugin. extracting info from payload
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrack 85
Aug 23 17:49:07 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 17:49:07 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:49:07 volumio volumio[8196]: info: CoreStateMachine::pushState
Aug 23 17:49:07 volumio volumio[8196]: info: CorePlayQueue::getTrack 85
Aug 23 17:49:07 volumio volumio[8196]: info: CoreCommandRouter::volumioPushState
Aug 23 17:49:07 volumio volumio[8196]: info: ------------------------------ 18ms
Aug 23 17:49:13 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 17:49:13 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 17:49:13 volumio volumio[8196]: info: Discovery: Getting this device information
Aug 23 17:49:13 volumio volumio[8196]: info: CoreCommandRouter::volumioGetState
Aug 23 17:49:13 volumio volumio[8196]: info: CorePlayQueue::getTrack 85
Aug 23 17:49:13 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 23 17:49:18 volumio volumio[8196]: info: Retrieving Cloud Streaming UI
Aug 23 17:49:18 volumio volumio[8196]: info: Getting Tidal Cloud Configuration
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 23 17:49:18 volumio volumio[8196]: info: Getting Qobuz Cloud Configuration
Aug 23 17:49:18 volumio volumio[8196]: info: Asking plugin for UI Config
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 23 17:49:18 volumio volumio[8196]: info: Getting Spotify Cloud Configuration
Aug 23 17:49:18 volumio volumio[8196]: info: Asking plugin for UI Config
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 23 17:49:18 volumio volumio[8196]: info: Saving Spotify Acccount
Aug 23 17:49:18 volumio volumio[8196]: info: Got Tidal Cloud Configuration
Aug 23 17:49:18 volumio volumio[8196]: info: Got it
Aug 23 17:49:18 volumio volumio[8196]: info: Got it
Aug 23 17:49:18 volumio volumio[8196]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 23 17:49:18 volumio volumio[8196]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 23 17:49:18 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Aug 23 17:49:22 volumio volumio[8196]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 23 17:49:23 volumio volumio[8196]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 23 17:49:24 volumio volumio[8196]: Error: connect ETIMEDOUT 128.121.146.109:443
Aug 23 17:49:24 volumio volumio[8196]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Aug 23 17:49:24 volumio volumio[8196]: errno: -110,
Aug 23 17:49:24 volumio volumio[8196]: code: 'ETIMEDOUT',
Aug 23 17:49:24 volumio volumio[8196]: syscall: 'connect',
Aug 23 17:49:24 volumio volumio[8196]: address: '128.121.146.109',
Aug 23 17:49:24 volumio volumio[8196]: port: 443
Aug 23 17:49:24 volumio volumio[8196]: }
Aug 23 17:49:24 volumio volumio[8196]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 23 17:49:24 volumio sudo[8620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-23 17:48
Aug 23 17:49:24 volumio sudo[8620]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST"
VOLUMIO_VERSION="3.742"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"