-- Logs begin at Thu 2019-02-14 12:11:58 EET, end at Sat 2025-03-01 16:56:40 EET. -- Mar 01 16:55:01 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:55:01 volumio volumio[1132]: info: Listing playlists Mar 01 16:55:01 volumio volumio[1132]: info: Listing playlists Mar 01 16:55:05 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 01 16:55:05 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 16:55:05 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 16:55:05 volumio volumio[1132]: info: Discovery: Getting this device information Mar 01 16:55:05 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:55:05 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 16:55:10 volumio volumio[1132]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/peppyspectrum/0.0.33/volumio/buster/armhf Mar 01 16:55:11 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:55:12 volumio volumio[1132]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/peppyspectrum/0.0.33/volumio/buster/armhf Mar 01 16:55:12 volumio volumio[1132]: info: Folder /tmp/plugins removed Mar 01 16:55:12 volumio volumio[1132]: info: Check plugin dependencies Mar 01 16:55:12 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 16:55:12 volumio volumio[1132]: info: Checking if plugin already exists Mar 01 16:55:12 volumio volumio[1132]: info: Rename folder Mar 01 16:55:12 volumio volumio[1132]: info: Folder /tmp/downloaded_plugin.zip removed Mar 01 16:55:12 volumio volumio[1132]: info: Move to category Mar 01 16:55:13 volumio volumio[1132]: info: Checking if install.sh is present Mar 01 16:55:13 volumio volumio[1132]: info: Executing install.sh Mar 01 16:55:13 volumio sudo[18574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/peppyspectrum/install.sh Mar 01 16:55:13 volumio sudo[18574]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:13 volumio volumio[1132]: info: Installing peppyalsa plugin dependencies Mar 01 16:55:13 volumio sudo[18579]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 01 16:55:13 volumio sudo[18579]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:13 volumio systemd[1]: Reloading. Mar 01 16:55:13 volumio 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. Mar 01 16:55:14 volumio sudo[18579]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:14 volumio sudo[18594]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update Mar 01 16:55:14 volumio sudo[18594]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:14 volumio volumio[1132]: info: Hit:1 http://archive.raspberrypi.org/debian buster InRelease Mar 01 16:55:14 volumio volumio[1132]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease Mar 01 16:55:14 volumio volumio[1132]: info: Get:3 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB] Mar 01 16:55:15 volumio volumio[1132]: info: Fetched 15.0 kB in 1s (14.6 kB/s) Mar 01 16:55:18 volumio volumio[1132]: info: Reading package lists... Mar 01 16:55:18 volumio sudo[18594]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:18 volumio volumio[1132]: info: cloning peppyspectrum repo Mar 01 16:55:21 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:55:21 volumio volumio[1132]: info: Listing playlists Mar 01 16:55:21 volumio volumio[1132]: info: Listing playlists Mar 01 16:55:21 volumio sudo[18876]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown -R volumio /data/plugins/user_interface/peppyspectrum /data/INTERNAL/PeppySpectrum/Templates Mar 01 16:55:21 volumio sudo[18876]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:22 volumio sudo[18876]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:22 volumio sudo[18878]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chgrp -R volumio /data/plugins/user_interface/peppyspectrum /data/INTERNAL/PeppySpectrum/Templates Mar 01 16:55:22 volumio sudo[18878]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:22 volumio sudo[18878]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:22 volumio volumio[1132]: info: installing apt packages Mar 01 16:55:22 volumio sudo[18880]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get -y install python3-pygame python3-pip python3-dev libjpeg-dev zlib1g-dev Mar 01 16:55:22 volumio sudo[18880]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:22 volumio volumio[1132]: info: Reading package lists... Mar 01 16:55:22 volumio volumio[1132]: info: Building dependency tree... Mar 01 16:55:22 volumio volumio[1132]: info: Reading state information... Mar 01 16:55:23 volumio volumio[1132]: info: libjpeg-dev is already the newest version (1:1.5.2-2+deb10u1). Mar 01 16:55:23 volumio sudo[18880]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:23 volumio volumio[1132]: info: python3-dev is already the newest version (3.7.3-1). Mar 01 16:55:23 volumio volumio[1132]: info: python3-pygame is already the newest version (1.9.4.post1+dfsg-3). Mar 01 16:55:23 volumio volumio[1132]: info: zlib1g-dev is already the newest version (1:1.2.11.dfsg-1+deb10u2). Mar 01 16:55:23 volumio volumio[1132]: info: python3-pip is already the newest version (18.1-5+rpt1). Mar 01 16:55:23 volumio volumio[1132]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. Mar 01 16:55:23 volumio volumio[1132]: info: Linked /data/plugins/user_interface/peppyspectrum/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppyspectrum/alsa-lib/libpeppyalsa.so Mar 01 16:55:23 volumio volumio[1132]: info: Linked /data/plugins/user_interface/peppyspectrum/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppyspectrum/alsa-lib/libpeppyalsa.so.0 Mar 01 16:55:27 volumio volumio[1132]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Mar 01 16:55:27 volumio volumio[1132]: info: Requirement already satisfied: Pillow in /usr/local/lib/python3.7/dist-packages (9.5.0) Mar 01 16:55:27 volumio sudo[18903]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/user_interface/peppyspectrum/startpeppyspectrum.sh Mar 01 16:55:27 volumio sudo[18903]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:27 volumio sudo[18903]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:27 volumio sudo[18574]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:27 volumio volumio[1132]: Plugin install end detected on script Mar 01 16:55:27 volumio volumio[1132]: info: Install script completed Mar 01 16:55:27 volumio volumio[1132]: info: Adding reference to registry Mar 01 16:55:28 volumio volumio[1132]: info: Done installing plugin. Mar 01 16:55:28 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 16:55:28 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 01 16:55:28 volumio volumio[1132]: info: Folder /tmp/plugins removed Mar 01 16:55:28 volumio volumio[1132]: info: Folder /tmp/downloaded_plugin.zip removed Mar 01 16:55:28 volumio volumio[1132]: info: Folder /data/temp removed Mar 01 16:55:29 volumio volumio[1132]: info: Enabling plugin peppyspectrum Mar 01 16:55:29 volumio volumio[1132]: info: Loading plugin "peppyspectrum"... Mar 01 16:55:29 volumio volumio[1132]: info: Preparing to generate the ALSA configuration file Mar 01 16:55:29 volumio volumio[1132]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 01 16:55:29 volumio volumio[1132]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Mar 01 16:55:29 volumio volumio[1132]: info: Reading ALSA contributions from plugins. Mar 01 16:55:29 volumio volumio[1132]: info: Asound.conf file written Mar 01 16:55:30 volumio sudo[18923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 01 16:55:30 volumio sudo[18923]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio sudo[18923]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio volumio[1132]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy Mar 01 16:55:30 volumio volumio[1132]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy Mar 01 16:55:30 volumio volumio[1132]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy Mar 01 16:55:30 volumio volumio[1132]: No state is present for card vc4hdmi0 Mar 01 16:55:30 volumio volumio[1132]: Found hardware: "vc4-hdmi" "" "" "" "" Mar 01 16:55:30 volumio volumio[1132]: Hardware is initialized using a generic method Mar 01 16:55:30 volumio volumio[1132]: No state is present for card vc4hdmi0 Mar 01 16:55:30 volumio volumio[1132]: No state is present for card vc4hdmi1 Mar 01 16:55:30 volumio volumio[1132]: Found hardware: "vc4-hdmi" "" "" "" "" Mar 01 16:55:30 volumio volumio[1132]: Hardware is initialized using a generic method Mar 01 16:55:30 volumio volumio[1132]: No state is present for card vc4hdmi1 Mar 01 16:55:30 volumio volumio[1132]: info: Output device has changed, restarting MPD Mar 01 16:55:30 volumio sudo[18929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 01 16:55:30 volumio sudo[18929]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio volumio[1132]: info: Output device has changed, restarting Shairport Sync Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 16:55:30 volumio sudo[18929]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio sudo[18932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 01 16:55:30 volumio sudo[18932]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio systemd[1]: Stopping Music Player Daemon... Mar 01 16:55:30 volumio volumio[1132]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 16:55:30 volumio volumio[1132]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 01 16:55:30 volumio systemd[1]: mpd.service: Succeeded. Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio systemd[1]: Stopped Music Player Daemon. Mar 01 16:55:30 volumio volumio[1132]: info: Relinquishing Volumio State Mar 01 16:55:30 volumio volumio[1132]: verbose: UNSET VOLATILE: Service: tidalconnect Mar 01 16:55:30 volumio volumio[1132]: info: unSetVolatile called Mar 01 16:55:30 volumio volumio[1132]: info: Relinquishing Volumio State to another service Mar 01 16:55:30 volumio vtcs[1867]: [2025-03-01 16:55:30.173] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=7 errorno=104 error=Connection reset by peer Mar 01 16:55:30 volumio vtcs[1867]: [2025-03-01 16:55:30.173] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Mar 01 16:55:30 volumio vtcs[1867]: [2025-03-01 16:55:30.173] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Mar 01 16:55:30 volumio volumio[1132]: info: PLUGIN START: peppyspectrum Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 01 16:55:30 volumio volumio[1132]: info: Preparing to generate the ALSA configuration file Mar 01 16:55:30 volumio volumio[1132]: info: Done. Mar 01 16:55:30 volumio sudo[18942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 01 16:55:30 volumio sudo[18942]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio systemd[1]: Starting Music Player Daemon... Mar 01 16:55:30 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Mar 01 16:55:30 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 01 16:55:30 volumio systemd[1]: vtcs.service: Succeeded. Mar 01 16:55:30 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Mar 01 16:55:30 volumio volumio[1132]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 01 16:55:30 volumio volumio[1132]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Mar 01 16:55:30 volumio volumio[1132]: info: Reading ALSA contributions from plugins. Mar 01 16:55:30 volumio sudo[18942]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 16:55:30 volumio sudo[18946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 01 16:55:30 volumio sudo[18946]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 16:55:30 volumio volumio[1132]: info: MPD Permissions set Mar 01 16:55:30 volumio sudo[18937]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 01 16:55:30 volumio sudo[18937]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio volumio[1132]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 01 16:55:30 volumio sudo[18937]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio sudo[18946]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: Starting Shairport Sync Mar 01 16:55:30 volumio sudo[18957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 16:55:30 volumio sudo[18957]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio volumio[1132]: info: Asound.conf file unchanged, so no further update is needed Mar 01 16:55:30 volumio volumio[1132]: info: Output device has changed, restarting MPD Mar 01 16:55:30 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 01 16:55:30 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 01 16:55:30 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 01 16:55:30 volumio sudo[18961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 01 16:55:30 volumio volumio[1132]: info: Output device has changed, restarting Shairport Sync Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 16:55:30 volumio volumio[1132]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: Relinquishing Volumio State Mar 01 16:55:30 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 01 16:55:30 volumio sudo[18961]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio sudo[18961]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio sudo[18965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 01 16:55:30 volumio sudo[18965]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio sudo[18957]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 01 16:55:30 volumio systemd[1]: mpd.service: Succeeded. Mar 01 16:55:30 volumio systemd[1]: Stopped Music Player Daemon. Mar 01 16:55:30 volumio systemd[1]: Starting Music Player Daemon... Mar 01 16:55:30 volumio sudo[18974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 01 16:55:30 volumio sudo[18974]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio sudo[18974]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 16:55:30 volumio sudo[18983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 01 16:55:30 volumio sudo[18983]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 16:55:30 volumio volumio[1132]: info: MPD Permissions set Mar 01 16:55:30 volumio volumio[1132]: info: Shairport-Sync Started Mar 01 16:55:30 volumio sudo[18983]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio sudo[18975]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 01 16:55:30 volumio sudo[18975]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio sudo[18975]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 16:55:30 volumio volumio[1132]: info: Starting Shairport Sync Mar 01 16:55:30 volumio sudo[18994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 16:55:30 volumio sudo[18994]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:30 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 16:55:30 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 01 16:55:30 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 01 16:55:30 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 01 16:55:30 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 01 16:55:30 volumio sudo[18994]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:30 volumio volumio[1132]: info: Shairport-Sync Started Mar 01 16:55:31 volumio mpd[18989]: Mar 01 16:55 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 01 16:55:31 volumio systemd[1]: Started Music Player Daemon. Mar 01 16:55:31 volumio sudo[18965]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:31 volumio sudo[18932]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:31 volumio volumio[1132]: error: MPD error: The expression evaluated to a falsy value: Mar 01 16:55:31 volumio volumio[1132]: assert.ok(self.idling) Mar 01 16:55:31 volumio volumio[1132]: error: The expression evaluated to a falsy value: Mar 01 16:55:31 volumio volumio[1132]: assert.ok(self.idling) Mar 01 16:55:31 volumio volumio[1132]: error: updateQueue error: null Mar 01 16:55:31 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:55:31 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:55:33 volumio volumio[1132]: info: TidalConnect service stoped! Mar 01 16:55:33 volumio volumio[1132]: info: TidalConnect service stoped! Mar 01 16:55:33 volumio volumio[1132]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 01 16:55:33 volumio volumio[1132]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 01 16:55:33 volumio sudo[19010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 01 16:55:33 volumio sudo[19010]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:33 volumio systemd[1]: Started Volumio Tidal Connect Service. Mar 01 16:55:33 volumio sudo[19010]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:33 volumio volumio[1132]: info: TidalConnect service stoped! Mar 01 16:55:33 volumio volumio[1132]: info: Executing endpoint tc_getconfig Mar 01 16:55:33 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 01 16:55:33 volumio vtcs[19012]: STARTING TidalConnect services, version: 1.4.0.34 Mar 01 16:55:33 volumio volumio[1132]: info: TidalConnect service stoped! Mar 01 16:55:33 volumio volumio[1132]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 01 16:55:33 volumio volumio[1132]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 01 16:55:33 volumio vtcs[19012]: STARTED TidalConnect services. Mar 01 16:55:33 volumio volumio[1132]: info: Executing endpoint tc_connect Mar 01 16:55:33 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 01 16:55:33 volumio volumio[1132]: info: Connecting to TidalConnect Mar 01 16:55:33 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:55:33 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:55:33 volumio volumio[1132]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Mar 01 16:55:33 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:55:33 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:55:33 volumio volumio[1132]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Mar 01 16:55:33 volumio sudo[19032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 01 16:55:33 volumio sudo[19032]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:33 volumio sudo[19032]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:35 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 16:55:35 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 16:55:35 volumio volumio[1132]: info: Discovery: Getting this device information Mar 01 16:55:35 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:55:35 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:55:35 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 16:55:36 volumio volumio[1132]: info: CoreCommandRouter::volumioPause Mar 01 16:55:36 volumio volumio[1132]: info: CoreStateMachine::pause Mar 01 16:55:36 volumio volumio[1132]: info: CoreStateMachine::stPlaybackTimer Mar 01 16:55:36 volumio volumio[1132]: info: CoreStateMachine::servicePause Mar 01 16:55:36 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:55:36 volumio volumio[1132]: info: CoreCommandRouter::servicePause Mar 01 16:55:36 volumio volumio[1132]: info: [1740840936338] ControllerWebradio::pause Mar 01 16:55:36 volumio volumio[1132]: verbose: ControllerMpd::sendMpdCommand pause Mar 01 16:55:36 volumio volumio[1132]: info: sendMpdCommand pause took 1 milliseconds Mar 01 16:55:36 volumio volumio[1132]: info: TidalConnect service started! Mar 01 16:55:36 volumio volumio[1132]: info: TidalConnect service started! Mar 01 16:55:39 volumio volumio[1132]: info: CoreCommandRouter::volumioPause Mar 01 16:55:39 volumio volumio[1132]: info: CoreStateMachine::pause Mar 01 16:55:41 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:55:41 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:55:41 volumio volumio[1132]: info: Listing playlists Mar 01 16:55:41 volumio volumio[1132]: info: Listing playlists Mar 01 16:55:48 volumio volumio[1132]: info: CoreCommandRouter::volumioPause Mar 01 16:55:48 volumio volumio[1132]: info: CoreStateMachine::pause Mar 01 16:55:48 volumio volumio[1132]: info: CoreCommandRouter::volumioPrevious Mar 01 16:55:48 volumio volumio[1132]: info: CoreStateMachine::previous Mar 01 16:55:48 volumio volumio[1132]: info: CoreStateMachine::updateTrackBlock Mar 01 16:55:48 volumio volumio[1132]: info: CorePlayQueue::getTrackBlock Mar 01 16:55:48 volumio volumio[1132]: info: CoreStateMachine::serviceClearAddPlay Mar 01 16:55:48 volumio volumio[1132]: info: CoreCommandRouter::serviceClearAddPlayTracks Mar 01 16:55:48 volumio volumio[1132]: error: WARNING: No clearAddPlayTracks method for service webradio Mar 01 16:55:49 volumio volumio[1132]: info: CoreCommandRouter::volumioNext Mar 01 16:55:49 volumio volumio[1132]: info: CoreStateMachine::next Mar 01 16:55:49 volumio volumio[1132]: info: CoreStateMachine::stop Mar 01 16:55:49 volumio volumio[1132]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 16:55:49 volumio volumio[1132]: info: CoreStateMachine::updateTrackBlock Mar 01 16:55:49 volumio volumio[1132]: info: CorePlayQueue::getTrackBlock Mar 01 16:55:49 volumio volumio[1132]: info: CoreStateMachine::stPlaybackTimer Mar 01 16:55:49 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:55:49 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:55:49 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 16:55:49 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:55:49 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:55:49 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:55:49 volumio volumio[1132]: info: CoreStateMachine::serviceStop Mar 01 16:55:49 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:55:49 volumio volumio[1132]: info: CoreCommandRouter::serviceStop Mar 01 16:55:49 volumio volumio[1132]: info: [1740840949819] ControllerWebradio::stop Mar 01 16:55:49 volumio volumio[1132]: verbose: ControllerMpd::sendMpdCommand stop Mar 01 16:55:49 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status stop Mar 01 16:55:49 volumio volumio[1132]: info: sendMpdCommand stop took 37 milliseconds Mar 01 16:55:49 volumio volumio[1132]: info: CoreStateMachine::play index undefined Mar 01 16:55:49 volumio volumio[1132]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 16:55:49 volumio volumio[1132]: info: CorePlayQueue::getTrack 1 Mar 01 16:55:49 volumio sudo[19085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 01 16:55:49 volumio sudo[19085]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:55:49 volumio volumio[1132]: info: touch_display: Setting screensaver timeout to 80 seconds. Mar 01 16:55:49 volumio sudo[19085]: pam_unix(sudo:session): session closed for user root Mar 01 16:55:49 volumio volumio[1132]: info: peppyspectrum Daemon Stop Mar 01 16:55:51 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:55:51 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:55:53 volumio volumio[1132]: info: CoreCommandRouter::volumioPrevious Mar 01 16:55:53 volumio volumio[1132]: info: CoreStateMachine::previous Mar 01 16:56:01 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:01 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:56:01 volumio volumio[1132]: info: Listing playlists Mar 01 16:56:05 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 16:56:05 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 16:56:05 volumio volumio[1132]: info: Discovery: Getting this device information Mar 01 16:56:05 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:05 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:56:05 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 16:56:07 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:07 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:56:07 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:07 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:56:07 volumio volumio[1132]: info: Currently active: webradio Mar 01 16:56:07 volumio volumio[1132]: info: Stopping currently active service Mar 01 16:56:07 volumio volumio[1132]: info: CoreCommandRouter::volumioStop Mar 01 16:56:07 volumio volumio[1132]: info: CoreStateMachine::stop Mar 01 16:56:07 volumio volumio[1132]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 16:56:07 volumio volumio[1132]: info: TidalConnect Active Mar 01 16:56:07 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:07 volumio volumio[1132]: info: CorePlayQueue::getTrack 0 Mar 01 16:56:07 volumio volumio[1132]: info: Currently active: webradio Mar 01 16:56:07 volumio volumio[1132]: info: Setting Volatile state to tidalconnect Mar 01 16:56:07 volumio volumio[1132]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 16:56:07 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:56:07 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:56:07 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 16:56:07 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:56:07 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:56:07 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:56:07 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:56:07 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:56:07 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:56:07 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:56:07 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:56:07 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status play Mar 01 16:56:07 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status play Mar 01 16:56:07 volumio sudo[19147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Mar 01 16:56:07 volumio sudo[19147]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:56:08 volumio sudo[19150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Mar 01 16:56:08 volumio sudo[19150]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:56:08 volumio volumio[1132]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 01 16:56:08 volumio systemd[1]: Started peppyspectrum Daemon. Mar 01 16:56:08 volumio sudo[19147]: pam_unix(sudo:session): session closed for user root Mar 01 16:56:08 volumio volumio[1132]: info: peppyspectrum Daemon Started Mar 01 16:56:08 volumio sudo[19150]: pam_unix(sudo:session): session closed for user root Mar 01 16:56:08 volumio volumio[1132]: info: peppyspectrum Daemon Started Mar 01 16:56:08 volumio vtcs[19012]: [2025-03-01 16:56:08.256] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:1 Mar 01 16:56:08 volumio volumio[1132]: info: Pushing metadata Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:56:08 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status play Mar 01 16:56:08 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status play Mar 01 16:56:08 volumio sudo[19163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Mar 01 16:56:08 volumio sudo[19163]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:56:08 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status pause Mar 01 16:56:08 volumio sudo[19163]: pam_unix(sudo:session): session closed for user root Mar 01 16:56:08 volumio sudo[19166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Mar 01 16:56:08 volumio sudo[19166]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:56:08 volumio sudo[19166]: pam_unix(sudo:session): session closed for user root Mar 01 16:56:08 volumio sudo[19169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 01 16:56:08 volumio sudo[19169]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:56:08 volumio volumio[1132]: info: peppyspectrum Daemon Started Mar 01 16:56:08 volumio systemd[1]: Stopping peppyspectrum Daemon... Mar 01 16:56:08 volumio systemd[1]: peppyspectrum.service: Main process exited, code=killed, status=15/TERM Mar 01 16:56:08 volumio volumio[1132]: info: peppyspectrum Daemon Started Mar 01 16:56:08 volumio systemd[1]: peppyspectrum.service: Succeeded. Mar 01 16:56:08 volumio systemd[1]: Stopped peppyspectrum Daemon. Mar 01 16:56:08 volumio volumio[1132]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 16:56:08 volumio volumio[1132]: info: touch_display: Setting screensaver timeout to 80 seconds. Mar 01 16:56:08 volumio sudo[19169]: pam_unix(sudo:session): session closed for user root Mar 01 16:56:08 volumio volumio[1132]: info: peppyspectrum Daemon Stop Mar 01 16:56:08 volumio volumio[1132]: info: Pushing metadata Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:56:08 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status pause Mar 01 16:56:08 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status pause Mar 01 16:56:08 volumio sudo[19176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 01 16:56:08 volumio sudo[19176]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:56:08 volumio sudo[19179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 01 16:56:08 volumio sudo[19179]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:56:08 volumio sudo[19176]: pam_unix(sudo:session): session closed for user root Mar 01 16:56:08 volumio volumio[1132]: info: peppyspectrum Daemon Stop Mar 01 16:56:08 volumio sudo[19179]: pam_unix(sudo:session): session closed for user root Mar 01 16:56:08 volumio volumio[1132]: info: peppyspectrum Daemon Stop Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:56:08 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:56:08 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:56:08 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status pause Mar 01 16:56:08 volumio sudo[19183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Mar 01 16:56:08 volumio sudo[19183]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:56:09 volumio sudo[19183]: pam_unix(sudo:session): session closed for user root Mar 01 16:56:09 volumio volumio[1132]: info: peppyspectrum Daemon Stop Mar 01 16:56:09 volumio vtcs[19012]: [2025-03-01 16:56:09.083] [tisoc] [warning] [flac_decoder.cpp:282] FLACDecoder::error_callback FLAC__STREAM_DECODER_ERROR_STATUS_LOST_SYNC Mar 01 16:56:09 volumio volumio[1132]: info: CoreCommandRouter::servicePushState Mar 01 16:56:09 volumio volumio[1132]: info: CoreStateMachine::pushState Mar 01 16:56:09 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 16:56:09 volumio volumio[1132]: info: CoreCommandRouter::volumioPushState Mar 01 16:56:09 volumio volumio[1132]: info: MRS: Pushing multiroomSync output update for this device Mar 01 16:56:09 volumio volumio[1132]: info: MRS: Pushing multiroomSync output Mar 01 16:56:09 volumio vtcs[19012]: vtcs: pcm_meter.c:1216: snd_pcm_scope_s16_get_channel_buffer: Assertion `s16->buf_areas' failed. Mar 01 16:56:09 volumio vtcs[19012]: Aborted Mar 01 16:56:09 volumio systemd[1]: vtcs.service: Main process exited, code=exited, status=134/n/a Mar 01 16:56:09 volumio systemd[1]: vtcs.service: Failed with result 'exit-code'. Mar 01 16:56:09 volumio volumio[1132]: info: PeppySpectrum ---peppyspectrum status play Mar 01 16:56:09 volumio sudo[19189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Mar 01 16:56:09 volumio sudo[19189]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 16:56:09 volumio volumio[1132]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 01 16:56:09 volumio systemd[1]: Started peppyspectrum Daemon. Mar 01 16:56:09 volumio sudo[19189]: pam_unix(sudo:session): session closed for user root Mar 01 16:56:09 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 01 16:56:09 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 1. Mar 01 16:56:09 volumio volumio[1132]: info: peppyspectrum Daemon Started Mar 01 16:56:09 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Mar 01 16:56:09 volumio systemd[1]: Started Volumio Tidal Connect Service. Mar 01 16:56:09 volumio volumio[1132]: info: Executing endpoint tc_getconfig Mar 01 16:56:09 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 01 16:56:09 volumio vtcs[19195]: BYE Mar 01 16:56:09 volumio systemd[1]: vtcs.service: Succeeded. Mar 01 16:56:09 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 01 16:56:09 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 2. Mar 01 16:56:09 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Mar 01 16:56:09 volumio systemd[1]: Started Volumio Tidal Connect Service. Mar 01 16:56:10 volumio volumio[1132]: info: Executing endpoint tc_getconfig Mar 01 16:56:10 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 01 16:56:10 volumio vtcs[19198]: BYE Mar 01 16:56:10 volumio systemd[1]: vtcs.service: Succeeded. Mar 01 16:56:10 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 01 16:56:10 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 3. Mar 01 16:56:10 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Mar 01 16:56:10 volumio systemd[1]: Started Volumio Tidal Connect Service. Mar 01 16:56:10 volumio volumio[1132]: info: Executing endpoint tc_getconfig Mar 01 16:56:10 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 01 16:56:10 volumio vtcs[19215]: BYE Mar 01 16:56:10 volumio systemd[1]: vtcs.service: Succeeded. Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio volumio[19193]: libpng warning: iCCP: known incorrect sRGB profile Mar 01 16:56:10 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 01 16:56:10 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 4. Mar 01 16:56:10 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Mar 01 16:56:10 volumio systemd[1]: Started Volumio Tidal Connect Service. Mar 01 16:56:11 volumio volumio[1132]: info: Executing endpoint tc_getconfig Mar 01 16:56:11 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 01 16:56:11 volumio vtcs[19222]: BYE Mar 01 16:56:11 volumio systemd[1]: vtcs.service: Succeeded. Mar 01 16:56:11 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 01 16:56:11 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 5. Mar 01 16:56:11 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Mar 01 16:56:11 volumio systemd[1]: Started Volumio Tidal Connect Service. Mar 01 16:56:11 volumio volumio[1132]: info: Executing endpoint tc_getconfig Mar 01 16:56:11 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 01 16:56:11 volumio vtcs[19225]: BYE Mar 01 16:56:11 volumio systemd[1]: vtcs.service: Succeeded. Mar 01 16:56:11 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Mar 01 16:56:11 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 6. Mar 01 16:56:11 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Mar 01 16:56:11 volumio systemd[1]: vtcs.service: Start request repeated too quickly. Mar 01 16:56:11 volumio systemd[1]: vtcs.service: Failed with result 'start-limit-hit'. Mar 01 16:56:11 volumio systemd[1]: Failed to start Volumio Tidal Connect Service. Mar 01 16:56:11 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:21 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:21 volumio volumio[1132]: info: Listing playlists Mar 01 16:56:21 volumio volumio[1132]: info: Listing playlists Mar 01 16:56:26 volumio volumio[1132]: verbose: New Socket.io Connection to 192.168.50.198 from 192.168.50.48 UA: Mozilla/5.0 (Linux; Android 15; CPH2415 Build/AP3A.240617.008; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.121 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::volumioGetVisibleSources Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 01 16:56:26 volumio volumio[1132]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 01 16:56:26 volumio volumio[1132]: info: Received Get System Info Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 16:56:26 volumio volumio[1132]: info: Discovery: Getting this device information Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:26 volumio volumio[1132]: info: Listing playlists Mar 01 16:56:26 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 01 16:56:31 volumio volumio[1132]: info: CoreCommandRouter::volumioGetState Mar 01 16:56:32 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 16:56:32 volumio volumio[1132]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 01 16:56:39 volumio volumio[1132]: info: Stopping peppyspectrum service Mar 01 16:56:39 volumio volumio[1132]: info: CoreStateMachine::stop Mar 01 16:56:39 volumio volumio[1132]: info: CoreStateMachine::serviceStop Mar 01 16:56:39 volumio volumio[1132]: info: CoreCommandRouter::serviceStop Mar 01 16:56:39 volumio volumio[1132]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 16:56:39 volumio volumio[1132]: TypeError: Cannot read property 'then' of undefined Mar 01 16:56:39 volumio volumio[1132]: at peppyspectrum.onStop (/data/plugins/user_interface/peppyspectrum/index.js:60:43) Mar 01 16:56:39 volumio volumio[1132]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Mar 01 16:56:39 volumio volumio[1132]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Mar 01 16:56:39 volumio volumio[1132]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Mar 01 16:56:39 volumio volumio[1132]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Mar 01 16:56:39 volumio volumio[1132]: at Socket.emit (events.js:315:20) Mar 01 16:56:39 volumio volumio[1132]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 01 16:56:39 volumio volumio[1132]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 01 16:56:39 volumio volumio[1132]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 16:56:40 volumio sudo[19347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-01 16:55 Mar 01 16:56:40 volumio sudo[19347]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"