-- Logs begin at Fri 2024-01-26 22:08:16 UTC, end at Mon 2024-03-18 01:01:16 UTC. -- Mar 18 01:00:03 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioGetVisibleSources Mar 18 01:00:03 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 01:00:03 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioGetState Mar 18 01:00:03 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 1 Mar 18 01:00:03 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioGetQueue Mar 18 01:00:03 volumio_zal volumio[1130]: info: CoreStateMachine::getQueue Mar 18 01:00:03 volumio_zal volumio[1130]: info: CorePlayQueue::getQueue Mar 18 01:00:03 volumio_zal volumio[1130]: info: Listing playlists Mar 18 01:00:03 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioNext Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::next Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::stop Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: UNSET VOLATILE Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::stPlaybackTimer Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::updateTrackBlock Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrackBlock Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 1 Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::serviceStop Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 1 Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::serviceStop Mar 18 01:00:10 volumio_zal volumio[1130]: info: ControllerMpd::stop Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand stop took 39 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::play index undefined Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::startPlaybackTimer Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::clearAddPlayTracks NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/06 - Tidal Wave.mp3 Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::updateTrackBlock Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrackBlock Mar 18 01:00:10 volumio_zal volumio[1130]: info: Mar 18 01:00:10 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:10 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand stop took 4 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand clear Mar 18 01:00:10 volumio_zal volumio[1130]: info: Mar 18 01:00:10 volumio_zal volumio[1130]: ---------------------------- MPD announces system playlist update Mar 18 01:00:10 volumio_zal volumio[1130]: info: Ignoring MPD Status Update Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand status took 5 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand clear took 4 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand add "NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/06 - Tidal Wave.mp3" Mar 18 01:00:10 volumio_zal volumio[1130]: error: updateQueue error: null Mar 18 01:00:10 volumio_zal volumio[1130]: info: Mar 18 01:00:10 volumio_zal volumio[1130]: ---------------------------- MPD announces system playlist update Mar 18 01:00:10 volumio_zal volumio[1130]: info: Ignoring MPD Status Update Mar 18 01:00:10 volumio_zal volumio[1130]: info: ------------------------------ 4ms Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand add "NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/06 - Tidal Wave.mp3" took 2 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand play Mar 18 01:00:10 volumio_zal volumio[1130]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 18 01:00:10 volumio_zal volumio[1130]: info: ------------------------------ 11ms Mar 18 01:00:10 volumio_zal volumio[1130]: info: ------------------------------ 5ms Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand play took 3 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: info: Mar 18 01:00:10 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:10 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:10 volumio_zal kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Mar 18 01:00:10 volumio_zal volumio[1130]: info: Mar 18 01:00:10 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand status took 12 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand status took 4 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:10 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Tidal Wave","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/06 - Tidal Wave.mp3","trackType":"mp3"} Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: CURRENT POSITION 5 Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:10 volumio_zal volumio[1130]: info: ------------------------------ 31ms Mar 18 01:00:10 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:10 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Tidal Wave","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/06 - Tidal Wave.mp3","trackType":"mp3"} Mar 18 01:00:10 volumio_zal volumio[1130]: verbose: CURRENT POSITION 5 Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus play Mar 18 01:00:10 volumio_zal volumio[1130]: info: Received an update from plugin. extracting info from payload Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:10 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:10 volumio_zal volumio[1130]: info: ------------------------------ 59ms Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioSeek Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreStateMachine::seek Mar 18 01:00:21 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:21 volumio_zal volumio[1130]: info: TRACKBLOCK {"uri":"mnt/NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/06 - Tidal Wave.mp3","service":"mpd","name":"Tidal Wave","artist":"Nickelback","album":"Get Rollin' (Deluxe)","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=127&web=Nickelback/Get%20Rollin'%20(Deluxe)/medium&path=%2FNAS%2FTorrent%2FNickelback%20-%202023%20-%20Get%20Rollin'%20(Deluxe)&metadata=false","duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","trackType":"mp3","channels":2} Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreStateMachine::startPlaybackTimer Mar 18 01:00:21 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:21 volumio_zal volumio[1130]: info: ControllerMpd::seek Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:21 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:21 volumio_zal volumio[1130]: error: null Mar 18 01:00:21 volumio_zal volumio[1130]: info: Mar 18 01:00:21 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:21 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:21 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:21 volumio_zal volumio[1130]: info: sendMpdCommand status took 1 milliseconds Mar 18 01:00:21 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:21 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:21 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 18 01:00:21 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:21 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:21 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:21 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69000,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Tidal Wave","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/06 - Tidal Wave.mp3","trackType":"mp3"} Mar 18 01:00:21 volumio_zal volumio[1130]: verbose: CURRENT POSITION 5 Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus play Mar 18 01:00:21 volumio_zal volumio[1130]: info: Received an update from plugin. extracting info from payload Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:21 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:21 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:21 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:21 volumio_zal volumio[1130]: info: ------------------------------ 23ms Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioNext Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::next Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::stop Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: UNSET VOLATILE Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::stPlaybackTimer Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::updateTrackBlock Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrackBlock Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::serviceStop Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 5 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::serviceStop Mar 18 01:00:24 volumio_zal volumio[1130]: info: ControllerMpd::stop Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 01:00:24 volumio_zal volumio[1130]: info: Mar 18 01:00:24 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand stop took 56 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::play index undefined Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::startPlaybackTimer Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::clearAddPlayTracks NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3 Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::updateTrackBlock Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrackBlock Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand status took 5 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand stop took 4 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand clear Mar 18 01:00:24 volumio_zal volumio[1130]: info: Mar 18 01:00:24 volumio_zal volumio[1130]: ---------------------------- MPD announces system playlist update Mar 18 01:00:24 volumio_zal volumio[1130]: info: Ignoring MPD Status Update Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand clear took 3 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand add "NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3" Mar 18 01:00:24 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tidal Wave","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/06 - Tidal Wave.mp3","trackType":"mp3"} Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: CURRENT POSITION 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService stop Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: No code Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: ------------------------------ 26ms Mar 18 01:00:24 volumio_zal volumio[1130]: error: updateQueue error: null Mar 18 01:00:24 volumio_zal volumio[1130]: info: Mar 18 01:00:24 volumio_zal volumio[1130]: ---------------------------- MPD announces system playlist update Mar 18 01:00:24 volumio_zal volumio[1130]: info: Ignoring MPD Status Update Mar 18 01:00:24 volumio_zal volumio[1130]: info: ------------------------------ 19ms Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand add "NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3" took 17 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand play Mar 18 01:00:24 volumio_zal volumio[1130]: info: ------------------------------ 8ms Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand play took 7 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: info: Mar 18 01:00:24 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:24 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:24 volumio_zal kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Mar 18 01:00:24 volumio_zal volumio[1130]: info: Mar 18 01:00:24 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand status took 13 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand status took 2 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":198,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Horizon (Acoustic)","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3","trackType":"mp3"} Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: CURRENT POSITION 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: ------------------------------ 27ms Mar 18 01:00:24 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":198,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Horizon (Acoustic)","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3","trackType":"mp3"} Mar 18 01:00:24 volumio_zal volumio[1130]: verbose: CURRENT POSITION 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus play Mar 18 01:00:24 volumio_zal volumio[1130]: info: Received an update from plugin. extracting info from payload Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:24 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:24 volumio_zal volumio[1130]: info: ------------------------------ 28ms Mar 18 01:00:27 volumio_zal volumio[1130]: info: Adding mnt/NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3 to favourites using generic method Mar 18 01:00:27 volumio_zal volumio[1130]: info: Saving local item favourites Mar 18 01:00:27 volumio_zal volumio[1130]: info: Pushing Favourites {"uri":"mnt/NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3","favourite":true} Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioSeek Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreStateMachine::seek Mar 18 01:00:29 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:29 volumio_zal volumio[1130]: info: TRACKBLOCK {"uri":"mnt/NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3","service":"mpd","name":"Horizon (Acoustic)","artist":"Nickelback","album":"Get Rollin' (Deluxe)","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=127&web=Nickelback/Get%20Rollin'%20(Deluxe)/medium&path=%2FNAS%2FTorrent%2FNickelback%20-%202023%20-%20Get%20Rollin'%20(Deluxe)&metadata=false","duration":198,"samplerate":"44.1 kHz","bitdepth":"24 bit","trackType":"mp3","channels":2} Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreStateMachine::startPlaybackTimer Mar 18 01:00:29 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:29 volumio_zal volumio[1130]: info: ControllerMpd::seek Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:29 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:29 volumio_zal volumio[1130]: error: null Mar 18 01:00:29 volumio_zal volumio[1130]: info: Mar 18 01:00:29 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:29 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:29 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:29 volumio_zal volumio[1130]: info: sendMpdCommand status took 3 milliseconds Mar 18 01:00:29 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:29 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:29 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 18 01:00:29 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:29 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:29 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:29 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29000,"duration":198,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Horizon (Acoustic)","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3","trackType":"mp3"} Mar 18 01:00:29 volumio_zal volumio[1130]: verbose: CURRENT POSITION 18 Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus play Mar 18 01:00:29 volumio_zal volumio[1130]: info: Received an update from plugin. extracting info from payload Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:29 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:29 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:29 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:29 volumio_zal volumio[1130]: info: ------------------------------ 41ms Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioNext Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::next Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::stop Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: UNSET VOLATILE Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::stPlaybackTimer Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::updateTrackBlock Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrackBlock Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::serviceStop Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 18 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::serviceStop Mar 18 01:00:33 volumio_zal volumio[1130]: info: ControllerMpd::stop Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 01:00:33 volumio_zal volumio[1130]: info: Mar 18 01:00:33 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand stop took 105 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::play index undefined Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::startPlaybackTimer Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::clearAddPlayTracks NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/11 - Just One More.mp3 Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::updateTrackBlock Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrackBlock Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand status took 10 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand stop took 5 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand clear Mar 18 01:00:33 volumio_zal volumio[1130]: info: Mar 18 01:00:33 volumio_zal volumio[1130]: ---------------------------- MPD announces system playlist update Mar 18 01:00:33 volumio_zal volumio[1130]: info: Ignoring MPD Status Update Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand clear took 4 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand add "NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/11 - Just One More.mp3" Mar 18 01:00:33 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Horizon (Acoustic)","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/19 - Horizon (Acoustic).mp3","trackType":"mp3"} Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: CURRENT POSITION 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService stop Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: No code Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: ------------------------------ 35ms Mar 18 01:00:33 volumio_zal volumio[1130]: error: updateQueue error: null Mar 18 01:00:33 volumio_zal volumio[1130]: info: Mar 18 01:00:33 volumio_zal volumio[1130]: ---------------------------- MPD announces system playlist update Mar 18 01:00:33 volumio_zal volumio[1130]: info: Ignoring MPD Status Update Mar 18 01:00:33 volumio_zal volumio[1130]: info: ------------------------------ 21ms Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand add "NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/11 - Just One More.mp3" took 19 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand play Mar 18 01:00:33 volumio_zal volumio[1130]: info: ------------------------------ 8ms Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand play took 6 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: info: Mar 18 01:00:33 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:33 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:33 volumio_zal kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Mar 18 01:00:33 volumio_zal volumio[1130]: info: Mar 18 01:00:33 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand status took 14 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand status took 2 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Just One More","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/11 - Just One More.mp3","trackType":"mp3"} Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: CURRENT POSITION 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: ------------------------------ 27ms Mar 18 01:00:33 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":219,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Just One More","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/11 - Just One More.mp3","trackType":"mp3"} Mar 18 01:00:33 volumio_zal volumio[1130]: verbose: CURRENT POSITION 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus play Mar 18 01:00:33 volumio_zal volumio[1130]: info: Received an update from plugin. extracting info from payload Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:00:33 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:00:33 volumio_zal volumio[1130]: info: ------------------------------ 32ms Mar 18 01:00:40 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 18 01:00:40 volumio_zal volumio[1130]: info: CURURI: music-library Mar 18 01:00:41 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 18 01:00:41 volumio_zal volumio[1130]: info: CURURI: music-library/NAS Mar 18 01:00:42 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 18 01:00:42 volumio_zal volumio[1130]: info: CURURI: music-library/NAS/Torrent Mar 18 01:01:03 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 18 01:01:03 volumio_zal volumio[1130]: info: CURURI: music-library/NAS/Torrent/Cafe 'Safari' Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::ClearQueue Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::stop Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: UNSET VOLATILE Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::stPlaybackTimer Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::updateTrackBlock Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrackBlock Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::serviceStop Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 10 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::serviceStop Mar 18 01:01:14 volumio_zal volumio[1130]: info: ControllerMpd::stop Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::clearPlayQueue Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::saveQueue Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushQueue Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::addQueueItems Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::addQueueItems Mar 18 01:01:14 volumio_zal volumio[1130]: info: Adding Item to queue: music-library/NAS/Torrent/Cafe 'Safari' Mar 18 01:01:14 volumio_zal volumio[1130]: info: Exploding uri music-library/NAS/Torrent/Cafe 'Safari' in service mpd Mar 18 01:01:14 volumio_zal volumio[1130]: info: Mar 18 01:01:14 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand stop took 42 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F01.%20Angel%E2%80%99s%20Smile%20%20%D0%A3%D0%BB%D1%8B%D0%B1%D0%BA%D0%B0%20%D0%B0%D0%BD%D0%B3%D0%B5%D0%BB%D0%B0.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/01. Angel’s Smile Улыбка ангела.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F02.%20Border%20Line%20%20%D0%9B%D0%B8%D0%BD%D0%B8%D1%8F%20%D0%B3%D0%BE%D1%80%D0%B8%D0%B7%D0%BE%D0%BD%D1%82%D0%B0.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/02. Border Line Линия горизонта.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F03.%20Copper%20Sky%20%20%D0%9C%D0%B5%D0%B4%D0%BD%D1%8B%D0%B5%20%D0%BD%D0%B5%D0%B1%D0%B5%D1%81%D0%B0.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/03. Copper Sky Медные небеса.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F04.%20Cafe%20'Safari'%20%20%D0%9A%D0%B0%D1%84%D0%B5%20'%D0%A1%D0%B0%D1%84%D0%B0%D1%80%D0%B8'.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/04. Cafe 'Safari' Кафе 'Сафари'.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F05.%20Chinese%20Red%20%20%D0%9A%D0%B8%D1%82%D0%B0%D0%B9%D1%81%D0%BA%D0%B8%D0%B9%20%D0%BA%D1%80%D0%B0%D1%81%D0%BD%D1%8B%D0%B9.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/05. Chinese Red Китайский красный.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F06.%20Robin%20Hood%20%20%D0%A0%D0%BE%D0%B1%D0%B8%D0%BD%20%D0%93%D1%83%D0%B4.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/06. Robin Hood Робин Гуд.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F07.%20One%20From%20the%20Heart%20%20%D0%9E%D1%82%20%D1%81%D0%B0%D0%BC%D0%BE%D0%B3%D0%BE%20%D1%81%D0%B5%D1%80%D0%B4%D1%86%D0%B0.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/07. One From the Heart От самого сердца.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F08.%20Golden%20Sands%20%20%D0%97%D0%BE%D0%BB%D0%BE%D1%82%D1%8B%D0%B5%20%D0%BF%D0%B5%D1%81%D0%BA%D0%B8.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/08. Golden Sands Золотые пески.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F09.%20Ephemera%20%20%D0%AD%D1%84%D0%B5%D0%BC%D0%B5%D1%80%D0%B0.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/09. Ephemera Эфемера.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F10.%20Mana%20Nokana%20%20%D0%9C%D0%B0%D0%BD%D0%B0%20%D0%9D%D0%BE%D0%BA%D0%B0%D0%BD%D0%B0.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/10. Mana Nokana Мана Нокана.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F11.%20Voyager%20%20%D0%9A%D1%80%D0%B5%D1%81%D1%82%D0%BE%D0%B2%D1%8B%D0%B9%20%D0%BF%D0%BE%D1%85%D0%BE%D0%B4.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/11. Voyager Крестовый поход.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: ALBUMART /albumart?cacheid=127&web=%D0%94%D0%BC%D0%B8%D1%82%D1%80%D0%B8%D0%B9%20%D0%9C%D0%B0%D0%BB%D0%B8%D0%BA%D0%BE%D0%B2/Cafe%20'Safari'/medium&path=%2Fmnt%2FNAS%2FTorrent%2FCafe%20'Safari'%2F12.%20The%20Knight%20to%20Remember%20%20%D0%A0%D1%8B%D1%86%D0%B0%D1%80%D1%8C%20%D0%BD%D0%B0%D0%B2%D1%81%D0%B5%D0%B3%D0%B4%D0%B0.mp3&metadata=false Mar 18 01:01:14 volumio_zal volumio[1130]: info: URI /mnt/NAS/Torrent/Cafe 'Safari'/12. The Knight to Remember Рыцарь навсегда.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand status took 8 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::saveQueue Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushQueue Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::updateTrackBlock Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrackBlock Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPlay Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: UNSET VOLATILE Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::play index 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::stop Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: UNSET VOLATILE Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::play index undefined Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::startPlaybackTimer Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::clearAddPlayTracks NAS/Torrent/Cafe 'Safari'/01. Angel’s Smile Улыбка ангела.mp3 Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand stop took 3 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand clear Mar 18 01:01:14 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Just One More","artist":"Nickelback","album":"Get Rollin' (Deluxe)","uri":"NAS/Torrent/Nickelback - 2023 - Get Rollin' (Deluxe)/11 - Just One More.mp3","trackType":"mp3"} Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: CURRENT POSITION 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService stop Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: No code Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: ------------------------------ 37ms Mar 18 01:01:14 volumio_zal volumio[1130]: info: Mar 18 01:01:14 volumio_zal volumio[1130]: ---------------------------- MPD announces system playlist update Mar 18 01:01:14 volumio_zal volumio[1130]: info: Ignoring MPD Status Update Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand clear took 18 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand add "NAS/Torrent/Cafe 'Safari'/01. Angel’s Smile Улыбка ангела.mp3" Mar 18 01:01:14 volumio_zal volumio[1130]: error: updateQueue error: null Mar 18 01:01:14 volumio_zal volumio[1130]: info: Mar 18 01:01:14 volumio_zal volumio[1130]: ---------------------------- MPD announces system playlist update Mar 18 01:01:14 volumio_zal volumio[1130]: info: Ignoring MPD Status Update Mar 18 01:01:14 volumio_zal volumio[1130]: info: ------------------------------ 15ms Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand add "NAS/Torrent/Cafe 'Safari'/01. Angel’s Smile Улыбка ангела.mp3" took 13 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand play Mar 18 01:01:14 volumio_zal volumio[1130]: info: ------------------------------ 6ms Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand play took 5 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: info: Mar 18 01:01:14 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:01:14 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:01:14 volumio_zal kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Mar 18 01:01:14 volumio_zal volumio[1130]: info: Mar 18 01:01:14 volumio_zal volumio[1130]: ---------------------------- MPD announces state update: player Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand status took 6 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: info: ControllerMpd::getState Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand status took 2 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::parseState Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Angel’s Smile | Улыбка ангела","artist":"Дмитрий Маликов","album":"Cafe 'Safari'","uri":"NAS/Torrent/Cafe 'Safari'/01. Angel’s Smile Улыбка ангела.mp3","trackType":"mp3"} Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: CURRENT POSITION 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: ------------------------------ 28ms Mar 18 01:01:14 volumio_zal volumio[1130]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: ControllerMpd::parseTrackInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: ControllerMpd::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::servicePushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Angel’s Smile | Улыбка ангела","artist":"Дмитрий Маликов","album":"Cafe 'Safari'","uri":"NAS/Torrent/Cafe 'Safari'/01. Angel’s Smile Улыбка ангела.mp3","trackType":"mp3"} Mar 18 01:01:14 volumio_zal volumio[1130]: verbose: CURRENT POSITION 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::syncState stateService play Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::syncState currentStatus play Mar 18 01:01:14 volumio_zal volumio[1130]: info: Received an update from plugin. extracting info from payload Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreStateMachine::pushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CorePlayQueue::getTrack 0 Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::volumioPushState Mar 18 01:01:14 volumio_zal volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 01:01:14 volumio_zal volumio[1130]: info: ------------------------------ 28ms Mar 18 01:01:15 volumio_zal volumio[1130]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 18 01:01:15 volumio_zal volumio[1130]: { Error: certificate is not yet valid Mar 18 01:01:15 volumio_zal volumio[1130]: at TLSSocket. (_tls_wrap.js:1105:38) Mar 18 01:01:15 volumio_zal volumio[1130]: at emitNone (events.js:106:13) Mar 18 01:01:15 volumio_zal volumio[1130]: at TLSSocket.emit (events.js:208:7) Mar 18 01:01:15 volumio_zal volumio[1130]: at TLSSocket._finishInit (_tls_wrap.js:639:8) Mar 18 01:01:15 volumio_zal volumio[1130]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:469:38) code: 'CERT_NOT_YET_VALID' } Mar 18 01:01:15 volumio_zal volumio[1130]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 18 01:01:16 volumio_zal sudo[23262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-18 01:00 Mar 18 01:01:16 volumio_zal sudo[23262]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"