-- Logs begin at Thu 2024-10-03 07:54:30 EDT, end at Thu 2024-10-03 08:22:17 EDT. --
Oct 03 08:21:01 volumac volumio[1039]: info: AutoStart - onStop
Oct 03 08:21:01 volumac volumio[1039]: info: Disabling plugin autostart
Oct 03 08:21:01 volumac volumio[1039]: info: Done.
Oct 03 08:21:02 volumac volumio[1039]: info: Enabling plugin crossfader_switch
Oct 03 08:21:02 volumac volumio[1039]: info: Loading plugin "crossfader_switch"...
Oct 03 08:21:02 volumac volumio[1039]: info: PLUGIN START: crossfader_switch
Oct 03 08:21:02 volumac volumio[1039]: info: Done.
Oct 03 08:21:03 volumac volumio[1039]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 03 08:21:24 volumac volumio[1039]: info: CALLMETHOD: system_controller crossfader_switch saveSettings [object Object]
Oct 03 08:21:24 volumac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: crossfader_switch , saveSettings
Oct 03 08:21:24 volumac volumio[1039]: info:
Oct 03 08:21:24 volumac volumio[1039]: ---------------------------- MPD announces state update: options
Oct 03 08:21:24 volumac volumio[1039]: info: ControllerMpd::getState
Oct 03 08:21:24 volumac volumio[1039]: verbose: ControllerMpd::sendMpdCommand status
Oct 03 08:21:24 volumac volumio[1039]: info:
Oct 03 08:21:24 volumac volumio[1039]: ---------------------------- MPD announces state update: options
Oct 03 08:21:24 volumac volumio[1039]: info: ControllerMpd::getState
Oct 03 08:21:24 volumac volumio[1039]: verbose: ControllerMpd::sendMpdCommand status
Oct 03 08:21:24 volumac volumio[1039]: info: sendMpdCommand status took 10 milliseconds
Oct 03 08:21:24 volumac volumio[1039]: verbose: ControllerMpd::parseState
Oct 03 08:21:24 volumac volumio[1039]: info: ControllerMpd::pushState
Oct 03 08:21:24 volumac volumio[1039]: info: CoreCommandRouter::servicePushState
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::pushState
Oct 03 08:21:24 volumac volumio[1039]: info: CorePlayQueue::getTrack 0
Oct 03 08:21:24 volumac volumio[1039]: info: CoreCommandRouter::volumioPushState
Oct 03 08:21:24 volumac volumio[1039]: info: CorePlayQueue::getTrack 0
Oct 03 08:21:24 volumac volumio[1039]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 03 08:21:24 volumac volumio[1039]: verbose: CURRENT POSITION 0
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::syncState stateService stop
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::syncState currentStatus stop
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::pushState
Oct 03 08:21:24 volumac volumio[1039]: info: CorePlayQueue::getTrack 0
Oct 03 08:21:24 volumac volumio[1039]: info: CoreCommandRouter::volumioPushState
Oct 03 08:21:24 volumac volumio[1039]: info: No code
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::pushState
Oct 03 08:21:24 volumac volumio[1039]: info: CorePlayQueue::getTrack 0
Oct 03 08:21:24 volumac volumio[1039]: info: CoreCommandRouter::volumioPushState
Oct 03 08:21:24 volumac volumio[1039]: info: ------------------------------ 34ms
Oct 03 08:21:24 volumac volumio[1039]: info: sendMpdCommand status took 30 milliseconds
Oct 03 08:21:24 volumac volumio[1039]: verbose: ControllerMpd::parseState
Oct 03 08:21:24 volumac volumio[1039]: info: ControllerMpd::pushState
Oct 03 08:21:24 volumac volumio[1039]: info: CoreCommandRouter::servicePushState
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::pushState
Oct 03 08:21:24 volumac volumio[1039]: info: CorePlayQueue::getTrack 0
Oct 03 08:21:24 volumac volumio[1039]: info: CoreCommandRouter::volumioPushState
Oct 03 08:21:24 volumac volumio[1039]: info: CorePlayQueue::getTrack 0
Oct 03 08:21:24 volumac volumio[1039]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 03 08:21:24 volumac volumio[1039]: verbose: CURRENT POSITION 0
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::syncState stateService stop
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::syncState currentStatus stop
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::pushState
Oct 03 08:21:24 volumac volumio[1039]: info: CorePlayQueue::getTrack 0
Oct 03 08:21:24 volumac volumio[1039]: info: CoreCommandRouter::volumioPushState
Oct 03 08:21:24 volumac volumio[1039]: info: No code
Oct 03 08:21:24 volumac volumio[1039]: info: CoreStateMachine::pushState
Oct 03 08:21:24 volumac volumio[1039]: info: CorePlayQueue::getTrack 0
Oct 03 08:21:24 volumac volumio[1039]: info: CoreCommandRouter::volumioPushState
Oct 03 08:21:24 volumac volumio[1039]: info: ------------------------------ 48ms
Oct 03 08:21:24 volumac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46
Oct 03 08:21:24 volumac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46
Oct 03 08:21:24 volumac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46
Oct 03 08:21:24 volumac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46
Oct 03 08:21:24 volumac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46
Oct 03 08:21:24 volumac volumio[1039]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46
Oct 03 08:21:28 volumac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 03 08:21:28 volumac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 03 08:21:37 volumac volumio[1039]: info: Enabling plugin music_services_shield
Oct 03 08:21:37 volumac volumio[1039]: info: Loading plugin "music_services_shield"...
Oct 03 08:21:37 volumac volumio[1039]: info: PLUGIN START: music_services_shield
Oct 03 08:21:37 volumac sudo[6567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Oct 03 08:21:37 volumac sudo[6567]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 03 08:21:38 volumac volumio[1039]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 03 08:21:38 volumac kernel: new mount options do not match the existing superblock, will be ignored
Oct 03 08:21:38 volumac sudo[6567]: pam_unix(sudo:session): session closed for user root
Oct 03 08:21:38 volumac volumio[1039]: info: Done.
Oct 03 08:21:38 volumac sudo[6587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh
Oct 03 08:21:38 volumac sudo[6587]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 03 08:21:38 volumac systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Oct 03 08:21:39 volumac volumio[6591]: cset: --> shielding system active with
Oct 03 08:21:39 volumac volumio[6591]: cset: "system" cpuset of CPUSPEC(1) with 129 tasks running
Oct 03 08:21:39 volumac volumio[6591]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
Oct 03 08:21:39 volumac systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Oct 03 08:21:39 volumac systemd[1]: Reloading.
Oct 03 08:21:39 volumac 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.
Oct 03 08:21:39 volumac systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Oct 03 08:21:39 volumac sudo[6587]: pam_unix(sudo:session): session closed for user root
Oct 03 08:21:39 volumac volumio[1039]: info: succeeded
Oct 03 08:21:40 volumac volumio[1039]: info: CALLMETHOD: system_hardware music_services_shield listUserTasks undefined
Oct 03 08:21:40 volumac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: music_services_shield , listUserTasks
Oct 03 08:21:40 volumac volumio[1039]: info: user tasks cset: --> shielding system active with cset: "system" cpuset of CPUSPEC(1) with 126 tasks running cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
USER PID PPID SPPr TASK NAME mpd 6174 1 Soth [mpd] mpd 6187 1 Soth [io] mpd 6188 1 Sf40 [rtio]
Oct 03 08:21:44 volumac volumio[1039]: info: CoreCommandRouter::Close All Modals sent
Oct 03 08:22:00 volumac volumio[1039]: info: CALLMETHOD: system_hardware music_services_shield saveConfig [object Object]
Oct 03 08:22:00 volumac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: music_services_shield , saveConfig
Oct 03 08:22:00 volumac sudo[6706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Oct 03 08:22:00 volumac sudo[6706]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 03 08:22:01 volumac sudo[6706]: pam_unix(sudo:session): session closed for user root
Oct 03 08:22:01 volumac volumio[1039]: info: succeeded
Oct 03 08:22:04 volumac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 03 08:22:04 volumac volumio[1039]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 03 08:22:11 volumac volumio[1039]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/fusiondsp/volumio/buster/amd64
Oct 03 08:22:16 volumac volumio[1039]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/fusiondsp/volumio/buster/amd64
Oct 03 08:22:17 volumac volumio[1039]: info: Folder /tmp/plugins removed
Oct 03 08:22:17 volumac volumio[1039]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 03 08:22:17 volumac volumio[1039]: Error: Unable to resolve or reject the same promise twice
Oct 03 08:22:17 volumac volumio[1039]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Oct 03 08:22:17 volumac volumio[1039]: at /volumio/app/pluginmanager.js:1087:11
Oct 03 08:22:17 volumac volumio[1039]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
Oct 03 08:22:17 volumac volumio[1039]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24
Oct 03 08:22:17 volumac volumio[1039]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
Oct 03 08:22:17 volumac volumio[1039]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:107:14
Oct 03 08:22:17 volumac volumio[1039]: at FSReqCallback.oncomplete (fs.js:180:23)
Oct 03 08:22:17 volumac volumio[1039]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 03 08:22:17 volumac sudo[6744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-03 08:21
Oct 03 08:22:17 volumac sudo[6744]: 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="8aa57e3ae5b742ea1069404608336a9884ccfb4e"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST"
VOLUMIO_VERSION="3.757"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"