-- Logs begin at Fri 2025-04-04 05:07:01 CEST, end at Sun 2025-04-27 22:27:14 CEST. -- Apr 27 22:26:02 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 22:26:02 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 22:26:02 volumio volumio[849]: info: Discovery: Getting this device information Apr 27 22:26:02 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:02 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 22:26:03 volumio volumio[849]: info: CoreCommandRouter::volumioGetQueue Apr 27 22:26:03 volumio volumio[849]: info: CoreStateMachine::getQueue Apr 27 22:26:03 volumio volumio[849]: info: CorePlayQueue::getQueue Apr 27 22:26:06 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 22:26:06 volumio volumio[849]: info: Received Get System Info Apr 27 22:26:06 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 22:26:06 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 22:26:06 volumio volumio[849]: info: Discovery: Getting this device information Apr 27 22:26:06 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:06 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 22:26:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 22:26:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 27 22:26:16 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 22:26:16 volumio volumio[849]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 27 22:26:16 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 27 22:26:16 volumio volumio[849]: info: Received Get System Version Apr 27 22:26:16 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 22:26:16 volumio volumio[849]: info: Received Get System Info Apr 27 22:26:16 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 22:26:16 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 22:26:16 volumio volumio[849]: info: Discovery: Getting this device information Apr 27 22:26:16 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:16 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 22:26:18 volumio volumio[849]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---list is Random,s.1,s.2,s.3,s.4,s.5,s.6 Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---1280x400+30-30bars-balbuze Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---1280x400+30-custom Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---1280x400+30-Gelo5 Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---1280x400+99-99bars-balbuze Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---1480x320+99-99bars-balbuze Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---1920x1080+13-Gelo5 Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---1920x1080+30-Gelo5 Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---1920x1080+55-Gelo5 Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---1920x720+99-99bars-balbuze Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---800x100+99-99bars Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---800x46+99-99bars-balbuze Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---800x480+20-marshall Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---800x480+230-230-bars-freq Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---800x480+30-30bars-balbuze Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---800x480+30-Gelo5 Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---800x480+30-marshall Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---800x480+55-marshall Apr 27 22:26:18 volumio volumio[849]: info: PeppySpectrum ---800x480+99-99bars-balbuze Apr 27 22:26:32 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 22:26:32 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 22:26:32 volumio volumio[849]: info: Discovery: Getting this device information Apr 27 22:26:32 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:32 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 22:26:34 volumio volumio[849]: info: CALLMETHOD: user_interface peppyspectrum dlspectrum [object Object] Apr 27 22:26:34 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , dlspectrum Apr 27 22:26:35 volumio volumio[849]: --2025-04-27 22:26:34-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/Zipped-folders/Choose Apr 27 22:26:35 volumio volumio[849]: Resolving github.com (github.com)... 140.82.121.4 Apr 27 22:26:35 volumio volumio[849]: Connecting to github.com (github.com)|140.82.121.4|:443... connected. Apr 27 22:26:35 volumio volumio[849]: HTTP request sent, awaiting response... 404 Not Found Apr 27 22:26:35 volumio volumio[849]: 2025-04-27 22:26:35 ERROR 404: Not Found. Apr 27 22:26:35 volumio volumio[849]: --2025-04-27 22:26:35-- http://a/ Apr 27 22:26:35 volumio volumio[849]: Resolving a (a)... failed: Device or resource busy. Apr 27 22:26:35 volumio volumio[849]: wget: unable to resolve host address ‘a’ Apr 27 22:26:35 volumio volumio[849]: --2025-04-27 22:26:35-- http://packet.zip/ Apr 27 22:26:35 volumio volumio[849]: Resolving packet.zip (packet.zip)... 162.255.119.167 Apr 27 22:26:35 volumio volumio[849]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. Apr 27 22:26:35 volumio volumio[849]: HTTP request sent, awaiting response... 302 Found Apr 27 22:26:35 volumio volumio[849]: Location: http://www.packet.zip/ [following] Apr 27 22:26:35 volumio volumio[849]: --2025-04-27 22:26:35-- http://www.packet.zip/ Apr 27 22:26:35 volumio volumio[849]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 Apr 27 22:26:35 volumio volumio[849]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Apr 27 22:26:35 volumio volumio[849]: HTTP request sent, awaiting response... 403 Forbidden Apr 27 22:26:35 volumio volumio[849]: 2025-04-27 22:26:35 ERROR 403: Forbidden. Apr 27 22:26:35 volumio volumio[849]: error: PeppySpectrum --- An error occurs while downloading or installing Spectrums Apr 27 22:26:35 volumio volumio[849]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Apr 27 22:26:35 volumio volumio[849]: /bin/rm: cannot remove 'a': No such file or directory Apr 27 22:26:35 volumio volumio[849]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Apr 27 22:26:35 volumio volumio[849]: (node:849) UnhandledPromiseRejectionWarning: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Apr 27 22:26:35 volumio volumio[849]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Apr 27 22:26:35 volumio volumio[849]: /bin/rm: cannot remove 'a': No such file or directory Apr 27 22:26:35 volumio volumio[849]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Apr 27 22:26:35 volumio volumio[849]: at checkExecSyncError (child_process.js:790:11) Apr 27 22:26:35 volumio volumio[849]: at execSync (child_process.js:863:15) Apr 27 22:26:35 volumio volumio[849]: at /data/plugins/user_interface/peppyspectrum/index.js:718:17 Apr 27 22:26:35 volumio volumio[849]: at new Promise () Apr 27 22:26:35 volumio volumio[849]: at peppyspectrum.dlspectrum (/data/plugins/user_interface/peppyspectrum/index.js:693:12) Apr 27 22:26:35 volumio volumio[849]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Apr 27 22:26:35 volumio volumio[849]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Apr 27 22:26:35 volumio volumio[849]: at Socket.emit (events.js:400:28) Apr 27 22:26:35 volumio volumio[849]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Apr 27 22:26:35 volumio volumio[849]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Apr 27 22:26:35 volumio volumio[849]: (Use `node --trace-warnings ...` to show where the warning was created) Apr 27 22:26:35 volumio volumio[849]: (node:849) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 1) Apr 27 22:26:35 volumio volumio[849]: (node:849) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Apr 27 22:26:37 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 22:26:37 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 22:26:37 volumio volumio[849]: info: Discovery: Getting this device information Apr 27 22:26:37 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:37 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 22:26:48 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:48 volumio sudo[11533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 22:26:48 volumio sudo[11533]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:48 volumio sudo[11536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 22:26:48 volumio sudo[11533]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:48 volumio sudo[11536]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:48 volumio sudo[11536]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:48 volumio volumio[849]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 22:26:49 volumio volumio[849]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 22:26:49 volumio sudo[11553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 22:26:49 volumio sudo[11553]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:49 volumio sudo[11556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 22:26:49 volumio sudo[11553]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:49 volumio sudo[11556]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:49 volumio sudo[11556]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:49 volumio volumio[849]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 22:26:49 volumio volumio[849]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 27 22:26:49 volumio volumio[849]: info: Listing playlists Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 27 22:26:49 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 22:26:50 volumio volumio[849]: info: CoreCommandRouter::volumioGetQueue Apr 27 22:26:50 volumio volumio[849]: info: CoreStateMachine::getQueue Apr 27 22:26:50 volumio volumio[849]: info: CorePlayQueue::getQueue Apr 27 22:26:53 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 22:26:53 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 27 22:26:53 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 22:26:53 volumio volumio[849]: info: Received Get System Info Apr 27 22:26:53 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 22:26:53 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 22:26:53 volumio volumio[849]: info: Discovery: Getting this device information Apr 27 22:26:53 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:53 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 22:26:58 volumio volumio[849]: info: Starting Uninstall of plugin user_interface - peppyspectrum Apr 27 22:26:58 volumio volumio[849]: info: Uninstalling plugin peppyspectrum Apr 27 22:26:58 volumio volumio[849]: info: Stopping peppyspectrum service Apr 27 22:26:58 volumio volumio[849]: info: CoreStateMachine::stop Apr 27 22:26:58 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 22:26:58 volumio volumio[849]: info: CoreStateMachine::stPlaybackTimer Apr 27 22:26:58 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Apr 27 22:26:58 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Apr 27 22:26:58 volumio volumio[849]: info: CoreStateMachine::pushState Apr 27 22:26:58 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:58 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 22:26:58 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Apr 27 22:26:58 volumio volumio[849]: info: CoreStateMachine::serviceStop Apr 27 22:26:58 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:58 volumio volumio[849]: info: CoreCommandRouter::serviceStop Apr 27 22:26:58 volumio volumio[849]: info: [1745785618981] ControllerWebradio::stop Apr 27 22:26:58 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 22:26:58 volumio volumio[849]: info: Disabling plugin peppyspectrum Apr 27 22:26:58 volumio volumio[849]: info: Preparing to generate the ALSA configuration file Apr 27 22:26:59 volumio volumio[849]: info: PeppySpectrum ---peppyspectrum status stop Apr 27 22:26:59 volumio volumio[849]: info: Apr 27 22:26:59 volumio volumio[849]: ---------------------------- MPD announces state update: player Apr 27 22:26:59 volumio volumio[849]: info: sendMpdCommand stop took 49 milliseconds Apr 27 22:26:59 volumio volumio[849]: info: ControllerMpd::getState Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Apr 27 22:26:59 volumio sudo[11587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 27 22:26:59 volumio volumio[849]: info: sendMpdCommand status took 19 milliseconds Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::parseState Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 22:26:59 volumio volumio[849]: info: Apr 27 22:26:59 volumio volumio[849]: ---------------------------- MPD announces state update: player Apr 27 22:26:59 volumio volumio[849]: info: ControllerMpd::getState Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Apr 27 22:26:59 volumio volumio[849]: info: Apr 27 22:26:59 volumio volumio[849]: ---------------------------- MPD announces state update: player Apr 27 22:26:59 volumio volumio[849]: info: ControllerMpd::getState Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Apr 27 22:26:59 volumio volumio[849]: info: Apr 27 22:26:59 volumio volumio[849]: ---------------------------- MPD announces state update: player Apr 27 22:26:59 volumio volumio[849]: info: ControllerMpd::getState Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Apr 27 22:26:59 volumio sudo[11587]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio volumio[849]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 27 22:26:59 volumio volumio[849]: info: sendMpdCommand status took 6 milliseconds Apr 27 22:26:59 volumio volumio[849]: info: sendMpdCommand status took 5 milliseconds Apr 27 22:26:59 volumio volumio[849]: info: sendMpdCommand status took 5 milliseconds Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::parseState Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::parseState Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::parseState Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 22:26:59 volumio volumio[849]: info: ControllerMpd::pushState Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::servicePushState Apr 27 22:26:59 volumio volumio[849]: info: CoreStateMachine::pushState Apr 27 22:26:59 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Apr 27 22:26:59 volumio sudo[11591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 27 22:26:59 volumio sudo[11591]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:59 volumio volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 27 22:26:59 volumio sudo[11587]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio volumio[849]: info: ------------------------------ 59ms Apr 27 22:26:59 volumio volumio[849]: info: sendMpdCommand playlistinfo took 32 milliseconds Apr 27 22:26:59 volumio volumio[849]: info: sendMpdCommand playlistinfo took 31 milliseconds Apr 27 22:26:59 volumio volumio[849]: info: sendMpdCommand playlistinfo took 32 milliseconds Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Apr 27 22:26:59 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Apr 27 22:26:59 volumio volumio[849]: info: ControllerMpd::pushState Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::servicePushState Apr 27 22:26:59 volumio volumio[849]: info: CoreStateMachine::pushState Apr 27 22:26:59 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Apr 27 22:26:59 volumio sudo[11591]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:59 volumio volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 27 22:26:59 volumio volumio[849]: info: ControllerMpd::pushState Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::servicePushState Apr 27 22:26:59 volumio volumio[849]: info: CoreStateMachine::pushState Apr 27 22:26:59 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Apr 27 22:26:59 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:59 volumio volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 27 22:26:59 volumio volumio[849]: info: ControllerMpd::pushState Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::servicePushState Apr 27 22:26:59 volumio volumio[849]: info: CoreStateMachine::pushState Apr 27 22:26:59 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Apr 27 22:26:59 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:59 volumio volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 27 22:26:59 volumio volumio[849]: info: ------------------------------ 78ms Apr 27 22:26:59 volumio volumio[849]: info: ------------------------------ 77ms Apr 27 22:26:59 volumio volumio[849]: info: ------------------------------ 77ms Apr 27 22:26:59 volumio volumio[849]: info: peppyspectrum Daemon Stop Apr 27 22:26:59 volumio volumio[849]: info: Asound.conf file written Apr 27 22:26:59 volumio sudo[11607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 27 22:26:59 volumio sudo[11607]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio sudo[11607]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio volumio[849]: xcb_connection_has_error() returned true Apr 27 22:26:59 volumio volumio[849]: info: Output device has changed, restarting MPD Apr 27 22:26:59 volumio volumio[849]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio sudo[11619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 22:26:59 volumio vtcs[10902]: [2025-04-27 22:26:59.295] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Apr 27 22:26:59 volumio vtcs[10902]: [2025-04-27 22:26:59.295] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Apr 27 22:26:59 volumio sudo[11622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 22:26:59 volumio sudo[11619]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio sudo[11619]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio sudo[11622]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio volumio[849]: info: Checking if uninstall.sh is present Apr 27 22:26:59 volumio systemd[1]: Stopping Music Player Daemon... Apr 27 22:26:59 volumio sudo[11638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 27 22:26:59 volumio sudo[11638]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio volumio[849]: info: Executing uninstall.sh Apr 27 22:26:59 volumio sudo[11644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 27 22:26:59 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 27 22:26:59 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 27 22:26:59 volumio systemd[1]: vtcs.service: Succeeded. Apr 27 22:26:59 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 27 22:26:59 volumio sudo[11644]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio sudo[11638]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 22:26:59 volumio systemd[1]: mpd.service: Succeeded. Apr 27 22:26:59 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 22:26:59 volumio volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 22:26:59 volumio systemd[1]: Starting Music Player Daemon... Apr 27 22:26:59 volumio volumio[849]: info: MPD Permissions set Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:26:59 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:26:59 volumio volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 27 22:26:59 volumio volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 22:26:59 volumio sudo[11644]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 22:26:59 volumio sudo[11652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/peppyspectrum/uninstall.sh Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 22:26:59 volumio sudo[11652]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio sudo[11657]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 22:26:59 volumio sudo[11657]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio sudo[11657]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio sudo[11678]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -Rf /data/plugins/user_interface/peppyspectrum/PeppySpectrum/__pycache__ Apr 27 22:26:59 volumio sudo[11678]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio sudo[11678]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio sudo[11692]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /etc/systemd/system/peppyspectrum.service Apr 27 22:26:59 volumio sudo[11692]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:26:59 volumio sudo[11692]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio sudo[11652]: pam_unix(sudo:session): session closed for user root Apr 27 22:26:59 volumio volumio[849]: info: Uninstall script completed Apr 27 22:26:59 volumio volumio[849]: info: Removing plugin peppyspectrum from configuration Apr 27 22:26:59 volumio volumio[849]: info: Successfully removed peppyspectrum configuration files Apr 27 22:26:59 volumio volumio[849]: info: Plugin folders cleanup Apr 27 22:26:59 volumio volumio[849]: info: Scanning into folder /volumio/app/plugins/ Apr 27 22:26:59 volumio volumio[849]: info: Scanning category audio_interface Apr 27 22:26:59 volumio volumio[849]: info: Scanning category miscellanea Apr 27 22:26:59 volumio volumio[849]: info: Scanning category music_service Apr 27 22:26:59 volumio volumio[849]: info: Scanning category plugins.json Apr 27 22:26:59 volumio volumio[849]: info: Scanning category system_controller Apr 27 22:26:59 volumio volumio[849]: info: Scanning category user_interface Apr 27 22:26:59 volumio volumio[849]: info: Scanning into folder /data/plugins/ Apr 27 22:26:59 volumio volumio[849]: info: Scanning category audio_interface Apr 27 22:26:59 volumio volumio[849]: info: Scanning category music_service Apr 27 22:26:59 volumio volumio[849]: info: Scanning category system_controller Apr 27 22:26:59 volumio volumio[849]: info: Scanning category user_interface Apr 27 22:26:59 volumio volumio[849]: info: Cleaning folder for peppyspectrum Apr 27 22:26:59 volumio volumio[849]: info: Plugin folders cleanup completed Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 22:26:59 volumio volumio[849]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.61","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":false,"active":false},{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube2","name":"youtube2","category":"music_service","version":"1.4.2","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.0.6","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.1.3","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false}] Apr 27 22:26:59 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 27 22:27:00 volumio mpd[11693]: Apr 27 22:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 27 22:27:00 volumio systemd[1]: Started Music Player Daemon. Apr 27 22:27:00 volumio sudo[11622]: pam_unix(sudo:session): session closed for user root Apr 27 22:27:00 volumio volumio[849]: error: updateQueue error: null Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 22:27:02 volumio volumio[849]: info: Discovery: Getting this device information Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:27:02 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 22:27:02 volumio volumio[849]: info: TidalConnect service stoped! Apr 27 22:27:02 volumio volumio[849]: info: TidalConnect service stoped! Apr 27 22:27:02 volumio volumio[849]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 27 22:27:02 volumio volumio[849]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 27 22:27:02 volumio sudo[11738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 27 22:27:02 volumio sudo[11738]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 22:27:02 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 27 22:27:02 volumio sudo[11738]: pam_unix(sudo:session): session closed for user root Apr 27 22:27:02 volumio volumio[849]: info: Executing endpoint tc_getconfig Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 27 22:27:02 volumio vtcs[11744]: STARTING TidalConnect services, version: 1.5.0.45 Apr 27 22:27:02 volumio vtcs[11744]: STARTED TidalConnect services. Apr 27 22:27:02 volumio volumio[849]: info: Executing endpoint tc_connect Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 27 22:27:02 volumio volumio[849]: info: Connecting to TidalConnect Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::servicePushState Apr 27 22:27:02 volumio volumio[849]: info: CoreStateMachine::pushState Apr 27 22:27:02 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Apr 27 22:27:02 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:27:02 volumio volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::servicePushState Apr 27 22:27:02 volumio volumio[849]: info: CoreStateMachine::pushState Apr 27 22:27:02 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:27:02 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Apr 27 22:27:02 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:27:02 volumio volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 27 22:27:05 volumio volumio[849]: info: TidalConnect service started! Apr 27 22:27:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 22:27:07 volumio volumio[849]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 27 22:27:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 27 22:27:07 volumio volumio[849]: info: Received Get System Version Apr 27 22:27:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 22:27:07 volumio volumio[849]: info: Received Get System Info Apr 27 22:27:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 22:27:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 22:27:07 volumio volumio[849]: info: Discovery: Getting this device information Apr 27 22:27:07 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Apr 27 22:27:07 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Apr 27 22:27:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 22:27:13 volumio volumio[849]: info: Starting Uninstall of plugin system_controller - ampswitch Apr 27 22:27:13 volumio volumio[849]: info: Uninstalling plugin ampswitch Apr 27 22:27:13 volumio volumio[849]: info: [ASDebug] Port: 24 Apr 27 22:27:13 volumio volumio[849]: info: [ASDebug] Inverted: false Apr 27 22:27:13 volumio volumio[849]: info: [ASDebug] Delay: 720 Apr 27 22:27:13 volumio volumio[849]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 22:27:13 volumio volumio[849]: TypeError: Cannot read property 'unexport' of undefined Apr 27 22:27:13 volumio volumio[849]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Apr 27 22:27:13 volumio volumio[849]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Apr 27 22:27:13 volumio volumio[849]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Apr 27 22:27:13 volumio volumio[849]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Apr 27 22:27:13 volumio volumio[849]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22) Apr 27 22:27:13 volumio volumio[849]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1260:45) Apr 27 22:27:13 volumio volumio[849]: at Socket.emit (events.js:400:28) Apr 27 22:27:13 volumio volumio[849]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Apr 27 22:27:13 volumio volumio[849]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Apr 27 22:27:13 volumio volumio[849]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 22:27:14 volumio sudo[11793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-27 22:26 Apr 27 22:27:14 volumio sudo[11793]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:14:40 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="a9bbde8819c9c7e405795a261e2a2f93"