-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2024-07-21 16:19:59 UTC. -- Jul 21 16:19:19 volumioat volumio[889]: verbose: New Socket.io Connection to 192.168.0.94 from 192.168.0.192 UA: unknown Total Clients: 4 Jul 21 16:19:19 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:19 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:19 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 21 16:19:19 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 21 16:19:19 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 21 16:19:19 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 21 16:19:19 volumioat volumio[889]: info: Discovery: Getting this device information Jul 21 16:19:19 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:19 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:19 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 21 16:19:20 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 21 16:19:20 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 21 16:19:20 volumioat volumio[889]: info: Discovery: Getting this device information Jul 21 16:19:20 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:20 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:20 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 21 16:19:20 volumioat volumio[889]: verbose: New Socket.io Connection to 192.168.0.115 from 192.168.0.192 UA: unknown Total Clients: 5 Jul 21 16:19:20 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:20 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:20 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 21 16:19:20 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 21 16:19:25 volumioat sudo[2634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 21 16:19:25 volumioat sudo[2634]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:19:25 volumioat sudo[2634]: pam_unix(sudo:session): session closed for user root Jul 21 16:19:25 volumioat sudo[2637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 16:19:25 volumioat sudo[2637]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:19:25 volumioat sudo[2637]: pam_unix(sudo:session): session closed for user root Jul 21 16:19:25 volumioat volumio[889]: verbose: New Socket.io Connection to 192.168.0.115 from 192.168.0.192 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 6 Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::volumioGetVisibleSources Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:25 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 21 16:19:25 volumioat volumio[889]: info: Received Get System Info Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 21 16:19:25 volumioat volumio[889]: info: Discovery: Getting this device information Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:25 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:25 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:25 volumioat volumio[889]: info: Listing playlists Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 21 16:19:25 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 21 16:19:26 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 21 16:19:26 volumioat volumio[889]: info: Received Get System Info Jul 21 16:19:26 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 21 16:19:26 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 21 16:19:26 volumioat volumio[889]: info: Discovery: Getting this device information Jul 21 16:19:26 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:26 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:26 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 21 16:19:26 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 21 16:19:28 volumioat volumio[889]: info: CoreCommandRouter::volumioPlay Jul 21 16:19:28 volumioat volumio[889]: info: CoreStateMachine::play index undefined Jul 21 16:19:28 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 16:19:28 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:28 volumioat volumio[889]: info: CoreStateMachine::startPlaybackTimer Jul 21 16:19:28 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:28 volumioat volumio[889]: info: [1721578768242] ControllerUPNPBrowser::clearAddPlayTrack Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand stop Jul 21 16:19:28 volumioat volumio[889]: info: sendMpdCommand stop took 4 milliseconds Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand clear Jul 21 16:19:28 volumioat volumio[889]: info: sendMpdCommand clear took 1 milliseconds Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4" Jul 21 16:19:28 volumioat volumio[889]: info: Jul 21 16:19:28 volumioat volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 16:19:28 volumioat volumio[889]: info: Ignoring MPD Status Update Jul 21 16:19:28 volumioat volumio[889]: error: Upnp client error: Error: This socket has been ended by the other party Jul 21 16:19:28 volumioat volumio[889]: error: updateQueue error: null Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4" Jul 21 16:19:28 volumioat volumio[889]: info: ------------------------------ 9ms Jul 21 16:19:28 volumioat volumio[889]: info: Jul 21 16:19:28 volumioat volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 16:19:28 volumioat volumio[889]: info: Ignoring MPD Status Update Jul 21 16:19:28 volumioat volumio[889]: info: sendMpdCommand add "http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4" took 3 milliseconds Jul 21 16:19:28 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand play Jul 21 16:19:28 volumioat volumio[889]: info: ------------------------------ 5ms Jul 21 16:19:28 volumioat volumio[889]: info: sendMpdCommand play took 4 milliseconds Jul 21 16:19:28 volumioat volumio[889]: info: Jul 21 16:19:28 volumioat volumio[889]: ---------------------------- MPD announces state update: player Jul 21 16:19:28 volumioat volumio[889]: info: ControllerMpd::getState Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand status Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 21 16:19:28 volumioat volumio[889]: info: sendMpdCommand status took 8 milliseconds Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::parseState Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 16:19:28 volumioat volumio[889]: info: sendMpdCommand clearerror took 4 milliseconds Jul 21 16:19:28 volumioat volumio[889]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 21 16:19:28 volumioat volumio[889]: verbose: ControllerMpd::parseTrackInfo Jul 21 16:19:28 volumioat volumio[889]: info: ControllerMpd::pushState Jul 21 16:19:28 volumioat volumio[889]: info: CoreCommandRouter::servicePushState Jul 21 16:19:28 volumioat volumio[889]: info: CoreStateMachine::pushState Jul 21 16:19:28 volumioat volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 16:19:28 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:28 volumioat volumio[889]: 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":"file.mp4","artist":null,"album":null,"uri":"http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4","trackType":"mp4"} Jul 21 16:19:28 volumioat volumio[889]: verbose: CURRENT POSITION 0 Jul 21 16:19:28 volumioat volumio[889]: info: CoreStateMachine::syncState stateService stop Jul 21 16:19:28 volumioat volumio[889]: info: CoreStateMachine::syncState currentStatus stop Jul 21 16:19:28 volumioat volumio[889]: info: CoreStateMachine::pushState Jul 21 16:19:28 volumioat volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 16:19:28 volumioat volumio[889]: info: No code Jul 21 16:19:28 volumioat volumio[889]: info: CoreStateMachine::pushState Jul 21 16:19:28 volumioat volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 16:19:28 volumioat volumio[889]: info: ------------------------------ 44ms Jul 21 16:19:29 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 21 16:19:29 volumioat volumio[889]: info: Received Get System Info Jul 21 16:19:29 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 21 16:19:29 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 21 16:19:29 volumioat volumio[889]: info: Discovery: Getting this device information Jul 21 16:19:29 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:29 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 21 16:19:30 volumioat volumio[889]: info: Received Get System Info Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 21 16:19:30 volumioat volumio[889]: info: Discovery: Getting this device information Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 21 16:19:30 volumioat volumio[889]: info: Received Get System Info Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 21 16:19:30 volumioat volumio[889]: info: Discovery: Getting this device information Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:30 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 21 16:19:36 volumioat volumio[889]: info: CoreCommandRouter::volumioPrevious Jul 21 16:19:36 volumioat volumio[889]: info: CoreStateMachine::previous Jul 21 16:19:36 volumioat volumio[889]: info: CoreStateMachine::updateTrackBlock Jul 21 16:19:36 volumioat volumio[889]: info: CorePlayQueue::getTrackBlock Jul 21 16:19:36 volumioat volumio[889]: info: CoreStateMachine::serviceClearAddPlay Jul 21 16:19:36 volumioat volumio[889]: info: CoreCommandRouter::serviceClearAddPlayTracks Jul 21 16:19:36 volumioat volumio[889]: error: WARNING: No clearAddPlayTracks method for service upnp_browser Jul 21 16:19:37 volumioat volumio[889]: info: CoreCommandRouter::volumioGetQueue Jul 21 16:19:37 volumioat volumio[889]: info: CoreStateMachine::getQueue Jul 21 16:19:37 volumioat volumio[889]: info: CorePlayQueue::getQueue Jul 21 16:19:38 volumioat volumio[889]: info: CoreCommandRouter::volumioPlay Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::play index 0 Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::stop Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::play index undefined Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 16:19:38 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::startPlaybackTimer Jul 21 16:19:38 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:38 volumioat volumio[889]: info: [1721578778266] ControllerUPNPBrowser::clearAddPlayTrack Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand stop Jul 21 16:19:38 volumioat volumio[889]: info: sendMpdCommand stop took 2 milliseconds Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand clear Jul 21 16:19:38 volumioat volumio[889]: info: sendMpdCommand clear took 1 milliseconds Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4" Jul 21 16:19:38 volumioat volumio[889]: info: Jul 21 16:19:38 volumioat volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 16:19:38 volumioat volumio[889]: info: Ignoring MPD Status Update Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4" Jul 21 16:19:38 volumioat volumio[889]: error: updateQueue error: null Jul 21 16:19:38 volumioat volumio[889]: info: Jul 21 16:19:38 volumioat volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 16:19:38 volumioat volumio[889]: info: Ignoring MPD Status Update Jul 21 16:19:38 volumioat volumio[889]: info: ------------------------------ 6ms Jul 21 16:19:38 volumioat volumio[889]: info: sendMpdCommand add "http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4" took 2 milliseconds Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand play Jul 21 16:19:38 volumioat volumio[889]: info: ------------------------------ 5ms Jul 21 16:19:38 volumioat volumio[889]: info: sendMpdCommand play took 4 milliseconds Jul 21 16:19:38 volumioat volumio[889]: info: Jul 21 16:19:38 volumioat volumio[889]: ---------------------------- MPD announces state update: player Jul 21 16:19:38 volumioat volumio[889]: info: ControllerMpd::getState Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand status Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 21 16:19:38 volumioat volumio[889]: info: sendMpdCommand status took 7 milliseconds Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::parseState Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 16:19:38 volumioat volumio[889]: info: sendMpdCommand clearerror took 4 milliseconds Jul 21 16:19:38 volumioat volumio[889]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 21 16:19:38 volumioat volumio[889]: verbose: ControllerMpd::parseTrackInfo Jul 21 16:19:38 volumioat volumio[889]: info: ControllerMpd::pushState Jul 21 16:19:38 volumioat volumio[889]: info: CoreCommandRouter::servicePushState Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::pushState Jul 21 16:19:38 volumioat volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 16:19:38 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:38 volumioat volumio[889]: 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":"file.mp4","artist":null,"album":null,"uri":"http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4","trackType":"mp4"} Jul 21 16:19:38 volumioat volumio[889]: verbose: CURRENT POSITION 0 Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::syncState stateService stop Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::syncState currentStatus stop Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::pushState Jul 21 16:19:38 volumioat volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 16:19:38 volumioat volumio[889]: info: No code Jul 21 16:19:38 volumioat volumio[889]: info: CoreStateMachine::pushState Jul 21 16:19:38 volumioat volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 16:19:38 volumioat volumio[889]: info: ------------------------------ 33ms Jul 21 16:19:39 volumioat volumio[889]: info: CoreCommandRouter::volumioPlay Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::play index 0 Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::stop Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::play index undefined Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 16:19:39 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::startPlaybackTimer Jul 21 16:19:39 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:39 volumioat volumio[889]: info: [1721578779454] ControllerUPNPBrowser::clearAddPlayTrack Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand stop Jul 21 16:19:39 volumioat volumio[889]: info: sendMpdCommand stop took 1 milliseconds Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand clear Jul 21 16:19:39 volumioat volumio[889]: info: Jul 21 16:19:39 volumioat volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 16:19:39 volumioat volumio[889]: info: Ignoring MPD Status Update Jul 21 16:19:39 volumioat volumio[889]: info: sendMpdCommand clear took 3 milliseconds Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4" Jul 21 16:19:39 volumioat volumio[889]: error: updateQueue error: null Jul 21 16:19:39 volumioat volumio[889]: info: ------------------------------ 6ms Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4" Jul 21 16:19:39 volumioat volumio[889]: info: Jul 21 16:19:39 volumioat volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 16:19:39 volumioat volumio[889]: info: Ignoring MPD Status Update Jul 21 16:19:39 volumioat volumio[889]: info: sendMpdCommand add "http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4" took 2 milliseconds Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand play Jul 21 16:19:39 volumioat volumio[889]: info: ------------------------------ 4ms Jul 21 16:19:39 volumioat volumio[889]: info: sendMpdCommand play took 2 milliseconds Jul 21 16:19:39 volumioat volumio[889]: info: Jul 21 16:19:39 volumioat volumio[889]: ---------------------------- MPD announces state update: player Jul 21 16:19:39 volumioat volumio[889]: info: ControllerMpd::getState Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand status Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 21 16:19:39 volumioat volumio[889]: info: sendMpdCommand status took 5 milliseconds Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::parseState Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 16:19:39 volumioat volumio[889]: info: sendMpdCommand clearerror took 2 milliseconds Jul 21 16:19:39 volumioat volumio[889]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 21 16:19:39 volumioat volumio[889]: verbose: ControllerMpd::parseTrackInfo Jul 21 16:19:39 volumioat volumio[889]: info: ControllerMpd::pushState Jul 21 16:19:39 volumioat volumio[889]: info: CoreCommandRouter::servicePushState Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::pushState Jul 21 16:19:39 volumioat volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 16:19:39 volumioat volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 16:19:39 volumioat volumio[889]: 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":"file.mp4","artist":null,"album":null,"uri":"http://192.168.0.101:32469/object/402dd8d622bcb6e88381/file.mp4","trackType":"mp4"} Jul 21 16:19:39 volumioat volumio[889]: verbose: CURRENT POSITION 0 Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::syncState stateService stop Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::syncState currentStatus stop Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::pushState Jul 21 16:19:39 volumioat volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 16:19:39 volumioat volumio[889]: info: No code Jul 21 16:19:39 volumioat volumio[889]: info: CoreStateMachine::pushState Jul 21 16:19:39 volumioat volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 16:19:39 volumioat volumio[889]: info: ------------------------------ 28ms Jul 21 16:19:43 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 21 16:19:43 volumioat volumio[889]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 21 16:19:43 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 21 16:19:43 volumioat volumio[889]: info: Received Get System Version Jul 21 16:19:43 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 16:19:43 volumioat volumio[889]: info: Received Get System Info Jul 21 16:19:43 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 21 16:19:43 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 21 16:19:43 volumioat volumio[889]: info: Discovery: Getting this device information Jul 21 16:19:43 volumioat volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 16:19:43 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 21 16:19:44 volumioat volumio[889]: info: Retrieving Cloud Streaming UI Jul 21 16:19:44 volumioat volumio[889]: info: Getting Tidal Cloud Configuration Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 21 16:19:44 volumioat volumio[889]: info: Getting Qobuz Cloud Configuration Jul 21 16:19:44 volumioat volumio[889]: info: Asking plugin for UI Config Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 21 16:19:44 volumioat volumio[889]: info: Getting Spotify Cloud Configuration Jul 21 16:19:44 volumioat volumio[889]: info: Asking plugin for UI Config Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 21 16:19:44 volumioat volumio[889]: info: Saving Spotify Acccount Jul 21 16:19:44 volumioat volumio[889]: info: Got Tidal Cloud Configuration Jul 21 16:19:44 volumioat volumio[889]: info: Got it Jul 21 16:19:44 volumioat volumio[889]: info: Got it Jul 21 16:19:44 volumioat volumio[889]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 21 16:19:44 volumioat volumio[889]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::volumioGetBrowseSources Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 21 16:19:44 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 21 16:19:48 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 21 16:19:52 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 21 16:19:54 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 21 16:19:54 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jul 21 16:19:56 volumioat volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 21 16:19:59 volumioat volumio[889]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 16:19:59 volumioat volumio[889]: Error: dns service error: unknown Jul 21 16:19:59 volumioat volumio[889]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Jul 21 16:19:59 volumioat volumio[889]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jul 21 16:19:59 volumioat volumio[889]: errorCode: -65537 Jul 21 16:19:59 volumioat volumio[889]: } Jul 21 16:19:59 volumioat volumio[889]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 16:19:59 volumioat sudo[2673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 16:18 Jul 21 16:19:59 volumioat sudo[2673]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="8e6823482d6af342172ec9fdc1c15b0dd02653d2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 04 Dec 2022 08:41:29 PM CET" VOLUMIO_VERSION="3.396" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d460c75d04818d0f55c67627fa362668"