Dec 27 11:18:00 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 27 11:18:00 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 27 11:18:00 volumio sudo[4887]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 27 11:18:00 volumio sudo[4887]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:00 volumio sudo[4892]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 27 11:18:00 volumio sudo[4892]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:00 volumio sudo[4892]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:00 volumio sudo[4898]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 27 11:18:00 volumio sudo[4898]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:00 volumio sudo[4903]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 27 11:18:00 volumio sudo[4903]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:00 volumio sudo[4898]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:00 volumio sudo[4903]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:00 volumio sudo[4909]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 27 11:18:00 volumio sudo[4909]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:00 volumio sudo[4909]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:00 volumio sudo[4913]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 27 11:18:00 volumio sudo[4913]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:00 volumio sudo[4913]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:00 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 27 11:18:00 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 27 11:18:00 volumio sudo[4918]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 27 11:18:00 volumio sudo[4918]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:04 volumio sudo[4918]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:10 volumio sudo[4887]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:18 volumio volumio[1438]: info: CoreCommandRouter::volumioGetState Dec 27 11:18:18 volumio volumio[1438]: info: CorePlayQueue::getTrack 2 Dec 27 11:18:25 volumio volumio[1438]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 27 11:18:25 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 27 11:18:25 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 27 11:18:25 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 27 11:18:25 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Dec 27 11:18:25 volumio volumio[1438]: info: Received Get System Version Dec 27 11:18:25 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 27 11:18:31 volumio volumio[1438]: info: CALLMETHOD: system_controller system setLanguageTimezone [object Object] Dec 27 11:18:31 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: system , setLanguageTimezone Dec 27 11:18:31 volumio volumio[1438]: info: Setting timezone to Asia/Ho_Chi_Minh Dec 27 11:18:31 volumio sudo[5095]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 27 11:18:31 volumio sudo[5095]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:31 volumio sudo[5095]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:31 volumio sudo[5099]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Ho_Chi_Minh /etc/localtime Dec 27 11:18:31 volumio sudo[5099]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:31 volumio sudo[5099]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:31 volumio sudo[5103]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 27 11:18:31 volumio sudo[5103]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:31 volumio sudo[5103]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:31 volumio sudo[5107]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Ho_Chi_Minh Dec 27 11:18:31 volumio sudo[5107]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 11:18:31 volumio dbus-daemon[893]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.22' (uid=0 pid=5108 comm="/usr/bin/timedatectl set-timezone Asia/Ho_Chi_Minh") Dec 27 11:18:31 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Dec 27 11:18:31 volumio dbus-daemon[893]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 27 11:18:31 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Dec 27 11:18:31 volumio sudo[5107]: pam_unix(sudo:session): session closed for user root Dec 27 11:18:31 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 27 11:18:31 volumio volumio[1438]: info: Loading i18n strings for locale en Dec 27 11:18:31 volumio volumio[1438]: Updating browse sources language Dec 27 11:18:31 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 27 11:18:32 volumio volumio[1438]: info: Fetching Streaming Services browse cache Dec 27 11:18:33 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 27 11:18:40 volumio volumio[1438]: info: CoreCommandRouter::volumioGetState Dec 27 11:18:40 volumio volumio[1438]: info: CorePlayQueue::getTrack 2 Dec 27 11:18:52 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 27 11:18:52 volumio volumio[1438]: info: CURURI: artists:// Dec 27 11:18:52 volumio volumio[1438]: info: Preload queue cleared Dec 27 11:18:58 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 27 11:18:58 volumio volumio[1438]: info: CURURI: artists://Tu%E1%BA%A5n%20Ng%E1%BB%8Dc Dec 27 11:18:59 volumio volumio[1438]: info: Preload queue cleared Dec 27 11:18:59 volumio volumio[1438]: info: Preload queue cleared Dec 27 11:19:01 volumio volumio[1438]: Upnp client error: Error: This socket has been ended by the other party Dec 27 11:19:01 volumio volumio[1438]: info: No valid Plugin REST Endpoint Dec 27 11:19:01 volumio volumio[1438]: info: No valid Plugin REST Endpoint Dec 27 11:19:01 volumio volumio[1438]: info: No valid Plugin REST Endpoint Dec 27 11:19:01 volumio volumio[1438]: info: No valid Plugin REST Endpoint Dec 27 11:19:01 volumio volumio[1438]: info: No valid Plugin REST Endpoint Dec 27 11:19:01 volumio volumio[1438]: info: No valid Plugin REST Endpoint Dec 27 11:19:01 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 27 11:19:01 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 27 11:19:01 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Dec 27 11:19:02 volumio volumio-remote-updater[909]: Test mode disabled Dec 27 11:19:02 volumio volumio-remote-updater[909]: Alpha mode disabled Dec 27 11:19:02 volumio volumio-remote-updater[909]: Alpha legacy test mode disabled Dec 27 11:19:02 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 27 11:19:12 volumio volumio[1438]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 27 11:19:12 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 27 11:19:12 volumio volumio[1438]: info: CoreCommandRouter::volumioPause Dec 27 11:19:12 volumio volumio[1438]: info: CoreStateMachine::pause Dec 27 11:19:12 volumio volumio[1438]: info: CoreStateMachine::stPlaybackTimer Dec 27 11:19:12 volumio volumio[1438]: info: CoreStateMachine::servicePause Dec 27 11:19:12 volumio volumio[1438]: info: CorePlayQueue::getTrack 2 Dec 27 11:19:12 volumio volumio[1438]: info: CoreCommandRouter::servicePause Dec 27 11:19:12 volumio volumio[1438]: info: ControllerMpd::pause Dec 27 11:19:12 volumio volumio[1438]: verbose: ControllerMpd::sendMpdCommand pause Dec 27 11:19:12 volumio volumio[1438]: info: CoreCommandRouter::volumioPause Dec 27 11:19:12 volumio volumio[1438]: info: CoreStateMachine::pause Dec 27 11:19:12 volumio volumio[1438]: Upnp client error: Error: This socket has been ended by the other party Dec 27 11:19:12 volumio volumio[1438]: info: Dec 27 11:19:12 volumio volumio[1438]: ---------------------------- MPD announces state update: player Dec 27 11:19:12 volumio volumio[1438]: info: sendMpdCommand pause took 4 milliseconds Dec 27 11:19:12 volumio volumio[1438]: info: ControllerMpd::getState Dec 27 11:19:12 volumio volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Dec 27 11:19:13 volumio volumio[1438]: info: sendMpdCommand status took 3 milliseconds Dec 27 11:19:13 volumio volumio[1438]: verbose: ControllerMpd::parseState Dec 27 11:19:13 volumio volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 11:19:13 volumio volumio[1438]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 27 11:19:13 volumio volumio[1438]: verbose: ControllerMpd::parseTrackInfo Dec 27 11:19:13 volumio volumio[1438]: info: ControllerMpd::pushState Dec 27 11:19:13 volumio volumio[1438]: info: CoreCommandRouter::servicePushState Dec 27 11:19:13 volumio volumio[1438]: info: CorePlayQueue::getTrack 2 Dec 27 11:19:13 volumio volumio[1438]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":110979,"duration":318,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Thu Quyến Rũ","artist":"Tuấn Ngọc","album":"Và Tôi Mãi Yêu Em - CD1","uri":"INTERNAL/Tuấn Ngọc - Và Tôi Mãi Yêu Em (CD1)/03 - Thu Quyen Ru.mp3","trackType":"mp3"} Dec 27 11:19:13 volumio volumio[1438]: verbose: CURRENT POSITION 2 Dec 27 11:19:13 volumio volumio[1438]: info: CoreStateMachine::syncState stateService pause Dec 27 11:19:13 volumio volumio[1438]: info: CoreStateMachine::syncState currentStatus pause Dec 27 11:19:13 volumio volumio[1438]: info: CoreStateMachine::pushState Dec 27 11:19:13 volumio volumio[1438]: info: CorePlayQueue::getTrack 2 Dec 27 11:19:13 volumio volumio[1438]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 11:19:13 volumio volumio[1438]: info: CoreCommandRouter::volumioPushState Dec 27 11:19:13 volumio volumio[1438]: info: CoreStateMachine::stPlaybackTimer Dec 27 11:19:13 volumio volumio[1438]: info: ------------------------------ 10ms Dec 27 11:19:13 volumio volumio[1438]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 27 11:19:13 volumio volumio[1438]: TypeError: Cannot read properties of null (reading 'slice') Dec 27 11:19:13 volumio volumio[1438]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 27 11:19:13 volumio volumio[1438]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 27 11:19:13 volumio volumio[1438]: at Object.onceWrapper (node:events:629:26) Dec 27 11:19:13 volumio volumio[1438]: at ClientRequest.emit (node:events:514:28) Dec 27 11:19:13 volumio volumio[1438]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Dec 27 11:19:13 volumio volumio[1438]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Dec 27 11:19:13 volumio volumio[1438]: at TLSSocket.socketOnData (node:_http_client:535:22) Dec 27 11:19:13 volumio volumio[1438]: at TLSSocket.emit (node:events:514:28) Dec 27 11:19:13 volumio volumio[1438]: at addChunk (node:internal/streams/readable:343:12) Dec 27 11:19:13 volumio volumio[1438]: at readableAddChunk (node:internal/streams/readable:316:9) Dec 27 11:19:13 volumio volumio[1438]: at Readable.push (node:internal/streams/readable:253:10) Dec 27 11:19:13 volumio volumio[1438]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Dec 27 11:19:13 volumio volumio[1438]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 27 11:19:13 volumio sudo[5289]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-27 11:18' Dec 27 11:19:13 volumio sudo[5289]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"