-- Logs begin at Fri 2024-04-05 18:50:12 CEST, end at Mon 2024-04-08 16:36:58 CEST. -- Apr 08 16:35:02 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Apr 08 16:35:02 volumio volumio[2496]: info: [youtube2-browse] browseUri: youtube2 Apr 08 16:35:02 volumio volumio[2496]: info: [youtube2] InnertubeLoader: creating Innertube instance... Apr 08 16:35:02 volumio volumio[2496]: info: [youtube2] InnertubeLoader: creating Auth instance... Apr 08 16:35:02 volumio volumio[2496]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 08 16:35:02 volumio volumio[2496]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 08 16:35:02 volumio volumio[2496]: info: [youtube2] InnertubeLoader: Auth instance created (status: pending sign-in) Apr 08 16:35:03 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:03 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:10 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Apr 08 16:35:10 volumio volumio[2496]: info: [youtube2-browse] browseUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEguide_builder%22%7D%7D Apr 08 16:35:10 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:10 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:10 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:10 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:10 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Apr 08 16:35:22 volumio volumio[2496]: info: [youtube2-browse] browseUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEguide_builder%22%7D%7D/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UCNHFdqPWAUa_fh92VmXJC-A%22%7D%7D Apr 08 16:35:22 volumio volumio[2496]: ChannelHeaderLinksView not found! Apr 08 16:35:22 volumio volumio[2496]: This is a bug, want to help us fix it? Follow the instructions at https://github.com/patrickkfkan/Volumio-YouTube.js/blob/main/docs/updating-the-parser.md or report it at https://github.com/patrickkfkan/Volumio-YouTube.js/issues! Apr 08 16:35:22 volumio volumio[2496]: Introspected and JIT generated this class in the meantime: Apr 08 16:35:22 volumio volumio[2496]: class ChannelHeaderLinksView extends YTNode { Apr 08 16:35:22 volumio volumio[2496]: static type = 'ChannelHeaderLinksView'; Apr 08 16:35:22 volumio volumio[2496]: first_link: { Apr 08 16:35:22 volumio volumio[2496]: content: string, Apr 08 16:35:22 volumio volumio[2496]: command_runs: { Apr 08 16:35:22 volumio volumio[2496]: 0: { Apr 08 16:35:22 volumio volumio[2496]: start_index: number, Apr 08 16:35:22 volumio volumio[2496]: length: number, Apr 08 16:35:22 volumio volumio[2496]: on_tap: { Apr 08 16:35:22 volumio volumio[2496]: innertube_command: NavigationEndpoint Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: }; Apr 08 16:35:22 volumio volumio[2496]: more: { Apr 08 16:35:22 volumio volumio[2496]: content: string, Apr 08 16:35:22 volumio volumio[2496]: command_runs: { Apr 08 16:35:22 volumio volumio[2496]: 0: { Apr 08 16:35:22 volumio volumio[2496]: start_index: number, Apr 08 16:35:22 volumio volumio[2496]: length: number, Apr 08 16:35:22 volumio volumio[2496]: on_tap: { Apr 08 16:35:22 volumio volumio[2496]: innertube_command: NavigationEndpoint Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: }; Apr 08 16:35:22 volumio volumio[2496]: constructor(data: RawNode) { Apr 08 16:35:22 volumio volumio[2496]: super(); Apr 08 16:35:22 volumio volumio[2496]: this.first_link = { Apr 08 16:35:22 volumio volumio[2496]: content: data.firstLink.content, Apr 08 16:35:22 volumio volumio[2496]: command_runs: { Apr 08 16:35:22 volumio volumio[2496]: 0: { Apr 08 16:35:22 volumio volumio[2496]: start_index: data.firstLink.commandRuns.0.startIndex, Apr 08 16:35:22 volumio volumio[2496]: length: data.firstLink.commandRuns.0.length, Apr 08 16:35:22 volumio volumio[2496]: on_tap: { Apr 08 16:35:22 volumio volumio[2496]: innertube_command: new NavigationEndpoint(data.firstLink.commandRuns.0.onTap.innertubeCommand) Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: }; Apr 08 16:35:22 volumio volumio[2496]: this.more = { Apr 08 16:35:22 volumio volumio[2496]: content: data.more.content, Apr 08 16:35:22 volumio volumio[2496]: command_runs: { Apr 08 16:35:22 volumio volumio[2496]: 0: { Apr 08 16:35:22 volumio volumio[2496]: start_index: data.more.commandRuns.0.startIndex, Apr 08 16:35:22 volumio volumio[2496]: length: data.more.commandRuns.0.length, Apr 08 16:35:22 volumio volumio[2496]: on_tap: { Apr 08 16:35:22 volumio volumio[2496]: innertube_command: new NavigationEndpoint(data.more.commandRuns.0.onTap.innertubeCommand) Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: }; Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: InnertubeError: Something went wrong at ChannelHeaderLinksView! Apr 08 16:35:22 volumio volumio[2496]: This is a bug, please report it at https://github.com/patrickkfkan/Volumio-YouTube.js/issues Apr 08 16:35:22 volumio volumio[2496]: at Function._Parser_printError (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18226:16) Apr 08 16:35:22 volumio volumio[2496]: at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18059:70) Apr 08 16:35:22 volumio volumio[2496]: at new C4TabbedHeader (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:10383:42) Apr 08 16:35:22 volumio volumio[2496]: at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24) Apr 08 16:35:22 volumio volumio[2496]: at Function.parse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18096:39) Apr 08 16:35:22 volumio volumio[2496]: at Function.parseResponse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:17920:39) Apr 08 16:35:22 volumio volumio[2496]: at EndpointModel._EndpointModel_doGetContents (/data/plugins/music_service/youtube2/dist/lib/model/EndpointModel.js:39:49) Apr 08 16:35:22 volumio volumio[2496]: at runMicrotasks () Apr 08 16:35:22 volumio volumio[2496]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 08 16:35:22 volumio volumio[2496]: at async GenericViewHandler.getContents (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:44:26) Apr 08 16:35:22 volumio volumio[2496]: at async GenericViewHandler.browse (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/FeedViewHandler.js:23:26) Apr 08 16:35:22 volumio volumio[2496]: at async BrowseController.browseUri (/data/plugins/music_service/youtube2/dist/lib/controller/browse/index.js:35:20) { Apr 08 16:35:22 volumio volumio[2496]: info: { Apr 08 16:35:22 volumio volumio[2496]: stack: 'Error: Type mismatch, got ChannelHeaderLinksView but expected ChannelHeaderLinks\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18053:19)\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at new C4TabbedHeader (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:10383:42)\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at Function.parse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18096:39)\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at Function.parseResponse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:17920:39)\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at EndpointModel._EndpointModel_doGetContents (/data/plugins/music_service/youtube2/dist/lib/model/EndpointModel.js:39:49)\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at runMicrotasks ()\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at processTicksAndRejections (internal/process/task_queues.js:93:5)\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at async GenericViewHandler.getContents (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:44:26)\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at async GenericViewHandler.browse (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/FeedViewHandler.js:23:26)\n' + Apr 08 16:35:22 volumio volumio[2496]: ' at async BrowseController.browseUri (/data/plugins/music_service/youtube2/dist/lib/controller/browse/index.js:35:20)' Apr 08 16:35:22 volumio volumio[2496]: }, Apr 08 16:35:22 volumio volumio[2496]: date: 2024-04-08T14:35:22.470Z, Apr 08 16:35:22 volumio volumio[2496]: version: '0.3.3' Apr 08 16:35:22 volumio volumio[2496]: } Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:22 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:25 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::ClearQueue Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::stop Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::stPlaybackTimer Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::updateTrackBlock Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrackBlock Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::serviceStop Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::serviceStop Apr 08 16:35:25 volumio volumio[2496]: info: ControllerMpd::stop Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand stop Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::clearPlayQueue Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::saveQueue Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushQueue Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::addQueueItems Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::addQueueItems Apr 08 16:35:25 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:25 volumio volumio[2496]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UCNHFdqPWAUa_fh92VmXJC-A%22%7D%7D Apr 08 16:35:25 volumio volumio[2496]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UCNHFdqPWAUa_fh92VmXJC-A%22%7D%7D in service youtube2 Apr 08 16:35:25 volumio volumio[2496]: info: [youtube2-browse] explodeUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UCNHFdqPWAUa_fh92VmXJC-A%22%7D%7D Apr 08 16:35:25 volumio volumio[2496]: info: Apr 08 16:35:25 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:25 volumio volumio[2496]: info: sendMpdCommand stop took 14 milliseconds Apr 08 16:35:25 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:25 volumio volumio[2496]: info: Apr 08 16:35:25 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:25 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:25 volumio volumio[2496]: info: Apr 08 16:35:25 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:25 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:25 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:25 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:25 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:25 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:35:25 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 08 16:35:25 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:25 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:25 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: 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":"Catch The Cat","artist":" Cherry Laine","album":"Greatest Hits","uri":"USB/SONY_32CA2/Cherry.Laine_Greatest.Hits_2007/Cherry Laine - Greatest Hits.flac","trackType":"flac"} Apr 08 16:35:25 volumio volumio[2496]: verbose: CURRENT POSITION 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::syncState stateService stop Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: No code Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: 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":"Catch The Cat","artist":" Cherry Laine","album":"Greatest Hits","uri":"USB/SONY_32CA2/Cherry.Laine_Greatest.Hits_2007/Cherry Laine - Greatest Hits.flac","trackType":"flac"} Apr 08 16:35:25 volumio volumio[2496]: verbose: CURRENT POSITION 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::syncState stateService stop Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: No code Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: 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":"Catch The Cat","artist":" Cherry Laine","album":"Greatest Hits","uri":"USB/SONY_32CA2/Cherry.Laine_Greatest.Hits_2007/Cherry Laine - Greatest Hits.flac","trackType":"flac"} Apr 08 16:35:25 volumio volumio[2496]: verbose: CURRENT POSITION 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::syncState stateService stop Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: No code Apr 08 16:35:25 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:25 volumio volumio[2496]: info: CorePlayQueue::getTrack 1 Apr 08 16:35:25 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:25 volumio volumio[2496]: info: ------------------------------ 23ms Apr 08 16:35:25 volumio volumio[2496]: info: ------------------------------ 22ms Apr 08 16:35:25 volumio volumio[2496]: info: ------------------------------ 22ms Apr 08 16:35:25 volumio volumio[2496]: InnertubeError: Something went wrong at ChannelHeaderLinksView! Apr 08 16:35:25 volumio volumio[2496]: This is a bug, please report it at https://github.com/patrickkfkan/Volumio-YouTube.js/issues Apr 08 16:35:25 volumio volumio[2496]: at Function._Parser_printError (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18226:16) Apr 08 16:35:25 volumio volumio[2496]: at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18059:70) Apr 08 16:35:25 volumio volumio[2496]: at new C4TabbedHeader (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:10383:42) Apr 08 16:35:25 volumio volumio[2496]: at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24) Apr 08 16:35:25 volumio volumio[2496]: at Function.parse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18096:39) Apr 08 16:35:25 volumio volumio[2496]: at Function.parseResponse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:17920:39) Apr 08 16:35:25 volumio volumio[2496]: at EndpointModel._EndpointModel_doGetContents (/data/plugins/music_service/youtube2/dist/lib/model/EndpointModel.js:39:49) Apr 08 16:35:25 volumio volumio[2496]: at runMicrotasks () Apr 08 16:35:25 volumio volumio[2496]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 08 16:35:25 volumio volumio[2496]: at async GenericViewHandler.getTracksOnExplode (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:71:28) Apr 08 16:35:25 volumio volumio[2496]: at async GenericViewHandler.explode (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/ExplodableViewHandler.js:14:24) Apr 08 16:35:25 volumio volumio[2496]: at async BrowseController.explodeUri (/data/plugins/music_service/youtube2/dist/lib/controller/browse/index.js:70:20) { Apr 08 16:35:25 volumio volumio[2496]: info: { Apr 08 16:35:25 volumio volumio[2496]: stack: 'Error: Type mismatch, got ChannelHeaderLinksView but expected ChannelHeaderLinks\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18053:19)\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at new C4TabbedHeader (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:10383:42)\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at Function.parse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18096:39)\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at Function.parseResponse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:17920:39)\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at EndpointModel._EndpointModel_doGetContents (/data/plugins/music_service/youtube2/dist/lib/model/EndpointModel.js:39:49)\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at runMicrotasks ()\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at processTicksAndRejections (internal/process/task_queues.js:93:5)\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at async GenericViewHandler.getTracksOnExplode (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:71:28)\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at async GenericViewHandler.explode (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/ExplodableViewHandler.js:14:24)\n' + Apr 08 16:35:25 volumio volumio[2496]: ' at async BrowseController.explodeUri (/data/plugins/music_service/youtube2/dist/lib/controller/browse/index.js:70:20)' Apr 08 16:35:25 volumio volumio[2496]: }, Apr 08 16:35:25 volumio volumio[2496]: date: 2024-04-08T14:35:25.854Z, Apr 08 16:35:25 volumio volumio[2496]: version: '0.3.3' Apr 08 16:35:25 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: SegmentedLikeDislikeButtonView not found! Apr 08 16:35:26 volumio volumio[2496]: This is a bug, want to help us fix it? Follow the instructions at https://github.com/patrickkfkan/Volumio-YouTube.js/blob/main/docs/updating-the-parser.md or report it at https://github.com/patrickkfkan/Volumio-YouTube.js/issues! Apr 08 16:35:26 volumio volumio[2496]: Introspected and JIT generated this class in the meantime: Apr 08 16:35:26 volumio volumio[2496]: class SegmentedLikeDislikeButtonView extends YTNode { Apr 08 16:35:26 volumio volumio[2496]: static type = 'SegmentedLikeDislikeButtonView'; Apr 08 16:35:26 volumio volumio[2496]: like_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: like_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: toggle_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: toggle_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: default_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: icon_name: string, Apr 08 16:35:26 volumio volumio[2496]: title: string, Apr 08 16:35:26 volumio volumio[2496]: on_tap: { Apr 08 16:35:26 volumio volumio[2496]: serial_command: NavigationEndpoint Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: accessibility_text: string, Apr 08 16:35:26 volumio volumio[2496]: style: string, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: string, Apr 08 16:35:26 volumio volumio[2496]: is_full_width: boolean, Apr 08 16:35:26 volumio volumio[2496]: type: string, Apr 08 16:35:26 volumio volumio[2496]: button_size: string, Apr 08 16:35:26 volumio volumio[2496]: accessibility_id: string, Apr 08 16:35:26 volumio volumio[2496]: tooltip: string Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: toggled_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: icon_name: string, Apr 08 16:35:26 volumio volumio[2496]: title: string, Apr 08 16:35:26 volumio volumio[2496]: on_tap: { Apr 08 16:35:26 volumio volumio[2496]: serial_command: NavigationEndpoint Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: accessibility_text: string, Apr 08 16:35:26 volumio volumio[2496]: style: string, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: string, Apr 08 16:35:26 volumio volumio[2496]: is_full_width: boolean, Apr 08 16:35:26 volumio volumio[2496]: type: string, Apr 08 16:35:26 volumio volumio[2496]: button_size: string, Apr 08 16:35:26 volumio volumio[2496]: accessibility_id: string, Apr 08 16:35:26 volumio volumio[2496]: tooltip: string Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: identifier: string, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: string, Apr 08 16:35:26 volumio volumio[2496]: is_toggling_disabled: boolean Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: like_status_entity_key: string, Apr 08 16:35:26 volumio volumio[2496]: like_status_entity: { Apr 08 16:35:26 volumio volumio[2496]: key: string, Apr 08 16:35:26 volumio volumio[2496]: like_status: string Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: dislike_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: dislike_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: toggle_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: toggle_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: default_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: icon_name: string, Apr 08 16:35:26 volumio volumio[2496]: title: string, Apr 08 16:35:26 volumio volumio[2496]: on_tap: { Apr 08 16:35:26 volumio volumio[2496]: serial_command: NavigationEndpoint Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: accessibility_text: string, Apr 08 16:35:26 volumio volumio[2496]: style: string, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: string, Apr 08 16:35:26 volumio volumio[2496]: is_full_width: boolean, Apr 08 16:35:26 volumio volumio[2496]: type: string, Apr 08 16:35:26 volumio volumio[2496]: button_size: string, Apr 08 16:35:26 volumio volumio[2496]: accessibility_id: string, Apr 08 16:35:26 volumio volumio[2496]: tooltip: string Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: toggled_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: icon_name: string, Apr 08 16:35:26 volumio volumio[2496]: title: string, Apr 08 16:35:26 volumio volumio[2496]: on_tap: { Apr 08 16:35:26 volumio volumio[2496]: serial_command: NavigationEndpoint Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: accessibility_text: string, Apr 08 16:35:26 volumio volumio[2496]: style: string, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: string, Apr 08 16:35:26 volumio volumio[2496]: is_full_width: boolean, Apr 08 16:35:26 volumio volumio[2496]: type: string, Apr 08 16:35:26 volumio volumio[2496]: button_size: string, Apr 08 16:35:26 volumio volumio[2496]: accessibility_id: string, Apr 08 16:35:26 volumio volumio[2496]: tooltip: string Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: string, Apr 08 16:35:26 volumio volumio[2496]: is_toggling_disabled: boolean Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: dislike_entity_key: string Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: icon_type: string; Apr 08 16:35:26 volumio volumio[2496]: like_count_entity: { Apr 08 16:35:26 volumio volumio[2496]: key: string Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: dynamic_like_count_update_data: { Apr 08 16:35:26 volumio volumio[2496]: update_status_key: string, Apr 08 16:35:26 volumio volumio[2496]: placeholder_like_count_values_key: string, Apr 08 16:35:26 volumio volumio[2496]: update_delay_loop_id: string, Apr 08 16:35:26 volumio volumio[2496]: update_delay_sec: number Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: constructor(data: RawNode) { Apr 08 16:35:26 volumio volumio[2496]: super(); Apr 08 16:35:26 volumio volumio[2496]: this.like_button_view_model = { Apr 08 16:35:26 volumio volumio[2496]: like_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: toggle_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: toggle_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: default_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: icon_name: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.iconName, Apr 08 16:35:26 volumio volumio[2496]: title: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.title, Apr 08 16:35:26 volumio volumio[2496]: on_tap: { Apr 08 16:35:26 volumio volumio[2496]: serial_command: new NavigationEndpoint(data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.onTap.serialCommand) Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: accessibility_text: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.accessibilityText, Apr 08 16:35:26 volumio volumio[2496]: style: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.style, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.trackingParams, Apr 08 16:35:26 volumio volumio[2496]: is_full_width: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.isFullWidth, Apr 08 16:35:26 volumio volumio[2496]: type: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.type, Apr 08 16:35:26 volumio volumio[2496]: button_size: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.buttonSize, Apr 08 16:35:26 volumio volumio[2496]: accessibility_id: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.accessibilityId, Apr 08 16:35:26 volumio volumio[2496]: tooltip: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.tooltip Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: toggled_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: icon_name: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.iconName, Apr 08 16:35:26 volumio volumio[2496]: title: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.title, Apr 08 16:35:26 volumio volumio[2496]: on_tap: { Apr 08 16:35:26 volumio volumio[2496]: serial_command: new NavigationEndpoint(data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.onTap.serialCommand) Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: accessibility_text: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.accessibilityText, Apr 08 16:35:26 volumio volumio[2496]: style: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.style, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.trackingParams, Apr 08 16:35:26 volumio volumio[2496]: is_full_width: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.isFullWidth, Apr 08 16:35:26 volumio volumio[2496]: type: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.type, Apr 08 16:35:26 volumio volumio[2496]: button_size: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.buttonSize, Apr 08 16:35:26 volumio volumio[2496]: accessibility_id: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.accessibilityId, Apr 08 16:35:26 volumio volumio[2496]: tooltip: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.tooltip Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: identifier: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.identifier, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.trackingParams, Apr 08 16:35:26 volumio volumio[2496]: is_toggling_disabled: data.likeButtonViewModel.likeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.isTogglingDisabled Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: like_status_entity_key: data.likeButtonViewModel.likeButtonViewModel.likeStatusEntityKey, Apr 08 16:35:26 volumio volumio[2496]: like_status_entity: { Apr 08 16:35:26 volumio volumio[2496]: key: data.likeButtonViewModel.likeButtonViewModel.likeStatusEntity.key, Apr 08 16:35:26 volumio volumio[2496]: like_status: data.likeButtonViewModel.likeButtonViewModel.likeStatusEntity.likeStatus Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: this.dislike_button_view_model = { Apr 08 16:35:26 volumio volumio[2496]: dislike_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: toggle_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: toggle_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: default_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: icon_name: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.iconName, Apr 08 16:35:26 volumio volumio[2496]: title: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.title, Apr 08 16:35:26 volumio volumio[2496]: on_tap: { Apr 08 16:35:26 volumio volumio[2496]: serial_command: new NavigationEndpoint(data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.onTap.serialCommand) Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: accessibility_text: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.accessibilityText, Apr 08 16:35:26 volumio volumio[2496]: style: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.style, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.trackingParams, Apr 08 16:35:26 volumio volumio[2496]: is_full_width: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.isFullWidth, Apr 08 16:35:26 volumio volumio[2496]: type: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.type, Apr 08 16:35:26 volumio volumio[2496]: button_size: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.buttonSize, Apr 08 16:35:26 volumio volumio[2496]: accessibility_id: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.accessibilityId, Apr 08 16:35:26 volumio volumio[2496]: tooltip: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.defaultButtonViewModel.buttonViewModel.tooltip Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: toggled_button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: button_view_model: { Apr 08 16:35:26 volumio volumio[2496]: icon_name: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.iconName, Apr 08 16:35:26 volumio volumio[2496]: title: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.title, Apr 08 16:35:26 volumio volumio[2496]: on_tap: { Apr 08 16:35:26 volumio volumio[2496]: serial_command: new NavigationEndpoint(data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.onTap.serialCommand) Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: accessibility_text: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.accessibilityText, Apr 08 16:35:26 volumio volumio[2496]: style: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.style, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.trackingParams, Apr 08 16:35:26 volumio volumio[2496]: is_full_width: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.isFullWidth, Apr 08 16:35:26 volumio volumio[2496]: type: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.type, Apr 08 16:35:26 volumio volumio[2496]: button_size: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.buttonSize, Apr 08 16:35:26 volumio volumio[2496]: accessibility_id: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.accessibilityId, Apr 08 16:35:26 volumio volumio[2496]: tooltip: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.toggledButtonViewModel.buttonViewModel.tooltip Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: tracking_params: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.trackingParams, Apr 08 16:35:26 volumio volumio[2496]: is_toggling_disabled: data.dislikeButtonViewModel.dislikeButtonViewModel.toggleButtonViewModel.toggleButtonViewModel.isTogglingDisabled Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: dislike_entity_key: data.dislikeButtonViewModel.dislikeButtonViewModel.dislikeEntityKey Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: this.icon_type = data.iconType; Apr 08 16:35:26 volumio volumio[2496]: this.like_count_entity = { Apr 08 16:35:26 volumio volumio[2496]: key: data.likeCountEntity.key Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: this.dynamic_like_count_update_data = { Apr 08 16:35:26 volumio volumio[2496]: update_status_key: data.dynamicLikeCountUpdateData.updateStatusKey, Apr 08 16:35:26 volumio volumio[2496]: placeholder_like_count_values_key: data.dynamicLikeCountUpdateData.placeholderLikeCountValuesKey, Apr 08 16:35:26 volumio volumio[2496]: update_delay_loop_id: data.dynamicLikeCountUpdateData.updateDelayLoopId, Apr 08 16:35:26 volumio volumio[2496]: update_delay_sec: data.dynamicLikeCountUpdateData.updateDelaySec Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: ButtonView not found! Apr 08 16:35:26 volumio volumio[2496]: This is a bug, want to help us fix it? Follow the instructions at https://github.com/patrickkfkan/Volumio-YouTube.js/blob/main/docs/updating-the-parser.md or report it at https://github.com/patrickkfkan/Volumio-YouTube.js/issues! Apr 08 16:35:26 volumio volumio[2496]: Introspected and JIT generated this class in the meantime: Apr 08 16:35:26 volumio volumio[2496]: class ButtonView extends YTNode { Apr 08 16:35:26 volumio volumio[2496]: static type = 'ButtonView'; Apr 08 16:35:26 volumio volumio[2496]: icon_name: string; Apr 08 16:35:26 volumio volumio[2496]: title: string; Apr 08 16:35:26 volumio volumio[2496]: on_tap: { Apr 08 16:35:26 volumio volumio[2496]: serial_command: NavigationEndpoint Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: accessibility_text: string; Apr 08 16:35:26 volumio volumio[2496]: style: string; Apr 08 16:35:26 volumio volumio[2496]: is_full_width: boolean; Apr 08 16:35:26 volumio volumio[2496]: type: string; Apr 08 16:35:26 volumio volumio[2496]: button_size: string; Apr 08 16:35:26 volumio volumio[2496]: state: string; Apr 08 16:35:26 volumio volumio[2496]: accessibility_id: string; Apr 08 16:35:26 volumio volumio[2496]: tooltip: string; Apr 08 16:35:26 volumio volumio[2496]: constructor(data: RawNode) { Apr 08 16:35:26 volumio volumio[2496]: super(); Apr 08 16:35:26 volumio volumio[2496]: this.icon_name = data.iconName; Apr 08 16:35:26 volumio volumio[2496]: this.title = data.title; Apr 08 16:35:26 volumio volumio[2496]: this.on_tap = { Apr 08 16:35:26 volumio volumio[2496]: serial_command: new NavigationEndpoint(data.onTap.serialCommand) Apr 08 16:35:26 volumio volumio[2496]: }; Apr 08 16:35:26 volumio volumio[2496]: this.accessibility_text = data.accessibilityText; Apr 08 16:35:26 volumio volumio[2496]: this.style = data.style; Apr 08 16:35:26 volumio volumio[2496]: this.is_full_width = data.isFullWidth; Apr 08 16:35:26 volumio volumio[2496]: this.type = data.type; Apr 08 16:35:26 volumio volumio[2496]: this.button_size = data.buttonSize; Apr 08 16:35:26 volumio volumio[2496]: this.state = data.state; Apr 08 16:35:26 volumio volumio[2496]: this.accessibility_id = data.accessibilityId; Apr 08 16:35:26 volumio volumio[2496]: this.tooltip = data.tooltip; Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: CommentsSimplebox not found! Apr 08 16:35:26 volumio volumio[2496]: This is a bug, want to help us fix it? Follow the instructions at https://github.com/patrickkfkan/Volumio-YouTube.js/blob/main/docs/updating-the-parser.md or report it at https://github.com/patrickkfkan/Volumio-YouTube.js/issues! Apr 08 16:35:26 volumio volumio[2496]: Introspected and JIT generated this class in the meantime: Apr 08 16:35:26 volumio volumio[2496]: class CommentsSimplebox extends YTNode { Apr 08 16:35:26 volumio volumio[2496]: static type = 'CommentsSimplebox'; Apr 08 16:35:26 volumio volumio[2496]: simplebox_avatar: Thumbnail[]; Apr 08 16:35:26 volumio volumio[2496]: simplebox_placeholder: Text; Apr 08 16:35:26 volumio volumio[2496]: constructor(data: RawNode) { Apr 08 16:35:26 volumio volumio[2496]: super(); Apr 08 16:35:26 volumio volumio[2496]: this.simplebox_avatar = Thumbnail.fromResponse(data.simpleboxAvatar); Apr 08 16:35:26 volumio volumio[2496]: this.simplebox_placeholder = new Text(data.simpleboxPlaceholder); Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: InnertubeError: Something went wrong at CommentsSimplebox! Apr 08 16:35:26 volumio volumio[2496]: This is a bug, please report it at https://github.com/patrickkfkan/Volumio-YouTube.js/issues Apr 08 16:35:26 volumio volumio[2496]: at Function._Parser_printError (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18226:16) Apr 08 16:35:26 volumio volumio[2496]: at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18059:70) Apr 08 16:35:26 volumio volumio[2496]: at new CommentsEntryPointHeader (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:12558:47) Apr 08 16:35:26 volumio volumio[2496]: at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24) Apr 08 16:35:26 volumio volumio[2496]: at Function.parseArray (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18069:29) Apr 08 16:35:26 volumio volumio[2496]: at new ItemSection (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:13951:36) Apr 08 16:35:26 volumio volumio[2496]: at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24) Apr 08 16:35:26 volumio volumio[2496]: at Function.parseArray (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18069:29) Apr 08 16:35:26 volumio volumio[2496]: at new TwoColumnWatchNextResults (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:16971:35) Apr 08 16:35:26 volumio volumio[2496]: at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24) Apr 08 16:35:26 volumio volumio[2496]: at Function.parse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18096:39) Apr 08 16:35:26 volumio volumio[2496]: at Function.parseResponse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:17864:27) Apr 08 16:35:26 volumio volumio[2496]: at EndpointModel._EndpointModel_doGetContents (/data/plugins/music_service/youtube2/dist/lib/model/EndpointModel.js:39:49) Apr 08 16:35:26 volumio volumio[2496]: at runMicrotasks () Apr 08 16:35:26 volumio volumio[2496]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 08 16:35:26 volumio volumio[2496]: at async GenericViewHandler.getTracksOnExplode (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:97:26) { Apr 08 16:35:26 volumio volumio[2496]: info: { Apr 08 16:35:26 volumio volumio[2496]: stack: 'Error: Type mismatch, got CommentsSimplebox but expected CommentsEntryPointTeaser\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18053:19)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at new CommentsEntryPointHeader (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:12558:47)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at Function.parseArray (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18069:29)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at new ItemSection (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:13951:36)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at Function.parseArray (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18069:29)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at new TwoColumnWatchNextResults (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:16971:35)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at Function.parseItem (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at Function.parse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:18096:39)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at Function.parseResponse (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:17864:27)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at EndpointModel._EndpointModel_doGetContents (/data/plugins/music_service/youtube2/dist/lib/model/EndpointModel.js:39:49)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at runMicrotasks ()\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at processTicksAndRejections (internal/process/task_queues.js:93:5)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at async GenericViewHandler.getTracksOnExplode (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:97:26)\n' + Apr 08 16:35:26 volumio volumio[2496]: ' at async GenericViewHandler.explode (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/ExplodableViewHandler.js:14:24)' Apr 08 16:35:26 volumio volumio[2496]: }, Apr 08 16:35:26 volumio volumio[2496]: date: 2024-04-08T14:35:26.541Z, Apr 08 16:35:26 volumio volumio[2496]: version: '0.3.3' Apr 08 16:35:26 volumio volumio[2496]: } Apr 08 16:35:26 volumio volumio[2496]: info: CoreCommandRouter::volumioPushQueue Apr 08 16:35:26 volumio volumio[2496]: info: CorePlayQueue::saveQueue Apr 08 16:35:26 volumio volumio[2496]: info: CoreStateMachine::updateTrackBlock Apr 08 16:35:26 volumio volumio[2496]: info: CorePlayQueue::getTrackBlock Apr 08 16:35:26 volumio volumio[2496]: info: CoreCommandRouter::volumioPlay Apr 08 16:35:26 volumio volumio[2496]: info: CoreStateMachine::play index 0 Apr 08 16:35:26 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:26 volumio volumio[2496]: info: CoreStateMachine::stop Apr 08 16:35:26 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:26 volumio volumio[2496]: info: CoreStateMachine::play index undefined Apr 08 16:35:26 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:26 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:26 volumio volumio[2496]: info: CoreStateMachine::startPlaybackTimer Apr 08 16:35:26 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:26 volumio volumio[2496]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Uw90n9zWEGE%22%2C%22playlistId%22%3A%22PLE0678B787033C19B%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Vintage%201950's%20curly%20hair%20tutorial%20ala%20Marilyn%20Monroe%20by%20CHERRY%20DOLLFACE%22%2C%22artist%22%3A%22Cherry%20Dollface%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FUw90n9zWEGE%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLALtBBgU0Ssl6XGYCDVCmJFEM49FQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Uw90n9zWEGE%22%2C%22playlistId%22%3A%22PLE0678B787033C19B%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D Apr 08 16:35:26 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:26 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand stop Apr 08 16:35:26 volumio volumio[2496]: info: sendMpdCommand stop took 2 milliseconds Apr 08 16:35:26 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand clear Apr 08 16:35:26 volumio volumio[2496]: info: Apr 08 16:35:26 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:26 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:26 volumio volumio[2496]: info: sendMpdCommand clear took 1 milliseconds Apr 08 16:35:26 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-h5bt5guxax3vh-91ql.googlevideo.com/videoplayback?expire=1712608526&ei=rgAUZp2CKKbNi9oPoYm48Aw&ip=62.201.67.76&id=o-ABrMVU3SKC5cZMQAqdyTNlD_7rbFGUr5p2nQ0xstewRl&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W_&mm=31%2C29&mn=sn-h5bt5guxax3vh-91ql%2Csn-c0q7lnz7&ms=au%2Crdu&mv=m&mvi=1&pl=23&initcwndbps=1472500&bui=AaUN6a18Ba8vXKlO10fjyrWKbFRsUE0gd15bzUXE25mqX8Tmy7IUS0Cn8LZLyG5pr24FwEvZt8OChD6a&spc=UWF9f_5reZnaCToQFD-eWLIayoUSpCWsEX07EwflRpAI2MM_BQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Pi98lz8gonMkA0Hi1863xHgQ&rqh=1&gir=yes&clen=8528574&dur=529.861&lmt=1698289813744145&mt=1712586557&fvip=1&keepalive=yes&fexp=51141541&c=WEB&sefc=1&txp=5432434&n=8I70ksCj0uJvrg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALtYYNSiFCHRvoWX0suSoZGOH0OutJVrd33keyVc8EHXAiBIppLAZxdlMHe1eR-nC5G7m8Vdqom2Lhh3zR_u8EYhbg%3D%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgbW0bPIj7gWdcTULPOt_1LSsVCC_UlRz6ndRS1Ql_pRYCIQDGKwX8U51S4Zwdy8iZ7gUkVIIalK2Er3fBNDR3zzoqrA%3D%3D&cver=2.20230104.01.00&t.YouTube" Apr 08 16:35:26 volumio volumio[2496]: info: Apr 08 16:35:26 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:26 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:26 volumio volumio[2496]: info: Apr 08 16:35:26 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:26 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:26 volumio volumio[2496]: error: updateQueue error: null Apr 08 16:35:26 volumio volumio[2496]: info: Apr 08 16:35:26 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:26 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:26 volumio volumio[2496]: info: ------------------------------ 1ms Apr 08 16:35:26 volumio volumio[2496]: info: sendMpdCommand addid "https://rr1---sn-h5bt5guxax3vh-91ql.googlevideo.com/videoplayback?expire=1712608526&ei=rgAUZp2CKKbNi9oPoYm48Aw&ip=62.201.67.76&id=o-ABrMVU3SKC5cZMQAqdyTNlD_7rbFGUr5p2nQ0xstewRl&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W_&mm=31%2C29&mn=sn-h5bt5guxax3vh-91ql%2Csn-c0q7lnz7&ms=au%2Crdu&mv=m&mvi=1&pl=23&initcwndbps=1472500&bui=AaUN6a18Ba8vXKlO10fjyrWKbFRsUE0gd15bzUXE25mqX8Tmy7IUS0Cn8LZLyG5pr24FwEvZt8OChD6a&spc=UWF9f_5reZnaCToQFD-eWLIayoUSpCWsEX07EwflRpAI2MM_BQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Pi98lz8gonMkA0Hi1863xHgQ&rqh=1&gir=yes&clen=8528574&dur=529.861&lmt=1698289813744145&mt=1712586557&fvip=1&keepalive=yes&fexp=51141541&c=WEB&sefc=1&txp=5432434&n=8I70ksCj0uJvrg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALtYYNSiFCHRvoWX0suSoZGOH0OutJVrd33keyVc8EHXAiBIppLAZxdlMHe1eR-nC5G7m8Vdqom2Lhh3zR_u8EYhbg%3D%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgbW0bPIj7gWdcTULPOt_1LSsVCC_UlRz6ndRS1Ql_pRYCIQDGKwX8U51S4Zwdy8iZ7gUkVIIalK2Er3fBNDR3zzoqrA%3D%3D&cver=2.20230104.01.00&t.YouTube" took 1 milliseconds Apr 08 16:35:26 volumio volumio[2496]: info: ------------------------------ 2ms Apr 08 16:35:26 volumio volumio[2496]: info: ------------------------------ 1ms Apr 08 16:35:26 volumio volumio[2496]: verbose: MPD COMMAND [object Object] Apr 08 16:35:26 volumio volumio[2496]: verbose: MPD COMMAND [object Object] Apr 08 16:35:26 volumio volumio[2496]: verbose: MPD COMMAND [object Object] Apr 08 16:35:26 volumio volumio[2496]: info: Apr 08 16:35:26 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:26 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:26 volumio volumio[2496]: info: Apr 08 16:35:26 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:26 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:26 volumio volumio[2496]: info: Apr 08 16:35:26 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:26 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:26 volumio volumio[2496]: info: ------------------------------ 2ms Apr 08 16:35:26 volumio volumio[2496]: info: ------------------------------ 1ms Apr 08 16:35:26 volumio volumio[2496]: info: ------------------------------ 1ms Apr 08 16:35:26 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 08 16:35:26 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand play Apr 08 16:35:26 volumio volumio[2496]: info: Apr 08 16:35:26 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:26 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:26 volumio volumio[2496]: info: Apr 08 16:35:26 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:26 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:26 volumio volumio[2496]: info: ------------------------------ 1ms Apr 08 16:35:26 volumio volumio[2496]: info: sendMpdCommand play took 1 milliseconds Apr 08 16:35:26 volumio volumio[2496]: info: ------------------------------ 1ms Apr 08 16:35:28 volumio volumio[2496]: info: Apr 08 16:35:28 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:28 volumio volumio[2496]: info: Apr 08 16:35:28 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:28 volumio volumio[2496]: info: Apr 08 16:35:28 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand status took 3 milliseconds Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:28 volumio volumio[2496]: info: Apr 08 16:35:28 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand status took 3 milliseconds Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand status took 2 milliseconds Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:28 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:28 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":530,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vintage 1950's curly hair tutorial ala Marilyn Monroe by CHERRY DOLLFACE","artist":"Cherry Dollface","album":"YouTube","uri":"https://rr1---sn-h5bt5guxax3vh-91ql.googlevideo.com/videoplayback?expire=1712608526&ei=rgAUZp2CKKbNi9oPoYm48Aw&ip=62.201.67.76&id=o-ABrMVU3SKC5cZMQAqdyTNlD_7rbFGUr5p2nQ0xstewRl&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W_&mm=31%2C29&mn=sn-h5bt5guxax3vh-91ql%2Csn-c0q7lnz7&ms=au%2Crdu&mv=m&mvi=1&pl=23&initcwndbps=1472500&bui=AaUN6a18Ba8vXKlO10fjyrWKbFRsUE0gd15bzUXE25mqX8Tmy7IUS0Cn8LZLyG5pr24FwEvZt8OChD6a&spc=UWF9f_5reZnaCToQFD-eWLIayoUSpCWsEX07EwflRpAI2MM_BQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Pi98lz8gonMkA0Hi1863xHgQ&rqh=1&gir=yes&clen=8528574&dur=529.861&lmt=1698289813744145&mt=1712586557&fvip=1&keepalive=yes&fexp=51141541&c=WEB&sefc=1&txp=5432434&n=8I70ksCj0uJvrg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALtYYNSiFCHRvoWX0suSoZGOH0OutJVrd33keyVc8EHXAiBIppLAZxdlMHe1eR-nC5G7m8Vdqom2Lhh3zR_u8EYhbg%3D%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgbW0bPIj7gWdcTULPOt_1LSsVCC_UlRz6ndRS1Ql_pRYCIQDGKwX8U51S4Zwdy8iZ7gUkVIIalK2Er3fBNDR3zzoqrA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 08 16:35:28 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:35:28 volumio volumio[2496]: info: ------------------------------ 5ms Apr 08 16:35:28 volumio volumio[2496]: info: Apr 08 16:35:28 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:28 volumio volumio[2496]: info: Apr 08 16:35:28 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand status took 2 milliseconds Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:28 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:28 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":530,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vintage 1950's curly hair tutorial ala Marilyn Monroe by CHERRY DOLLFACE","artist":"Cherry Dollface","album":"YouTube","uri":"https://rr1---sn-h5bt5guxax3vh-91ql.googlevideo.com/videoplayback?expire=1712608526&ei=rgAUZp2CKKbNi9oPoYm48Aw&ip=62.201.67.76&id=o-ABrMVU3SKC5cZMQAqdyTNlD_7rbFGUr5p2nQ0xstewRl&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W_&mm=31%2C29&mn=sn-h5bt5guxax3vh-91ql%2Csn-c0q7lnz7&ms=au%2Crdu&mv=m&mvi=1&pl=23&initcwndbps=1472500&bui=AaUN6a18Ba8vXKlO10fjyrWKbFRsUE0gd15bzUXE25mqX8Tmy7IUS0Cn8LZLyG5pr24FwEvZt8OChD6a&spc=UWF9f_5reZnaCToQFD-eWLIayoUSpCWsEX07EwflRpAI2MM_BQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Pi98lz8gonMkA0Hi1863xHgQ&rqh=1&gir=yes&clen=8528574&dur=529.861&lmt=1698289813744145&mt=1712586557&fvip=1&keepalive=yes&fexp=51141541&c=WEB&sefc=1&txp=5432434&n=8I70ksCj0uJvrg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALtYYNSiFCHRvoWX0suSoZGOH0OutJVrd33keyVc8EHXAiBIppLAZxdlMHe1eR-nC5G7m8Vdqom2Lhh3zR_u8EYhbg%3D%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgbW0bPIj7gWdcTULPOt_1LSsVCC_UlRz6ndRS1Ql_pRYCIQDGKwX8U51S4Zwdy8iZ7gUkVIIalK2Er3fBNDR3zzoqrA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 08 16:35:28 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:28 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:28 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:28 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":530,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vintage 1950's curly hair tutorial ala Marilyn Monroe by CHERRY DOLLFACE","artist":"Cherry Dollface","album":"YouTube","uri":"https://rr1---sn-h5bt5guxax3vh-91ql.googlevideo.com/videoplayback?expire=1712608526&ei=rgAUZp2CKKbNi9oPoYm48Aw&ip=62.201.67.76&id=o-ABrMVU3SKC5cZMQAqdyTNlD_7rbFGUr5p2nQ0xstewRl&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W_&mm=31%2C29&mn=sn-h5bt5guxax3vh-91ql%2Csn-c0q7lnz7&ms=au%2Crdu&mv=m&mvi=1&pl=23&initcwndbps=1472500&bui=AaUN6a18Ba8vXKlO10fjyrWKbFRsUE0gd15bzUXE25mqX8Tmy7IUS0Cn8LZLyG5pr24FwEvZt8OChD6a&spc=UWF9f_5reZnaCToQFD-eWLIayoUSpCWsEX07EwflRpAI2MM_BQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Pi98lz8gonMkA0Hi1863xHgQ&rqh=1&gir=yes&clen=8528574&dur=529.861&lmt=1698289813744145&mt=1712586557&fvip=1&keepalive=yes&fexp=51141541&c=WEB&sefc=1&txp=5432434&n=8I70ksCj0uJvrg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALtYYNSiFCHRvoWX0suSoZGOH0OutJVrd33keyVc8EHXAiBIppLAZxdlMHe1eR-nC5G7m8Vdqom2Lhh3zR_u8EYhbg%3D%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgbW0bPIj7gWdcTULPOt_1LSsVCC_UlRz6ndRS1Ql_pRYCIQDGKwX8U51S4Zwdy8iZ7gUkVIIalK2Er3fBNDR3zzoqrA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 08 16:35:28 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:28 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: ------------------------------ 12ms Apr 08 16:35:28 volumio volumio[2496]: info: ------------------------------ 12ms Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 08 16:35:28 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:28 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:28 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:28 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":530,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vintage 1950's curly hair tutorial ala Marilyn Monroe by CHERRY DOLLFACE","artist":"Cherry Dollface","album":"YouTube","uri":"https://rr1---sn-h5bt5guxax3vh-91ql.googlevideo.com/videoplayback?expire=1712608526&ei=rgAUZp2CKKbNi9oPoYm48Aw&ip=62.201.67.76&id=o-ABrMVU3SKC5cZMQAqdyTNlD_7rbFGUr5p2nQ0xstewRl&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W_&mm=31%2C29&mn=sn-h5bt5guxax3vh-91ql%2Csn-c0q7lnz7&ms=au%2Crdu&mv=m&mvi=1&pl=23&initcwndbps=1472500&bui=AaUN6a18Ba8vXKlO10fjyrWKbFRsUE0gd15bzUXE25mqX8Tmy7IUS0Cn8LZLyG5pr24FwEvZt8OChD6a&spc=UWF9f_5reZnaCToQFD-eWLIayoUSpCWsEX07EwflRpAI2MM_BQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Pi98lz8gonMkA0Hi1863xHgQ&rqh=1&gir=yes&clen=8528574&dur=529.861&lmt=1698289813744145&mt=1712586557&fvip=1&keepalive=yes&fexp=51141541&c=WEB&sefc=1&txp=5432434&n=8I70ksCj0uJvrg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALtYYNSiFCHRvoWX0suSoZGOH0OutJVrd33keyVc8EHXAiBIppLAZxdlMHe1eR-nC5G7m8Vdqom2Lhh3zR_u8EYhbg%3D%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgbW0bPIj7gWdcTULPOt_1LSsVCC_UlRz6ndRS1Ql_pRYCIQDGKwX8U51S4Zwdy8iZ7gUkVIIalK2Er3fBNDR3zzoqrA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 08 16:35:28 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:28 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:28 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:28 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":530,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vintage 1950's curly hair tutorial ala Marilyn Monroe by CHERRY DOLLFACE","artist":"Cherry Dollface","album":"YouTube","uri":"https://rr1---sn-h5bt5guxax3vh-91ql.googlevideo.com/videoplayback?expire=1712608526&ei=rgAUZp2CKKbNi9oPoYm48Aw&ip=62.201.67.76&id=o-ABrMVU3SKC5cZMQAqdyTNlD_7rbFGUr5p2nQ0xstewRl&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W_&mm=31%2C29&mn=sn-h5bt5guxax3vh-91ql%2Csn-c0q7lnz7&ms=au%2Crdu&mv=m&mvi=1&pl=23&initcwndbps=1472500&bui=AaUN6a18Ba8vXKlO10fjyrWKbFRsUE0gd15bzUXE25mqX8Tmy7IUS0Cn8LZLyG5pr24FwEvZt8OChD6a&spc=UWF9f_5reZnaCToQFD-eWLIayoUSpCWsEX07EwflRpAI2MM_BQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Pi98lz8gonMkA0Hi1863xHgQ&rqh=1&gir=yes&clen=8528574&dur=529.861&lmt=1698289813744145&mt=1712586557&fvip=1&keepalive=yes&fexp=51141541&c=WEB&sefc=1&txp=5432434&n=8I70ksCj0uJvrg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALtYYNSiFCHRvoWX0suSoZGOH0OutJVrd33keyVc8EHXAiBIppLAZxdlMHe1eR-nC5G7m8Vdqom2Lhh3zR_u8EYhbg%3D%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgbW0bPIj7gWdcTULPOt_1LSsVCC_UlRz6ndRS1Ql_pRYCIQDGKwX8U51S4Zwdy8iZ7gUkVIIalK2Er3fBNDR3zzoqrA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 08 16:35:28 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:28 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:28 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:28 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":530,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vintage 1950's curly hair tutorial ala Marilyn Monroe by CHERRY DOLLFACE","artist":"Cherry Dollface","album":"YouTube","uri":"https://rr1---sn-h5bt5guxax3vh-91ql.googlevideo.com/videoplayback?expire=1712608526&ei=rgAUZp2CKKbNi9oPoYm48Aw&ip=62.201.67.76&id=o-ABrMVU3SKC5cZMQAqdyTNlD_7rbFGUr5p2nQ0xstewRl&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=W_&mm=31%2C29&mn=sn-h5bt5guxax3vh-91ql%2Csn-c0q7lnz7&ms=au%2Crdu&mv=m&mvi=1&pl=23&initcwndbps=1472500&bui=AaUN6a18Ba8vXKlO10fjyrWKbFRsUE0gd15bzUXE25mqX8Tmy7IUS0Cn8LZLyG5pr24FwEvZt8OChD6a&spc=UWF9f_5reZnaCToQFD-eWLIayoUSpCWsEX07EwflRpAI2MM_BQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Pi98lz8gonMkA0Hi1863xHgQ&rqh=1&gir=yes&clen=8528574&dur=529.861&lmt=1698289813744145&mt=1712586557&fvip=1&keepalive=yes&fexp=51141541&c=WEB&sefc=1&txp=5432434&n=8I70ksCj0uJvrg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALtYYNSiFCHRvoWX0suSoZGOH0OutJVrd33keyVc8EHXAiBIppLAZxdlMHe1eR-nC5G7m8Vdqom2Lhh3zR_u8EYhbg%3D%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgbW0bPIj7gWdcTULPOt_1LSsVCC_UlRz6ndRS1Ql_pRYCIQDGKwX8U51S4Zwdy8iZ7gUkVIIalK2Er3fBNDR3zzoqrA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 08 16:35:28 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:28 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:28 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:28 volumio volumio[2496]: info: ------------------------------ 17ms Apr 08 16:35:28 volumio volumio[2496]: info: ------------------------------ 15ms Apr 08 16:35:28 volumio volumio[2496]: info: ------------------------------ 16ms Apr 08 16:35:35 volumio volumio[2496]: info: CoreCommandRouter::volumioGetState Apr 08 16:35:40 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:35:40 volumio volumio[2496]: info: CURURI: music-library Apr 08 16:35:40 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:42 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:35:42 volumio volumio[2496]: info: CURURI: music-library/NAS Apr 08 16:35:42 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:43 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:35:43 volumio volumio[2496]: info: CURURI: music-library/NAS/PC Apr 08 16:35:43 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:43 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Kerekes _PIKI_ József - Távolodom.mp3 Apr 08 16:35:43 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/PIKI (Kerekes József) a régmúltból!.mp3 Apr 08 16:35:43 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Kerekes _PIKI_ József - Távolodom.mp3 in service mpd Apr 08 16:35:43 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=pccsaj1994//extralarge&path=%2Fmnt%2FNAS%2FPC%2FKerekes%20_PIKI_%20J%C3%B3zsef%20-%20T%C3%A1volodom.mp3&metadata=false Apr 08 16:35:43 volumio volumio[2496]: info: URI /mnt/NAS/PC/Kerekes _PIKI_ József - Távolodom.mp3 Apr 08 16:35:43 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/PIKI (Kerekes József) a régmúltból!.mp3 in service mpd Apr 08 16:35:43 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=//extralarge&path=%2Fmnt%2FNAS%2FPC%2FPIKI%20(Kerekes%20J%C3%B3zsef)%20a%20r%C3%A9gm%C3%BAltb%C3%B3l!.mp3&metadata=false Apr 08 16:35:43 volumio volumio[2496]: info: URI /mnt/NAS/PC/PIKI (Kerekes József) a régmúltból!.mp3 Apr 08 16:35:45 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:35:45 volumio volumio[2496]: info: CURURI: music-library/NAS/PC/Abba - ABBA_DSD_Stig Apr 08 16:35:45 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A2.Hey Hey Helen.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A3.Tropical Loveland.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A4.SOS.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A5.Man In The Middle.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A6.Bang-A-Boomerang.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B1.I Do I Do I Do I Do I Do.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B2.Rock Me.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B3.Intermezzo No. 1.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B4.I've Been Waiting For You.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Preloading song: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B5.So Long.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf in service mpd Apr 08 16:35:45 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FA1.Mamma%20Mia.dsf&metadata=false Apr 08 16:35:45 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/A2.Hey Hey Helen.dsf in service mpd Apr 08 16:35:45 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FA2.Hey%20Hey%20Helen.dsf&metadata=false Apr 08 16:35:45 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/A2.Hey Hey Helen.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/A3.Tropical Loveland.dsf in service mpd Apr 08 16:35:45 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FA3.Tropical%20Loveland.dsf&metadata=false Apr 08 16:35:45 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/A3.Tropical Loveland.dsf Apr 08 16:35:45 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/A4.SOS.dsf in service mpd Apr 08 16:35:45 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FA4.SOS.dsf&metadata=false Apr 08 16:35:45 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/A4.SOS.dsf Apr 08 16:35:46 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/A5.Man In The Middle.dsf in service mpd Apr 08 16:35:46 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FA5.Man%20In%20The%20Middle.dsf&metadata=false Apr 08 16:35:46 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/A5.Man In The Middle.dsf Apr 08 16:35:46 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/A6.Bang-A-Boomerang.dsf in service mpd Apr 08 16:35:46 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FA6.Bang-A-Boomerang.dsf&metadata=false Apr 08 16:35:46 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/A6.Bang-A-Boomerang.dsf Apr 08 16:35:46 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/B1.I Do I Do I Do I Do I Do.dsf in service mpd Apr 08 16:35:46 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FB1.I%20Do%20I%20Do%20I%20Do%20I%20Do%20I%20Do.dsf&metadata=false Apr 08 16:35:46 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/B1.I Do I Do I Do I Do I Do.dsf Apr 08 16:35:46 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/B2.Rock Me.dsf in service mpd Apr 08 16:35:46 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FB2.Rock%20Me.dsf&metadata=false Apr 08 16:35:46 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/B2.Rock Me.dsf Apr 08 16:35:46 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/B3.Intermezzo No. 1.dsf in service mpd Apr 08 16:35:46 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FB3.Intermezzo%20No.%201.dsf&metadata=false Apr 08 16:35:46 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/B3.Intermezzo No. 1.dsf Apr 08 16:35:46 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/B4.I've Been Waiting For You.dsf in service mpd Apr 08 16:35:46 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FB4.I've%20Been%20Waiting%20For%20You.dsf&metadata=false Apr 08 16:35:46 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/B4.I've Been Waiting For You.dsf Apr 08 16:35:46 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig/B5.So Long.dsf in service mpd Apr 08 16:35:46 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=ABBA/ABBA/extralarge&path=%2Fmnt%2FNAS%2FPC%2FAbba%20-%20ABBA_DSD_Stig%2FB5.So%20Long.dsf&metadata=false Apr 08 16:35:46 volumio volumio[2496]: info: URI /mnt/NAS/PC/Abba - ABBA_DSD_Stig/B5.So Long.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::ClearQueue Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::stop Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::stPlaybackTimer Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::updateTrackBlock Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrackBlock Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::serviceStop Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::serviceStop Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 08 16:35:47 volumio volumio[2496]: info: ControllerMpd::stop Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand stop Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::clearPlayQueue Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::saveQueue Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPushQueue Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::addQueueItems Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::addQueueItems Apr 08 16:35:47 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A2.Hey Hey Helen.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A2.Hey Hey Helen.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A3.Tropical Loveland.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A3.Tropical Loveland.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A4.SOS.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A4.SOS.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A5.Man In The Middle.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A5.Man In The Middle.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A6.Bang-A-Boomerang.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/A6.Bang-A-Boomerang.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B1.I Do I Do I Do I Do I Do.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B1.I Do I Do I Do I Do I Do.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B2.Rock Me.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B2.Rock Me.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B3.Intermezzo No. 1.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B3.Intermezzo No. 1.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B4.I've Been Waiting For You.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B4.I've Been Waiting For You.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B5.So Long.dsf Apr 08 16:35:47 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Abba - ABBA_DSD_Stig/B5.So Long.dsf Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPushQueue Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::saveQueue Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::updateTrackBlock Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrackBlock Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPlay Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::play index 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::stop Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::play index undefined Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::startPlaybackTimer Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand stop Apr 08 16:35:47 volumio volumio[2496]: info: Apr 08 16:35:47 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:47 volumio volumio[2496]: info: sendMpdCommand stop took 11 milliseconds Apr 08 16:35:47 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:47 volumio volumio[2496]: info: sendMpdCommand stop took 5 milliseconds Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand clear Apr 08 16:35:47 volumio volumio[2496]: info: Apr 08 16:35:47 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:47 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:47 volumio volumio[2496]: info: Apr 08 16:35:47 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:47 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:47 volumio volumio[2496]: info: Apr 08 16:35:47 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:47 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:47 volumio volumio[2496]: info: sendMpdCommand status took 3 milliseconds Apr 08 16:35:47 volumio volumio[2496]: info: sendMpdCommand clear took 3 milliseconds Apr 08 16:35:47 volumio volumio[2496]: info: sendMpdCommand status took 2 milliseconds Apr 08 16:35:47 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf" Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:47 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 16:35:47 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::syncState stateService stop Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:47 volumio volumio[2496]: info: No code Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:47 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 16:35:47 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::syncState stateService stop Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:47 volumio volumio[2496]: info: No code Apr 08 16:35:47 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:47 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:47 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:47 volumio volumio[2496]: info: ------------------------------ 16ms Apr 08 16:35:47 volumio volumio[2496]: info: ------------------------------ 16ms Apr 08 16:35:47 volumio volumio[2496]: info: Apr 08 16:35:47 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:47 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:47 volumio volumio[2496]: info: Apr 08 16:35:47 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:47 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:47 volumio volumio[2496]: error: updateQueue error: null Apr 08 16:35:47 volumio volumio[2496]: info: Apr 08 16:35:47 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:47 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:47 volumio volumio[2496]: info: ------------------------------ 18ms Apr 08 16:35:47 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 08 16:35:47 volumio volumio[2496]: info: sendMpdCommand add "NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf" took 17 milliseconds Apr 08 16:35:47 volumio volumio[2496]: info: ------------------------------ 5ms Apr 08 16:35:47 volumio volumio[2496]: info: ------------------------------ 4ms Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:47 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand play Apr 08 16:35:47 volumio volumio[2496]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 08 16:35:47 volumio volumio[2496]: info: ------------------------------ 23ms Apr 08 16:35:47 volumio volumio[2496]: info: Apr 08 16:35:47 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:47 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:47 volumio volumio[2496]: info: Apr 08 16:35:47 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:47 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:48 volumio volumio[2496]: info: Apr 08 16:35:48 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:48 volumio volumio[2496]: info: ------------------------------ 109ms Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand play took 107 milliseconds Apr 08 16:35:48 volumio volumio[2496]: info: ------------------------------ 106ms Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:48 volumio volumio[2496]: info: Apr 08 16:35:48 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand status took 55 milliseconds Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:48 volumio volumio[2496]: info: Apr 08 16:35:48 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:48 volumio volumio[2496]: info: Apr 08 16:35:48 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand status took 5 milliseconds Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand status took 3 milliseconds Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand status took 2 milliseconds Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":746,"duration":215,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1.Mamma Mia","artist":"ABBA","album":"ABBA","uri":"NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf","trackType":"dsf"} Apr 08 16:35:48 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:35:48 volumio volumio[2496]: info: ------------------------------ 65ms Apr 08 16:35:48 volumio volumio[2496]: info: Apr 08 16:35:48 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:48 volumio volumio[2496]: info: Apr 08 16:35:48 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand status took 2 milliseconds Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":995,"duration":215,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1.Mamma Mia","artist":"ABBA","album":"ABBA","uri":"NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf","trackType":"dsf"} Apr 08 16:35:48 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:48 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":995,"duration":215,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1.Mamma Mia","artist":"ABBA","album":"ABBA","uri":"NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf","trackType":"dsf"} Apr 08 16:35:48 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:48 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":995,"duration":215,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1.Mamma Mia","artist":"ABBA","album":"ABBA","uri":"NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf","trackType":"dsf"} Apr 08 16:35:48 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:48 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: ------------------------------ 42ms Apr 08 16:35:48 volumio volumio[2496]: info: ------------------------------ 39ms Apr 08 16:35:48 volumio volumio[2496]: info: ------------------------------ 39ms Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 27 milliseconds Apr 08 16:35:48 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 28 milliseconds Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:48 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":995,"duration":215,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1.Mamma Mia","artist":"ABBA","album":"ABBA","uri":"NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf","trackType":"dsf"} Apr 08 16:35:48 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:48 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":995,"duration":215,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1.Mamma Mia","artist":"ABBA","album":"ABBA","uri":"NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf","trackType":"dsf"} Apr 08 16:35:48 volumio volumio[2496]: verbose: CURRENT POSITION 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:48 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:48 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:48 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:48 volumio volumio[2496]: info: ------------------------------ 42ms Apr 08 16:35:48 volumio volumio[2496]: info: ------------------------------ 41ms Apr 08 16:35:54 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:35:54 volumio volumio[2496]: info: CURURI: music-library/NAS/PC/Die Hit Giganten Best Of 70 Apr 08 16:35:54 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:56 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: [1712586956921] ---------------------------- Client requests add and Play Volumio CUE entry Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue Apr 08 16:35:56 volumio volumio[2496]: info: Adding CUE individual entry: 0 NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.cue Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::volumioAddQueueItems Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::addQueueItems Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::addQueueItems Apr 08 16:35:56 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:35:56 volumio volumio[2496]: info: Adding Item to queue: cue://NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.cue@0 Apr 08 16:35:56 volumio volumio[2496]: info: Exploding uri cue://NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.cue@0 in service mpd Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::volumioPlay Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::play index 11 Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::stop Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::stPlaybackTimer Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::updateTrackBlock Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrackBlock Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::serviceStop Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrack 0 Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::serviceStop Apr 08 16:35:56 volumio volumio[2496]: info: ControllerMpd::stop Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand stop Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::volumioPushQueue Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::saveQueue Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::updateTrackBlock Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrackBlock Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand stop took 8 milliseconds Apr 08 16:35:56 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::play index undefined Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::startPlaybackTimer Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand stop Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:56 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:56 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand status took 2 milliseconds Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand stop took 2 milliseconds Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand clear Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:56 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand clear took 1 milliseconds Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand load "NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.cue" Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:56 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:56 volumio volumio[2496]: 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":"A1.Mamma Mia","artist":"ABBA","album":"ABBA","uri":"NAS/PC/Abba - ABBA_DSD_Stig/A1.Mamma Mia.dsf","trackType":"dsf"} Apr 08 16:35:56 volumio volumio[2496]: verbose: CURRENT POSITION 11 Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::syncState stateService stop Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:56 volumio volumio[2496]: info: No code Apr 08 16:35:56 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:56 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:56 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:56 volumio volumio[2496]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 08 16:35:56 volumio volumio[2496]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 08 16:35:56 volumio volumio[2496]: info: ------------------------------ 10ms Apr 08 16:35:56 volumio volumio[2496]: info: ------------------------------ 9ms Apr 08 16:35:56 volumio volumio[2496]: info: ------------------------------ 8ms Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:56 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:56 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:56 volumio volumio[2496]: error: updateQueue error: null Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:56 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:56 volumio volumio[2496]: info: ------------------------------ 10ms Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand load "NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.cue" took 9 milliseconds Apr 08 16:35:56 volumio volumio[2496]: info: ------------------------------ 1ms Apr 08 16:35:56 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand play Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:56 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:56 volumio volumio[2496]: info: Apr 08 16:35:56 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:35:56 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:35:56 volumio volumio[2496]: info: ------------------------------ 4ms Apr 08 16:35:56 volumio volumio[2496]: info: ------------------------------ 3ms Apr 08 16:35:56 volumio volumio[2496]: info: sendMpdCommand play took 2 milliseconds Apr 08 16:35:56 volumio volumio[2496]: info: ------------------------------ 2ms Apr 08 16:35:57 volumio volumio[2496]: info: Apr 08 16:35:57 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:57 volumio volumio[2496]: info: Apr 08 16:35:57 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:57 volumio volumio[2496]: info: Apr 08 16:35:57 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:57 volumio volumio[2496]: info: Apr 08 16:35:57 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand status took 5 milliseconds Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:57 volumio volumio[2496]: info: Apr 08 16:35:57 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:57 volumio volumio[2496]: info: Apr 08 16:35:57 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand status took 2 milliseconds Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand status took 0 milliseconds Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand status took 0 milliseconds Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":193,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"840 Kbps","isStreaming":false,"title":"Don't Stop","artist":"Fleetwood Mac","album":"Die Hit Giganten - Best Of 70's CD1","uri":"NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.flac","trackType":"flac"} Apr 08 16:35:57 volumio volumio[2496]: verbose: CURRENT POSITION 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":193,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"840 Kbps","isStreaming":false,"title":"Don't Stop","artist":"Fleetwood Mac","album":"Die Hit Giganten - Best Of 70's CD1","uri":"NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.flac","trackType":"flac"} Apr 08 16:35:57 volumio volumio[2496]: verbose: CURRENT POSITION 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:57 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":193,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"840 Kbps","isStreaming":false,"title":"Don't Stop","artist":"Fleetwood Mac","album":"Die Hit Giganten - Best Of 70's CD1","uri":"NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.flac","trackType":"flac"} Apr 08 16:35:57 volumio volumio[2496]: verbose: CURRENT POSITION 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:57 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: ------------------------------ 12ms Apr 08 16:35:57 volumio volumio[2496]: info: ------------------------------ 12ms Apr 08 16:35:57 volumio volumio[2496]: info: ------------------------------ 12ms Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 08 16:35:57 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:57 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":193,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"840 Kbps","isStreaming":false,"title":"Don't Stop","artist":"Fleetwood Mac","album":"Die Hit Giganten - Best Of 70's CD1","uri":"NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.flac","trackType":"flac"} Apr 08 16:35:57 volumio volumio[2496]: verbose: CURRENT POSITION 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:57 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":193,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"840 Kbps","isStreaming":false,"title":"Don't Stop","artist":"Fleetwood Mac","album":"Die Hit Giganten - Best Of 70's CD1","uri":"NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.flac","trackType":"flac"} Apr 08 16:35:57 volumio volumio[2496]: verbose: CURRENT POSITION 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:57 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":193,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"840 Kbps","isStreaming":false,"title":"Don't Stop","artist":"Fleetwood Mac","album":"Die Hit Giganten - Best Of 70's CD1","uri":"NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.flac","trackType":"flac"} Apr 08 16:35:57 volumio volumio[2496]: verbose: CURRENT POSITION 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:35:57 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:35:57 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:35:57 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:35:57 volumio volumio[2496]: info: ------------------------------ 30ms Apr 08 16:35:57 volumio volumio[2496]: info: ------------------------------ 29ms Apr 08 16:35:57 volumio volumio[2496]: info: ------------------------------ 29ms Apr 08 16:36:05 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:36:05 volumio volumio[2496]: info: CURURI: music-library/NAS/PC/Club Hits From The 70s To The 80s -3 CD Apr 08 16:36:05 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:36:06 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:36:06 volumio volumio[2496]: info: CURURI: music-library/NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2 Apr 08 16:36:06 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:36:07 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: [1712586967770] ---------------------------- Client requests add and Play Volumio CUE entry Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue Apr 08 16:36:07 volumio volumio[2496]: info: Adding CUE individual entry: 1 NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.cue Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioAddQueueItems Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::addQueueItems Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::addQueueItems Apr 08 16:36:07 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:36:07 volumio volumio[2496]: info: Adding Item to queue: cue://NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.cue@1 Apr 08 16:36:07 volumio volumio[2496]: info: Exploding uri cue://NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.cue@1 in service mpd Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPlay Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::play index 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::stop Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::stPlaybackTimer Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::updateTrackBlock Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrackBlock Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::serviceStop Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 11 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::serviceStop Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::stop Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand stop Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushQueue Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::saveQueue Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::updateTrackBlock Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrackBlock Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand stop took 6 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::play index undefined Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::startPlaybackTimer Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand stop Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand status took 2 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand stop took 1 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand clear Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:36:07 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand clear took 0 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand load "NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.cue" Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Stop","artist":"Fleetwood Mac","album":"Die Hit Giganten - Best Of 70's CD1","uri":"NAS/PC/Die Hit Giganten Best Of 70/Various Artists - Die Hit Giganten - Best Of 70's CD1.flac","trackType":"flac"} Apr 08 16:36:07 volumio volumio[2496]: verbose: CURRENT POSITION 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState stateService stop Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: No code Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 15ms Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:36:07 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:36:07 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:36:07 volumio volumio[2496]: error: updateQueue error: null Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:36:07 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 15ms Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand load "NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.cue" took 14 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 3ms Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 2ms Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand play Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:36:07 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces system playlist update Apr 08 16:36:07 volumio volumio[2496]: info: Ignoring MPD Status Update Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 4ms Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand play took 3 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 3ms Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 2ms Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand status took 2 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand status took 0 milliseconds Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:36:07 volumio volumio[2496]: info: Apr 08 16:36:07 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::getState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand status Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand status took 4 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand status took 1 milliseconds Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseState Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Like Chopin","artist":"Gazebo","album":"The Hits Of The 80ies Vol.2","uri":"NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.flac","trackType":"flac"} Apr 08 16:36:07 volumio volumio[2496]: verbose: CURRENT POSITION 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus stop Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Like Chopin","artist":"Gazebo","album":"The Hits Of The 80ies Vol.2","uri":"NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.flac","trackType":"flac"} Apr 08 16:36:07 volumio volumio[2496]: verbose: CURRENT POSITION 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:36:07 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Like Chopin","artist":"Gazebo","album":"The Hits Of The 80ies Vol.2","uri":"NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.flac","trackType":"flac"} Apr 08 16:36:07 volumio volumio[2496]: verbose: CURRENT POSITION 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:36:07 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 11ms Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 16ms Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 17ms Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 08 16:36:07 volumio volumio[2496]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:36:07 volumio volumio[2496]: verbose: ControllerMpd::parseTrackInfo Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Like Chopin","artist":"Gazebo","album":"The Hits Of The 80ies Vol.2","uri":"NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.flac","trackType":"flac"} Apr 08 16:36:07 volumio volumio[2496]: verbose: CURRENT POSITION 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:36:07 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Like Chopin","artist":"Gazebo","album":"The Hits Of The 80ies Vol.2","uri":"NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.flac","trackType":"flac"} Apr 08 16:36:07 volumio volumio[2496]: verbose: CURRENT POSITION 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:36:07 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: ControllerMpd::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::servicePushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Like Chopin","artist":"Gazebo","album":"The Hits Of The 80ies Vol.2","uri":"NAS/PC/Club Hits From The 70s To The 80s -3 CD/CD.2/Various - The Hits Of The 80ies Vol.2.flac","trackType":"flac"} Apr 08 16:36:07 volumio volumio[2496]: verbose: CURRENT POSITION 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState stateService play Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::syncState currentStatus play Apr 08 16:36:07 volumio volumio[2496]: info: Received an update from plugin. extracting info from payload Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:07 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:07 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 34ms Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 33ms Apr 08 16:36:07 volumio volumio[2496]: info: ------------------------------ 32ms Apr 08 16:36:07 volumio kernel: CIFS: __readahead_batch() returned 32/1024 Apr 08 16:36:14 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:36:14 volumio volumio[2496]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 08 16:36:14 volumio volumio[2496]: info: CoreStateMachine::ClearQueue Apr 08 16:36:14 volumio volumio[2496]: info: CoreStateMachine::stop Apr 08 16:36:14 volumio volumio[2496]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 16:36:14 volumio volumio[2496]: info: CoreStateMachine::stPlaybackTimer Apr 08 16:36:14 volumio volumio[2496]: info: CoreStateMachine::updateTrackBlock Apr 08 16:36:14 volumio volumio[2496]: info: CorePlayQueue::getTrackBlock Apr 08 16:36:14 volumio volumio[2496]: info: CoreStateMachine::pushState Apr 08 16:36:14 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:14 volumio volumio[2496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:36:14 volumio volumio[2496]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:14 volumio volumio[2496]: info: CoreStateMachine::serviceStop Apr 08 16:36:14 volumio volumio[2496]: info: CorePlayQueue::getTrack 12 Apr 08 16:36:14 volumio volumio[2496]: info: CoreCommandRouter::serviceStop Apr 08 16:36:14 volumio volumio[2496]: info: ControllerMpd::stop Apr 08 16:36:14 volumio volumio[2496]: verbose: ControllerMpd::sendMpdCommand stop Apr 08 16:36:14 volumio volumio[2496]: info: CorePlayQueue::clearPlayQueue Apr 08 16:36:14 volumio volumio[2496]: info: CorePlayQueue::saveQueue Apr 08 16:36:14 volumio volumio[2496]: info: CoreCommandRouter::volumioPushQueue Apr 08 16:36:14 volumio volumio[2496]: info: CoreStateMachine::addQueueItems Apr 08 16:36:14 volumio volumio[2496]: info: CorePlayQueue::addQueueItems Apr 08 16:36:14 volumio volumio[2496]: info: Preload queue cleared Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Kerekes _PIKI_ József - Távolodom.mp3 Apr 08 16:36:14 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/Kerekes _PIKI_ József - Távolodom.mp3 Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/PIKI (Kerekes József) a régmúltból!.mp3 Apr 08 16:36:14 volumio volumio[2496]: info: Using cached record of: music-library/NAS/PC/PIKI (Kerekes József) a régmúltból!.mp3 Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/!Collection - Vengaboys Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/!Collection - Vengaboys in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/1VA - Disco Nostalgia of 80s vol.1 (2008) [FLAC] NP Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/1VA - Disco Nostalgia of 80s vol.1 (2008) [FLAC] NP in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/50 év magyar dalai Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/50 év magyar dalai in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Abba - ABBA_DSD_Stig Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Abba - ABBA_DSD_Stig in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Acker Bilk - [1990] The Greatest Hits of Acker Bilk Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Acker Bilk - [1990] The Greatest Hits of Acker Bilk in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Bikini-1992-Búcsúkoncert 1992 BS-Scans Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Bikini-1992-Búcsúkoncert 1992 BS-Scans in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Cabinet Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Cabinet in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Club Hits From The 70s To The 80s -3 CD Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Club Hits From The 70s To The 80s -3 CD in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Die Hit Giganten Best Of 70 Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Die Hit Giganten Best Of 70 in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Glenn Philips Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Glenn Philips in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Otto Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Otto in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/VA - 70s - School Days - The Ultimate Collection (2017) [FLAC 5CD] Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/VA - 70s - School Days - The Ultimate Collection (2017) [FLAC 5CD] in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/VA - 70s one-hit wonders (compilation 2005.) Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/VA - 70s one-hit wonders (compilation 2005.) in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/VA - Ultimate... 70s [4CD] (2015) [FLAC] Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/VA - Ultimate... 70s [4CD] (2015) [FLAC] in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Adding Item to queue: music-library/NAS/PC/Various Artists - The Nation's Favourite 70s Number Ones (2015) [FLAC] Apr 08 16:36:14 volumio volumio[2496]: info: Exploding uri music-library/NAS/PC/Various Artists - The Nation's Favourite 70s Number Ones (2015) [FLAC] in service mpd Apr 08 16:36:14 volumio volumio[2496]: info: Apr 08 16:36:14 volumio volumio[2496]: ---------------------------- MPD announces state update: player Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F01%20-%20We%20Like%20to%20Party!.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/01 - We Like to Party!.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F02%20-%20Boom%2C%20Boom%2C%20Boom%2C%20Boom!!.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/02 - Boom, Boom, Boom, Boom!!.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F03%20-%20Ho%20Ho%20Vengaboys!.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/03 - Ho Ho Vengaboys!.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F04%20-%20Up%20%26%20Down.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/04 - Up & Down.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F05%20-%20We're%20Going%20to%20Ibiza.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/05 - We're Going to Ibiza.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F06%20-%20Parada%20de%20Tettas.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/06 - Parada de Tettas.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F07%20-%20To%20Brazil!%20(Medium%20Radio).flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/07 - To Brazil! (Medium Radio).flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F08%20-%20Movin'%20Around.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/08 - Movin' Around.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F09%20-%20Overwhelm%20Yourself!.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/09 - Overwhelm Yourself!.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F10%20-%20You%20and%20Me.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/10 - You and Me.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F11%20-%20The%20Vengabeat.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/11 - The Vengabeat.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F12%20-%20Paradise....flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/12 - Paradise....flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F13%20-%20Superfly%20Slick%20Dick.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/13 - Superfly Slick Dick.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F14%20-%20All%20Night%20Passion.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/14 - All Night Passion.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F15%20-%2024%20Hours.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/15 - 24 Hours.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Vengaboys/Greatest%20Hits!%20Part%20I/extralarge&path=%2Fmnt%2FNAS%2FPC%2F!Collection%20-%20Vengaboys%2F1998%20-%20Greatest%20Hits!%20Part%20I%20(KRAK%204033)%2F16%20-%20To%20the%20Rhythm!.flac&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/!Collection - Vengaboys/1998 - Greatest Hits! Part I (KRAK 4033)/16 - To the Rhythm!.flac Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=John%20Lennon/DISCO%20Nostalgia%20of%2080s%20vol.1/extralarge&path=%2Fmnt%2FNAS%2FPC%2F1VA%20-%20Disco%20Nostalgia%20of%2080s%20vol.1%20(2008)%20%5BFLAC%5D%20NP%2FVarious%20-%20DISCO%20Nostalgia%20of%2080s%20vol.1.cue&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/1VA - Disco Nostalgia of 80s vol.1 (2008) [FLAC] NP/Various - DISCO Nostalgia of 80s vol.1.cue Apr 08 16:36:14 volumio volumio[2496]: info: ALBUMART /albumart?cacheid=645&web=Roxette/DISCO%20Nostalgia%20of%2080s%20vol.1/extralarge&path=%2Fmnt%2FNAS%2FPC%2F1VA%20-%20Disco%20Nostalgia%20of%2080s%20vol.1%20(2008)%20%5BFLAC%5D%20NP%2FVarious%20-%20DISCO%20Nostalgia%20of%2080s%20vol.1.cue&metadata=false Apr 08 16:36:14 volumio volumio[2496]: info: URI /mnt/NAS/PC/1VA - Disco Nostalgia of 80s vol.1 (2008) [FLAC] NP/Various - DISCO Nostalgia of 80s vol.1.cue Apr 08 16:36:14 volumio volumio[2496]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 08 16:36:14 volumio volumio[2496]: Error: Unable to resolve or reject the same promise twice Apr 08 16:36:14 volumio volumio[2496]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 08 16:36:14 volumio volumio[2496]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 08 16:36:14 volumio volumio[2496]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 08 16:36:14 volumio volumio[2496]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 08 16:36:14 volumio volumio[2496]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 08 16:36:14 volumio volumio[2496]: at Socket.emit (events.js:315:20) Apr 08 16:36:14 volumio volumio[2496]: at addChunk (internal/streams/readable.js:309:12) Apr 08 16:36:14 volumio volumio[2496]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 08 16:36:14 volumio volumio[2496]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 08 16:36:14 volumio volumio[2496]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 08 16:36:14 volumio volumio[2496]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 08 16:36:14 volumio sudo[2863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-08 16:35 Apr 08 16:36:14 volumio sudo[2863]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:14 volumio sudo[2863]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:14 volumio volumio-remote-updater[599]: [2024-04-08 16:36:14] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 08 16:36:14 volumio volumio-remote-updater[599]: [2024-04-08 16:36:14] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 08 16:36:14 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 08 16:36:14 volumio ntfs-3g[2549]: Unmounting /dev/sdb2 (2) Apr 08 16:36:14 volumio ntfs-3g[2541]: Unmounting /dev/sdb1 (1) Apr 08 16:36:14 volumio systemd[1]: media-4.mount: Succeeded. Apr 08 16:36:14 volumio ntfs-3g[2557]: Unmounting /dev/sdb3 (3) Apr 08 16:36:14 volumio systemd[1]: media-3.mount: Succeeded. Apr 08 16:36:14 volumio ntfs-3g[2565]: Unmounting /dev/sdb4 (4) Apr 08 16:36:14 volumio systemd[1]: media-2.mount: Succeeded. Apr 08 16:36:14 volumio systemd[1]: media-1.mount: Succeeded. Apr 08 16:36:14 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 08 16:36:14 volumio systemd[1]: Started dynamicswap service. Apr 08 16:36:14 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 08 16:36:14 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 08 16:36:14 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Apr 08 16:36:14 volumio systemd[1]: Started dynamicswap service. Apr 08 16:36:14 volumio systemd[1]: Stopped Volumio Backend Module. Apr 08 16:36:14 volumio systemd[1]: Started Volumio Backend Module. Apr 08 16:36:14 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 08 16:36:15 volumio volumio[2879]: info: ------------------------------------------- Apr 08 16:36:15 volumio volumio[2879]: info: ----- Volumio3 ---- Apr 08 16:36:15 volumio volumio[2879]: info: ------------------------------------------- Apr 08 16:36:15 volumio volumio[2879]: info: ----- System startup ---- Apr 08 16:36:15 volumio volumio[2879]: info: ------------------------------------------- Apr 08 16:36:15 volumio volumio[2879]: info: MYVOLUMIO Environment detected Apr 08 16:36:15 volumio volumio[2879]: info: Plugin folders cleanup Apr 08 16:36:15 volumio volumio[2879]: info: Scanning into folder /volumio/app/plugins/ Apr 08 16:36:15 volumio volumio[2879]: info: Scanning category audio_interface Apr 08 16:36:15 volumio volumio[2879]: info: Scanning category miscellanea Apr 08 16:36:15 volumio volumio[2879]: info: Scanning category music_service Apr 08 16:36:15 volumio volumio[2879]: info: Scanning category plugins.json Apr 08 16:36:15 volumio volumio[2879]: info: Scanning category system_controller Apr 08 16:36:15 volumio volumio[2879]: info: Scanning category user_interface Apr 08 16:36:15 volumio volumio[2879]: info: Scanning into folder /data/plugins/ Apr 08 16:36:15 volumio volumio[2879]: info: Scanning category music_service Apr 08 16:36:15 volumio volumio[2879]: info: Plugin folders cleanup completed Apr 08 16:36:15 volumio volumio[2879]: info: ------------------------------------------- Apr 08 16:36:15 volumio volumio[2879]: info: ----- Core plugins startup ---- Apr 08 16:36:15 volumio volumio[2879]: info: ------------------------------------------- Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugins from folder /volumio/app/plugins/ Apr 08 16:36:15 volumio volumio[2879]: info: Adding plugin upnp to MyMusic Plugins Apr 08 16:36:15 volumio volumio[2879]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 08 16:36:15 volumio volumio[2879]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugins from folder /data/plugins/ Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "system"... Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "appearance"... Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "network"... Apr 08 16:36:15 volumio volumio[2879]: info: Refreshing Cached IP Addresses Apr 08 16:36:15 volumio sudo[2905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 08 16:36:15 volumio sudo[2905]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:15 volumio sudo[2905]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:15 volumio sudo[2907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 08 16:36:15 volumio sudo[2907]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "services"... Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "alsa_controller"... Apr 08 16:36:15 volumio sudo[2907]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:15 volumio sudo[2910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 08 16:36:15 volumio sudo[2910]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:15 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "wizard"... Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "networkfs"... Apr 08 16:36:15 volumio volumio[2879]: info: Cannot mount NAS PC at system boot, trial number 1 ,retrying in 5 seconds Apr 08 16:36:15 volumio volumio[2879]: info: Starting Udev Watcher for removable devices Apr 08 16:36:15 volumio volumio[2879]: info: Mounting Device 1 Apr 08 16:36:15 volumio sudo[2921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/1 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio sudo[2921]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:15 volumio ntfs-3g[2924]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 08 16:36:15 volumio ntfs-3g[2924]: Mounted /dev/sdb1 (Read-Write, label "1", NTFS 3.1) Apr 08 16:36:15 volumio ntfs-3g[2924]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio ntfs-3g[2924]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 Apr 08 16:36:15 volumio ntfs-3g[2924]: Global ownership and permissions enforced, configuration type 7 Apr 08 16:36:15 volumio sudo[2921]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:15 volumio volumio[2879]: info: Mounting Device 2 Apr 08 16:36:15 volumio sudo[2929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb2 /mnt/USB/2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio sudo[2929]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:15 volumio ntfs-3g[2933]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 08 16:36:15 volumio ntfs-3g[2933]: Mounted /dev/sdb2 (Read-Write, label "2", NTFS 3.1) Apr 08 16:36:15 volumio ntfs-3g[2933]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio ntfs-3g[2933]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb2,blkdev,blksize=4096 Apr 08 16:36:15 volumio ntfs-3g[2933]: Global ownership and permissions enforced, configuration type 7 Apr 08 16:36:15 volumio sudo[2929]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:15 volumio volumio[2879]: info: Mounting Device 3 Apr 08 16:36:15 volumio sudo[2938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb3 /mnt/USB/3 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio sudo[2938]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:15 volumio ntfs-3g[2941]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 08 16:36:15 volumio ntfs-3g[2941]: Mounted /dev/sdb3 (Read-Write, label "3", NTFS 3.1) Apr 08 16:36:15 volumio ntfs-3g[2941]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio ntfs-3g[2941]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb3,blkdev,blksize=4096 Apr 08 16:36:15 volumio ntfs-3g[2941]: Global ownership and permissions enforced, configuration type 7 Apr 08 16:36:15 volumio sudo[2938]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:15 volumio volumio[2879]: info: Mounting Device 4 Apr 08 16:36:15 volumio sudo[2946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb4 /mnt/USB/4 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio sudo[2946]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:15 volumio ntfs-3g[2949]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 08 16:36:15 volumio ntfs-3g[2949]: Mounted /dev/sdb4 (Read-Write, label "4", NTFS 3.1) Apr 08 16:36:15 volumio ntfs-3g[2949]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio ntfs-3g[2949]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb4,blkdev,blksize=4096 Apr 08 16:36:15 volumio ntfs-3g[2949]: Global ownership and permissions enforced, configuration type 7 Apr 08 16:36:15 volumio sudo[2946]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:15 volumio volumio[2879]: info: Mounting Device SONY_32CA2 Apr 08 16:36:15 volumio sudo[2954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/SONY_32CA2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio sudo[2954]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:15 volumio sudo[2954]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:15 volumio volumio[2879]: mount: /media/SONY_32CA2: /dev/sda1 already mounted on /media/SONY_32CA2. Apr 08 16:36:15 volumio volumio[2879]: error: Failed to mount SONY_32CA2: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/SONY_32CA2" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 16:36:15 volumio volumio[2879]: mount: /media/SONY_32CA2: /dev/sda1 already mounted on /media/SONY_32CA2. Apr 08 16:36:15 volumio volumio[2879]: info: Ignoring mount for partition: boot Apr 08 16:36:15 volumio volumio[2879]: info: Ignoring mount for partition: volumio Apr 08 16:36:15 volumio volumio[2879]: info: Ignoring mount for partition: volumio_data Apr 08 16:36:15 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "volumio_command_line_client"... Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "upnp"... Apr 08 16:36:15 volumio volumio[2879]: info: [1712586975936] Starting Upmpd Daemon Apr 08 16:36:15 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "my_music"... Apr 08 16:36:15 volumio volumio[2879]: info: Loading plugin "mpd"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "upnp_browser"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "alarm-clock"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "airplay_emulation"... Apr 08 16:36:16 volumio volumio[2879]: info: Starting Shairport Sync Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "last_100"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "webradio"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "i2s_dacs"... Apr 08 16:36:16 volumio volumio[2879]: info: I2S DAC not set, start Auto-detection Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "volumiodiscovery"... Apr 08 16:36:16 volumio volumio[2879]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 08 16:36:16 volumio node[2879]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 08 16:36:16 volumio volumio[2879]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 08 16:36:16 volumio node[2879]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 08 16:36:16 volumio volumio[2879]: *** WARNING *** For more information see Apr 08 16:36:16 volumio node[2879]: *** WARNING *** For more information see Apr 08 16:36:16 volumio volumio[2879]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 08 16:36:16 volumio node[2879]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 08 16:36:16 volumio volumio[2879]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 08 16:36:16 volumio node[2879]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 08 16:36:16 volumio volumio[2879]: *** WARNING *** For more information see Apr 08 16:36:16 volumio node[2879]: *** WARNING *** For more information see Apr 08 16:36:16 volumio volumio[2879]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 08 16:36:16 volumio volumio[2879]: info: Discovery: Started advertising with name: Volumio Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "youtube2"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "outputs"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "albumart"... Apr 08 16:36:16 volumio volumio[2879]: info: Plugin example_plugin is not enabled Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "inputs"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "updater_comm"... Apr 08 16:36:16 volumio volumio[2879]: info: Plugin mpdemulation is not enabled Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "rest_api"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading plugin "websocket"... Apr 08 16:36:16 volumio volumio[2879]: info: Loading i18n strings for locale hu Apr 08 16:36:16 volumio volumio[2879]: Updating browse sources language Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::initPlayerControls Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: Express server listening on port 3000 Apr 08 16:36:16 volumio volumio[2879]: [Metrics] WebUI: 1s 423.10ms Apr 08 16:36:16 volumio volumio[2879]: Forking 3 albumart workers Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::resetVolumioState Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::getcurrentVolume Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioRetrievevolume Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:16 volumio volumio[2879]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.199 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 1 Apr 08 16:36:16 volumio volumio[2879]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.199 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 2 Apr 08 16:36:16 volumio volumio[2879]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.199 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 3 Apr 08 16:36:16 volumio volumio[2879]: info: Reloading queue from file Apr 08 16:36:16 volumio volumio[2879]: info: VolumeController:: Volume=46 Mute =false Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::pushState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::updateTrackBlock Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrackBlock Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioRetrievevolume Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::setRepeat null single undefined Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::pushState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::setRandom null Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::pushState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:16 volumio volumio[2879]: info: Setting Device type: Raspberry PI Apr 08 16:36:16 volumio volumio[2879]: Starting albumart workers Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: Starting albumart workers Apr 08 16:36:16 volumio volumio[2879]: Starting albumart workers Apr 08 16:36:16 volumio volumio[2879]: info: Received Get System Info Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 08 16:36:16 volumio volumio[2879]: info: Discovery: Getting this device information Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioGetVisibleSources Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioGetQueue Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::getQueue Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getQueue Apr 08 16:36:16 volumio volumio[2879]: info: Listing playlists Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 08 16:36:16 volumio volumio[2879]: info: Received Get System Info Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 08 16:36:16 volumio volumio[2879]: info: Discovery: Getting this device information Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: VolumeController:: Volume=46 Mute =false Apr 08 16:36:16 volumio volumio[2879]: info: CoreStateMachine::pushState Apr 08 16:36:16 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:16 volumio volumio[2879]: info: CoreCommandRouter::volumioPushState Apr 08 16:36:17 volumio volumio[2879]: info: Discovery: adding e600d3dc-3efc-4c2a-b095-8c966e6af18e Apr 08 16:36:17 volumio volumio[2879]: info: Discovery: Found device Volumio Apr 08 16:36:17 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:17 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:17 volumio volumio[2879]: info: Discovery: this is already registered, e600d3dc-3efc-4c2a-b095-8c966e6af18e Apr 08 16:36:17 volumio volumio[2879]: info: Discovery: Found device Volumio Apr 08 16:36:17 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:17 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:19 volumio sudo[2910]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:19 volumio volumio-remote-updater[599]: [2024-04-08 16:36:19] [connect] Successful connection Apr 08 16:36:19 volumio volumio-remote-updater[599]: [2024-04-08 16:36:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712586979 101 Apr 08 16:36:19 volumio volumio[2879]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 4 Apr 08 16:36:20 volumio volumio[2879]: info: Cannot mount NAS PC at system boot, trial number 2 ,retrying in 5 seconds Apr 08 16:36:21 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:36:21 volumio volumio[2879]: info: CURURI: music-library/NAS/PC/Glenn Philips Apr 08 16:36:21 volumio volumio[2879]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Apr 08 16:36:25 volumio volumio[2879]: info: Cannot mount NAS PC at system boot, trial number 3 ,retrying in 5 seconds Apr 08 16:36:25 volumio sudo[3026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 08 16:36:25 volumio sudo[3026]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:25 volumio sudo[3026]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:25 volumio sudo[3028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 08 16:36:25 volumio sudo[3028]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:25 volumio sudo[3028]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:25 volumio sudo[3032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 08 16:36:25 volumio sudo[3032]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:25 volumio sudo[3032]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:25 volumio volumio[2879]: info: Upmpdcli Daemon Started Apr 08 16:36:26 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:36:26 volumio volumio[2879]: info: CURURI: music-library Apr 08 16:36:26 volumio volumio[2879]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Apr 08 16:36:30 volumio volumio[2879]: info: Cannot mount NAS PC at system boot, trial number 4 ,retrying in 5 seconds Apr 08 16:36:35 volumio volumio[2879]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Apr 08 16:36:43 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 16:36:43 volumio volumio[2879]: info: CURURI: music-library Apr 08 16:36:43 volumio volumio[2879]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Apr 08 16:36:46 volumio volumio[2879]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion Apr 08 16:36:46 volumio volumio[2879]: info: Preparing to generate the ALSA configuration file Apr 08 16:36:46 volumio volumio[2879]: info: Asound.conf file unchanged, so no further update is needed Apr 08 16:36:46 volumio volumio[2879]: info: Output device has changed, restarting MPD Apr 08 16:36:46 volumio sudo[3074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 08 16:36:46 volumio sudo[3074]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:46 volumio volumio[2879]: info: Output device has changed, restarting Shairport Sync Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:46 volumio sudo[3074]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:46 volumio sudo[3077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 08 16:36:46 volumio sudo[3077]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:46 volumio systemd[1]: Stopping Music Player Daemon... Apr 08 16:36:46 volumio volumio[2879]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 08 16:36:46 volumio volumio[2879]: info: ___________ START PLUGINS ___________ Apr 08 16:36:46 volumio volumio[2879]: info: ControllerMpd::onStart: Initializing MPD Apr 08 16:36:46 volumio volumio[2879]: info: Creating MPD Configuration file Apr 08 16:36:46 volumio systemd[1]: mpd.service: Succeeded. Apr 08 16:36:46 volumio systemd[1]: Stopped Music Player Daemon. Apr 08 16:36:46 volumio sudo[3083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 08 16:36:46 volumio sudo[3083]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:46 volumio systemd[1]: Starting Music Player Daemon... Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 08 16:36:46 volumio volumio[2879]: info: [1712587006527] CoreMusicLibrary::Adding element Médiaszerverek Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:46 volumio sudo[3083]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:46 volumio sudo[3086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 08 16:36:46 volumio sudo[3086]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:46 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 08 16:36:46 volumio systemd[1]: mpd.service: Succeeded. Apr 08 16:36:46 volumio systemd[1]: Stopped Music Player Daemon. Apr 08 16:36:46 volumio systemd[1]: Starting Music Player Daemon... Apr 08 16:36:46 volumio volumio[2879]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 08 16:36:46 volumio volumio[2879]: info: [1712587006570] CoreMusicLibrary::Adding element Last_100 Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 08 16:36:46 volumio volumio[2879]: info: [1712587006571] CoreMusicLibrary::Adding element Webradio Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 08 16:36:46 volumio volumio[2879]: info: [1712587006574] CoreMusicLibrary::Adding element YouTube2 Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 08 16:36:46 volumio volumio[2879]: Cannot find translation for source YouTube2 Apr 08 16:36:46 volumio volumio[2879]: info: Volumio Calling Home Apr 08 16:36:46 volumio volumio[2879]: info: MPD Permissions set Apr 08 16:36:46 volumio volumio[2879]: info: MPD Permissions set Apr 08 16:36:46 volumio volumio[2879]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 16:36:46 volumio volumio[2879]: info: Starting Shairport Sync Apr 08 16:36:46 volumio volumio[2879]: info: Starting Shairport Sync Apr 08 16:36:46 volumio sudo[3108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 08 16:36:46 volumio sudo[3108]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:46 volumio volumio[2879]: info: Starting Shairport Sync Apr 08 16:36:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 08 16:36:46 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 08 16:36:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 08 16:36:46 volumio sudo[3111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 08 16:36:46 volumio sudo[3111]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:46 volumio sudo[3113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 08 16:36:46 volumio sudo[3113]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 08 16:36:46 volumio volumio[2879]: info: CoreCommandRouter::volumioGetState Apr 08 16:36:46 volumio volumio[2879]: info: CorePlayQueue::getTrack 0 Apr 08 16:36:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 08 16:36:46 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 08 16:36:46 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 08 16:36:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 08 16:36:46 volumio sudo[3108]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:46 volumio volumio[2879]: info: Shairport-Sync Started Apr 08 16:36:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 08 16:36:46 volumio volumio[2879]: Error adding Membership: Error: addMembership EINVAL Apr 08 16:36:46 volumio volumio[2879]: info: Volumio called home Apr 08 16:36:46 volumio sudo[3111]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:46 volumio sudo[3113]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:46 volumio volumio[2879]: info: Shairport-Sync Started Apr 08 16:36:46 volumio volumio[2879]: info: Shairport-Sync Started Apr 08 16:36:46 volumio mpd[3092]: Apr 08 16:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 08 16:36:46 volumio systemd[1]: Started Music Player Daemon. Apr 08 16:36:46 volumio sudo[3086]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:46 volumio sudo[3077]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:46 volumio volumio[2879]: info: Completed starting Core Plugins Apr 08 16:36:46 volumio volumio[2879]: info: ------------------------------------------- Apr 08 16:36:46 volumio volumio[2879]: info: ----- MyVolumio plugins startup ---- Apr 08 16:36:46 volumio volumio[2879]: info: ------------------------------------------- Apr 08 16:36:46 volumio volumio[2879]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 08 16:36:46 volumio volumio[2879]: error: MPD error: The expression evaluated to a falsy value: Apr 08 16:36:46 volumio volumio[2879]: assert.ok(self.idling) Apr 08 16:36:46 volumio volumio[2879]: error: The expression evaluated to a falsy value: Apr 08 16:36:46 volumio volumio[2879]: assert.ok(self.idling) Apr 08 16:36:46 volumio volumio[2879]: error: updateQueue error: null Apr 08 16:36:46 volumio volumio[2879]: info: MPD running with PID3092 Apr 08 16:36:46 volumio volumio[2879]: ,establishing connection Apr 08 16:36:46 volumio volumio[2879]: error: updateQueue error: null Apr 08 16:36:50 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 08 16:36:50 volumio volumio[2879]: info: Preload queue cleared Apr 08 16:36:52 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 08 16:36:52 volumio volumio[2879]: info: Preload queue cleared Apr 08 16:36:54 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 08 16:36:54 volumio volumio[2879]: info: Preload queue cleared Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 08 16:36:55 volumio volumio[2879]: info: Adding plugin bluetooth to MyMusic Plugins Apr 08 16:36:55 volumio volumio[2879]: info: Adding plugin multiroom to MyMusic Plugins Apr 08 16:36:55 volumio volumio[2879]: info: Adding plugin metavolumio to MyMusic Plugins Apr 08 16:36:55 volumio volumio[2879]: info: Adding plugin cd_controller to MyMusic Plugins Apr 08 16:36:55 volumio volumio[2879]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 08 16:36:55 volumio volumio[2879]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 08 16:36:55 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:55 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:55 volumio volumio[2879]: info: Starting MyVolumio Remote Streaming Endpoints Apr 08 16:36:55 volumio volumio[2879]: info: MyVolumio login type: Token Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 08 16:36:55 volumio volumio[2879]: info: Starting Streaming Service Transparent Proxy Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 08 16:36:55 volumio volumio[2879]: info: Streaming services startup Apr 08 16:36:55 volumio volumio[2879]: info: Starting Streaming Daemon Apr 08 16:36:55 volumio sudo[3131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 08 16:36:55 volumio sudo[3131]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:55 volumio sudo[3131]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:55 volumio volumio[2879]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 08 16:36:55 volumio volumio[2879]: error: Cannot start Volumio Streaming Daemon Apr 08 16:36:55 volumio volumio[2879]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 08 16:36:55 volumio volumio[2879]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 08 16:36:55 volumio volumio[2879]: STREAMING PROXY: Starting server on port 3245 Apr 08 16:36:55 volumio volumio[2879]: Node JS runtime: 14 Apr 08 16:36:56 volumio volumio[2879]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 08 16:36:57 volumio volumio[2879]: info: MyVolumio token set successfully Apr 08 16:36:57 volumio volumio[2879]: info: MYVOLUMIO: Adding device Apr 08 16:36:57 volumio volumio[2879]: info: MYVOLUMIO: Evaluating Server Apr 08 16:36:57 volumio volumio[2879]: info: MyVolumio status changed Apr 08 16:36:57 volumio volumio[2879]: info: Streaming services startup Apr 08 16:36:57 volumio volumio[2879]: info: Starting Streaming Daemon Apr 08 16:36:57 volumio volumio[2879]: info: Removing browser output: myVolumio user plan is not superstar Apr 08 16:36:57 volumio volumio[2879]: info: Removing audio output: Apr 08 16:36:57 volumio volumio[2879]: info: Stoppping Tunnel 1 Apr 08 16:36:57 volumio sudo[3157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 08 16:36:57 volumio sudo[3157]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:57 volumio sudo[3160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 08 16:36:57 volumio sudo[3157]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:57 volumio sudo[3160]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 16:36:57 volumio volumio[2879]: error: Cannot start Volumio Streaming Daemon Apr 08 16:36:57 volumio volumio[2879]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 08 16:36:57 volumio volumio[2879]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 08 16:36:57 volumio sudo[3160]: pam_unix(sudo:session): session closed for user root Apr 08 16:36:57 volumio volumio[2879]: info: Remote SSH Stopped Apr 08 16:36:57 volumio volumio[2879]: info: Setting Geolocation for MyVolumio to eu6 Apr 08 16:36:57 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:57 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:57 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 16:36:57 volumio volumio[2879]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 08 16:36:57 volumio volumio[2879]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 08 16:36:57 volumio volumio[2879]: TypeError: Cannot read property 'length' of undefined Apr 08 16:36:57 volumio volumio[2879]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Apr 08 16:36:57 volumio volumio[2879]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Apr 08 16:36:57 volumio volumio[2879]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Apr 08 16:36:57 volumio volumio[2879]: at Parser.emit (events.js:315:20) Apr 08 16:36:57 volumio volumio[2879]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Apr 08 16:36:57 volumio volumio[2879]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Apr 08 16:36:57 volumio volumio[2879]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Apr 08 16:36:57 volumio volumio[2879]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Apr 08 16:36:57 volumio volumio[2879]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Apr 08 16:36:57 volumio volumio[2879]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Apr 08 16:36:57 volumio volumio[2879]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Apr 08 16:36:57 volumio volumio[2879]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Apr 08 16:36:57 volumio volumio[2879]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Apr 08 16:36:57 volumio volumio[2879]: at IncomingMessage.emit (events.js:327:22) Apr 08 16:36:57 volumio volumio[2879]: at endReadableNT (internal/streams/readable.js:1327:12) Apr 08 16:36:57 volumio volumio[2879]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 08 16:36:57 volumio volumio[2879]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 08 16:36:58 volumio sudo[3171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-08 16:35 Apr 08 16:36:58 volumio sudo[3171]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"