-- Logs begin at Mon 2026-01-26 21:52:24 MSK, end at Mon 2026-01-26 22:11:53 MSK. -- Jan 26 22:10:32 volumio volumio[1231]: info: CorePlayQueue::getTrack 4 Jan 26 22:10:32 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:10:32 volumio volumio[1231]: info: Prefetching next song Jan 26 22:10:32 volumio volumio[1231]: info: DOING PREFETCH IN MPD Jan 26 22:10:32 volumio volumio[1231]: verbose: ControllerMpd::sendMpdCommand add "USB/EXTERNAL_USB/Pop/Pink - Trustfall (2023)/09. Hate Me.flac" Jan 26 22:10:32 volumio volumio[1231]: info: Jan 26 22:10:32 volumio volumio[1231]: ---------------------------- MPD announces system playlist update Jan 26 22:10:32 volumio volumio[1231]: info: Ignoring MPD Status Update Jan 26 22:10:32 volumio volumio[1231]: info: sendMpdCommand add "USB/EXTERNAL_USB/Pop/Pink - Trustfall (2023)/09. Hate Me.flac" took 6 milliseconds Jan 26 22:10:32 volumio volumio[1231]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 26 22:10:32 volumio volumio[1231]: info: ------------------------------ 6ms Jan 26 22:10:32 volumio volumio[1231]: info: sendMpdCommand consume 1 took 4 milliseconds Jan 26 22:10:36 volumio volumio[1231]: info: CoreStateMachine::startPlaybackTimer Jan 26 22:10:36 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:10:37 volumio volumio[1231]: info: CoreStateMachine::pushState Jan 26 22:10:37 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:10:37 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 22:10:37 volumio volumio[1231]: info: CoreCommandRouter::volumioPushState Jan 26 22:10:37 volumio volumio[1231]: info: Jan 26 22:10:37 volumio volumio[1231]: ---------------------------- MPD announces system playlist update Jan 26 22:10:37 volumio volumio[1231]: info: Ignoring MPD Status Update Jan 26 22:10:37 volumio volumio[1231]: info: Jan 26 22:10:37 volumio volumio[1231]: ---------------------------- MPD announces state update: player Jan 26 22:10:37 volumio volumio[1231]: info: ControllerMpd::getState Jan 26 22:10:37 volumio volumio[1231]: verbose: ControllerMpd::sendMpdCommand status Jan 26 22:10:37 volumio volumio[1231]: info: ------------------------------ 8ms Jan 26 22:10:37 volumio volumio[1231]: info: sendMpdCommand status took 5 milliseconds Jan 26 22:10:37 volumio volumio[1231]: verbose: ControllerMpd::parseState Jan 26 22:10:37 volumio volumio[1231]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 22:10:37 volumio volumio[1231]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 26 22:10:37 volumio volumio[1231]: verbose: ControllerMpd::parseTrackInfo Jan 26 22:10:37 volumio volumio[1231]: info: ControllerMpd::pushState Jan 26 22:10:37 volumio volumio[1231]: info: CoreCommandRouter::servicePushState Jan 26 22:10:37 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:10:37 volumio volumio[1231]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"563 Kbps","isStreaming":false,"title":"Hate Me","artist":"P!nk","album":"TRUSTFALL","uri":"USB/EXTERNAL_USB/Pop/Pink - Trustfall (2023)/09. Hate Me.flac","trackType":"flac"} Jan 26 22:10:37 volumio volumio[1231]: verbose: CURRENT POSITION 5 Jan 26 22:10:37 volumio volumio[1231]: info: CoreStateMachine::syncState stateService play Jan 26 22:10:37 volumio volumio[1231]: info: CoreStateMachine::syncState currentStatus play Jan 26 22:10:37 volumio volumio[1231]: info: Received an update from plugin. extracting info from payload Jan 26 22:10:37 volumio volumio[1231]: info: CoreStateMachine::pushState Jan 26 22:10:37 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:10:37 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 22:10:37 volumio volumio[1231]: info: CoreCommandRouter::volumioPushState Jan 26 22:10:37 volumio volumio[1231]: info: CoreStateMachine::pushState Jan 26 22:10:37 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:10:37 volumio volumio[1231]: info: CoreCommandRouter::volumioPushState Jan 26 22:10:37 volumio volumio[1231]: info: ------------------------------ 62ms Jan 26 22:10:58 volumio volumio[1231]: verbose: New Socket.io Connection to 192.168.0.17:3000 from 192.168.0.11 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jan 26 22:11:05 volumio volumio[1231]: verbose: New Socket.io Connection to 192.168.0.17 from 192.168.0.11 UA: Mozilla/5.0 (Linux; Android 12; B1 Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.59 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jan 26 22:11:05 volumio volumio[1231]: verbose: New Socket.io Connection to 192.168.0.17 from 192.168.0.11 UA: Mozilla/5.0 (Linux; Android 12; B1 Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.59 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 26 22:11:05 volumio volumio[1231]: verbose: New Socket.io Connection to 192.168.0.17:3000 from 192.168.0.11 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Jan 26 22:11:06 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:11:06 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:11:06 volumio volumio[1231]: info: Discovery: Getting this device information Jan 26 22:11:06 volumio volumio[1231]: info: CoreCommandRouter::volumioGetState Jan 26 22:11:06 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:11:06 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:11:11 volumio volumio[1231]: verbose: New Socket.io Connection to 192.168.0.17 from 192.168.0.11 UA: Mozilla/5.0 (Linux; Android 12; B1 Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.59 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jan 26 22:11:11 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::volumioGetState Jan 26 22:11:12 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 26 22:11:12 volumio volumio[1231]: info: Received Get System Info Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:11:12 volumio volumio[1231]: info: Discovery: Getting this device information Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::volumioGetState Jan 26 22:11:12 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::volumioGetState Jan 26 22:11:12 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:11:12 volumio volumio[1231]: info: Listing playlists Jan 26 22:11:12 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 26 22:11:15 volumio volumio[1231]: verbose: New Socket.io Connection to 192.168.0.17:3000 from 192.168.0.11 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Jan 26 22:11:16 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 22:11:16 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 22:11:16 volumio volumio[1231]: info: Discovery: Getting this device information Jan 26 22:11:16 volumio volumio[1231]: info: CoreCommandRouter::volumioGetState Jan 26 22:11:16 volumio volumio[1231]: info: CorePlayQueue::getTrack 5 Jan 26 22:11:16 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 22:11:16 volumio volumio[1231]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/P!nk/TRUSTFALL/81f8eb02-d12c-43c7-b5b0-af48de6bf249.jpg' Jan 26 22:11:32 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 26 22:11:32 volumio volumio[1231]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 26 22:11:40 volumio ntpd[2307]: 176.50.91.208 local addr 192.168.0.17 -> Jan 26 22:11:52 volumio volumio[1231]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 22:11:52 volumio volumio[1231]: Error: Client network socket disconnected before secure TLS connection was established Jan 26 22:11:52 volumio volumio[1231]: at connResetException (internal/errors.js:639:14) Jan 26 22:11:52 volumio volumio[1231]: at TLSSocket.onConnectEnd (_tls_wrap.js:1570:19) Jan 26 22:11:52 volumio volumio[1231]: at TLSSocket.emit (events.js:412:35) Jan 26 22:11:52 volumio volumio[1231]: at endReadableNT (internal/streams/readable.js:1333:12) Jan 26 22:11:52 volumio volumio[1231]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Jan 26 22:11:52 volumio volumio[1231]: code: 'ECONNRESET', Jan 26 22:11:52 volumio volumio[1231]: path: null, Jan 26 22:11:52 volumio volumio[1231]: host: 'lastfm.freetls.fastly.net', Jan 26 22:11:52 volumio volumio[1231]: port: 443, Jan 26 22:11:52 volumio volumio[1231]: localAddress: undefined Jan 26 22:11:52 volumio volumio[1231]: } Jan 26 22:11:52 volumio volumio[1231]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 22:11:53 volumio sudo[4962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-26 22:10 Jan 26 22:11:53 volumio sudo[4962]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:18:30 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="33f9369b544b4488ff4979d2ee3813a5"