-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Tue 2024-10-29 08:18:54 UTC. -- Oct 29 08:17:48 volumio volumio[1062]: info: CoreCommandRouter::volumioPause Oct 29 08:17:48 volumio volumio[1062]: info: CoreStateMachine::pause Oct 29 08:17:48 volumio volumio[1062]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:17:48 volumio volumio[1062]: info: CoreStateMachine::servicePause Oct 29 08:17:48 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:48 volumio volumio[1062]: info: CoreCommandRouter::servicePause Oct 29 08:17:48 volumio volumio[1062]: info: ControllerMpd::pause Oct 29 08:17:48 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand pause Oct 29 08:17:48 volumio volumio[1062]: info: sendMpdCommand pause took 2 milliseconds Oct 29 08:17:48 volumio volumio[1062]: info: Oct 29 08:17:48 volumio volumio[1062]: ---------------------------- MPD announces state update: player Oct 29 08:17:48 volumio volumio[1062]: info: ControllerMpd::getState Oct 29 08:17:48 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:17:48 volumio volumio[1062]: info: sendMpdCommand status took 2 milliseconds Oct 29 08:17:48 volumio volumio[1062]: verbose: ControllerMpd::parseState Oct 29 08:17:48 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:17:48 volumio volumio[1062]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 08:17:48 volumio volumio[1062]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:17:48 volumio volumio[1062]: info: ControllerMpd::pushState Oct 29 08:17:48 volumio volumio[1062]: info: CoreCommandRouter::servicePushState Oct 29 08:17:48 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:48 volumio volumio[1062]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":62599,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Make You Feel My Love","artist":"Adele","album":null,"uri":"USB/Music/Music/make_you_feel_my_love.ape","trackType":"ape"} Oct 29 08:17:48 volumio volumio[1062]: verbose: CURRENT POSITION 2 Oct 29 08:17:48 volumio volumio[1062]: info: CoreStateMachine::syncState stateService pause Oct 29 08:17:48 volumio volumio[1062]: info: CoreStateMachine::syncState currentStatus pause Oct 29 08:17:48 volumio volumio[1062]: info: CoreStateMachine::pushState Oct 29 08:17:48 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:48 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:17:48 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Oct 29 08:17:48 volumio volumio[1062]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:17:48 volumio volumio[1062]: info: ------------------------------ 37ms Oct 29 08:17:48 volumio kernel: xhci-hcd-meson xhci-hcd-meson.0.auto: start stop ep=1, slot=2 Oct 29 08:17:48 volumio kernel: xhci-hcd-meson xhci-hcd-meson.0.auto: start stop ep=2, slot=2 Oct 29 08:17:49 volumio volumio[1062]: info: CoreCommandRouter::volumioPlay Oct 29 08:17:49 volumio volumio[1062]: info: CoreStateMachine::play index undefined Oct 29 08:17:49 volumio volumio[1062]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:17:49 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:49 volumio volumio[1062]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:17:49 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:49 volumio volumio[1062]: info: ControllerMpd::resume Oct 29 08:17:49 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:17:49 volumio ntpd[2927]: Soliciting pool server 2001:ac8:a:23:0:1:0:14 Oct 29 08:17:50 volumio volumio[1062]: info: Oct 29 08:17:50 volumio volumio[1062]: ---------------------------- MPD announces state update: player Oct 29 08:17:50 volumio volumio[1062]: info: sendMpdCommand play took 66 milliseconds Oct 29 08:17:50 volumio volumio[1062]: info: ControllerMpd::getState Oct 29 08:17:50 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:17:50 volumio volumio[1062]: info: sendMpdCommand status took 1 milliseconds Oct 29 08:17:50 volumio volumio[1062]: verbose: ControllerMpd::parseState Oct 29 08:17:50 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:17:50 volumio volumio[1062]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 08:17:50 volumio volumio[1062]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:17:50 volumio volumio[1062]: info: ControllerMpd::pushState Oct 29 08:17:50 volumio volumio[1062]: info: CoreCommandRouter::servicePushState Oct 29 08:17:50 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:50 volumio volumio[1062]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63469,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Make You Feel My Love","artist":"Adele","album":null,"uri":"USB/Music/Music/make_you_feel_my_love.ape","trackType":"ape"} Oct 29 08:17:50 volumio volumio[1062]: verbose: CURRENT POSITION 2 Oct 29 08:17:50 volumio volumio[1062]: info: CoreStateMachine::syncState stateService play Oct 29 08:17:50 volumio volumio[1062]: info: CoreStateMachine::syncState currentStatus pause Oct 29 08:17:50 volumio volumio[1062]: info: CoreStateMachine::pushState Oct 29 08:17:50 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:50 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:17:50 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Oct 29 08:17:50 volumio volumio[1062]: info: ------------------------------ 9ms Oct 29 08:17:50 volumio volumio[1062]: info: VolumeController::SetAlsaVolume35 Oct 29 08:17:50 volumio volumio[1062]: info: CoreStateMachine::pushState Oct 29 08:17:50 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:50 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:17:50 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Oct 29 08:17:50 volumio volumio[1062]: info: VolumeController::SetAlsaVolume75 Oct 29 08:17:51 volumio volumio[1062]: info: CoreStateMachine::pushState Oct 29 08:17:51 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:51 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:17:51 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Oct 29 08:17:52 volumio volumio[1062]: info: VolumeController::SetAlsaVolume35 Oct 29 08:17:52 volumio volumio[1062]: info: CoreStateMachine::pushState Oct 29 08:17:52 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:52 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:17:52 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Oct 29 08:17:53 volumio volumio[1062]: info: VolumeController::SetAlsaVolume90 Oct 29 08:17:53 volumio volumio[1062]: info: CoreStateMachine::pushState Oct 29 08:17:53 volumio volumio[1062]: info: CorePlayQueue::getTrack 2 Oct 29 08:17:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:17:53 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 29 08:18:28 volumio volumio[1062]: error: Could not retrieve plugin music_service streaming_services Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 29 08:18:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 29 08:18:32 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 29 08:18:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 29 08:18:40 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 29 08:18:45 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 29 08:18:48 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 29 08:18:48 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 29 08:18:48 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 29 08:18:50 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 29 08:18:50 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 29 08:18:50 volumio volumio[1062]: info: Error browsing device WeDocs for shares : Error: Command failed: echo volumio | smbclient -L WeDocs.local. Oct 29 08:18:50 volumio volumio[1062]: Unable to initialize messaging context Oct 29 08:18:51 volumio volumio[1062]: info: Error browsing device WeDocs for shares : Error: Command failed: echo volumio | smbclient -L WeDocs.local. Oct 29 08:18:51 volumio volumio[1062]: Unable to initialize messaging context Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 29 08:18:53 volumio volumio[1062]: error: Could not retrieve plugin music_service streaming_services Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 29 08:18:53 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 29 08:18:53 volumio volumio[1062]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 08:18:53 volumio volumio[1062]: Error: dns service error: unknown Oct 29 08:18:53 volumio volumio[1062]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Oct 29 08:18:53 volumio volumio[1062]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Oct 29 08:18:53 volumio volumio[1062]: errorCode: -65537 Oct 29 08:18:53 volumio volumio[1062]: } Oct 29 08:18:53 volumio volumio[1062]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 08:18:54 volumio sudo[6364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-29 08:17 Oct 29 08:18:54 volumio sudo[6364]: 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="e71179fefb92227f783fc914e012504f08dcf6fb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 25 11:19:12 AM UTC 2024" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="vim4" VOLUMIO_DEVICENAME="Khadas VIM4" VOLUMIO_HASH="45cbc7a358f4ac7caaf1c988ea607de8"