-- Logs begin at Sat 2024-08-24 12:59:41 BST, end at Sat 2024-08-24 18:09:29 BST. -- Aug 24 18:08:04 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:08:10 volumio volumio[1407]: info: CoreCommandRouter::volumioSeek Aug 24 18:08:10 volumio volumio[1407]: info: CoreStateMachine::seek Aug 24 18:08:10 volumio volumio[1407]: info: WARNING: No seek method for volatile plugin undefined Aug 24 18:08:10 volumio volumio[1407]: info: CoreStateMachine::startPlaybackTimer Aug 24 18:08:10 volumio volumio[1407]: info: CorePlayQueue::getTrack 42 Aug 24 18:08:10 volumio volumio[1407]: info: CoreStateMachine::pushState Aug 24 18:08:10 volumio volumio[1407]: info: CoreCommandRouter::volumioPushState Aug 24 18:08:10 volumio volumio[1407]: info: MRS: Pushing multiroomSync output update for this device Aug 24 18:08:10 volumio volumio[1407]: info: MRS: Pushing multiroomSync output Aug 24 18:08:10 volumio volumio[1407]: info: PeppySpectrum ---peppyspectrum status stop Aug 24 18:08:10 volumio volumio[1407]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Aug 24 18:08:10 volumio sudo[18818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Aug 24 18:08:10 volumio sudo[18818]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 18:08:10 volumio sudo[18818]: pam_unix(sudo:session): session closed for user root Aug 24 18:08:10 volumio volumio[1407]: info: peppyspectrum Daemon Stop Aug 24 18:08:14 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:08:14 volumio volumio[1407]: info: Listing playlists Aug 24 18:08:14 volumio volumio[1407]: info: Listing playlists Aug 24 18:08:24 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:08:27 volumio volumio[1407]: info: CoreCommandRouter::volumioVolatilePlay Aug 24 18:08:27 volumio volumio[1407]: info: CoreStateMachine::volatilePlay Aug 24 18:08:27 volumio volumio[1407]: info: WARNING: No play method for volatile plugin undefined Aug 24 18:08:34 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:08:34 volumio volumio[1407]: info: Listing playlists Aug 24 18:08:34 volumio volumio[1407]: info: Listing playlists Aug 24 18:08:44 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:08:44 volumio volumio[1407]: info: VolumeController::SetAlsaVolume17 Aug 24 18:08:44 volumio volumio[1407]: info: CoreStateMachine::pushState Aug 24 18:08:44 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 18:08:44 volumio volumio[1407]: info: CoreCommandRouter::volumioPushState Aug 24 18:08:44 volumio volumio[1407]: info: MRS: Pushing multiroomSync output update for this device Aug 24 18:08:44 volumio volumio[1407]: info: MRS: Pushing multiroomSync output Aug 24 18:08:44 volumio volumio[1407]: info: PeppySpectrum ---peppyspectrum status stop Aug 24 18:08:44 volumio volumio[1407]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Aug 24 18:08:44 volumio volumio[1407]: SPOTIFY: SPOTIFY VOLUME 95 Aug 24 18:08:44 volumio volumio[1407]: SPOTIFY: VOLUMIO VOLUME 17 Aug 24 18:08:44 volumio volumio[1407]: SPOTIFY: DELTA VOLUME ENOUGH: true Aug 24 18:08:44 volumio volumio[1407]: info: Setting Spotify Volume from Volumio: 17 Aug 24 18:08:44 volumio sudo[18825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Aug 24 18:08:44 volumio sudo[18825]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 18:08:44 volumio sudo[18825]: pam_unix(sudo:session): session closed for user root Aug 24 18:08:44 volumio volumio[1407]: info: peppyspectrum Daemon Stop Aug 24 18:08:46 volumio volumio[1407]: SPOTIFY: SETTING SPOTIFY VOLUME 17 Aug 24 18:08:46 volumio volumio[1407]: info: Sending Spotify command with payload to local API: /player/volume Aug 24 18:08:46 volumio go-librespot[1665]: time="2024-08-24T18:08:46+01:00" level=debug msg="update volume to 11140/65535" Aug 24 18:08:46 volumio go-librespot[1665]: time="2024-08-24T18:08:46+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Aug 24 18:08:46 volumio go-librespot[1665]: time="2024-08-24T18:08:46+01:00" level=trace msg="emitting websocket event: volume" Aug 24 18:08:46 volumio volumio[1407]: SPOTIFY: received: {"type":"volume","data":{"value":17,"max":100}} Aug 24 18:08:46 volumio volumio[1407]: SPOTIFY: RECEIVED SPOTIFY VOLUME 17 Aug 24 18:08:46 volumio volumio[1407]: info: VolumeController::SetAlsaVolume40 Aug 24 18:08:46 volumio volumio[1407]: info: CoreStateMachine::pushState Aug 24 18:08:46 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 18:08:46 volumio volumio[1407]: info: CoreCommandRouter::volumioPushState Aug 24 18:08:46 volumio volumio[1407]: info: MRS: Pushing multiroomSync output update for this device Aug 24 18:08:46 volumio volumio[1407]: info: MRS: Pushing multiroomSync output Aug 24 18:08:46 volumio volumio[1407]: info: PeppySpectrum ---peppyspectrum status stop Aug 24 18:08:46 volumio volumio[1407]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Aug 24 18:08:46 volumio volumio[1407]: SPOTIFY: SPOTIFY VOLUME 17 Aug 24 18:08:46 volumio volumio[1407]: SPOTIFY: VOLUMIO VOLUME 40 Aug 24 18:08:46 volumio volumio[1407]: SPOTIFY: DELTA VOLUME ENOUGH: true Aug 24 18:08:46 volumio volumio[1407]: info: Setting Spotify Volume from Volumio: 40 Aug 24 18:08:46 volumio sudo[18829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Aug 24 18:08:46 volumio sudo[18829]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 18:08:46 volumio sudo[18829]: pam_unix(sudo:session): session closed for user root Aug 24 18:08:46 volumio volumio[1407]: info: peppyspectrum Daemon Stop Aug 24 18:08:48 volumio volumio[1407]: SPOTIFY: SETTING SPOTIFY VOLUME 40 Aug 24 18:08:48 volumio volumio[1407]: info: Sending Spotify command with payload to local API: /player/volume Aug 24 18:08:48 volumio go-librespot[1665]: time="2024-08-24T18:08:48+01:00" level=debug msg="update volume to 26214/65535" Aug 24 18:08:48 volumio go-librespot[1665]: time="2024-08-24T18:08:48+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Aug 24 18:08:48 volumio go-librespot[1665]: time="2024-08-24T18:08:48+01:00" level=trace msg="emitting websocket event: volume" Aug 24 18:08:48 volumio volumio[1407]: SPOTIFY: received: {"type":"volume","data":{"value":40,"max":100}} Aug 24 18:08:48 volumio volumio[1407]: SPOTIFY: RECEIVED SPOTIFY VOLUME 40 Aug 24 18:08:51 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Aug 24 18:08:51 volumio volumio[1407]: error: MRS: impossible to set browserPlayback volume: device not found Aug 24 18:08:54 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:08:54 volumio volumio[1407]: info: Listing playlists Aug 24 18:08:54 volumio volumio[1407]: info: Listing playlists Aug 24 18:09:04 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:09:08 volumio volumio[1407]: info: CorePlayQueue::getTrack 42 Aug 24 18:09:08 volumio volumio[1407]: info: CorePlayQueue::getTrack 43 Aug 24 18:09:08 volumio volumio[1407]: info: Prefetching next song Aug 24 18:09:08 volumio volumio[1407]: info: [1724519348409] ControllerSpotify::prefetch Aug 24 18:09:08 volumio volumio[1407]: info: Sending Spotify command with payload to local API: /player/add_to_queue Aug 24 18:09:08 volumio go-librespot[1665]: time="2024-08-24T18:09:08+01:00" level=warning msg="cannot add to queue without a context" Aug 24 18:09:12 volumio volumio[1407]: info: CoreStateMachine::startPlaybackTimer Aug 24 18:09:12 volumio volumio[1407]: info: CorePlayQueue::getTrack 43 Aug 24 18:09:13 volumio volumio[1407]: info: CoreStateMachine::pushState Aug 24 18:09:13 volumio volumio[1407]: info: CoreCommandRouter::volumioPushState Aug 24 18:09:13 volumio volumio[1407]: info: MRS: Pushing multiroomSync output update for this device Aug 24 18:09:13 volumio volumio[1407]: info: MRS: Pushing multiroomSync output Aug 24 18:09:13 volumio volumio[1407]: info: PeppySpectrum ---peppyspectrum status stop Aug 24 18:09:13 volumio volumio[1407]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Aug 24 18:09:13 volumio sudo[18877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Aug 24 18:09:13 volumio sudo[18877]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 18:09:13 volumio sudo[18877]: pam_unix(sudo:session): session closed for user root Aug 24 18:09:13 volumio volumio[1407]: info: peppyspectrum Daemon Stop Aug 24 18:09:14 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:09:14 volumio volumio[1407]: info: Listing playlists Aug 24 18:09:14 volumio volumio[1407]: info: Listing playlists Aug 24 18:09:19 volumio sudo[18880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 24 18:09:19 volumio sudo[18880]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 18:09:19 volumio sudo[18880]: pam_unix(sudo:session): session closed for user root Aug 24 18:09:19 volumio sudo[18883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 24 18:09:19 volumio sudo[18883]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 18:09:19 volumio sudo[18883]: pam_unix(sudo:session): session closed for user root Aug 24 18:09:19 volumio volumio[1407]: verbose: New Socket.io Connection to 192.168.0.108 from 192.168.0.102 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 10 Aug 24 18:09:19 volumio volumio[1407]: info: CoreCommandRouter::volumioGetVisibleSources Aug 24 18:09:19 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 24 18:09:19 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:09:19 volumio volumio[1407]: info: CoreCommandRouter::volumioGetQueue Aug 24 18:09:19 volumio volumio[1407]: info: CoreStateMachine::getQueue Aug 24 18:09:19 volumio volumio[1407]: info: CorePlayQueue::getQueue Aug 24 18:09:19 volumio volumio[1407]: info: Listing playlists Aug 24 18:09:19 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 24 18:09:19 volumio volumio[1407]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 24 18:09:19 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 24 18:09:19 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 24 18:09:19 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 24 18:09:19 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 24 18:09:21 volumio volumio[1407]: info: CoreCommandRouter::volumioVolatilePlay Aug 24 18:09:21 volumio volumio[1407]: info: CoreStateMachine::volatilePlay Aug 24 18:09:21 volumio volumio[1407]: info: WARNING: No play method for volatile plugin undefined Aug 24 18:09:21 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 24 18:09:21 volumio volumio[1407]: info: Received Get System Info Aug 24 18:09:21 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 24 18:09:21 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 24 18:09:21 volumio volumio[1407]: info: Discovery: Getting this device information Aug 24 18:09:21 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:09:21 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 24 18:09:22 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 24 18:09:22 volumio volumio[1407]: info: Received Get System Info Aug 24 18:09:22 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 24 18:09:22 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 24 18:09:22 volumio volumio[1407]: info: Discovery: Getting this device information Aug 24 18:09:22 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:09:22 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 24 18:09:24 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:09:27 volumio volumio[1407]: verbose: New Socket.io Connection to 192.168.0.108 from 192.168.0.102 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 OPR/112.0.0.0 Engine version: 3 Transport: polling Total Clients: 11 Aug 24 18:09:27 volumio volumio[1407]: info: CoreCommandRouter::volumioGetVisibleSources Aug 24 18:09:27 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 24 18:09:27 volumio volumio[1407]: info: CoreCommandRouter::volumioGetState Aug 24 18:09:27 volumio volumio[1407]: info: CoreCommandRouter::volumioGetQueue Aug 24 18:09:27 volumio volumio[1407]: info: CoreStateMachine::getQueue Aug 24 18:09:27 volumio volumio[1407]: info: CorePlayQueue::getQueue Aug 24 18:09:27 volumio volumio[1407]: info: Listing playlists Aug 24 18:09:27 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 24 18:09:27 volumio volumio[1407]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 24 18:09:29 volumio volumio[1407]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Aug 24 18:09:29 volumio volumio[1407]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Aug 24 18:09:29 volumio volumio[1407]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 24 18:09:29 volumio volumio[1407]: TypeError: Cannot read property 'then' of undefined Aug 24 18:09:29 volumio volumio[1407]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Aug 24 18:09:29 volumio volumio[1407]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2260:30) Aug 24 18:09:29 volumio volumio[1407]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1442:26) Aug 24 18:09:29 volumio volumio[1407]: at Socket.emit (events.js:315:20) Aug 24 18:09:29 volumio volumio[1407]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 24 18:09:29 volumio volumio[1407]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 24 18:09:29 volumio volumio[1407]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 24 18:09:29 volumio sudo[18895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-24 18:08 Aug 24 18:09:29 volumio sudo[18895]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"