-- Logs begin at Sun 2024-07-14 06:46:35 CEST, end at Sun 2024-07-14 16:38:55 CEST. -- Jul 14 16:37:00 volumio volumio[22848]: info: 0 upgraded, 1 newly installed, 0 to remove and 7 not upgraded. Jul 14 16:37:00 volumio volumio[22848]: info: Need to get 112 kB of archives. Jul 14 16:37:00 volumio volumio[22848]: info: After this operation, 512 kB of additional disk space will be used. Jul 14 16:37:00 volumio volumio[22848]: info: Get:1 http://raspbian.mirror.garr.it/mirrors/raspbian/raspbian buster/main armhf drc armhf 3.2.2~dfsg0-2 [112 kB] Jul 14 16:37:02 volumio volumio[22848]: info: Fetched 112 kB in 1s (80.6 kB/s) Jul 14 16:37:02 volumio volumio[22848]: info: Selecting previously unselected package drc. Jul 14 16:37:03 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:03 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:03 volumio volumio[22848]: [620B blob data] Jul 14 16:37:03 volumio volumio[22848]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Jul 14 16:37:03 volumio volumio[22848]: info: Unpacking drc (3.2.2~dfsg0-2) ... Jul 14 16:37:04 volumio volumio[22848]: info: Setting up drc (3.2.2~dfsg0-2) ... Jul 14 16:37:05 volumio volumio[22848]: info: Processing triggers for man-db (2.8.5-2+deb10u1) ... Jul 14 16:37:09 volumio sudo[9690]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:09 volumio sudo[9033]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:09 volumio volumio[22848]: Plugin install end detected on script Jul 14 16:37:09 volumio volumio[22848]: info: Install script completed Jul 14 16:37:09 volumio volumio[22848]: info: Adding reference to registry Jul 14 16:37:09 volumio volumio[22848]: info: Done installing plugin. Jul 14 16:37:09 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 14 16:37:09 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 14 16:37:09 volumio volumio[22848]: info: Folder /tmp/plugins removed Jul 14 16:37:09 volumio volumio[22848]: info: Folder /tmp/downloaded_plugin.zip removed Jul 14 16:37:09 volumio volumio[22848]: info: Folder /data/temp removed Jul 14 16:37:12 volumio go-librespot[26037]: time="2024-07-14T16:37:12+02:00" level=error msg="did not receive last pong ack from accesspoint, 15600s passed" Jul 14 16:37:13 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:13 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:13 volumio volumio[22848]: info: Listing playlists Jul 14 16:37:13 volumio volumio[22848]: info: Listing playlists Jul 14 16:37:13 volumio go-librespot[26037]: time="2024-07-14T16:37:13+02:00" level=error msg="did not receive last pong from dealer, 15598s passed" Jul 14 16:37:14 volumio volumio[22848]: info: Enabling plugin fusiondsp Jul 14 16:37:14 volumio volumio[22848]: info: Loading plugin "fusiondsp"... Jul 14 16:37:15 volumio volumio[22848]: info: Preparing to generate the ALSA configuration file Jul 14 16:37:15 volumio volumio[22848]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 14 16:37:15 volumio volumio[22848]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 14 16:37:15 volumio volumio[22848]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 14 16:37:15 volumio volumio[22848]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jul 14 16:37:15 volumio volumio[22848]: info: Reading ALSA contributions from plugins. Jul 14 16:37:15 volumio volumio[22848]: info: Asound.conf file written Jul 14 16:37:15 volumio sudo[9775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 14 16:37:15 volumio sudo[9775]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:15 volumio sudo[9775]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:16 volumio volumio[22848]: info: Output device has changed, restarting MPD Jul 14 16:37:16 volumio sudo[9782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 14 16:37:16 volumio sudo[9782]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:16 volumio sudo[9782]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:16 volumio volumio[22848]: info: Output device has changed, restarting Shairport Sync Jul 14 16:37:16 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:16 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:16 volumio sudo[9785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 14 16:37:16 volumio sudo[9785]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:16 volumio volumio[22848]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 14 16:37:16 volumio volumio[22848]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 14 16:37:16 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:16 volumio systemd[1]: Stopping Music Player Daemon... Jul 14 16:37:16 volumio sudo[9793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 14 16:37:16 volumio sudo[9793]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:16 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jul 14 16:37:16 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jul 14 16:37:16 volumio systemd[1]: vtcs.service: Succeeded. Jul 14 16:37:16 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jul 14 16:37:16 volumio volumio[22848]: info: PLUGIN START: fusiondsp Jul 14 16:37:16 volumio volumio[22848]: info: Loading i18n strings for locale it Jul 14 16:37:16 volumio volumio[22848]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jul 14 16:37:16 volumio sudo[9793]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:16 volumio volumio[22848]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found. Jul 14 16:37:16 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 14 16:37:16 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:16 volumio volumio[22848]: info: FusionDsp - mixtype--------------------- Software Jul 14 16:37:16 volumio volumio[22848]: info: Preparing to generate the ALSA configuration file Jul 14 16:37:17 volumio volumio[22848]: info: Done. Jul 14 16:37:17 volumio volumio[22848]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 14 16:37:17 volumio volumio[22848]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 14 16:37:17 volumio volumio[22848]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 14 16:37:17 volumio volumio[22848]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jul 14 16:37:17 volumio volumio[22848]: info: Reading ALSA contributions from plugins. Jul 14 16:37:17 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 14 16:37:17 volumio sudo[9797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 14 16:37:17 volumio sudo[9797]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:17 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 14 16:37:17 volumio volumio[22848]: info: MPD Permissions set Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio sudo[9797]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: Starting Shairport Sync Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 14 16:37:17 volumio volumio[22848]: info: Asound.conf file unchanged, so no further update is needed Jul 14 16:37:17 volumio volumio[22848]: info: Output device has changed, restarting MPD Jul 14 16:37:17 volumio sudo[9805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 14 16:37:17 volumio sudo[9805]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:17 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 14 16:37:17 volumio sudo[9808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 14 16:37:17 volumio sudo[9808]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:17 volumio sudo[9808]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:17 volumio volumio[22848]: info: Output device has changed, restarting Shairport Sync Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:17 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 14 16:37:17 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 14 16:37:17 volumio sudo[9815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 14 16:37:17 volumio sudo[9815]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:17 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 14 16:37:17 volumio sudo[9805]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:17 volumio volumio[22848]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 14 16:37:17 volumio volumio[22848]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:17 volumio sudo[9876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 14 16:37:17 volumio sudo[9876]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:17 volumio sudo[9876]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:17 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:17 volumio sudo[9879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 14 16:37:17 volumio sudo[9879]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:17 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 14 16:37:17 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 14 16:37:17 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 14 16:37:17 volumio volumio[22848]: info: MPD Permissions set Jul 14 16:37:17 volumio volumio[22848]: info: Shairport-Sync Started Jul 14 16:37:17 volumio sudo[9879]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:18 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:18 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:18 volumio volumio[22848]: info: Starting Shairport Sync Jul 14 16:37:18 volumio sudo[9888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 14 16:37:18 volumio sudo[9888]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 14 16:37:18 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 14 16:37:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 14 16:37:18 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 14 16:37:18 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 14 16:37:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 14 16:37:18 volumio sudo[9888]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:18 volumio volumio[22848]: info: Shairport-Sync Started Jul 14 16:37:18 volumio volumio[22848]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 14 16:37:18 volumio volumio[22848]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 14 16:37:18 volumio systemd[1]: mpd.service: Succeeded. Jul 14 16:37:18 volumio systemd[1]: Stopped Music Player Daemon. Jul 14 16:37:18 volumio systemd[1]: Starting Music Player Daemon... Jul 14 16:37:18 volumio sudo[9895]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 14 16:37:18 volumio sudo[9895]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:18 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 14 16:37:18 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 14 16:37:18 volumio sudo[9895]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:19 volumio volumio[22848]: info: camilladsp spawned new process with pid 9907, instance 1, run: true Jul 14 16:37:19 volumio volumio[22848]: info: camilladsp service started and running in background, instance 1 Jul 14 16:37:19 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:19 volumio volumio[22848]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 <-AAAAAAAAAAAAA Jul 14 16:37:19 volumio volumio[22848]: info: FusionDsp loaded Jul 14 16:37:19 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 14 16:37:19 volumio sudo[9913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 14 16:37:19 volumio sudo[9913]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:19 volumio volumio[22848]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 14 16:37:19 volumio volumio[22848]: info: Adding Signal Path Element [object Object] Jul 14 16:37:19 volumio volumio[22848]: info: Adding fusiondspeq DSP Signal Path Element Jul 14 16:37:19 volumio volumio[22848]: info: FusionDsp - ---- installed callbackRead Jul 14 16:37:19 volumio volumio[22848]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 16:37:19 volumio systemd[1]: Started FusionDsp Daemon. Jul 14 16:37:19 volumio sudo[9913]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:19 volumio volumio[22848]: error: FusionDsp - WebSocket error: [object Object] Jul 14 16:37:19 volumio volumio[22848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jul 14 16:37:20 volumio volumio[22848]: info: TidalConnect service stoped! Jul 14 16:37:20 volumio volumio[22848]: info: TidalConnect service stoped! Jul 14 16:37:20 volumio volumio[22848]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 14 16:37:20 volumio volumio[22848]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 14 16:37:20 volumio sudo[9926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 14 16:37:20 volumio sudo[9926]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:20 volumio systemd[1]: Started Volumio Tidal Connect Service. Jul 14 16:37:20 volumio sudo[9926]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:20 volumio volumio[22848]: 0+0 records in Jul 14 16:37:20 volumio volumio[22848]: 0+0 records out Jul 14 16:37:20 volumio volumio[22848]: 0 bytes copied, 0.000361562 s, 0.0 kB/s Jul 14 16:37:20 volumio volumio[22848]: info: camilladsp spawned new process with pid 9933, instance 1, run: true Jul 14 16:37:20 volumio volumio[22848]: info: TidalConnect service stoped! Jul 14 16:37:20 volumio volumio[22848]: info: TidalConnect service stoped! Jul 14 16:37:21 volumio volumio[22848]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 14 16:37:21 volumio volumio[22848]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 14 16:37:21 volumio volumio[22848]: info: Executing endpoint tc_getconfig Jul 14 16:37:21 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jul 14 16:37:21 volumio vtcs[9928]: STARTING TidalConnect services, version: 1.4.0.34 Jul 14 16:37:21 volumio sudo[9952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 14 16:37:21 volumio sudo[9952]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:21 volumio sudo[9952]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:21 volumio vtcs[9928]: STARTED TidalConnect services. Jul 14 16:37:21 volumio volumio[22848]: info: Executing endpoint tc_connect Jul 14 16:37:21 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jul 14 16:37:21 volumio volumio[22848]: info: Connecting to TidalConnect Jul 14 16:37:21 volumio volumio[22848]: info: CoreCommandRouter::servicePushState Jul 14 16:37:21 volumio volumio[22848]: info: CoreStateMachine::pushState Jul 14 16:37:21 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:21 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 16:37:21 volumio volumio[22848]: info: CoreCommandRouter::volumioPushState Jul 14 16:37:21 volumio volumio[22848]: info: MRS: Pushing multiroomSync output update for this device Jul 14 16:37:21 volumio volumio[22848]: info: MRS: Pushing multiroomSync output Jul 14 16:37:21 volumio volumio[22848]: error: Help! Some callbacks for volumioPushState are crashing! Jul 14 16:37:21 volumio volumio[22848]: error: service is not defined Jul 14 16:37:21 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:21 volumio volumio[22848]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Jul 14 16:37:21 volumio volumio[22848]: info: CoreCommandRouter::servicePushState Jul 14 16:37:21 volumio volumio[22848]: info: CoreStateMachine::pushState Jul 14 16:37:21 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:21 volumio volumio[22848]: info: CoreCommandRouter::volumioPushState Jul 14 16:37:21 volumio volumio[22848]: info: MRS: Pushing multiroomSync output update for this device Jul 14 16:37:21 volumio volumio[22848]: info: MRS: Pushing multiroomSync output Jul 14 16:37:21 volumio volumio[22848]: error: Help! Some callbacks for volumioPushState are crashing! Jul 14 16:37:21 volumio volumio[22848]: error: service is not defined Jul 14 16:37:21 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:21 volumio volumio[22848]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Jul 14 16:37:21 volumio volumio[22848]: info: PeppySpectrum ---peppyspectrum status play Jul 14 16:37:21 volumio sudo[9971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 14 16:37:21 volumio sudo[9971]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:21 volumio systemd[1]: Started peppyspectrum Daemon. Jul 14 16:37:21 volumio sudo[9971]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:21 volumio volumio[22848]: info: PeppySpectrum ---peppyspectrum status play Jul 14 16:37:21 volumio volumio[22848]: info: peppyspectrum Daemon Started Jul 14 16:37:21 volumio sudo[9976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 14 16:37:21 volumio sudo[9976]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:22 volumio sudo[9976]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:22 volumio volumio[22848]: info: peppyspectrum Daemon Started Jul 14 16:37:22 volumio mpd[9900]: Jul 14 16:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 14 16:37:23 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:23 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:23 volumio volumio[9973]: No protocol specified Jul 14 16:37:23 volumio volumio[9973]: No protocol specified Jul 14 16:37:23 volumio volumio[9973]: pygame 1.9.4.post1 Jul 14 16:37:23 volumio volumio[9973]: Hello from the pygame community. https://www.pygame.org/contribute.html Jul 14 16:37:23 volumio volumio[9973]: Traceback (most recent call last): Jul 14 16:37:23 volumio volumio[9973]: File "spectrum.py", line 715, in Jul 14 16:37:23 volumio volumio[9973]: pm = Spectrum(None, True) Jul 14 16:37:23 volumio volumio[9973]: File "spectrum.py", line 63, in __init__ Jul 14 16:37:23 volumio volumio[9973]: self.init_display() Jul 14 16:37:23 volumio volumio[9973]: File "spectrum.py", line 104, in init_display Jul 14 16:37:23 volumio volumio[9973]: pygame.display.init() Jul 14 16:37:23 volumio volumio[9973]: pygame.error: Unable to open /dev/fb1 Jul 14 16:37:23 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE Jul 14 16:37:23 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'. Jul 14 16:37:23 volumio systemd[1]: Started Music Player Daemon. Jul 14 16:37:23 volumio sudo[9815]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:23 volumio sudo[9785]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:23 volumio volumio[22848]: error: MPD error: The expression evaluated to a falsy value: Jul 14 16:37:23 volumio volumio[22848]: assert.ok(self.idling) Jul 14 16:37:23 volumio volumio[22848]: error: The expression evaluated to a falsy value: Jul 14 16:37:23 volumio volumio[22848]: assert.ok(self.idling) Jul 14 16:37:23 volumio volumio[22848]: info: TidalConnect service started! Jul 14 16:37:23 volumio volumio[22848]: error: updateQueue error: null Jul 14 16:37:24 volumio volumio[22848]: info: TidalConnect service started! Jul 14 16:37:33 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:33 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:36 volumio volumio[22848]: error: error Jul 14 16:37:36 volumio volumio[22848]: error: error Jul 14 16:37:36 volumio volumio[22848]: error: error Jul 14 16:37:36 volumio volumio[22848]: error: error Jul 14 16:37:43 volumio go-librespot[26037]: time="2024-07-14T16:37:43+02:00" level=error msg="did not receive last pong from dealer, 15628s passed" Jul 14 16:37:46 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:46 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:37:53 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:53 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:06 volumio volumio[22848]: verbose: New Socket.io Connection to 192.168.178.68 from 192.168.178.99 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jul 14 16:38:06 volumio volumio[22848]: verbose: New Socket.io Connection to 192.168.178.67 from 192.168.178.99 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jul 14 16:38:06 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:06 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:06 volumio volumio[22848]: verbose: New Socket.io Connection to 192.168.178.67 from 192.168.178.99 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jul 14 16:38:06 volumio volumio[22848]: verbose: New Socket.io Connection to 192.168.178.68 from 192.168.178.99 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Jul 14 16:38:07 volumio volumio[22848]: verbose: New Socket.io Connection to 192.168.178.67 from 192.168.178.99 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Jul 14 16:38:07 volumio volumio[22848]: verbose: New Socket.io Connection to 192.168.178.68 from 192.168.178.99 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Jul 14 16:38:07 volumio volumio[22848]: info: Listing playlists Jul 14 16:38:07 volumio volumio[22848]: info: Listing playlists Jul 14 16:38:07 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:07 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:07 volumio volumio[22848]: info: Received Get System Info Jul 14 16:38:07 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 14 16:38:07 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 14 16:38:07 volumio volumio[22848]: info: Discovery: Getting this device information Jul 14 16:38:07 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:07 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:07 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:08 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::volumioGetVisibleSources Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:08 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:08 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 14 16:38:08 volumio volumio[22848]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 14 16:38:08 volumio volumio[22848]: info: Received Get System Info Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 14 16:38:08 volumio volumio[22848]: info: Discovery: Getting this device information Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:08 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:08 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:08 volumio volumio[22848]: info: Listing playlists Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 14 16:38:08 volumio volumio[22848]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 14 16:38:13 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:13 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:13 volumio go-librespot[26037]: time="2024-07-14T16:38:13+02:00" level=error msg="did not receive last pong from dealer, 15658s passed" Jul 14 16:38:15 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 14 16:38:16 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 14 16:38:16 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 14 16:38:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 14 16:38:17 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 14 16:38:23 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:23 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:23 volumio volumio[22848]: info: Listing playlists Jul 14 16:38:23 volumio volumio[22848]: info: Listing playlists Jul 14 16:38:33 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:33 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:43 volumio volumio[22848]: info: CoreCommandRouter::volumioGetState Jul 14 16:38:43 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:43 volumio volumio[22848]: info: Listing playlists Jul 14 16:38:43 volumio volumio[22848]: info: Listing playlists Jul 14 16:38:43 volumio go-librespot[26037]: time="2024-07-14T16:38:43+02:00" level=error msg="did not receive last pong from dealer, 15688s passed" Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 6 Jul 14 16:38:49 volumio volumio[22848]: info: Prefetching next song Jul 14 16:38:49 volumio volumio[22848]: info: DOING PREFETCH IN MPD Jul 14 16:38:49 volumio volumio[22848]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/2024 ambient/Various Artists - Ministry of Sound - The Annual 2023 (2022) Mp3 320kbps [PMEDIA] ⭐️/07. Joel Corry & Becky Hill - HISTORY.mp3" Jul 14 16:38:49 volumio volumio[22848]: info: sendMpdCommand add "NAS/Music/2024 ambient/Various Artists - Ministry of Sound - The Annual 2023 (2022) Mp3 320kbps [PMEDIA] ⭐️/07. Joel Corry & Becky Hill - HISTORY.mp3" took 10 milliseconds Jul 14 16:38:49 volumio volumio[22848]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 14 16:38:49 volumio volumio[22848]: info: Jul 14 16:38:49 volumio volumio[22848]: ---------------------------- MPD announces system playlist update Jul 14 16:38:49 volumio volumio[22848]: info: Ignoring MPD Status Update Jul 14 16:38:49 volumio volumio[22848]: info: Jul 14 16:38:49 volumio volumio[22848]: ---------------------------- MPD announces state update: options Jul 14 16:38:49 volumio volumio[22848]: info: sendMpdCommand consume 1 took 3 milliseconds Jul 14 16:38:49 volumio volumio[22848]: info: ControllerMpd::getState Jul 14 16:38:49 volumio volumio[22848]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:38:49 volumio volumio[22848]: info: Jul 14 16:38:49 volumio volumio[22848]: ---------------------------- MPD announces system playlist update Jul 14 16:38:49 volumio volumio[22848]: info: Ignoring MPD Status Update Jul 14 16:38:49 volumio volumio[22848]: info: ------------------------------ 7ms Jul 14 16:38:49 volumio volumio[22848]: info: sendMpdCommand status took 22 milliseconds Jul 14 16:38:49 volumio volumio[22848]: verbose: ControllerMpd::parseState Jul 14 16:38:49 volumio volumio[22848]: info: ControllerMpd::pushState Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::servicePushState Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::pushState Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::volumioPushState Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output update for this device Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output Jul 14 16:38:49 volumio volumio[22848]: error: Help! Some callbacks for volumioPushState are crashing! Jul 14 16:38:49 volumio volumio[22848]: error: service is not defined Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 5 Jul 14 16:38:49 volumio volumio[22848]: 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} Jul 14 16:38:49 volumio volumio[22848]: verbose: CURRENT POSITION 5 Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::syncState stateService stop Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::syncState currentStatus play Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::pushState Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 6 Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::volumioPushState Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output update for this device Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::pushState Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 6 Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::volumioPushState Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output update for this device Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output Jul 14 16:38:49 volumio volumio[22848]: info: ------------------------------ 78ms Jul 14 16:38:49 volumio volumio[22848]: info: ------------------------------ 78ms Jul 14 16:38:49 volumio volumio[22848]: info: Jul 14 16:38:49 volumio volumio[22848]: ---------------------------- MPD announces state update: options Jul 14 16:38:49 volumio volumio[22848]: info: ControllerMpd::getState Jul 14 16:38:49 volumio volumio[22848]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:38:49 volumio volumio[22848]: info: PeppySpectrum ---peppyspectrum status play Jul 14 16:38:49 volumio volumio[22848]: info: sendMpdCommand status took 74 milliseconds Jul 14 16:38:49 volumio volumio[22848]: verbose: ControllerMpd::parseState Jul 14 16:38:49 volumio volumio[22848]: info: ControllerMpd::pushState Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::servicePushState Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::pushState Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 6 Jul 14 16:38:49 volumio sudo[10133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Jul 14 16:38:49 volumio sudo[10133]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::volumioPushState Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output update for this device Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 6 Jul 14 16:38:49 volumio volumio[22848]: 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} Jul 14 16:38:49 volumio volumio[22848]: verbose: CURRENT POSITION 6 Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::syncState stateService stop Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::pushState Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 6 Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::volumioPushState Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output update for this device Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output Jul 14 16:38:49 volumio volumio[22848]: info: No code Jul 14 16:38:49 volumio volumio[22848]: info: CoreStateMachine::pushState Jul 14 16:38:49 volumio volumio[22848]: info: CorePlayQueue::getTrack 6 Jul 14 16:38:49 volumio volumio[22848]: info: CoreCommandRouter::volumioPushState Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output update for this device Jul 14 16:38:49 volumio volumio[22848]: info: MRS: Pushing multiroomSync output Jul 14 16:38:49 volumio volumio[22848]: info: ------------------------------ 111ms Jul 14 16:38:49 volumio systemd[1]: Started peppyspectrum Daemon. Jul 14 16:38:49 volumio sudo[10133]: pam_unix(sudo:session): session closed for user root Jul 14 16:38:49 volumio volumio[22848]: info: PeppySpectrum ---peppyspectrum status stop Jul 14 16:38:49 volumio sudo[10138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Jul 14 16:38:49 volumio sudo[10138]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:38:49 volumio volumio[22848]: info: peppyspectrum Daemon Started Jul 14 16:38:49 volumio systemd[1]: Stopping peppyspectrum Daemon... Jul 14 16:38:49 volumio systemd[1]: peppyspectrum.service: Main process exited, code=killed, status=15/TERM Jul 14 16:38:50 volumio systemd[1]: peppyspectrum.service: Succeeded. Jul 14 16:38:50 volumio systemd[1]: Stopped peppyspectrum Daemon. Jul 14 16:38:50 volumio sudo[10138]: pam_unix(sudo:session): session closed for user root Jul 14 16:38:50 volumio volumio[22848]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 14 16:38:50 volumio volumio[22848]: info: peppyspectrum Daemon Stop Jul 14 16:38:50 volumio volumio[22848]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 14 16:38:50 volumio volumio[22848]: info: PeppySpectrum ---peppyspectrum status stop Jul 14 16:38:50 volumio sudo[10143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Jul 14 16:38:50 volumio sudo[10143]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:38:50 volumio sudo[10143]: pam_unix(sudo:session): session closed for user root Jul 14 16:38:51 volumio volumio[22848]: info: peppyspectrum Daemon Stop Jul 14 16:38:51 volumio volumio[22848]: info: PeppySpectrum ---peppyspectrum status stop Jul 14 16:38:51 volumio sudo[10146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Jul 14 16:38:51 volumio sudo[10146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:38:51 volumio volumio[22848]: info: PeppySpectrum ---peppyspectrum status stop Jul 14 16:38:51 volumio sudo[10146]: pam_unix(sudo:session): session closed for user root Jul 14 16:38:51 volumio volumio[22848]: info: peppyspectrum Daemon Stop Jul 14 16:38:51 volumio sudo[10149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Jul 14 16:38:51 volumio sudo[10149]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:38:51 volumio volumio[22848]: info: PeppySpectrum ---peppyspectrum status stop Jul 14 16:38:51 volumio sudo[10149]: pam_unix(sudo:session): session closed for user root Jul 14 16:38:51 volumio sudo[10152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Jul 14 16:38:51 volumio sudo[10152]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:38:51 volumio volumio[22848]: info: peppyspectrum Daemon Stop Jul 14 16:38:51 volumio sudo[10152]: pam_unix(sudo:session): session closed for user root Jul 14 16:38:51 volumio volumio[22848]: info: peppyspectrum Daemon Stop Jul 14 16:38:52 volumio volumio[22848]: info: MRS: STARTING volumioStreaming Jul 14 16:38:52 volumio sudo[10158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Jul 14 16:38:52 volumio sudo[10158]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:38:52 volumio volumio[22848]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 16:38:52 volumio sudo[10156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream0.ts /tmp/hls/stream1.ts /tmp/hls/stream10.ts /tmp/hls/stream100.ts /tmp/hls/stream101.ts /tmp/hls/stream102.ts /tmp/hls/stream103.ts /tmp/hls/stream104.ts /tmp/hls/stream105.ts /tmp/hls/stream106.ts /tmp/hls/stream107.ts /tmp/hls/stream108.ts /tmp/hls/stream109.ts /tmp/hls/stream11.ts /tmp/hls/stream110.ts /tmp/hls/stream111.ts /tmp/hls/stream112.ts /tmp/hls/stream113.ts /tmp/hls/stream114.ts /tmp/hls/stream115.ts /tmp/hls/stream116.ts /tmp/hls/stream117.ts /tmp/hls/stream118.ts /tmp/hls/stream119.ts /tmp/hls/stream12.ts /tmp/hls/stream120.ts /tmp/hls/stream121.ts /tmp/hls/stream122.ts /tmp/hls/stream123.ts /tmp/hls/stream124.ts /tmp/hls/stream125.ts /tmp/hls/stream126.ts /tmp/hls/stream127.ts /tmp/hls/stream128.ts /tmp/hls/stream129.ts /tmp/hls/stream13.ts /tmp/hls/stream130.ts /tmp/hls/stream131.ts /tmp/hls/stream132.ts /tmp/hls/stream133.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream134.ts /tmp/hls/stream135.ts /tmp/hls/stream136.ts /tmp/hls/stream137.ts /tmp/hls/stream138.ts /tmp/hls/stream139.ts /tmp/hls/stream14.ts /tmp/hls/stream140.ts /tmp/hls/stream141.ts /tmp/hls/stream142.ts /tmp/hls/stream143.ts /tmp/hls/stream144.ts /tmp/hls/stream145.ts /tmp/hls/stream146.ts /tmp/hls/stream147.ts /tmp/hls/stream148.ts /tmp/hls/stream149.ts /tmp/hls/stream15.ts /tmp/hls/stream150.ts /tmp/hls/stream151.ts /tmp/hls/stream152.ts /tmp/hls/stream153.ts /tmp/hls/stream154.ts /tmp/hls/stream155.ts /tmp/hls/stream156.ts /tmp/hls/stream157.ts /tmp/hls/stream158.ts /tmp/hls/stream159.ts /tmp/hls/stream16.ts /tmp/hls/stream160.ts /tmp/hls/stream161.ts /tmp/hls/stream162.ts /tmp/hls/stream163.ts /tmp/hls/stream164.ts /tmp/hls/stream165.ts /tmp/hls/stream166.ts /tmp/hls/stream167.ts /tmp/hls/stream168.ts /tmp/hls/stream169.ts /tmp/hls/stream17.ts /tmp/hls/stream170.ts /tmp/hls/stream171.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream172.ts /tmp/hls/stream173.ts /tmp/hls/stream174.ts /tmp/hls/stream175.ts /tmp/hls/stream176.ts /tmp/hls/stream177.ts /tmp/hls/stream178.ts /tmp/hls/stream179.ts /tmp/hls/stream18.ts /tmp/hls/stream180.ts /tmp/hls/stream181.ts /tmp/hls/stream182.ts /tmp/hls/stream183.ts /tmp/hls/stream184.ts /tmp/hls/stream185.ts /tmp/hls/stream186.ts /tmp/hls/stream187.ts /tmp/hls/stream188.ts /tmp/hls/stream189.ts /tmp/hls/stream19.ts /tmp/hls/stream190.ts /tmp/hls/stream191.ts /tmp/hls/stream192.ts /tmp/hls/stream193.ts /tmp/hls/stream194.ts /tmp/hls/stream195.ts /tmp/hls/stream196.ts /tmp/hls/stream197.ts /tmp/hls/stream198.ts /tmp/hls/stream199.ts /tmp/hls/stream2.ts /tmp/hls/stream20.ts /tmp/hls/stream200.ts /tmp/hls/stream201.ts /tmp/hls/stream202.ts /tmp/hls/stream203.ts /tmp/hls/stream204.ts /tmp/hls/stream205.ts /tmp/hls/stream206.ts /tmp/hls/stream207.ts /tmp/hls/stream208.ts /tmp/hls/stream209.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream21.ts /tmp/hls/stream210.ts /tmp/hls/stream211.ts /tmp/hls/stream212.ts /tmp/hls/stream213.ts /tmp/hls/stream214.ts /tmp/hls/stream215.ts /tmp/hls/stream216.ts /tmp/hls/stream217.ts /tmp/hls/stream218.ts /tmp/hls/stream219.ts /tmp/hls/stream22.ts /tmp/hls/stream220.ts /tmp/hls/stream221.ts /tmp/hls/stream222.ts /tmp/hls/stream223.ts /tmp/hls/stream224.ts /tmp/hls/stream225.ts /tmp/hls/stream226.ts /tmp/hls/stream227.ts /tmp/hls/stream228.ts /tmp/hls/stream229.ts /tmp/hls/stream23.ts /tmp/hls/stream230.ts /tmp/hls/stream231.ts /tmp/hls/stream232.ts /tmp/hls/stream233.ts /tmp/hls/stream234.ts /tmp/hls/stream235.ts /tmp/hls/stream236.ts /tmp/hls/stream237.ts /tmp/hls/stream238.ts /tmp/hls/stream239.ts /tmp/hls/stream24.ts /tmp/hls/stream240.ts /tmp/hls/stream241.ts /tmp/hls/stream242.ts /tmp/hls/stream243.ts /tmp/hls/stream244.ts /tmp/hls/stream245.ts /tmp/hls/stream246.ts /tmp/hls/stream247.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream248.ts /tmp/hls/stream249.ts /tmp/hls/stream25.ts /tmp/hls/stream250.ts /tmp/hls/stream251.ts /tmp/hls/stream252.ts /tmp/hls/stream253.ts /tmp/hls/stream254.ts /tmp/hls/stream255.ts /tmp/hls/stream256.ts /tmp/hls/stream257.ts /tmp/hls/stream258.ts /tmp/hls/stream259.ts /tmp/hls/stream26.ts /tmp/hls/stream260.ts /tmp/hls/stream261.ts /tmp/hls/stream262.ts /tmp/hls/stream263.ts /tmp/hls/stream264.ts /tmp/hls/stream265.ts /tmp/hls/stream266.ts /tmp/hls/stream267.ts /tmp/hls/stream268.ts /tmp/hls/stream269.ts /tmp/hls/stream27.ts /tmp/hls/stream270.ts /tmp/hls/stream271.ts /tmp/hls/stream272.ts /tmp/hls/stream273.ts /tmp/hls/stream274.ts /tmp/hls/stream275.ts /tmp/hls/stream276.ts /tmp/hls/stream277.ts /tmp/hls/stream278.ts /tmp/hls/stream279.ts /tmp/hls/stream28.ts /tmp/hls/stream280.ts /tmp/hls/stream281.ts /tmp/hls/stream282.ts /tmp/hls/stream283.ts /tmp/hls/stream284.ts /tmp/hls/stream285.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream286.ts /tmp/hls/stream287.ts /tmp/hls/stream288.ts /tmp/hls/stream289.ts /tmp/hls/stream29.ts /tmp/hls/stream290.ts /tmp/hls/stream291.ts /tmp/hls/stream292.ts /tmp/hls/stream293.ts /tmp/hls/stream294.ts /tmp/hls/stream295.ts /tmp/hls/stream296.ts /tmp/hls/stream297.ts /tmp/hls/stream298.ts /tmp/hls/stream299.ts /tmp/hls/stream3.ts /tmp/hls/stream30.ts /tmp/hls/stream300.ts /tmp/hls/stream301.ts /tmp/hls/stream302.ts /tmp/hls/stream303.ts /tmp/hls/stream304.ts /tmp/hls/stream305.ts /tmp/hls/stream306.ts /tmp/hls/stream307.ts /tmp/hls/stream308.ts /tmp/hls/stream309.ts /tmp/hls/stream31.ts /tmp/hls/stream310.ts /tmp/hls/stream311.ts /tmp/hls/stream312.ts /tmp/hls/stream313.ts /tmp/hls/stream314.ts /tmp/hls/stream315.ts /tmp/hls/stream316.ts /tmp/hls/stream317.ts /tmp/hls/stream318.ts /tmp/hls/stream319.ts /tmp/hls/stream32.ts /tmp/hls/stream320.ts /tmp/hls/stream321.ts /tmp/hls/stream322.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream323.ts /tmp/hls/stream324.ts /tmp/hls/stream325.ts /tmp/hls/stream326.ts /tmp/hls/stream327.ts /tmp/hls/stream328.ts /tmp/hls/stream329.ts /tmp/hls/stream33.ts /tmp/hls/stream330.ts /tmp/hls/stream331.ts /tmp/hls/stream332.ts /tmp/hls/stream333.ts /tmp/hls/stream334.ts /tmp/hls/stream335.ts /tmp/hls/stream336.ts /tmp/hls/stream337.ts /tmp/hls/stream338.ts /tmp/hls/stream339.ts /tmp/hls/stream34.ts /tmp/hls/stream340.ts /tmp/hls/stream341.ts /tmp/hls/stream342.ts /tmp/hls/stream343.ts /tmp/hls/stream344.ts /tmp/hls/stream345.ts /tmp/hls/stream346.ts /tmp/hls/stream347.ts /tmp/hls/stream348.ts /tmp/hls/stream349.ts /tmp/hls/stream35.ts /tmp/hls/stream350.ts /tmp/hls/stream351.ts /tmp/hls/stream352.ts /tmp/hls/stream353.ts /tmp/hls/stream354.ts /tmp/hls/stream355.ts /tmp/hls/stream356.ts /tmp/hls/stream357.ts /tmp/hls/stream358.ts /tmp/hls/stream359.ts /tmp/hls/stream36.ts /tmp/hls/stream360.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream361.ts /tmp/hls/stream362.ts /tmp/hls/stream363.ts /tmp/hls/stream364.ts /tmp/hls/stream365.ts /tmp/hls/stream366.ts /tmp/hls/stream367.ts /tmp/hls/stream368.ts /tmp/hls/stream369.ts /tmp/hls/stream37.ts /tmp/hls/stream370.ts /tmp/hls/stream371.ts /tmp/hls/stream372.ts /tmp/hls/stream373.ts /tmp/hls/stream374.ts /tmp/hls/stream375.ts /tmp/hls/stream376.ts /tmp/hls/stream377.ts /tmp/hls/stream378.ts /tmp/hls/stream379.ts /tmp/hls/stream38.ts /tmp/hls/stream380.ts /tmp/hls/stream381.ts /tmp/hls/stream382.ts /tmp/hls/stream383.ts /tmp/hls/stream384.ts /tmp/hls/stream385.ts /tmp/hls/stream386.ts /tmp/hls/stream387.ts /tmp/hls/stream388.ts /tmp/hls/stream389.ts /tmp/hls/stream39.ts /tmp/hls/stream390.ts /tmp/hls/stream391.ts /tmp/hls/stream392.ts /tmp/hls/stream393.ts /tmp/hls/stream394.ts /tmp/hls/stream395.ts /tmp/hls/stream396.ts /tmp/hls/stream397.ts /tmp/hls/stream398.ts /tmp/hls/stream399.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream4.ts /tmp/hls/stream40.ts /tmp/hls/stream400.ts /tmp/hls/stream401.ts /tmp/hls/stream402.ts /tmp/hls/stream403.ts /tmp/hls/stream404.ts /tmp/hls/stream405.ts /tmp/hls/stream406.ts /tmp/hls/stream407.ts /tmp/hls/stream408.ts /tmp/hls/stream409.ts /tmp/hls/stream41.ts /tmp/hls/stream410.ts /tmp/hls/stream411.ts /tmp/hls/stream412.ts /tmp/hls/stream413.ts /tmp/hls/stream414.ts /tmp/hls/stream415.ts /tmp/hls/stream416.ts /tmp/hls/stream417.ts /tmp/hls/stream418.ts /tmp/hls/stream419.ts /tmp/hls/stream42.ts /tmp/hls/stream420.ts /tmp/hls/stream421.ts /tmp/hls/stream422.ts /tmp/hls/stream423.ts /tmp/hls/stream424.ts /tmp/hls/stream425.ts /tmp/hls/stream426.ts /tmp/hls/stream427.ts /tmp/hls/stream428.ts /tmp/hls/stream429.ts /tmp/hls/stream43.ts /tmp/hls/stream430.ts /tmp/hls/stream431.ts /tmp/hls/stream432.ts /tmp/hls/stream433.ts /tmp/hls/stream434.ts /tmp/hls/stream435.ts /tmp/hls/stream436.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream437.ts /tmp/hls/stream438.ts /tmp/hls/stream439.ts /tmp/hls/stream44.ts /tmp/hls/stream440.ts /tmp/hls/stream441.ts /tmp/hls/stream442.ts /tmp/hls/stream443.ts /tmp/hls/stream444.ts /tmp/hls/stream445.ts /tmp/hls/stream446.ts /tmp/hls/stream447.ts /tmp/hls/stream448.ts /tmp/hls/stream449.ts /tmp/hls/stream45.ts /tmp/hls/stream450.ts /tmp/hls/stream451.ts /tmp/hls/stream452.ts /tmp/hls/stream453.ts /tmp/hls/stream454.ts /tmp/hls/stream455.ts /tmp/hls/stream456.ts /tmp/hls/stream457.ts /tmp/hls/stream458.ts /tmp/hls/stream459.ts /tmp/hls/stream46.ts /tmp/hls/stream460.ts /tmp/hls/stream461.ts /tmp/hls/stream47.ts /tmp/hls/stream48.ts /tmp/hls/stream49.ts /tmp/hls/stream5.ts /tmp/hls/stream50.ts /tmp/hls/stream51.ts /tmp/hls/stream52.ts /tmp/hls/stream53.ts /tmp/hls/stream54.ts /tmp/hls/stream55.ts /tmp/hls/stream56.ts /tmp/hls/stream57.ts /tmp/hls/stream58.ts /tmp/hls/stream59.ts /tmp/hls/stream6.ts Jul 14 16:38:52 volumio sudo[10156]: volumio : (command continued) /tmp/hls/stream60.ts /tmp/hls/stream61.ts /tmp/hls/stream62.ts /tmp/hls/stream63.ts /tmp/hls/stream64.ts /tmp/hls/stream65.ts /tmp/hls/stream66.ts /tmp/hls/stream67.ts /tmp/hls/stream68.ts /tmp/hls/stream69.ts /tmp/hls/stream7.ts /tmp/hls/stream70.ts /tmp/hls/stream71.ts /tmp/hls/stream72.ts /tmp/hls/stream73.ts /tmp/hls/stream74.ts /tmp/hls/stream75.ts /tmp/hls/stream76.ts /tmp/hls/stream77.ts /tmp/hls/stream78.ts /tmp/hls/stream79.ts /tmp/hls/stream8.ts /tmp/hls/stream80.ts /tmp/hls/stream81.ts /tmp/hls/stream82.ts /tmp/hls/stream83.ts /tmp/hls/stream84.ts /tmp/hls/stream85.ts /tmp/hls/stream86.ts /tmp/hls/stream87.ts /tmp/hls/stream88.ts /tmp/hls/stream89.ts /tmp/hls/stream9.ts /tmp/hls/stream90.ts /tmp/hls/stream91.ts /tmp/hls/stream92.ts /tmp/hls/stream93.ts /tmp/hls/stream94.ts /tmp/hls/stream95.ts /tmp/hls/stream96.ts /tmp/hls/stream97.ts /tmp/hls/stream98.ts /tmp/hls/stream99.ts Jul 14 16:38:52 volumio sudo[10156]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:38:52 volumio volumio[22848]: TypeError: Cannot read property 'send' of null Jul 14 16:38:52 volumio volumio[22848]: at Client.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:128:11) Jul 14 16:38:52 volumio volumio[22848]: at Channel.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:34:12) Jul 14 16:38:52 volumio volumio[22848]: at fn.Controller.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:28:16) Jul 14 16:38:52 volumio volumio[22848]: at fn.RequestResponseController.request (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:34:8) Jul 14 16:38:52 volumio volumio[22848]: at fn.MediaController.sessionRequest (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/media.js:91:8) Jul 14 16:38:52 volumio volumio[22848]: at fn.MediaController.stop (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/media.js:107:8) Jul 14 16:38:52 volumio volumio[22848]: at DefaultMediaReceiver.stop (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/default-media-receiver.js:42:19) Jul 14 16:38:52 volumio volumio[22848]: at Timeout._onTimeout (/myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:5002) Jul 14 16:38:52 volumio volumio[22848]: at listOnTimeout (internal/timers.js:554:17) Jul 14 16:38:52 volumio volumio[22848]: at processTimers (internal/timers.js:497:7) Jul 14 16:38:52 volumio volumio[22848]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 16:38:52 volumio systemd[1]: Stopping VolumioStreamingService... Jul 14 16:38:52 volumio systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Jul 14 16:38:52 volumio systemd[1]: volumioStreaming.service: Succeeded. Jul 14 16:38:52 volumio systemd[1]: Stopped VolumioStreamingService. Jul 14 16:38:52 volumio sudo[10156]: pam_unix(sudo:session): session closed for user root Jul 14 16:38:52 volumio systemd[1]: Started VolumioStreamingService. Jul 14 16:38:52 volumio sudo[10158]: pam_unix(sudo:session): session closed for user root Jul 14 16:38:52 volumio sudo[10165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 14 16:38:52 volumio sudo[10165]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:38:52 volumio sudo[10165]: pam_unix(sudo:session): session closed for user root Jul 14 16:38:55 volumio sudo[10186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-14 16:37 Jul 14 16:38:55 volumio sudo[10186]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"