-- Logs begin at Thu 2019-02-14 10:12:00 UTC, end at Thu 2022-06-09 16:59:53 UTC. -- Jun 09 16:58:22 volumio ntpd[593]: Soliciting pool server 103.130.217.41 Jun 09 16:58:23 volumio ntpd[593]: Soliciting pool server 103.130.217.41 Jun 09 16:58:26 volumio ntpd[593]: Soliciting pool server 103.130.217.41 Jun 09 16:58:26 volumio ntpd[593]: Soliciting pool server 103.130.217.41 Jun 09 16:59:29 volumio ntpd[593]: Soliciting pool server 2405:a640::149 Jun 09 16:59:29 volumio ntpd[593]: Soliciting pool server 203.113.174.44 Jun 09 16:59:33 volumio ntpd[593]: Soliciting pool server 203.113.174.44 Jun 09 16:59:33 volumio ntpd[593]: Soliciting pool server 203.113.174.44 Jun 09 16:59:41 volumio sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 09 16:59:41 volumio sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 09 16:59:41 volumio sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 16:59:41 volumio sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 16:59:41 volumio sudo[1125]: pam_unix(sudo:session): session closed for user root Jun 09 16:59:41 volumio sudo[1123]: pam_unix(sudo:session): session closed for user root Jun 09 16:59:41 volumio sudo[1129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 09 16:59:41 volumio sudo[1129]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 16:59:41 volumio volumio[740]: verbose: New Socket.io Connection to 192.168.1.22 from 192.168.1.10 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Mobile Safari/537.36 Total Clients: 3 Jun 09 16:59:41 volumio sudo[1129]: pam_unix(sudo:session): session closed for user root Jun 09 16:59:41 volumio sudo[1131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 09 16:59:41 volumio sudo[1131]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 16:59:41 volumio sudo[1131]: pam_unix(sudo:session): session closed for user root Jun 09 16:59:41 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 09 16:59:41 volumio volumio[740]: verbose: New Socket.io Connection to 192.168.1.22 from 192.168.1.10 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Mobile Safari/537.36 Total Clients: 4 Jun 09 16:59:41 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 09 16:59:41 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 09 16:59:41 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 09 16:59:42 volumio volumio[740]: info: CoreCommandRouter::volumioGetVisibleSources Jun 09 16:59:42 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 09 16:59:42 volumio volumio[740]: info: CoreCommandRouter::volumioGetState Jun 09 16:59:42 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jun 09 16:59:42 volumio volumio[740]: info: CoreCommandRouter::volumioGetQueue Jun 09 16:59:42 volumio volumio[740]: info: CoreStateMachine::getQueue Jun 09 16:59:42 volumio volumio[740]: info: CorePlayQueue::getQueue Jun 09 16:59:42 volumio volumio[740]: info: Listing playlists Jun 09 16:59:42 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 09 16:59:42 volumio volumio[740]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/B%E1%BA%B1ng%20Ki%E1%BB%81u/Anh%20S%E1%BA%BD%20Nh%E1%BB%9B%20M%C3%A3i/1d14e424-7014-4cd9-a82c-9e56f2619045.jpg' Jun 09 16:59:43 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:59:43 volumio volumio[740]: info: CURURI: music-library Jun 09 16:59:44 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:59:44 volumio volumio[740]: info: CURURI: music-library/USB Jun 09 16:59:45 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:59:45 volumio volumio[740]: info: CURURI: music-library/USB/18FA-DD43 Jun 09 16:59:48 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:59:48 volumio volumio[740]: info: CURURI: music-library/USB/18FA-DD43/Cam Ly Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::ClearQueue Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::stop Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:59:49 volumio volumio[740]: verbose: UNSET VOLATILE Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::clearPlayQueue Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::saveQueue Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::volumioPushQueue Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::addQueueItems Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::addQueueItems Jun 09 16:59:49 volumio volumio[740]: info: Adding Item to queue: music-library/USB/18FA-DD43/Cam Ly/Noi Buon Hoa Phuong - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: Exploding uri music-library/USB/18FA-DD43/Cam Ly/Noi Buon Hoa Phuong - Cam Ly.flac in service mpd Jun 09 16:59:49 volumio volumio[740]: info: Adding Item to queue: music-library/USB/18FA-DD43/Cam Ly/Khong Bao Gio Quen Anh - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: Exploding uri music-library/USB/18FA-DD43/Cam Ly/Khong Bao Gio Quen Anh - Cam Ly.flac in service mpd Jun 09 16:59:49 volumio volumio[740]: info: Adding Item to queue: music-library/USB/18FA-DD43/Cam Ly/Ngay Xua Hai Dua - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: Exploding uri music-library/USB/18FA-DD43/Cam Ly/Ngay Xua Hai Dua - Cam Ly.flac in service mpd Jun 09 16:59:49 volumio volumio[740]: info: Adding Item to queue: music-library/USB/18FA-DD43/Cam Ly/Mua Rung - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: Exploding uri music-library/USB/18FA-DD43/Cam Ly/Mua Rung - Cam Ly.flac in service mpd Jun 09 16:59:49 volumio volumio[740]: info: Adding Item to queue: music-library/USB/18FA-DD43/Cam Ly/Nguoi Ve Cuoi Pho - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: Exploding uri music-library/USB/18FA-DD43/Cam Ly/Nguoi Ve Cuoi Pho - Cam Ly.flac in service mpd Jun 09 16:59:49 volumio volumio[740]: info: ALBUMART /albumart?cacheid=17&web=C%E1%BA%A9m%20Ly/K%E1%BA%BB%20%C4%90%E1%BB%A9ng%20Sau%20T%C3%ACnh%20Y%C3%AAu/extralarge&path=%2Fmnt%2FUSB%2F18FA-DD43%2FCam%20Ly%2FNoi%20Buon%20Hoa%20Phuong%20-%20Cam%20Ly.flac&metadata=false Jun 09 16:59:49 volumio volumio[740]: info: URI /mnt/USB/18FA-DD43/Cam Ly/Noi Buon Hoa Phuong - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: ALBUMART /albumart?cacheid=17&web=C%E1%BA%A9m%20Ly/Ng%E1%BB%8Dn%20Tr%C3%BAc%20%C4%90%C3%A0o/extralarge&path=%2Fmnt%2FUSB%2F18FA-DD43%2FCam%20Ly%2FKhong%20Bao%20Gio%20Quen%20Anh%20-%20Cam%20Ly.flac&metadata=false Jun 09 16:59:49 volumio volumio[740]: info: URI /mnt/USB/18FA-DD43/Cam Ly/Khong Bao Gio Quen Anh - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: ALBUMART /albumart?cacheid=17&web=C%E1%BA%A9m%20Ly/Ng%C6%B0%E1%BB%9Di%20Nh%E1%BB%9B%20Kh%C3%B4ng%20Ng%C6%B0%E1%BB%9Di%3B%20Em%20S%E1%BA%BD%20L%C3%A0%20Ng%C6%B0%E1%BB%9Di%20Ra%20%C4%90i/extralarge&path=%2Fmnt%2FUSB%2F18FA-DD43%2FCam%20Ly%2FNgay%20Xua%20Hai%20Dua%20-%20Cam%20Ly.flac&metadata=false Jun 09 16:59:49 volumio volumio[740]: info: URI /mnt/USB/18FA-DD43/Cam Ly/Ngay Xua Hai Dua - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: ALBUMART /albumart?cacheid=17&web=C%E1%BA%A9m%20Ly/Th%C6%B0%C6%A1ng/extralarge&path=%2Fmnt%2FUSB%2F18FA-DD43%2FCam%20Ly%2FMua%20Rung%20-%20Cam%20Ly.flac&metadata=false Jun 09 16:59:49 volumio volumio[740]: info: URI /mnt/USB/18FA-DD43/Cam Ly/Mua Rung - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: ALBUMART /albumart?cacheid=17&web=C%E1%BA%A9m%20Ly/Top%20Music/extralarge&path=%2Fmnt%2FUSB%2F18FA-DD43%2FCam%20Ly%2FNguoi%20Ve%20Cuoi%20Pho%20-%20Cam%20Ly.flac&metadata=false Jun 09 16:59:49 volumio volumio[740]: info: URI /mnt/USB/18FA-DD43/Cam Ly/Nguoi Ve Cuoi Pho - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::saveQueue Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::volumioPushQueue Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::updateTrackBlock Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::getTrackBlock Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::volumioPlay Jun 09 16:59:49 volumio volumio[740]: verbose: UNSET VOLATILE Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::play index 0 Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::stop Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:59:49 volumio volumio[740]: verbose: UNSET VOLATILE Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::play index undefined Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::startPlaybackTimer Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::clearAddPlayTracks USB/18FA-DD43/Cam Ly/Noi Buon Hoa Phuong - Cam Ly.flac Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand stop Jun 09 16:59:49 volumio volumio[740]: info: sendMpdCommand stop took 5 milliseconds Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand clear Jun 09 16:59:49 volumio volumio[740]: info: Jun 09 16:59:49 volumio volumio[740]: ---------------------------- MPD announces system playlist update Jun 09 16:59:49 volumio volumio[740]: info: Ignoring MPD Status Update Jun 09 16:59:49 volumio volumio[740]: info: sendMpdCommand clear took 16 milliseconds Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand add "USB/18FA-DD43/Cam Ly/Noi Buon Hoa Phuong - Cam Ly.flac" Jun 09 16:59:49 volumio volumio[740]: error: updateQueue error: null Jun 09 16:59:49 volumio volumio[740]: info: Jun 09 16:59:49 volumio volumio[740]: ---------------------------- MPD announces system playlist update Jun 09 16:59:49 volumio volumio[740]: info: Ignoring MPD Status Update Jun 09 16:59:49 volumio volumio[740]: info: ------------------------------ 14ms Jun 09 16:59:49 volumio volumio[740]: info: sendMpdCommand add "USB/18FA-DD43/Cam Ly/Noi Buon Hoa Phuong - Cam Ly.flac" took 9 milliseconds Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand play Jun 09 16:59:49 volumio volumio[740]: error: Upnp client error: Error: This socket has been ended by the other party Jun 09 16:59:49 volumio volumio[740]: info: Jun 09 16:59:49 volumio volumio[740]: ---------------------------- MPD announces state update: player Jun 09 16:59:49 volumio volumio[740]: info: ------------------------------ 21ms Jun 09 16:59:49 volumio volumio[740]: info: sendMpdCommand play took 16 milliseconds Jun 09 16:59:49 volumio volumio[740]: info: ControllerMpd::getState Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand status Jun 09 16:59:49 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jun 09 16:59:49 volumio volumio[740]: info: Jun 09 16:59:49 volumio volumio[740]: ---------------------------- MPD announces state update: player Jun 09 16:59:49 volumio volumio[740]: info: sendMpdCommand status took 19 milliseconds Jun 09 16:59:49 volumio volumio[740]: info: ControllerMpd::getState Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand status Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::parseState Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 09 16:59:49 volumio volumio[740]: info: sendMpdCommand status took 9 milliseconds Jun 09 16:59:49 volumio volumio[740]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::parseState Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::parseTrackInfo Jun 09 16:59:49 volumio volumio[740]: info: ControllerMpd::pushState Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::servicePushState Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jun 09 16:59:49 volumio volumio[740]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"89 Kbps","isStreaming":false,"title":"Nỗi Buồn Hoa Phượng","artist":"Cẩm Ly","album":"Kẻ Đứng Sau Tình Yêu","uri":"USB/18FA-DD43/Cam Ly/Noi Buon Hoa Phuong - Cam Ly.flac","trackType":"flac"} Jun 09 16:59:49 volumio volumio[740]: verbose: CURRENT POSITION 0 Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::syncState stateService play Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::syncState currentStatus stop Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::pushState Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jun 09 16:59:49 volumio volumio[740]: info: ------------------------------ 81ms Jun 09 16:59:49 volumio volumio[740]: info: sendMpdCommand playlistinfo took 45 milliseconds Jun 09 16:59:49 volumio volumio[740]: verbose: ControllerMpd::parseTrackInfo Jun 09 16:59:49 volumio volumio[740]: info: ControllerMpd::pushState Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::servicePushState Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jun 09 16:59:49 volumio volumio[740]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"727 Kbps","isStreaming":false,"title":"Nỗi Buồn Hoa Phượng","artist":"Cẩm Ly","album":"Kẻ Đứng Sau Tình Yêu","uri":"USB/18FA-DD43/Cam Ly/Noi Buon Hoa Phuong - Cam Ly.flac","trackType":"flac"} Jun 09 16:59:49 volumio volumio[740]: verbose: CURRENT POSITION 0 Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::syncState stateService play Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:59:49 volumio volumio[740]: info: Received an update from plugin. extracting info from payload Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::pushState Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jun 09 16:59:49 volumio volumio[740]: info: CoreStateMachine::pushState Jun 09 16:59:49 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jun 09 16:59:49 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jun 09 16:59:49 volumio volumio[740]: info: ------------------------------ 114ms Jun 09 16:59:51 volumio volumio[740]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 16:59:51 volumio volumio[740]: Error: certificate is not yet valid Jun 09 16:59:51 volumio volumio[740]: at TLSSocket.onConnectSecure (_tls_wrap.js:1497:34) Jun 09 16:59:51 volumio volumio[740]: at TLSSocket.emit (events.js:315:20) Jun 09 16:59:51 volumio volumio[740]: at TLSSocket._finishInit (_tls_wrap.js:932:8) Jun 09 16:59:51 volumio volumio[740]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { Jun 09 16:59:51 volumio volumio[740]: code: 'CERT_NOT_YET_VALID' Jun 09 16:59:51 volumio volumio[740]: } Jun 09 16:59:51 volumio volumio[740]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 16:59:53 volumio sudo[1156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2022-06-09 16:58 Jun 09 16:59:53 volumio sudo[1156]: 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="3cfa1502993c2310fc263d6ebda1707071fe4cc2" VOLUMIO_FE_VERSION="8efe4f08f83e5de574651b8ed2333629c140d365" VOLUMIO_FE3_VERSION="8f1d07fcde806ea34f52cff908ec76359e14970e" VOLUMIO_BE_VERSION="e249dfa388452e6b8443121dc9b4cabca459c531" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 09 Jun 2022 05:55:51 PM CEST" VOLUMIO_VERSION="3.301" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6a8974e587cd4bab189d231f79b65462"