-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Fri 2025-05-09 23:27:18 MSK. -- May 09 23:26:00 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 09 23:26:00 phantom volumio[943]: info: Received Get System Info May 09 23:26:00 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 23:26:00 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 23:26:00 phantom volumio[943]: info: Discovery: Getting this device information May 09 23:26:00 phantom volumio[943]: info: CoreCommandRouter::volumioGetState May 09 23:26:00 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 23:26:03 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri May 09 23:26:03 phantom volumio[943]: info: Preload queue cleared May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950826:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950827:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950828:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950829:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950830:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950833:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950835:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950837:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950839:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950840:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Preloading song: yandex_music/track/83950842:15850288@15850288 May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950826:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950827:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950828:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950829:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950830:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950833:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950835:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950837:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950839:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950840:15850288@15850288 in service yandex_music May 09 23:26:03 phantom volumio[943]: info: Exploding uri yandex_music/track/83950842:15850288@15850288 in service yandex_music May 09 23:26:07 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 09 23:26:13 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri May 09 23:26:13 phantom volumio[943]: info: Preload queue cleared May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/118465147:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/118465148:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/118465149:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/118465150:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/118465151:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/113111843:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/118465152:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/118465153:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/118465154:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Preloading song: yandex_music/track/117546781:27856013@27856013 May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/118465147:27856013@27856013 in service yandex_music May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/118465148:27856013@27856013 in service yandex_music May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/118465149:27856013@27856013 in service yandex_music May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/118465150:27856013@27856013 in service yandex_music May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/118465151:27856013@27856013 in service yandex_music May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/113111843:27856013@27856013 in service yandex_music May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/118465152:27856013@27856013 in service yandex_music May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/118465153:27856013@27856013 in service yandex_music May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/118465154:27856013@27856013 in service yandex_music May 09 23:26:13 phantom volumio[943]: info: Exploding uri yandex_music/track/117546781:27856013@27856013 in service yandex_music May 09 23:26:15 phantom volumio[943]: info: Preload queue cleared May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::ClearQueue May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::stop May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::updateTrackBlock May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::getTrackBlock May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::stPlaybackTimer May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::getTrack 1 May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::serviceStop May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::getTrack 1 May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::serviceStop May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 23:26:15 phantom volumio[943]: info: ControllerMpd::stop May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand stop May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::clearPlayQueue May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::saveQueue May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::volumioPushQueue May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::addQueueItems May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::addQueueItems May 09 23:26:15 phantom volumio[943]: info: Preload queue cleared May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/118465147:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/118465147:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/118465148:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/118465148:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/118465149:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/118465149:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/118465150:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/118465150:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/118465151:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/118465151:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/113111843:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/113111843:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::volumioPushQueue May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::saveQueue May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::updateTrackBlock May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::getTrackBlock May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::volumioPlay May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::play index 5 May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::addQueueItems May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::addQueueItems May 09 23:26:15 phantom volumio[943]: info: Preload queue cleared May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/118465152:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/118465152:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/118465153:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/118465153:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/118465154:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/118465154:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/117546781:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: Using cached record of: yandex_music/track/117546781:27856013@27856013 May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::stop May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::volumioPushQueue May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::saveQueue May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::play index undefined May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::updateTrackBlock May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::getTrackBlock May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::startPlaybackTimer May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand stop May 09 23:26:15 phantom volumio[943]: info: May 09 23:26:15 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:26:15 phantom volumio[943]: info: sendMpdCommand stop took 28 milliseconds May 09 23:26:15 phantom volumio[943]: info: ControllerMpd::getState May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:26:15 phantom volumio[943]: info: sendMpdCommand stop took 4 milliseconds May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand clear May 09 23:26:15 phantom volumio[943]: info: May 09 23:26:15 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:26:15 phantom volumio[943]: info: ControllerMpd::getState May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:26:15 phantom volumio[943]: info: May 09 23:26:15 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:26:15 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:26:15 phantom volumio[943]: info: sendMpdCommand status took 3 milliseconds May 09 23:26:15 phantom volumio[943]: info: sendMpdCommand clear took 3 milliseconds May 09 23:26:15 phantom volumio[943]: info: sendMpdCommand status took 2 milliseconds May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:26:15 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:26:15 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:26:15 phantom volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd May 09 23:26:15 phantom volumio[943]: info: ------------------------------ 17ms May 09 23:26:15 phantom volumio[943]: info: May 09 23:26:15 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:26:15 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:26:15 phantom volumio[943]: error: updateQueue error: null May 09 23:26:15 phantom volumio[943]: error: updateQueue error: null May 09 23:26:15 phantom volumio[943]: info: ------------------------------ 23ms May 09 23:26:15 phantom volumio[943]: info: sendMpdCommand playlistinfo took 22 milliseconds May 09 23:26:15 phantom volumio[943]: info: ------------------------------ 4ms May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:26:15 phantom volumio[943]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 09 23:26:15 phantom volumio[943]: info: ------------------------------ 29ms May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand addid "https://s1008sas.storage.yandex.net/get-mp3/20df2a14ffa452ed57a2ab8e4fb83965/000634ba9dc1c316/rmusic/U2FsdGVkX19ld5rR0EDJp3x1xzV7i-drlYIqRUTW5rVZoRLfdtnLyrj15aPACcqFLYNuK8Ef07FA60D--U9zZ2e4xNkuYGga-zZ2M2iJmvo/4f73a9ba4e85417cb6b80731e6c3eae99f4d6ebab3cdcc50183c9377ed3c049e/31671" May 09 23:26:15 phantom volumio[943]: info: May 09 23:26:15 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:26:15 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:26:15 phantom volumio[943]: info: sendMpdCommand addid "https://s1008sas.storage.yandex.net/get-mp3/20df2a14ffa452ed57a2ab8e4fb83965/000634ba9dc1c316/rmusic/U2FsdGVkX19ld5rR0EDJp3x1xzV7i-drlYIqRUTW5rVZoRLfdtnLyrj15aPACcqFLYNuK8Ef07FA60D--U9zZ2e4xNkuYGga-zZ2M2iJmvo/4f73a9ba4e85417cb6b80731e6c3eae99f4d6ebab3cdcc50183c9377ed3c049e/31671" took 2 milliseconds May 09 23:26:15 phantom volumio[943]: verbose: MPD COMMAND [object Object] May 09 23:26:15 phantom volumio[943]: verbose: MPD COMMAND [object Object] May 09 23:26:15 phantom volumio[943]: verbose: MPD COMMAND [object Object] May 09 23:26:15 phantom volumio[943]: info: May 09 23:26:15 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:26:15 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:26:15 phantom volumio[943]: info: May 09 23:26:15 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:26:15 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:26:15 phantom volumio[943]: info: ------------------------------ 4ms May 09 23:26:15 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 23:26:15 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand play May 09 23:26:15 phantom volumio[943]: info: May 09 23:26:15 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:26:15 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:26:15 phantom volumio[943]: info: ------------------------------ 4ms May 09 23:26:15 phantom volumio[943]: info: ------------------------------ 4ms May 09 23:26:15 phantom volumio[943]: info: sendMpdCommand play took 3 milliseconds May 09 23:26:15 phantom volumio[943]: info: ------------------------------ 2ms May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 09 23:26:15 phantom volumio[943]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 09 23:26:15 phantom volumio[943]: info: Received Get System Version May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 09 23:26:15 phantom volumio[943]: info: Received Get System Info May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 23:26:15 phantom volumio[943]: info: Discovery: Getting this device information May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::volumioGetState May 09 23:26:15 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 23:26:16 phantom volumio[943]: info: May 09 23:26:16 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:26:16 phantom volumio[943]: info: ControllerMpd::getState May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:26:16 phantom volumio[943]: info: May 09 23:26:16 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:26:16 phantom volumio[943]: info: ControllerMpd::getState May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:26:16 phantom volumio[943]: info: May 09 23:26:16 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:26:16 phantom volumio[943]: info: ControllerMpd::getState May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:26:16 phantom volumio[943]: info: sendMpdCommand status took 3 milliseconds May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:26:16 phantom volumio[943]: info: sendMpdCommand status took 6 milliseconds May 09 23:26:16 phantom volumio[943]: info: sendMpdCommand status took 5 milliseconds May 09 23:26:16 phantom volumio[943]: info: sendMpdCommand playlistinfo took 5 milliseconds May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:26:16 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:26:16 phantom volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"За край","artist":"Три дня дождя","album":"melancholia","uri":"https://s1008sas.storage.yandex.net/get-mp3/20df2a14ffa452ed57a2ab8e4fb83965/000634ba9dc1c316/rmusic/U2FsdGVkX19ld5rR0EDJp3x1xzV7i-drlYIqRUTW5rVZoRLfdtnLyrj15aPACcqFLYNuK8Ef07FA60D--U9zZ2e4xNkuYGga-zZ2M2iJmvo/4f73a9ba4e85417cb6b80731e6c3eae99f4d6ebab3cdcc50183c9377ed3c049e/31671","trackType":""} May 09 23:26:16 phantom volumio[943]: verbose: CURRENT POSITION 5 May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::syncState stateService play May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 09 23:26:16 phantom volumio[943]: info: ------------------------------ 13ms May 09 23:26:16 phantom volumio[943]: info: May 09 23:26:16 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:26:16 phantom volumio[943]: info: ControllerMpd::getState May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:26:16 phantom volumio[943]: info: sendMpdCommand playlistinfo took 3 milliseconds May 09 23:26:16 phantom volumio[943]: info: sendMpdCommand playlistinfo took 3 milliseconds May 09 23:26:16 phantom volumio[943]: info: sendMpdCommand status took 1 milliseconds May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:26:16 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:26:16 phantom volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"За край","artist":"Три дня дождя","album":"melancholia","uri":"https://s1008sas.storage.yandex.net/get-mp3/20df2a14ffa452ed57a2ab8e4fb83965/000634ba9dc1c316/rmusic/U2FsdGVkX19ld5rR0EDJp3x1xzV7i-drlYIqRUTW5rVZoRLfdtnLyrj15aPACcqFLYNuK8Ef07FA60D--U9zZ2e4xNkuYGga-zZ2M2iJmvo/4f73a9ba4e85417cb6b80731e6c3eae99f4d6ebab3cdcc50183c9377ed3c049e/31671","trackType":""} May 09 23:26:16 phantom volumio[943]: verbose: CURRENT POSITION 5 May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::syncState stateService play May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::syncState currentStatus play May 09 23:26:16 phantom volumio[943]: info: Received an update from plugin. extracting info from payload May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:26:16 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:26:16 phantom volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"За край","artist":"Три дня дождя","album":"melancholia","uri":"https://s1008sas.storage.yandex.net/get-mp3/20df2a14ffa452ed57a2ab8e4fb83965/000634ba9dc1c316/rmusic/U2FsdGVkX19ld5rR0EDJp3x1xzV7i-drlYIqRUTW5rVZoRLfdtnLyrj15aPACcqFLYNuK8Ef07FA60D--U9zZ2e4xNkuYGga-zZ2M2iJmvo/4f73a9ba4e85417cb6b80731e6c3eae99f4d6ebab3cdcc50183c9377ed3c049e/31671","trackType":""} May 09 23:26:16 phantom volumio[943]: verbose: CURRENT POSITION 5 May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::syncState stateService play May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::syncState currentStatus play May 09 23:26:16 phantom volumio[943]: info: Received an update from plugin. extracting info from payload May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:26:16 phantom volumio[943]: info: ------------------------------ 28ms May 09 23:26:16 phantom volumio[943]: info: ------------------------------ 27ms May 09 23:26:16 phantom volumio[943]: info: sendMpdCommand playlistinfo took 18 milliseconds May 09 23:26:16 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:26:16 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:26:16 phantom volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"За край","artist":"Три дня дождя","album":"melancholia","uri":"https://s1008sas.storage.yandex.net/get-mp3/20df2a14ffa452ed57a2ab8e4fb83965/000634ba9dc1c316/rmusic/U2FsdGVkX19ld5rR0EDJp3x1xzV7i-drlYIqRUTW5rVZoRLfdtnLyrj15aPACcqFLYNuK8Ef07FA60D--U9zZ2e4xNkuYGga-zZ2M2iJmvo/4f73a9ba4e85417cb6b80731e6c3eae99f4d6ebab3cdcc50183c9377ed3c049e/31671","trackType":""} May 09 23:26:16 phantom volumio[943]: verbose: CURRENT POSITION 5 May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::syncState stateService play May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::syncState currentStatus play May 09 23:26:16 phantom volumio[943]: info: Received an update from plugin. extracting info from payload May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:26:16 phantom volumio[943]: info: ------------------------------ 31ms May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:26:16 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:26:16 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:26:16 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:26:20 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 23:26:20 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 23:26:20 phantom volumio[943]: info: Discovery: Getting this device information May 09 23:26:20 phantom volumio[943]: info: CoreCommandRouter::volumioGetState May 09 23:26:20 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 23:26:20 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 23:26:20 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 23:26:20 phantom volumio[943]: info: Discovery: Getting this device information May 09 23:26:20 phantom volumio[943]: info: CoreCommandRouter::volumioGetState May 09 23:26:20 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 23:26:22 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 23:26:22 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 23:26:22 phantom volumio[943]: info: Discovery: Getting this device information May 09 23:26:22 phantom volumio[943]: info: CoreCommandRouter::volumioGetState May 09 23:26:22 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 23:26:39 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri May 09 23:26:39 phantom volumio[943]: info: Preload queue cleared May 09 23:26:39 phantom volumio[943]: info: Preload queue cleared May 09 23:26:39 phantom volumio[943]: info: Preload queue cleared May 09 23:26:39 phantom volumio[943]: info: Preload queue cleared May 09 23:26:39 phantom volumio[943]: info: Preload queue cleared May 09 23:26:43 phantom volumio[943]: Searching plugin music_service/yandex_music May 09 23:26:43 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: yandex_music , search May 09 23:26:43 phantom volumio[943]: info: All search sources collected, pushing search results May 09 23:26:44 phantom volumio[943]: Searching plugin music_service/yandex_music May 09 23:26:44 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: yandex_music , search May 09 23:26:44 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 09 23:26:44 phantom volumio[943]: info: Preload queue cleared May 09 23:26:44 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri May 09 23:26:44 phantom volumio[943]: info: Preload queue cleared May 09 23:26:44 phantom volumio[943]: info: All search sources collected, pushing search results May 09 23:26:47 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri May 09 23:26:47 phantom volumio[943]: info: Preload queue cleared May 09 23:26:48 phantom volumio[943]: info: Preload queue cleared May 09 23:26:50 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 23:26:50 phantom volumio[943]: info: CURURI: playlists May 09 23:26:50 phantom volumio[943]: info: Listing playlists May 09 23:26:50 phantom volumio[943]: info: Preload queue cleared May 09 23:26:50 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 23:26:50 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 23:26:50 phantom volumio[943]: info: Discovery: Getting this device information May 09 23:26:50 phantom volumio[943]: info: CoreCommandRouter::volumioGetState May 09 23:26:50 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 23:26:50 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 23:26:50 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 23:26:50 phantom volumio[943]: info: Discovery: Getting this device information May 09 23:26:50 phantom volumio[943]: info: CoreCommandRouter::volumioGetState May 09 23:26:50 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 23:26:51 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 23:26:51 phantom volumio[943]: info: CURURI: music-library May 09 23:26:51 phantom volumio[943]: error: Failed LSINFO: null May 09 23:26:51 phantom volumio[943]: info: Preload queue cleared May 09 23:26:52 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 23:26:52 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 23:26:52 phantom volumio[943]: info: Discovery: Getting this device information May 09 23:26:52 phantom volumio[943]: info: CoreCommandRouter::volumioGetState May 09 23:26:52 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 23:26:53 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 23:26:53 phantom volumio[943]: info: CURURI: artists:// May 09 23:26:53 phantom volumio[943]: info: Preload queue cleared May 09 23:26:55 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 23:26:55 phantom volumio[943]: info: CURURI: albums:// May 09 23:26:55 phantom volumio[943]: info: listAlbums - loading Albums from cache May 09 23:26:55 phantom volumio[943]: info: Preload queue cleared May 09 23:26:57 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 23:26:57 phantom volumio[943]: info: CURURI: genres:// May 09 23:26:57 phantom volumio[943]: info: Preload queue cleared May 09 23:27:01 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri May 09 23:27:01 phantom volumio[943]: info: Preload queue cleared May 09 23:27:01 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 09 23:27:01 phantom volumio[943]: info: Preload queue cleared May 09 23:27:02 phantom volumio[943]: info: Preload queue cleared May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::ClearQueue May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::stop May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::stPlaybackTimer May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::updateTrackBlock May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::getTrackBlock May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::serviceStop May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::getTrack 5 May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::serviceStop May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 23:27:02 phantom volumio[943]: info: ControllerMpd::stop May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand stop May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::clearPlayQueue May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::saveQueue May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::volumioPushQueue May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::addQueueItems May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::addQueueItems May 09 23:27:02 phantom volumio[943]: info: Preload queue cleared May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556355:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556355:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556356:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556356:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556357:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556357:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::volumioPushQueue May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::saveQueue May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::updateTrackBlock May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::getTrackBlock May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::volumioPlay May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::play index 2 May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::addQueueItems May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::addQueueItems May 09 23:27:02 phantom volumio[943]: info: Preload queue cleared May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556358:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556358:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556359:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556359:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556360:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556360:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556361:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556361:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556362:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556362:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556363:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556363:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556364:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556364:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Adding Item to queue: yandex_music/track/62556365:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: Using cached record of: yandex_music/track/62556365:9875277@9875277 May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::stop May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::volumioPushQueue May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::saveQueue May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::play index undefined May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::updateTrackBlock May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::getTrackBlock May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::getTrack 2 May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::startPlaybackTimer May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::getTrack 2 May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand stop May 09 23:27:02 phantom volumio[943]: info: May 09 23:27:02 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:27:02 phantom volumio[943]: info: sendMpdCommand stop took 23 milliseconds May 09 23:27:02 phantom volumio[943]: info: ControllerMpd::getState May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:27:02 phantom volumio[943]: info: sendMpdCommand stop took 6 milliseconds May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand clear May 09 23:27:02 phantom volumio[943]: info: May 09 23:27:02 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:27:02 phantom volumio[943]: info: ControllerMpd::getState May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:27:02 phantom volumio[943]: info: May 09 23:27:02 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:27:02 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:27:02 phantom volumio[943]: info: sendMpdCommand status took 5 milliseconds May 09 23:27:02 phantom volumio[943]: info: sendMpdCommand clear took 5 milliseconds May 09 23:27:02 phantom volumio[943]: info: sendMpdCommand status took 5 milliseconds May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:27:02 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::getTrack 2 May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 23:27:02 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:27:02 phantom volumio[943]: info: CorePlayQueue::getTrack 2 May 09 23:27:02 phantom volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd May 09 23:27:02 phantom volumio[943]: info: ------------------------------ 15ms May 09 23:27:02 phantom volumio[943]: info: May 09 23:27:02 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:27:02 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:27:02 phantom volumio[943]: error: updateQueue error: null May 09 23:27:02 phantom volumio[943]: error: updateQueue error: null May 09 23:27:02 phantom volumio[943]: info: ------------------------------ 19ms May 09 23:27:02 phantom volumio[943]: info: sendMpdCommand playlistinfo took 18 milliseconds May 09 23:27:02 phantom volumio[943]: info: ------------------------------ 4ms May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:27:02 phantom volumio[943]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 09 23:27:02 phantom volumio[943]: info: ------------------------------ 26ms May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand addid "https://s935sas.storage.yandex.net/get-mp3/a83e0bf4ba6a44d94d68534cecf3186c/000634baa09322af/rmusic/U2FsdGVkX1-DSRSangM6l7Rtgo0cONQuoYCKJD3S5AxwkL5fEzkmxhK0f9GaMvlgwZ0Y3ILvGYYCTQrpgFEhln1Qv-Ia-m-QiOGLMO56gXY/cc152e56b79f852d8e31ba799dceaf06f274d48675b5642ca8a5431dd6935ba5" May 09 23:27:02 phantom volumio[943]: info: May 09 23:27:02 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:27:02 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:27:02 phantom volumio[943]: info: sendMpdCommand addid "https://s935sas.storage.yandex.net/get-mp3/a83e0bf4ba6a44d94d68534cecf3186c/000634baa09322af/rmusic/U2FsdGVkX1-DSRSangM6l7Rtgo0cONQuoYCKJD3S5AxwkL5fEzkmxhK0f9GaMvlgwZ0Y3ILvGYYCTQrpgFEhln1Qv-Ia-m-QiOGLMO56gXY/cc152e56b79f852d8e31ba799dceaf06f274d48675b5642ca8a5431dd6935ba5" took 2 milliseconds May 09 23:27:02 phantom volumio[943]: verbose: MPD COMMAND [object Object] May 09 23:27:02 phantom volumio[943]: verbose: MPD COMMAND [object Object] May 09 23:27:02 phantom volumio[943]: verbose: MPD COMMAND [object Object] May 09 23:27:02 phantom volumio[943]: info: May 09 23:27:02 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:27:02 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:27:02 phantom volumio[943]: info: May 09 23:27:02 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:27:02 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:27:02 phantom volumio[943]: info: ------------------------------ 4ms May 09 23:27:02 phantom volumio[943]: info: ------------------------------ 2ms May 09 23:27:02 phantom volumio[943]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 23:27:02 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand play May 09 23:27:02 phantom volumio[943]: info: May 09 23:27:02 phantom volumio[943]: ---------------------------- MPD announces system playlist update May 09 23:27:02 phantom volumio[943]: info: Ignoring MPD Status Update May 09 23:27:02 phantom volumio[943]: info: ------------------------------ 3ms May 09 23:27:02 phantom volumio[943]: info: sendMpdCommand play took 2 milliseconds May 09 23:27:02 phantom volumio[943]: info: ------------------------------ 1ms May 09 23:27:03 phantom volumio[943]: info: May 09 23:27:03 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:27:03 phantom volumio[943]: info: ControllerMpd::getState May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:27:03 phantom volumio[943]: info: May 09 23:27:03 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:27:03 phantom volumio[943]: info: ControllerMpd::getState May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:27:03 phantom volumio[943]: info: May 09 23:27:03 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:27:03 phantom volumio[943]: info: ControllerMpd::getState May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:27:03 phantom volumio[943]: info: sendMpdCommand status took 2 milliseconds May 09 23:27:03 phantom volumio[943]: info: sendMpdCommand status took 1 milliseconds May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:27:03 phantom volumio[943]: info: May 09 23:27:03 phantom volumio[943]: ---------------------------- MPD announces state update: player May 09 23:27:03 phantom volumio[943]: info: ControllerMpd::getState May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 09 23:27:03 phantom volumio[943]: info: sendMpdCommand status took 3 milliseconds May 09 23:27:03 phantom volumio[943]: info: sendMpdCommand playlistinfo took 2 milliseconds May 09 23:27:03 phantom volumio[943]: info: sendMpdCommand playlistinfo took 2 milliseconds May 09 23:27:03 phantom volumio[943]: info: sendMpdCommand status took 2 milliseconds May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::parseState May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 23:27:03 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getTrack 2 May 09 23:27:03 phantom volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":137,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Про любовь","artist":"Три дня дождя","album":"Любовь, аддикция и марафоны","uri":"https://s935sas.storage.yandex.net/get-mp3/a83e0bf4ba6a44d94d68534cecf3186c/000634baa09322af/rmusic/U2FsdGVkX1-DSRSangM6l7Rtgo0cONQuoYCKJD3S5AxwkL5fEzkmxhK0f9GaMvlgwZ0Y3ILvGYYCTQrpgFEhln1Qv-Ia-m-QiOGLMO56gXY/cc152e56b79f852d8e31ba799dceaf06f274d48675b5642ca8a5431dd6935ba5","trackType":""} May 09 23:27:03 phantom volumio[943]: verbose: CURRENT POSITION 2 May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::syncState stateService play May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 09 23:27:03 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getTrack 2 May 09 23:27:03 phantom volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":137,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Про любовь","artist":"Три дня дождя","album":"Любовь, аддикция и марафоны","uri":"https://s935sas.storage.yandex.net/get-mp3/a83e0bf4ba6a44d94d68534cecf3186c/000634baa09322af/rmusic/U2FsdGVkX1-DSRSangM6l7Rtgo0cONQuoYCKJD3S5AxwkL5fEzkmxhK0f9GaMvlgwZ0Y3ILvGYYCTQrpgFEhln1Qv-Ia-m-QiOGLMO56gXY/cc152e56b79f852d8e31ba799dceaf06f274d48675b5642ca8a5431dd6935ba5","trackType":""} May 09 23:27:03 phantom volumio[943]: verbose: CURRENT POSITION 2 May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::syncState stateService play May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::syncState currentStatus play May 09 23:27:03 phantom volumio[943]: info: Received an update from plugin. extracting info from payload May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:27:03 phantom volumio[943]: info: ------------------------------ 14ms May 09 23:27:03 phantom volumio[943]: info: ------------------------------ 17ms May 09 23:27:03 phantom volumio[943]: info: sendMpdCommand playlistinfo took 12 milliseconds May 09 23:27:03 phantom volumio[943]: info: sendMpdCommand playlistinfo took 11 milliseconds May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:27:03 phantom volumio[943]: verbose: ControllerMpd::parseTrackInfo May 09 23:27:03 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getTrack 2 May 09 23:27:03 phantom volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":137,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Про любовь","artist":"Три дня дождя","album":"Любовь, аддикция и марафоны","uri":"https://s935sas.storage.yandex.net/get-mp3/a83e0bf4ba6a44d94d68534cecf3186c/000634baa09322af/rmusic/U2FsdGVkX1-DSRSangM6l7Rtgo0cONQuoYCKJD3S5AxwkL5fEzkmxhK0f9GaMvlgwZ0Y3ILvGYYCTQrpgFEhln1Qv-Ia-m-QiOGLMO56gXY/cc152e56b79f852d8e31ba799dceaf06f274d48675b5642ca8a5431dd6935ba5","trackType":""} May 09 23:27:03 phantom volumio[943]: verbose: CURRENT POSITION 2 May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::syncState stateService play May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::syncState currentStatus play May 09 23:27:03 phantom volumio[943]: info: Received an update from plugin. extracting info from payload May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:27:03 phantom volumio[943]: info: ControllerMpd::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::servicePushState May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getTrack 2 May 09 23:27:03 phantom volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":137,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Про любовь","artist":"Три дня дождя","album":"Любовь, аддикция и марафоны","uri":"https://s935sas.storage.yandex.net/get-mp3/a83e0bf4ba6a44d94d68534cecf3186c/000634baa09322af/rmusic/U2FsdGVkX1-DSRSangM6l7Rtgo0cONQuoYCKJD3S5AxwkL5fEzkmxhK0f9GaMvlgwZ0Y3ILvGYYCTQrpgFEhln1Qv-Ia-m-QiOGLMO56gXY/cc152e56b79f852d8e31ba799dceaf06f274d48675b5642ca8a5431dd6935ba5","trackType":""} May 09 23:27:03 phantom volumio[943]: verbose: CURRENT POSITION 2 May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::syncState stateService play May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::syncState currentStatus play May 09 23:27:03 phantom volumio[943]: info: Received an update from plugin. extracting info from payload May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::pushState May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioPushState May 09 23:27:03 phantom volumio[943]: info: ------------------------------ 36ms May 09 23:27:03 phantom volumio[943]: info: ------------------------------ 33ms May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:27:03 phantom volumio[943]: info: CoreCommandRouter::volumioGetQueue May 09 23:27:03 phantom volumio[943]: info: CoreStateMachine::getQueue May 09 23:27:03 phantom volumio[943]: info: CorePlayQueue::getQueue May 09 23:27:10 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 23:27:10 phantom volumio[943]: info: CURURI: music-library May 09 23:27:10 phantom volumio[943]: error: Failed LSINFO: null May 09 23:27:10 phantom volumio[943]: info: Preload queue cleared May 09 23:27:12 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri May 09 23:27:12 phantom volumio[943]: info: Preload queue cleared May 09 23:27:12 phantom volumio[943]: info: Preloading song: soundcloud/track@trackId=1183942489 May 09 23:27:12 phantom volumio[943]: info: Preloading song: soundcloud/track@trackId=2077235664 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/51043098:7091838@7091838 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/138174527:36216839@36216839 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/57175802:8565415@8565415 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/69420955:11611668@11611668 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/122066274:29476076@user:onyourwave May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/136615064:35615240@user:onyourwave May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/47627256@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/79012582:14297602@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/114160950:26003521@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/100859701:21213422@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/83629829:15767740@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/104598833:22531789@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/95866447:19584746@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/89480861:17554329@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/117892334:27606569@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/90391527:17857677@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/106941620:21989238@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/113830140:25858353@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/42600600:11637286@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/117465765:27420423@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/114754779:26263427@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/119738650:28418011@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/84169328:15924234@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/104516352:22499190@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/114161761:26003942@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/104841692:22613856@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/113111843:27856013@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/117270409:28431387@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/106618980:23265774@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/124666550:30642919@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/124372495:30504496@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/104841679:22613856@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/113242491:25616725@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/130832165:33170323@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/126339152:31370415@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/129558898:32649658@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/33226443:4059374@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/125605015:31055791@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/116336596:26936387@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/130919931:33207179@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/119069150:28128245@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/125338953:30935348@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/123246473:30002754@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/129257709:32528071@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/60378070:9321157@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/98659036:27363624@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/130540764:33052725@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/97807580:13564748@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/95866441:19584746@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/102489206:21760624@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/131527613:33447815@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/82309829@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/118168194:27723970@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/130737248:33133539@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/115432230:26570912@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/132678490:33913577@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/132595681:33879488@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/131986289:33628523@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/132868611:33991271@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/120407225:28707991@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/79338767:14407003@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/135198936:34980210@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/70595351:11939027@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/134485726:34648162@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/125295951:30913658@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/95932205:22068269@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/120063910:28558551@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/108128916:23812738@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/73472009:12756425@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/116554509:27032976@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/131236410:33330980@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/136565551:35594834@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/128175401:32111971@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/62517796:9865308@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Preloading song: yandex_music/track/137403424:35900742@699959717:3 May 09 23:27:12 phantom volumio[943]: info: Exploding uri soundcloud/track@trackId=1183942489 in service soundcloud May 09 23:27:12 phantom volumio[943]: info: [soundcloud] explodeUri: soundcloud/track@trackId=1183942489 May 09 23:27:12 phantom volumio[943]: info: [soundcloud] getTrackUri(): soundcloud/track@trackId=1183942489 May 09 23:27:12 phantom volumio[943]: info: Exploding uri soundcloud/track@trackId=2077235664 in service soundcloud May 09 23:27:12 phantom volumio[943]: info: [soundcloud] explodeUri: soundcloud/track@trackId=2077235664 May 09 23:27:12 phantom volumio[943]: info: [soundcloud] getTrackUri(): soundcloud/track@trackId=2077235664 May 09 23:27:12 phantom volumio[943]: info: Exploding uri yandex_music/track/51043098:7091838@7091838 in service yandex_music May 09 23:27:12 phantom volumio[943]: info: Exploding uri yandex_music/track/138174527:36216839@36216839 in service yandex_music May 09 23:27:12 phantom volumio[943]: info: Exploding uri yandex_music/track/57175802:8565415@8565415 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/69420955:11611668@11611668 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/122066274:29476076@user:onyourwave in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/136615064:35615240@user:onyourwave in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/47627256@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/79012582:14297602@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/114160950:26003521@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/100859701:21213422@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/83629829:15767740@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/104598833:22531789@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/95866447:19584746@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/89480861:17554329@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/117892334:27606569@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/90391527:17857677@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/106941620:21989238@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/113830140:25858353@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/42600600:11637286@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/117465765:27420423@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 09 23:27:13 phantom volumio[943]: info: Exploding uri yandex_music/track/114754779:26263427@699959717:3 in service yandex_music May 09 23:27:13 phantom volumio[943]: info: Preload queue cleared May 09 23:27:14 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 09 23:27:14 phantom volumio[943]: info: Preload queue cleared May 09 23:27:15 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 09 23:27:15 phantom volumio[943]: info: Preload queue cleared May 09 23:27:18 phantom volumio[943]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 09 23:27:18 phantom volumio[943]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 23:27:18 phantom volumio[943]: TypeError: Cannot read property 'length' of undefined May 09 23:27:18 phantom volumio[943]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 09 23:27:18 phantom volumio[943]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 09 23:27:18 phantom volumio[943]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 09 23:27:18 phantom volumio[943]: at Parser.emit (events.js:315:20) May 09 23:27:18 phantom volumio[943]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 09 23:27:18 phantom volumio[943]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 09 23:27:18 phantom volumio[943]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 09 23:27:18 phantom volumio[943]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 09 23:27:18 phantom volumio[943]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 09 23:27:18 phantom volumio[943]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 09 23:27:18 phantom volumio[943]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 09 23:27:18 phantom volumio[943]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 09 23:27:18 phantom volumio[943]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 09 23:27:18 phantom volumio[943]: at IncomingMessage.emit (events.js:327:22) May 09 23:27:18 phantom volumio[943]: at endReadableNT (internal/streams/readable.js:1327:12) May 09 23:27:18 phantom volumio[943]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 09 23:27:18 phantom volumio[943]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 23:27:18 phantom sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-09 23:26 May 09 23:27:18 phantom sudo[1464]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"