-- Logs begin at Sun 2024-10-13 13:53:29 EDT, end at Sat 2024-10-19 11:25:23 EDT. -- Oct 19 11:24:00 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preload queue cleared Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@58024078c5acad17747a Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@a53960cf153d074668fd Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@da676b7ddcb373acacac Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@cbb7171f1d859ec6eb63 Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@bc1532f6dbda82688cde Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@d083a0581775da858144 Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2b3ab836c40970c28d5f Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@7adb64e2e91be9945efc Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@824777958aff9dcda0ee Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fe1a698d939cb2128e27 Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@72c81676b149c5db6799 Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@d7b480589c795e26dd76 Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@58024078c5acad17747a in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@a53960cf153d074668fd in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@da676b7ddcb373acacac in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@cbb7171f1d859ec6eb63 in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@bc1532f6dbda82688cde in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@d083a0581775da858144 in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2b3ab836c40970c28d5f in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@7adb64e2e91be9945efc in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@824777958aff9dcda0ee in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fe1a698d939cb2128e27 in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@72c81676b149c5db6799 in service upnp_browser Oct 19 11:24:01 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@d7b480589c795e26dd76 in service upnp_browser Oct 19 11:24:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 11:24:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 11:24:04 volumio--primo-hi-fi-edition volumio[1071]: info: Discovery: Getting this device information Oct 19 11:24:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetState Oct 19 11:24:04 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 8 Oct 19 11:24:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 19 11:24:17 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 11:24:18 volumio--primo-hi-fi-edition volumio[1071]: info: Preload queue cleared Oct 19 11:24:21 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 11:24:21 volumio--primo-hi-fi-edition volumio[1071]: info: Preload queue cleared Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preload queue cleared Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@56229bea72e75e5e5fcb Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@0575309fa5e51bf1961e Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fa64c17febe758241f59 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5a8c997175d4462e9548 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@beb0b37bb6cc220439bc Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@649296d9ecd333cd70d0 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@4cec62905b86c67ca108 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@e7396809d68383285f60 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5dca850a6ea6653c83e7 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@1a72546d97c7df2a297e Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5051b9346d61912d9cdc Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fbb8d9c2a23ce964481d Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@48e042f93f6a0ad463ea Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@ae27a0d9521cd0c3b8c5 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2a8b2d1af45ec0ecaa98 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2764edb3c0b6afe0f211 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Preloading song: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@dce7c4b42404b3fb8068 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@56229bea72e75e5e5fcb in service upnp_browser Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@0575309fa5e51bf1961e in service upnp_browser Oct 19 11:24:30 volumio--primo-hi-fi-edition volumiologrotate[567]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fa64c17febe758241f59 in service upnp_browser Oct 19 11:24:30 volumio--primo-hi-fi-edition volumiologrotate[567]: ls: cannot access 'PRIMO': No such file or directory Oct 19 11:24:30 volumio--primo-hi-fi-edition volumiologrotate[567]: ls: cannot access 'HI-FI': No such file or directory Oct 19 11:24:30 volumio--primo-hi-fi-edition volumiologrotate[567]: ls: cannot access 'EDITION': No such file or directory Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5a8c997175d4462e9548 in service upnp_browser Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@beb0b37bb6cc220439bc in service upnp_browser Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@649296d9ecd333cd70d0 in service upnp_browser Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@4cec62905b86c67ca108 in service upnp_browser Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Received Get System Info Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Discovery: Getting this device information Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetState Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 8 Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@e7396809d68383285f60 in service upnp_browser Oct 19 11:24:30 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5dca850a6ea6653c83e7 in service upnp_browser Oct 19 11:24:31 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@1a72546d97c7df2a297e in service upnp_browser Oct 19 11:24:31 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5051b9346d61912d9cdc in service upnp_browser Oct 19 11:24:31 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fbb8d9c2a23ce964481d in service upnp_browser Oct 19 11:24:31 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@48e042f93f6a0ad463ea in service upnp_browser Oct 19 11:24:31 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@ae27a0d9521cd0c3b8c5 in service upnp_browser Oct 19 11:24:31 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2a8b2d1af45ec0ecaa98 in service upnp_browser Oct 19 11:24:31 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2764edb3c0b6afe0f211 in service upnp_browser Oct 19 11:24:31 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@dce7c4b42404b3fb8068 in service upnp_browser Oct 19 11:24:34 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 11:24:34 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 11:24:34 volumio--primo-hi-fi-edition volumio[1071]: info: Discovery: Getting this device information Oct 19 11:24:34 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetState Oct 19 11:24:34 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 8 Oct 19 11:24:34 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Preload queue cleared Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::ClearQueue Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::stop Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::updateTrackBlock Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrackBlock Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::stPlaybackTimer Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 8 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::serviceStop Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 8 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::serviceStop Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: [1729351485834] ControllerUPNPBrowser::stop Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::clearPlayQueue Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::saveQueue Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushQueue Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::addQueueItems Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::addQueueItems Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Preload queue cleared Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/folder/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@48d30f1e434b21e09d26 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Exploding uri upnp/folder/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@48d30f1e434b21e09d26 in service upnp_browser Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@56229bea72e75e5e5fcb Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@56229bea72e75e5e5fcb Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@0575309fa5e51bf1961e Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@0575309fa5e51bf1961e Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fa64c17febe758241f59 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fa64c17febe758241f59 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5a8c997175d4462e9548 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5a8c997175d4462e9548 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@beb0b37bb6cc220439bc Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@beb0b37bb6cc220439bc Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@649296d9ecd333cd70d0 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@649296d9ecd333cd70d0 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@4cec62905b86c67ca108 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@4cec62905b86c67ca108 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@e7396809d68383285f60 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@e7396809d68383285f60 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5dca850a6ea6653c83e7 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5dca850a6ea6653c83e7 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@1a72546d97c7df2a297e Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@1a72546d97c7df2a297e Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5051b9346d61912d9cdc Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@5051b9346d61912d9cdc Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fbb8d9c2a23ce964481d Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@fbb8d9c2a23ce964481d Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@48e042f93f6a0ad463ea Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@48e042f93f6a0ad463ea Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@ae27a0d9521cd0c3b8c5 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@ae27a0d9521cd0c3b8c5 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2a8b2d1af45ec0ecaa98 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2a8b2d1af45ec0ecaa98 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2764edb3c0b6afe0f211 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@2764edb3c0b6afe0f211 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Adding Item to queue: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@dce7c4b42404b3fb8068 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Using cached record of: upnp/http://192.168.2.119:32469/ContentDirectory/8bb6d568-61ab-79fd-9ffd-39f65135b296/control.xml@dce7c4b42404b3fb8068 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: ---------------------------- MPD announces state update: player Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand stop took 69 milliseconds Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: ControllerMpd::getState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand status Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand status took 7 milliseconds Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::parseState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::parseTrackInfo Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: ControllerMpd::pushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::servicePushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 8 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 8 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: 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":"Never Going Back Again [ Live ]","artist":"Fleetwood Mac","album":"Don't Stop : 50 Years ( Standard Edition )","uri":"http://192.168.2.119:32469/object/c9f6e9eeeab170a7214d/file.flac","trackType":"flac"} Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: verbose: CURRENT POSITION 8 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::syncState stateService stop Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::syncState currentStatus stop Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 8 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: No code Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 8 Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:45 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ------------------------------ 109ms Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushQueue Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::saveQueue Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::updateTrackBlock Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrackBlock Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPlay Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::play index 1 Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::stop Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::play index undefined Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 1 Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::startPlaybackTimer Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 1 Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: [1729351486250] ControllerUPNPBrowser::clearAddPlayTrack Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand stop took 5 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand clear Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: ---------------------------- MPD announces system playlist update Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Ignoring MPD Status Update Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand clear took 4 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.2.119:32469/object/0575309fa5e51bf1961e/file.flac" Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: error: updateQueue error: null Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ------------------------------ 8ms Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.2.119:32469/object/0575309fa5e51bf1961e/file.flac" Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: ---------------------------- MPD announces system playlist update Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Ignoring MPD Status Update Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand add "http://192.168.2.119:32469/object/0575309fa5e51bf1961e/file.flac" took 7 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand play Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ------------------------------ 10ms Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand play took 5 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: ---------------------------- MPD announces state update: player Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ControllerMpd::getState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand status Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: ---------------------------- MPD announces state update: player Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ControllerMpd::getState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand status Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand status took 7 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::parseState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand status took 8 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand playlistinfo took 25 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::parseState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::parseTrackInfo Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ControllerMpd::pushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::servicePushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 1 Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.2.119:32469/object/0575309fa5e51bf1961e/file.flac","trackType":"flac"} Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: CURRENT POSITION 1 Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::syncState stateService play Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::syncState currentStatus stop Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ------------------------------ 86ms Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: ---------------------------- MPD announces system playlist update Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Ignoring MPD Status Update Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: ---------------------------- MPD announces state update: player Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand playlistinfo took 67 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ControllerMpd::getState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand status Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::parseTrackInfo Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ControllerMpd::pushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::servicePushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 1 Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.2.119:32469/object/0575309fa5e51bf1961e/file.flac","trackType":"flac"} Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: CURRENT POSITION 1 Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::syncState stateService play Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::syncState currentStatus play Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Received an update from plugin. extracting info from payload Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ------------------------------ 173ms Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ------------------------------ 87ms Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand status took 57 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::parseState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: sendMpdCommand playlistinfo took 19 milliseconds Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: ControllerMpd::parseTrackInfo Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ControllerMpd::pushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::servicePushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getTrack 1 Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"643 Kbps","isStreaming":false,"title":"Another One Bites The Dust","artist":"Queen","album":"Greatest Hits (1981-2011 Remaster)","uri":"http://192.168.2.119:32469/object/0575309fa5e51bf1961e/file.flac","trackType":"flac"} Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: verbose: CURRENT POSITION 1 Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::syncState stateService play Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::syncState currentStatus play Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: Received an update from plugin. extracting info from payload Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: ------------------------------ 132ms Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:46 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:50 volumio--primo-hi-fi-edition volumio[1071]: info: Executing endpoint metavolumio Oct 19 11:24:50 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 19 11:24:50 volumio--primo-hi-fi-edition volumio[1071]: info: Executing endpoint metavolumio Oct 19 11:24:50 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 19 11:24:50 volumio--primo-hi-fi-edition volumio[1071]: info: Executing endpoint metavolumio Oct 19 11:24:50 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:54 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:56 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:57 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume- Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:58 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:24:59 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:25:00 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: Discovery: Getting this device information Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetState Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:25:04 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: info: VolumeController::SetAlsaVolume+ Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::pushState Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioPushState Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output update for this device Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: info: MRS: Pushing multiroomSync output Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::volumioGetQueue Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: info: CoreStateMachine::getQueue Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: info: CorePlayQueue::getQueue Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Oct 19 11:25:05 volumio--primo-hi-fi-edition volumio[1071]: xcb_connection_has_error() returned true Oct 19 11:25:21 volumio--primo-hi-fi-edition volumio[1071]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: TypeError: Cannot read property 'length' of undefined Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at Parser.emit (events.js:400:28) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at IncomingMessage.emit (events.js:412:35) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at endReadableNT (internal/streams/readable.js:1333:12) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Oct 19 11:25:22 volumio--primo-hi-fi-edition volumio[1071]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 11:25:23 volumio--primo-hi-fi-edition sudo[19144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-19 11:24 Oct 19 11:25:23 volumio--primo-hi-fi-edition sudo[19144]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:19:36 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="43b87fbef9c19ede18711bdf23c439c5"