-- Logs begin at Tue 2025-12-23 02:09:54 +07, end at Tue 2025-12-23 02:15:47 +07. --
Dec 23 02:14:00 chot volumio[961]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/music_services_shield/volumio/buster/armhf
Dec 23 02:14:02 chot volumio[961]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/music_services_shield/volumio/buster/armhf
Dec 23 02:14:02 chot volumio[961]: info: Folder /tmp/plugins removed
Dec 23 02:14:02 chot volumio[961]: info: Check plugin dependencies
Dec 23 02:14:02 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 23 02:14:02 chot volumio[961]: info: Checking if plugin already exists
Dec 23 02:14:02 chot volumio[961]: info: Rename folder
Dec 23 02:14:02 chot volumio[961]: info: Folder /tmp/downloaded_plugin.zip removed
Dec 23 02:14:02 chot volumio[961]: info: Move to category
Dec 23 02:14:05 chot volumio[961]: info: Checking if install.sh is present
Dec 23 02:14:05 chot volumio[961]: info: Executing install.sh
Dec 23 02:14:05 chot sudo[3211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/music_services_shield/install.sh
Dec 23 02:14:05 chot sudo[3211]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:05 chot volumio[961]: info: Installing Music Services Shield Dependencies
Dec 23 02:14:05 chot volumio[961]: info: Detected cpu architecture as armv7l
Dec 23 02:14:05 chot sudo[3221]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update
Dec 23 02:14:05 chot sudo[3221]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:05 chot volumio[961]: info: Get:1 http://archive.debian.org/debian buster InRelease [122 kB]
Dec 23 02:14:07 chot volumio[961]: info: Get:2 https://deb.nodesource.com/node_14.x buster InRelease [4584 B]
Dec 23 02:14:08 chot volumio[961]: info: Get:3 http://archive.debian.org/debian buster/main armhf Packages [7706 kB]
Dec 23 02:14:08 chot volumio[961]: info: Get:4 http://archive.debian.org/debian buster/main Translation-en [5969 kB]
Dec 23 02:14:08 chot volumio[961]: info: Get:5 http://archive.debian.org/debian buster/contrib armhf Packages [40.1 kB]
Dec 23 02:14:08 chot volumio[961]: info: Get:6 http://archive.debian.org/debian buster/contrib Translation-en [44.2 kB]
Dec 23 02:14:08 chot volumio[961]: info: Get:7 http://archive.debian.org/debian buster/non-free armhf Packages [62.1 kB]
Dec 23 02:14:08 chot volumio[961]: info: Get:8 http://archive.debian.org/debian buster/non-free Translation-en [88.9 kB]
Dec 23 02:14:08 chot volumio[961]: info: Get:9 https://deb.nodesource.com/node_14.x buster/main armhf Packages [786 B]
Dec 23 02:14:17 chot volumio[961]: info: Fetched 14.0 MB in 12s (1135 kB/s)
Dec 23 02:14:20 chot volumio[961]: info: Reading package lists...
Dec 23 02:14:20 chot sudo[3221]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:20 chot sudo[3486]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get -y install cpuset
Dec 23 02:14:20 chot sudo[3486]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:20 chot volumio[961]: info: Reading package lists...
Dec 23 02:14:21 chot volumio[961]: info: Building dependency tree...
Dec 23 02:14:21 chot volumio[961]: info: Reading state information...
Dec 23 02:14:28 chot volumio[961]: info: The following NEW packages will be installed:
Dec 23 02:14:28 chot volumio[961]: info: cpuset
Dec 23 02:14:28 chot volumio[961]: info: 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
Dec 23 02:14:28 chot volumio[961]: info: Need to get 87.9 kB of archives.
Dec 23 02:14:28 chot volumio[961]: info: After this operation, 337 kB of additional disk space will be used.
Dec 23 02:14:28 chot volumio[961]: info: Get:1 http://archive.debian.org/debian buster/main armhf cpuset all 1.5.6-5.1 [87.9 kB]
Dec 23 02:14:32 chot volumio[961]: info: Fetched 87.9 kB in 1s (134 kB/s)
Dec 23 02:14:33 chot volumio[961]: info: Selecting previously unselected package cpuset.
Dec 23 02:14:33 chot volumio[961]: [145B blob data]
Dec 23 02:14:34 chot volumio[961]: [146B blob data]
Dec 23 02:14:34 chot volumio[961]: [173B blob data]
Dec 23 02:14:34 chot volumio[961]: [202B blob data]
Dec 23 02:14:34 chot volumio[961]: [145B blob data]
Dec 23 02:14:34 chot volumio[961]: [416B blob data]
Dec 23 02:14:34 chot volumio[961]: info: Preparing to unpack .../cpuset_1.5.6-5.1_all.deb ...
Dec 23 02:14:34 chot volumio[961]: info: Unpacking cpuset (1.5.6-5.1) ...
Dec 23 02:14:48 chot volumio[961]: info: Setting up cpuset (1.5.6-5.1) ...
Dec 23 02:14:49 chot volumio[961]: info: Processing triggers for man-db (2.8.5-2) ...
Dec 23 02:14:50 chot sudo[3486]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:50 chot sudo[3599]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/moveprocess.sh
Dec 23 02:14:50 chot sudo[3599]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:50 chot sudo[3599]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:50 chot sudo[3608]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Dec 23 02:14:50 chot sudo[3608]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:50 chot sudo[3608]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:50 chot sudo[3617]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/usertaskstable.sh
Dec 23 02:14:50 chot sudo[3617]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:50 chot sudo[3617]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:50 chot sudo[3626]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/builduiconfig.sh
Dec 23 02:14:50 chot sudo[3626]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:50 chot sudo[3626]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:50 chot sudo[3635]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/setconfigparameter.sh
Dec 23 02:14:50 chot sudo[3635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:50 chot sudo[3635]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:50 chot sudo[3644]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/setrtpriority.sh
Dec 23 02:14:50 chot sudo[3644]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:50 chot sudo[3644]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:50 chot sudo[3653]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/addservice.sh
Dec 23 02:14:50 chot sudo[3653]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:50 chot sudo[3653]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:50 chot sudo[3662]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/removeservice.sh
Dec 23 02:14:50 chot sudo[3662]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:50 chot sudo[3662]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:51 chot sudo[3211]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:51 chot volumio[961]: Plugin install end detected on script
Dec 23 02:14:51 chot volumio[961]: info: Install script completed
Dec 23 02:14:51 chot volumio[961]: info: Adding reference to registry
Dec 23 02:14:51 chot volumio[961]: info: Done installing plugin.
Dec 23 02:14:51 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 23 02:14:51 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 23 02:14:51 chot volumio[961]: info: Folder /tmp/plugins removed
Dec 23 02:14:51 chot volumio[961]: info: Folder /tmp/downloaded_plugin.zip removed
Dec 23 02:14:51 chot volumio[961]: info: Folder /data/temp removed
Dec 23 02:14:57 chot volumio[961]: info: Enabling plugin music_services_shield
Dec 23 02:14:57 chot volumio[961]: info: Loading plugin "music_services_shield"...
Dec 23 02:14:57 chot volumio[961]: info: PLUGIN START: music_services_shield
Dec 23 02:14:58 chot sudo[3733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Dec 23 02:14:58 chot sudo[3733]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:58 chot kernel: cgroup: new mount options do not match the existing superblock, will be ignored
Dec 23 02:14:58 chot sudo[3733]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:58 chot volumio[961]: info: Done.
Dec 23 02:14:58 chot sudo[3761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh
Dec 23 02:14:58 chot sudo[3761]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:14:58 chot systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Dec 23 02:14:58 chot volumio[3770]: cset: --> shielding system active with
Dec 23 02:14:58 chot volumio[3770]: cset: "system" cpuset of CPUSPEC(1-3) with 110 tasks running
Dec 23 02:14:58 chot volumio[3770]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
Dec 23 02:14:58 chot systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Dec 23 02:14:59 chot systemd[1]: Reloading.
Dec 23 02:14:59 chot systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Dec 23 02:14:59 chot sudo[3761]: pam_unix(sudo:session): session closed for user root
Dec 23 02:14:59 chot volumio[961]: info: succeeded
Dec 23 02:15:03 chot volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 23 02:15:09 chot volumio[961]: info: CALLMETHOD: system_hardware music_services_shield saveConfig [object Object]
Dec 23 02:15:09 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: music_services_shield , saveConfig
Dec 23 02:15:14 chot volumio[961]: info: CALLMETHOD: system_hardware music_services_shield saveConfig [object Object]
Dec 23 02:15:14 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: music_services_shield , saveConfig
Dec 23 02:15:15 chot sudo[3898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Dec 23 02:15:15 chot sudo[3898]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:15:15 chot sudo[3898]: pam_unix(sudo:session): session closed for user root
Dec 23 02:15:17 chot volumio[961]: info: succeeded
Dec 23 02:15:17 chot sudo[3962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Dec 23 02:15:17 chot sudo[3962]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 02:15:17 chot sudo[3962]: pam_unix(sudo:session): session closed for user root
Dec 23 02:15:17 chot volumio[961]: info: succeeded
Dec 23 02:15:19 chot volumio[961]: info: CALLMETHOD: system_hardware music_services_shield listUserTasks undefined
Dec 23 02:15:19 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: music_services_shield , listUserTasks
Dec 23 02:15:21 chot volumio[961]: info: user tasks cset: --> shielding system active with cset: "system" cpuset of CPUSPEC(0) with 107 tasks running cset: "user" cpuset of CPUSPEC(1-3) with 3 tasks running
USER PID PPID SPPr TASK NAME mpd 2279 1 Soth [mpd] mpd 2280 1 Soth [io] mpd 2281 1 Sf40 [rtio]
Dec 23 02:15:26 chot volumio[961]: info: CoreCommandRouter::Close All Modals sent
Dec 23 02:15:28 chot volumio[961]: info: CoreCommandRouter::volumioGetState
Dec 23 02:15:28 chot volumio[961]: info: CorePlayQueue::getTrack 0
Dec 23 02:15:34 chot ntpd[1300]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Dec 23 02:15:35 chot ntpd[1300]: frequency error 1753 PPM exceeds tolerance 500 PPM
Dec 23 02:15:35 chot ntpd[1300]: receive: Unexpected origin timestamp 0xecf41756.ab001d05 does not match aorg 0000000000.00000000 from server@202.12.97.45 xmt 0xecf41757.3835a23d
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 23 02:15:37 chot volumio[961]: info: Retrieving Cloud Streaming UI
Dec 23 02:15:37 chot volumio[961]: info: Getting Tidal Cloud Configuration
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 23 02:15:37 chot volumio[961]: info: Getting Qobuz Cloud Configuration
Dec 23 02:15:37 chot volumio[961]: info: Asking plugin for UI Config
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 23 02:15:37 chot volumio[961]: info: Getting Spotify Cloud Configuration
Dec 23 02:15:37 chot volumio[961]: info: Asking plugin for UI Config
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 23 02:15:37 chot volumio[961]: info: Saving Spotify Acccount
Dec 23 02:15:37 chot volumio[961]: info: Got Tidal Cloud Configuration
Dec 23 02:15:37 chot volumio[961]: info: Got it
Dec 23 02:15:37 chot volumio[961]: info: Got it
Dec 23 02:15:37 chot volumio[961]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 23 02:15:37 chot volumio[961]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 23 02:15:37 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Dec 23 02:15:41 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 23 02:15:45 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 23 02:15:46 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Dec 23 02:15:46 chot volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Dec 23 02:15:47 chot volumio[961]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 23 02:15:47 chot volumio[961]: Error: getaddrinfo -3007
Dec 23 02:15:47 chot volumio[961]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Dec 23 02:15:47 chot volumio[961]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Dec 23 02:15:47 chot volumio[961]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Dec 23 02:15:47 chot volumio[961]: code: -3007,
Dec 23 02:15:47 chot volumio[961]: errno: -3007,
Dec 23 02:15:47 chot volumio[961]: syscall: 'getaddrinfo'
Dec 23 02:15:47 chot volumio[961]: }
Dec 23 02:15:47 chot volumio[961]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 23 02:15:47 chot sudo[4062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-23 02:14
Dec 23 02:15:47 chot sudo[4062]: 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="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:03:54 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_DEVICENAME="Asus Tinkerboard"
VOLUMIO_HASH="35e446ff98e90abcfcab1bb2733dfd3a"