-- Logs begin at Fri 2024-07-26 16:55:15 CEST, end at Fri 2024-07-26 16:57:45 CEST. --
Jul 26 16:56:01 volumio volumio[982]: info: volroon::Roon Core Paired: 192.168.50.82:9330 with ID of: 09d7dd99-97ca-42ee-ab4d-e58ac160002c
Jul 26 16:56:01 volumio volumio[982]: error: volroon::Metadata - ReferenceError: roonPausedTimer is not defined
Jul 26 16:56:02 volumio volumio[1345]: .......................................++++
Jul 26 16:56:02 volumio volumio[982]: error: volroon::Metadata - ReferenceError: roonPausedTimer is not defined
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jul 26 16:56:09 volumio volumio[982]: info: Adding plugin bluetooth to MyMusic Plugins
Jul 26 16:56:09 volumio volumio[982]: info: Adding plugin multiroom to MyMusic Plugins
Jul 26 16:56:09 volumio volumio[982]: info: Adding plugin metavolumio to MyMusic Plugins
Jul 26 16:56:09 volumio volumio[982]: info: Adding plugin cd_controller to MyMusic Plugins
Jul 26 16:56:09 volumio volumio[982]: info: Adding plugin smart_inputs to MyMusic Plugins
Jul 26 16:56:09 volumio volumio[982]: info: Adding plugin tidalconnect to MyMusic Plugins
Jul 26 16:56:09 volumio volumio[982]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jul 26 16:56:10 volumio volumio[982]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jul 26 16:56:10 volumio volumio[982]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jul 26 16:56:10 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:10 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:10 volumio volumio[982]: info: Starting MyVolumio Remote Streaming Endpoints
Jul 26 16:56:10 volumio volumio[982]: info: MyVolumio login type: Token
Jul 26 16:56:10 volumio volumio[982]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jul 26 16:56:10 volumio volumio[982]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Jul 26 16:56:11 volumio volumio[982]: info: Starting Streaming Service Transparent Proxy
Jul 26 16:56:11 volumio volumio[982]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Jul 26 16:56:11 volumio volumio[982]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Jul 26 16:56:11 volumio volumio[982]: info: Streaming services startup
Jul 26 16:56:11 volumio volumio[982]: info: Starting Streaming Daemon
Jul 26 16:56:11 volumio sudo[1619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 26 16:56:11 volumio sudo[1619]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 26 16:56:11 volumio volumio[982]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Jul 26 16:56:11 volumio sudo[1619]: pam_unix(sudo:session): session closed for user root
Jul 26 16:56:12 volumio volumio[982]: error: Cannot start Volumio Streaming Daemon
Jul 26 16:56:12 volumio volumio[982]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jul 26 16:56:12 volumio volumio[982]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jul 26 16:56:13 volumio volumio[982]: STREAMING PROXY: Starting server on port 3245
Jul 26 16:56:13 volumio volumio[982]: Node JS runtime: 14
Jul 26 16:56:14 volumio volumio[982]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Jul 26 16:56:15 volumio volumio[982]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Jul 26 16:56:16 volumio volumio[982]: info: MyVolumio token set successfully
Jul 26 16:56:16 volumio volumio[982]: info: MYVOLUMIO: Adding device
Jul 26 16:56:16 volumio volumio[982]: info: MYVOLUMIO: Evaluating Server
Jul 26 16:56:16 volumio volumio[982]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Jul 26 16:56:17 volumio volumio[982]: info: MyVolumio status changed
Jul 26 16:56:17 volumio volumio[982]: info: Streaming services startup
Jul 26 16:56:17 volumio volumio[982]: info: Starting Streaming Daemon
Jul 26 16:56:17 volumio volumio[982]: info: Removing browser output: myVolumio user plan is not superstar
Jul 26 16:56:17 volumio volumio[982]: info: Removing audio output:
Jul 26 16:56:17 volumio volumio[982]: info: Stoppping Tunnel 1
Jul 26 16:56:17 volumio sudo[1648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 26 16:56:17 volumio sudo[1648]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 26 16:56:17 volumio sudo[1648]: pam_unix(sudo:session): session closed for user root
Jul 26 16:56:17 volumio sudo[1651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Jul 26 16:56:17 volumio sudo[1651]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 26 16:56:17 volumio sudo[1651]: pam_unix(sudo:session): session closed for user root
Jul 26 16:56:17 volumio volumio[982]: error: Cannot start Volumio Streaming Daemon
Jul 26 16:56:17 volumio volumio[982]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jul 26 16:56:17 volumio volumio[982]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jul 26 16:56:17 volumio volumio[982]: info: Remote SSH Stopped
Jul 26 16:56:17 volumio volumio[982]: info: Setting Geolocation for MyVolumio to eu10
Jul 26 16:56:17 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:17 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:17 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:17 volumio volumio[982]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Jul 26 16:56:18 volumio volumio[982]: info: Updating MyVolumio device info
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:18 volumio volumio[982]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:18 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 26 16:56:18 volumio volumio[982]: info: Received Get System Info
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 26 16:56:18 volumio volumio[982]: info: Discovery: Getting this device information
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:18 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:18 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:18 volumio volumio[982]: info: Listing playlists
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:18 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 26 16:56:18 volumio volumio[982]: info: Received Get System Info
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 26 16:56:18 volumio volumio[982]: info: Discovery: Getting this device information
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:18 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:18 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:18 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 26 16:56:18 volumio volumio[982]: info: Received Get System Info
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 26 16:56:18 volumio volumio[982]: info: Discovery: Getting this device information
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:18 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:18 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:18 volumio volumio[982]: info: Listing playlists
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jul 26 16:56:18 volumio volumio[982]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Jul 26 16:56:18 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jul 26 16:56:20 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jul 26 16:56:21 volumio volumio[982]: info: MYVOLUMIO: Adding device
Jul 26 16:56:21 volumio volumio[982]: info: MYVOLUMIO: Evaluating Server
Jul 26 16:56:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 26 16:56:22 volumio volumio[982]: info: Received Get System Info
Jul 26 16:56:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 26 16:56:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 26 16:56:22 volumio volumio[982]: info: Discovery: Getting this device information
Jul 26 16:56:22 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:22 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 26 16:56:22 volumio volumio[982]: info: Setting Geolocation for MyVolumio to eu4
Jul 26 16:56:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 26 16:56:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 26 16:56:23 volumio volumio-remote-updater[662]: Test mode enabled
Jul 26 16:56:23 volumio volumio-remote-updater[662]: No alpha test mode
Jul 26 16:56:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jul 26 16:56:23 volumio volumio[982]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Jul 26 16:56:23 volumio volumio[982]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Improved translations
\n- Fix for controlling Volumio device from another one
\n- Fix for slow playback on RPi5 with HifiBerry DAC
\n- Improved speed for default albumart
\n- Fix for Hifiberry DAC Detection
\n- Fix for Supersearch bar on Iphone
\n- Fix for Network connection on Wizard
\n
\nNEW ADDITIONS
\n\n- Kanji conversion for Japanese Keyboard
\n- Facility for third party UIs
\n- Enable THD compensation on Motivo
\n- Bump CM4 kernel to 6.6.30
\n- New custom display driver on Motivo
\n- Improved Plymouth boot animation on Motivo
\n- Enable Albumart on Motivo
\n- Add zoom setting on Vivaldi kiosk
\n- Set default zoom to 120% on Motivo
\n- Add DAC filter selection on Primo v2
\n- UNSTABLE ALPHA BUILD, DO NOT INSTALL
\n
\n","title":"Update v3.742","updateavailable":true}
Jul 26 16:56:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jul 26 16:56:23 volumio volumio[982]: info: Updating MyVolumio device info
Jul 26 16:56:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:24 volumio volumio[982]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Jul 26 16:56:25 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 26 16:56:25 volumio volumio[982]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 26 16:56:25 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:25 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:26 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 26 16:56:27 volumio ntpd[783]: Soliciting pool server 212.45.144.206
Jul 26 16:56:28 volumio ntpd[783]: Soliciting pool server 212.6.50.243
Jul 26 16:56:28 volumio ntpd[783]: Soliciting pool server 217.61.62.224
Jul 26 16:56:29 volumio ntpd[783]: Soliciting pool server 95.110.254.234
Jul 26 16:56:29 volumio ntpd[783]: Soliciting pool server 185.157.229.254
Jul 26 16:56:29 volumio ntpd[783]: Soliciting pool server 188.213.165.209
Jul 26 16:56:30 volumio ntpd[783]: Soliciting pool server 93.94.88.50
Jul 26 16:56:30 volumio ntpd[783]: Soliciting pool server 95.230.240.5
Jul 26 16:56:30 volumio ntpd[783]: Soliciting pool server 37.247.53.178
Jul 26 16:56:30 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 26 16:56:30 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 26 16:56:30 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jul 26 16:56:30 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jul 26 16:56:30 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jul 26 16:56:30 volumio volumio[982]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 26 16:56:30 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 26 16:56:31 volumio ntpd[783]: Soliciting pool server 93.44.243.48
Jul 26 16:56:31 volumio ntpd[783]: Soliciting pool server 31.14.133.122
Jul 26 16:56:31 volumio volumio[982]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Jul 26 16:56:31 volumio volumio[982]: info: Completed starting MyVolumio Plugin
Jul 26 16:56:31 volumio volumio[982]: info: BOOT COMPLETED
Jul 26 16:56:31 volumio volumio[982]: [Metrics] CommandRouter: 47s 928.69ms
Jul 26 16:56:31 volumio volumio[982]: info: CoreCommandRouter::volumiosetStartupVolume
Jul 26 16:56:31 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 26 16:56:31 volumio volumio[982]: info: VolumeController:: Setting startup Volume 30
Jul 26 16:56:31 volumio volumio[982]: info: VolumeController::SetAlsaVolume30
Jul 26 16:56:31 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 16:56:31 volumio volumio[982]: info: CoreCommandRouter::Close All Modals sent
Jul 26 16:56:31 volumio volumio[982]: info: CoreCommandRouter::Close All Modals sent
Jul 26 16:56:31 volumio volumio[982]: info: CoreStateMachine::pushState
Jul 26 16:56:31 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:31 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 26 16:56:31 volumio volumio[982]: info: CoreCommandRouter::volumioPushState
Jul 26 16:56:31 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum status stop
Jul 26 16:56:31 volumio volumio[982]: error: volroon::Metadata - ReferenceError: roonPausedTimer is not defined
Jul 26 16:56:31 volumio sudo[1909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 26 16:56:31 volumio sudo[1909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 26 16:56:31 volumio sudo[1909]: pam_unix(sudo:session): session closed for user root
Jul 26 16:56:31 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum failed to stop!! Error: Command failed: /usr/bin/sudo /bin/systemctl stop peppyspectrum.service
Jul 26 16:56:31 volumio volumio[982]: Failed to stop peppyspectrum.service: Unit peppyspectrum.service not loaded.
Jul 26 16:56:32 volumio ntpd[783]: Soliciting pool server 2001:760:2602::232
Jul 26 16:56:32 volumio ntpd[783]: Soliciting pool server 2.234.152.249
Jul 26 16:56:32 volumio ntpd[783]: Soliciting pool server 212.45.144.3
Jul 26 16:56:32 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 26 16:56:32 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 26 16:56:32 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 26 16:56:33 volumio ntpd[783]: Soliciting pool server 162.159.200.1
Jul 26 16:56:33 volumio volumio[1345]: .........................................................................................................................................................................................................................................................................................................................................++++
Jul 26 16:56:33 volumio volumio[1345]: e is 65537 (0x010001)
Jul 26 16:56:33 volumio volumio[1345]: writing RSA key
Jul 26 16:56:34 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 26 16:56:34 volumio volumio[982]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 26 16:56:34 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 26 16:56:34 volumio volumio[982]: info: Received Get System Version
Jul 26 16:56:34 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 26 16:56:34 volumio volumio[982]: info: Received Get System Info
Jul 26 16:56:34 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 26 16:56:34 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 26 16:56:34 volumio volumio[982]: info: Discovery: Getting this device information
Jul 26 16:56:34 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:56:34 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:56:34 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 26 16:56:34 volumio ntpd[783]: Soliciting pool server 185.19.184.35
Jul 26 16:56:35 volumio ntpd[783]: Soliciting pool server 85.199.214.99
Jul 26 16:57:07 volumio ntpd[783]: receive: Unexpected origin timestamp 0xea4e37a3.9031163b does not match aorg 0000000000.00000000 from server@185.157.229.254 xmt 0xea4e37c3.2f581250
Jul 26 16:57:07 volumio ntpd[783]: receive: Unexpected origin timestamp 0xea4e37a3.903406d7 does not match aorg 0000000000.00000000 from server@212.45.144.206 xmt 0xea4e37c3.2f09e734
Jul 26 16:57:07 volumio ntpd[783]: receive: Unexpected origin timestamp 0xea4e37a3.902dd712 does not match aorg 0000000000.00000000 from server@95.230.240.5 xmt 0xea4e37c3.2f6b8f9b
Jul 26 16:57:07 volumio ntpd[783]: receive: Unexpected origin timestamp 0xea4e37a3.90300b2f does not match aorg 0000000000.00000000 from server@95.110.254.234 xmt 0xea4e37c3.30320fa8
Jul 26 16:57:07 volumio ntpd[783]: receive: Unexpected origin timestamp 0xea4e37a3.90330888 does not match aorg 0000000000.00000000 from server@212.6.50.243 xmt 0xea4e37c3.308ddf26
Jul 26 16:57:07 volumio ntpd[783]: receive: Unexpected origin timestamp 0xea4e37a3.902b7f98 does not match aorg 0000000000.00000000 from server@93.44.243.48 xmt 0xea4e37c3.3034ccbc
Jul 26 16:57:07 volumio ntpd[783]: receive: Unexpected origin timestamp 0xea4e37a3.902cc23b does not match aorg 0000000000.00000000 from server@93.94.88.50 xmt 0xea4e37c3.30f7ae50
Jul 26 16:57:07 volumio ntpd[783]: receive: Unexpected origin timestamp 0xea4e37a3.90296edb does not match aorg 0000000000.00000000 from server@2.234.152.249 xmt 0xea4e37c3.338d8e64
Jul 26 16:57:20 volumio volumio[982]: info: volroon::getState
Jul 26 16:57:20 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:57:20 volumio volumio[982]: info: CoreCommandRouter::volumioClearQueue
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::ClearQueue
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::stop
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 26 16:57:20 volumio volumio[982]: info: CorePlayQueue::clearPlayQueue
Jul 26 16:57:20 volumio volumio[982]: info: CorePlayQueue::saveQueue
Jul 26 16:57:20 volumio volumio[982]: info: CoreCommandRouter::volumioPushState
Jul 26 16:57:20 volumio volumio[982]: info: CoreCommandRouter::volumioPushQueue
Jul 26 16:57:20 volumio volumio[982]: info: CoreCommandRouter::volumioStop
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::stop
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 26 16:57:20 volumio volumio[982]: verbose: volroon::State snapshot: {"status":"play","service":"volroon","title":"No More Tears","artist":"Ozzy Osbourne","album":"No More Tears","albumart":"http://192.168.50.82:9330/api/image/2662518ce88a85702bccdbb59b36682c","uri":"","trackType":"roon","seek":173000,"duration":444,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false}
Jul 26 16:57:20 volumio volumio[982]: info: volroon::pushState
Jul 26 16:57:20 volumio volumio[982]: info: CoreCommandRouter::servicePushState
Jul 26 16:57:20 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:57:20 volumio volumio[982]: verbose: STATE SERVICE {"status":"play","service":"volroon","title":"No More Tears","artist":"Ozzy Osbourne","album":"No More Tears","albumart":"http://192.168.50.82:9330/api/image/2662518ce88a85702bccdbb59b36682c","uri":"","trackType":"roon","seek":173000,"duration":444,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false}
Jul 26 16:57:20 volumio volumio[982]: verbose: CURRENT POSITION 0
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::syncState stateService play
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::syncState currentStatus stop
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::resetVolumioState
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::getcurrentVolume
Jul 26 16:57:20 volumio volumio[982]: info: CoreCommandRouter::volumioRetrievevolume
Jul 26 16:57:20 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum status stop
Jul 26 16:57:20 volumio sudo[1944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 26 16:57:20 volumio sudo[1944]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 26 16:57:20 volumio sudo[1944]: pam_unix(sudo:session): session closed for user root
Jul 26 16:57:20 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum failed to stop!! Error: Command failed: /usr/bin/sudo /bin/systemctl stop peppyspectrum.service
Jul 26 16:57:20 volumio volumio[982]: Failed to stop peppyspectrum.service: Unit peppyspectrum.service not loaded.
Jul 26 16:57:20 volumio volumio[982]: info: VolumeController:: Volume=30 Mute =false
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::pushState
Jul 26 16:57:20 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:57:20 volumio volumio[982]: info: CoreCommandRouter::volumioPushState
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::updateTrackBlock
Jul 26 16:57:20 volumio volumio[982]: info: CorePlayQueue::getTrackBlock
Jul 26 16:57:20 volumio volumio[982]: info: CoreCommandRouter::volumioRetrievevolume
Jul 26 16:57:20 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum status stop
Jul 26 16:57:20 volumio sudo[1949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 26 16:57:20 volumio sudo[1949]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 26 16:57:20 volumio sudo[1949]: pam_unix(sudo:session): session closed for user root
Jul 26 16:57:20 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum failed to stop!! Error: Command failed: /usr/bin/sudo /bin/systemctl stop peppyspectrum.service
Jul 26 16:57:20 volumio volumio[982]: Failed to stop peppyspectrum.service: Unit peppyspectrum.service not loaded.
Jul 26 16:57:20 volumio volumio[982]: info: VolumeController:: Volume=30 Mute =false
Jul 26 16:57:20 volumio volumio[982]: info: CoreStateMachine::pushState
Jul 26 16:57:20 volumio volumio[982]: info: CorePlayQueue::getTrack 0
Jul 26 16:57:20 volumio volumio[982]: info: CoreCommandRouter::volumioPushState
Jul 26 16:57:21 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum status stop
Jul 26 16:57:21 volumio sudo[1954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 26 16:57:21 volumio sudo[1954]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 26 16:57:21 volumio sudo[1954]: pam_unix(sudo:session): session closed for user root
Jul 26 16:57:21 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum failed to stop!! Error: Command failed: /usr/bin/sudo /bin/systemctl stop peppyspectrum.service
Jul 26 16:57:21 volumio volumio[982]: Failed to stop peppyspectrum.service: Unit peppyspectrum.service not loaded.
Jul 26 16:57:21 volumio volumio[982]: info: volroon::Setting volatile state to volroon
Jul 26 16:57:21 volumio volumio[982]: info: volroon::pushState
Jul 26 16:57:21 volumio volumio[982]: info: CoreCommandRouter::servicePushState
Jul 26 16:57:21 volumio volumio[982]: info: CoreStateMachine::pushState
Jul 26 16:57:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 26 16:57:21 volumio volumio[982]: info: CoreCommandRouter::volumioPushState
Jul 26 16:57:21 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum status play
Jul 26 16:57:21 volumio sudo[1960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 26 16:57:21 volumio sudo[1960]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 26 16:57:21 volumio sudo[1960]: pam_unix(sudo:session): session closed for user root
Jul 26 16:57:21 volumio volumio[982]: info: PeppySpectrum ---peppyspectrum failed to start. Check your configuration Error: Command failed: /usr/bin/sudo /bin/systemctl start peppyspectrum.service
Jul 26 16:57:21 volumio volumio[982]: Failed to start peppyspectrum.service: Unit peppyspectrum.service not found.
Jul 26 16:57:21 volumio volumio[982]: info: touch_display: Setting screensaver timeout to 0 seconds.
Jul 26 16:57:27 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 26 16:57:27 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jul 26 16:57:35 volumio volumio[982]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---list is Random,G5_01Pipe,G5_02Pipe,G5_03Nixie,G5_04Pipe Wood,G5_05Pipe Gold,G5_06Nixie,G5_07Naim,G5_08Kenwood,G5_09Marshal,G5_10Gold 2,G5_11Dorrought
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---1280x400+30-30bars-balbuze
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---1280x400+30-custom
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---1280x400+30-Gelo5
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---1280x400+99-99bars-balbuze
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---1480x320+99-99bars-balbuze
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---1920x1080+13-Gelo5
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---1920x1080+30-Gelo5
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---1920x1080+55-Gelo5
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---1920x720+99-99bars-balbuze
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---800x100+99-99bars
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---800x46+99-99bars-balbuze
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---800x480+20-marshall
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---800x480+230-230-bars-freq
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---800x480+30-30bars-balbuze
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---800x480+30-Gelo5
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---800x480+30-marshall
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---800x480+55-marshall
Jul 26 16:57:35 volumio volumio[982]: info: PeppySpectrum ---800x480+99-99bars-balbuze
Jul 26 16:57:40 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:57:41 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 26 16:57:41 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jul 26 16:57:41 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 26 16:57:41 volumio volumio[982]: info: Received Get System Info
Jul 26 16:57:41 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 26 16:57:41 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 26 16:57:41 volumio volumio[982]: info: Discovery: Getting this device information
Jul 26 16:57:41 volumio volumio[982]: info: CoreCommandRouter::volumioGetState
Jul 26 16:57:41 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 26 16:57:45 volumio volumio[982]: info: Starting Uninstall of plugin user_interface - peppyspectrum
Jul 26 16:57:45 volumio volumio[982]: info: Uninstalling plugin peppyspectrum
Jul 26 16:57:45 volumio volumio[982]: info: Stopping peppyspectrum service
Jul 26 16:57:45 volumio volumio[982]: info: CoreStateMachine::stop
Jul 26 16:57:45 volumio volumio[982]: info: CoreStateMachine::serviceStop
Jul 26 16:57:45 volumio volumio[982]: info: CoreCommandRouter::serviceStop
Jul 26 16:57:45 volumio volumio[982]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 26 16:57:45 volumio volumio[982]: TypeError: Cannot read property 'then' of undefined
Jul 26 16:57:45 volumio volumio[982]: at peppyspectrum.onStop (/data/plugins/user_interface/peppyspectrum/index.js:60:43)
Jul 26 16:57:45 volumio volumio[982]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Jul 26 16:57:45 volumio volumio[982]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10)
Jul 26 16:57:45 volumio volumio[982]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1465:22)
Jul 26 16:57:45 volumio volumio[982]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1242:45)
Jul 26 16:57:45 volumio volumio[982]: at Socket.emit (events.js:315:20)
Jul 26 16:57:45 volumio volumio[982]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jul 26 16:57:45 volumio volumio[982]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jul 26 16:57:45 volumio volumio[982]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 26 16:57:45 volumio sudo[1987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-26 16:56
Jul 26 16:57:45 volumio sudo[1987]: 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="905ee02fb5387537cfa16b84ebd7f14b7640848e"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 18 Jul 2024 07:14:40 PM CEST"
VOLUMIO_VERSION="3.741"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="a68099d1a5f4301106a28f85f8548ae3"