-- Logs begin at Sun 2024-07-21 19:29:11 EDT, end at Sun 2024-07-21 19:31:30 EDT. --
Jul 21 19:30:00 volumio wpa_supplicant[1175]: RRM: Ignoring radio measurement request: Not RRM network
Jul 21 19:30:04 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 21 19:30:04 volumio volumio[1261]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 21 19:30:04 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 21 19:30:04 volumio volumio[1261]: info: Received Get System Version
Jul 21 19:30:04 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 21 19:30:04 volumio volumio[1261]: info: Received Get System Info
Jul 21 19:30:04 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 21 19:30:04 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 21 19:30:04 volumio volumio[1261]: info: Discovery: Getting this device information
Jul 21 19:30:04 volumio volumio[1261]: info: CoreCommandRouter::volumioGetState
Jul 21 19:30:04 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:04 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 21 19:30:05 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 21 19:30:05 volumio volumio[1261]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14
Jul 21 19:30:05 volumio volumio[1261]: info: CoreCommandRouter::volumioGetState
Jul 21 19:30:05 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:07 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 21 19:30:07 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:30:07 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 21 19:30:07 volumio volumio-remote-updater[943]: No test mode
Jul 21 19:30:07 volumio volumio-remote-updater[943]: No alpha test mode
Jul 21 19:30:07 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jul 21 19:30:07 volumio volumio[1261]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Jul 21 19:30:07 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 21 19:30:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 21 19:30:10 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:30:10 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:30:10 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jul 21 19:30:10 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jul 21 19:30:10 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jul 21 19:30:10 volumio volumio[1261]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 21 19:30:10 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 21 19:30:11 volumio volumio[1261]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Jul 21 19:30:11 volumio volumio[1261]: info: Completed starting MyVolumio Plugin
Jul 21 19:30:11 volumio volumio[1261]: info: BOOT COMPLETED
Jul 21 19:30:11 volumio volumio[1261]: [Metrics] CommandRouter: 41s 783.14ms
Jul 21 19:30:11 volumio volumio[1261]: info: CoreCommandRouter::volumiosetStartupVolume
Jul 21 19:30:11 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:30:11 volumio volumio[1261]: info: VolumeController:: Setting startup Volume 10
Jul 21 19:30:11 volumio volumio[1261]: info: VolumeController::SetAlsaVolume10
Jul 21 19:30:11 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:30:11 volumio volumio[1261]: info: CoreCommandRouter::Close All Modals sent
Jul 21 19:30:11 volumio volumio[1261]: info: CoreCommandRouter::Close All Modals sent
Jul 21 19:30:11 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:30:11 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:11 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:30:11 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:30:11 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status stop
Jul 21 19:30:11 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:30:11 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 10
Jul 21 19:30:11 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 10
Jul 21 19:30:11 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: false
Jul 21 19:30:11 volumio volumio[1261]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jul 21 19:30:11 volumio volumio[1261]: info: FusionDsp - ---- read samplerate from file: 44100
Jul 21 19:30:11 volumio volumio[1261]: info: camilladsp stopping service pid 1786...
Jul 21 19:30:11 volumio sudo[2383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 21 19:30:11 volumio sudo[2383]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:30:11 volumio volumio[1261]: info: camilladsp service terminated, instance 1
Jul 21 19:30:11 volumio volumio[1261]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jul 21 19:30:11 volumio volumio[1261]: info: camilladsp service started and running in background, instance 1
Jul 21 19:30:11 volumio sudo[2383]: pam_unix(sudo:session): session closed for user root
Jul 21 19:30:11 volumio volumio[1261]: info: camilladsp spawned new process with pid 2388, instance 1, run: true
Jul 21 19:30:11 volumio volumio[1261]: info: peppyspectrum Daemon Stop
Jul 21 19:30:11 volumio volumio[1261]: info: camilladsp spawned new process with pid 2396, instance 1, run: true
Jul 21 19:30:12 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 21 19:30:12 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 21 19:30:12 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 21 19:30:19 volumio ntpd[1079]: Soliciting pool server 216.197.228.230
Jul 21 19:30:20 volumio ntpd[1079]: Soliciting pool server 131.153.171.22
Jul 21 19:30:20 volumio ntpd[1079]: Soliciting pool server 216.232.132.102
Jul 21 19:30:21 volumio sudo[2449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 21 19:30:21 volumio sudo[2449]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:30:21 volumio sudo[2449]: pam_unix(sudo:session): session closed for user root
Jul 21 19:30:21 volumio sudo[2452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 21 19:30:21 volumio sudo[2452]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:30:21 volumio sudo[2452]: pam_unix(sudo:session): session closed for user root
Jul 21 19:30:21 volumio volumio[1261]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.70 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Jul 21 19:30:21 volumio ntpd[1079]: Soliciting pool server 174.142.148.226
Jul 21 19:30:21 volumio ntpd[1079]: Soliciting pool server 155.138.150.213
Jul 21 19:30:21 volumio ntpd[1079]: Soliciting pool server 216.197.156.83
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::volumioGetState
Jul 21 19:30:21 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 21 19:30:21 volumio sudo[2455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 21 19:30:21 volumio sudo[2455]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:30:21 volumio sudo[2455]: pam_unix(sudo:session): session closed for user root
Jul 21 19:30:21 volumio sudo[2458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 21 19:30:21 volumio sudo[2458]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:30:21 volumio sudo[2458]: pam_unix(sudo:session): session closed for user root
Jul 21 19:30:21 volumio volumio[1261]: verbose: New Socket.io Connection to 192.168.1.76 from 192.168.1.70 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::volumioGetState
Jul 21 19:30:21 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 21 19:30:21 volumio volumio[1261]: info: Listing playlists
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jul 21 19:30:21 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 21 19:30:22 volumio ntpd[1079]: Soliciting pool server 216.232.132.95
Jul 21 19:30:22 volumio ntpd[1079]: Soliciting pool server 51.79.69.205
Jul 21 19:30:22 volumio ntpd[1079]: Soliciting pool server 66.49.222.68
Jul 21 19:30:23 volumio ntpd[1079]: Soliciting pool server 173.183.146.26
Jul 21 19:30:23 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 21 19:30:23 volumio volumio[1261]: info: Received Get System Info
Jul 21 19:30:23 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 21 19:30:23 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 21 19:30:23 volumio volumio[1261]: info: Discovery: Getting this device information
Jul 21 19:30:23 volumio volumio[1261]: info: CoreCommandRouter::volumioGetState
Jul 21 19:30:23 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:23 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 21 19:30:24 volumio volumio[1261]: info: CoreCommandRouter::volumioGetQueue
Jul 21 19:30:24 volumio volumio[1261]: info: CoreStateMachine::getQueue
Jul 21 19:30:24 volumio volumio[1261]: info: CorePlayQueue::getQueue
Jul 21 19:30:24 volumio volumio[1261]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 21 19:30:24 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 21 19:30:24 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 21 19:30:24 volumio volumio[1261]: info: Received Get System Info
Jul 21 19:30:24 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 21 19:30:24 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 21 19:30:24 volumio volumio[1261]: info: Discovery: Getting this device information
Jul 21 19:30:24 volumio volumio[1261]: info: CoreCommandRouter::volumioGetState
Jul 21 19:30:24 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:24 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 21 19:30:24 volumio ntpd[1079]: Soliciting pool server 142.4.192.253
Jul 21 19:30:24 volumio ntpd[1079]: Soliciting pool server 216.6.2.70
Jul 21 19:30:25 volumio ntpd[1079]: Soliciting pool server 162.159.200.123
Jul 21 19:30:25 volumio ntpd[1079]: Soliciting pool server 2607:5300:60:1524:5005:5005:5005:5005
Jul 21 19:30:26 volumio ntpd[1079]: Soliciting pool server 162.159.200.1
Jul 21 19:30:27 volumio ntpd[1079]: Soliciting pool server 23.162.240.10
Jul 21 19:30:27 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri
Jul 21 19:30:27 volumio volumio[1261]: info: [1721604627823] [80s80s] handleBrowseUri curUri: 80s80s
Jul 21 19:30:27 volumio volumio[1261]: info: Preload queue cleared
Jul 21 19:30:29 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri
Jul 21 19:30:29 volumio volumio[1261]: info: [1721604629302] [80s80s] handleBrowseUri curUri: 80s80s/eighties
Jul 21 19:30:29 volumio volumio[1261]: info: [1721604629302] [80s80s] getRadioContent url: eighties
Jul 21 19:30:29 volumio volumio[1261]: info: Preload queue cleared
Jul 21 19:30:30 volumio volumio[1261]: info: Preload queue cleared
Jul 21 19:30:30 volumio volumio[1261]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::ClearQueue
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::stop
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:30:30 volumio volumio[1261]: info: CorePlayQueue::clearPlayQueue
Jul 21 19:30:30 volumio volumio[1261]: info: CorePlayQueue::saveQueue
Jul 21 19:30:30 volumio volumio[1261]: info: CoreCommandRouter::volumioPushQueue
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::addQueueItems
Jul 21 19:30:30 volumio volumio[1261]: info: CorePlayQueue::addQueueItems
Jul 21 19:30:30 volumio volumio[1261]: info: Preload queue cleared
Jul 21 19:30:30 volumio volumio[1261]: info: Adding Item to queue: webeighties/2
Jul 21 19:30:30 volumio volumio[1261]: info: Exploding uri webeighties/2 in service 80s80s
Jul 21 19:30:30 volumio volumio[1261]: info: [1721604630831] [80s80s] explodeUri: webeighties/2
Jul 21 19:30:30 volumio volumio[1261]: info: CoreCommandRouter::volumioPushQueue
Jul 21 19:30:30 volumio volumio[1261]: info: CorePlayQueue::saveQueue
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::updateTrackBlock
Jul 21 19:30:30 volumio volumio[1261]: info: CorePlayQueue::getTrackBlock
Jul 21 19:30:30 volumio volumio[1261]: info: CoreCommandRouter::volumioPlay
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::play index 0
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::stop
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::play index undefined
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:30:30 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:30 volumio volumio[1261]: info: CoreStateMachine::startPlaybackTimer
Jul 21 19:30:30 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:30 volumio volumio[1261]: info: [1721604630836] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/love/mp3-192/volumio
Jul 21 19:30:30 volumio volumio[1261]: info: [1721604630836] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=85&count=2
Jul 21 19:30:31 volumio volumio[1261]: info: [1721604631199] [80s80s] received new event containing 2 songs.
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand stop
Jul 21 19:30:31 volumio volumio[1261]: info: sendMpdCommand stop took 0 milliseconds
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand clear
Jul 21 19:30:31 volumio volumio[1261]: info:
Jul 21 19:30:31 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:31 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:31 volumio volumio[1261]: info: sendMpdCommand clear took 0 milliseconds
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand consume 1
Jul 21 19:30:31 volumio volumio[1261]: info:
Jul 21 19:30:31 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:31 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:31 volumio volumio[1261]: info:
Jul 21 19:30:31 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:31 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:31 volumio volumio[1261]: error: updateQueue error: null
Jul 21 19:30:31 volumio volumio[1261]: info:
Jul 21 19:30:31 volumio volumio[1261]: ---------------------------- MPD announces state update: options
Jul 21 19:30:31 volumio volumio[1261]: error: updateQueue error: null
Jul 21 19:30:31 volumio volumio[1261]: error: updateQueue error: null
Jul 21 19:30:31 volumio volumio[1261]: info: ------------------------------ 2ms
Jul 21 19:30:31 volumio volumio[1261]: info: sendMpdCommand consume 1 took 1 milliseconds
Jul 21 19:30:31 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:31 volumio volumio[1261]: info: ------------------------------ 1ms
Jul 21 19:30:31 volumio volumio[1261]: info: ------------------------------ 2ms
Jul 21 19:30:31 volumio volumio[1261]: info: [1721604631204] [80s80s] adding url: http://streams.80s80s.de/love/mp3-192/volumio
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/love/mp3-192/volumio"
Jul 21 19:30:31 volumio volumio[1261]: info:
Jul 21 19:30:31 volumio volumio[1261]: ---------------------------- MPD announces state update: options
Jul 21 19:30:31 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:31 volumio volumio[1261]: info:
Jul 21 19:30:31 volumio volumio[1261]: ---------------------------- MPD announces state update: options
Jul 21 19:30:31 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:31 volumio volumio[1261]: info:
Jul 21 19:30:31 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:31 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:31 volumio volumio[1261]: info: sendMpdCommand status took 2 milliseconds
Jul 21 19:30:31 volumio volumio[1261]: info: sendMpdCommand add "http://streams.80s80s.de/love/mp3-192/volumio" took 1 milliseconds
Jul 21 19:30:31 volumio volumio[1261]: info: sendMpdCommand status took 2 milliseconds
Jul 21 19:30:31 volumio volumio[1261]: info: sendMpdCommand status took 1 milliseconds
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand play
Jul 21 19:30:31 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:31 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:31 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:31 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:30:31 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:31 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:30:31 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:30:31 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:31 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:31 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:31 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:31 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:30:31 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:31 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:30:31 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:31 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:31 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:31 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:31 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:30:31 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:31 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:30:31 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:31 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:31 volumio volumio[1261]: info: ------------------------------ 12ms
Jul 21 19:30:31 volumio volumio[1261]: info: ------------------------------ 14ms
Jul 21 19:30:31 volumio volumio[1261]: info: ------------------------------ 14ms
Jul 21 19:30:31 volumio volumio[1261]: info:
Jul 21 19:30:31 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:31 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:31 volumio volumio[1261]: info:
Jul 21 19:30:31 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:31 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:31 volumio volumio[1261]: info: ------------------------------ 15ms
Jul 21 19:30:31 volumio volumio[1261]: info: sendMpdCommand play took 11 milliseconds
Jul 21 19:30:31 volumio volumio[1261]: info: [1721604631221] [80s80s] Pushing the next song state: America - The Last Unicorn
Jul 21 19:30:31 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:31 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:31 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:31 volumio volumio[1261]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music123/v4/ed/d0/78/edd078f9-2e7f-c0b9-8eb5-b9a44d4a8c9c/source/600x600bb.jpg","name":"America - The Last Unicorn","title":"The Last Unicorn","artist":"80s80s Love","album":"","streaming":true,"disableUiControls":true,"duration":"181","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Jul 21 19:30:31 volumio volumio[1261]: verbose: CURRENT POSITION 0
Jul 21 19:30:31 volumio volumio[1261]: info: CoreStateMachine::syncState stateService play
Jul 21 19:30:31 volumio volumio[1261]: info: CoreStateMachine::syncState currentStatus stop
Jul 21 19:30:31 volumio volumio[1261]: info: [1721604631222] [80s80s] PlayNextTrack API delay: 30
Jul 21 19:30:31 volumio volumio[1261]: info: [1721604631235] [80s80s] Setting timer to: 181000 milliseconds.
Jul 21 19:30:31 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status stop
Jul 21 19:30:31 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status stop
Jul 21 19:30:31 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status stop
Jul 21 19:30:31 volumio sudo[2467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 21 19:30:31 volumio sudo[2467]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:30:31 volumio sudo[2469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 21 19:30:31 volumio sudo[2469]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:30:31 volumio sudo[2469]: pam_unix(sudo:session): session closed for user root
Jul 21 19:30:31 volumio sudo[2467]: pam_unix(sudo:session): session closed for user root
Jul 21 19:30:31 volumio sudo[2473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 21 19:30:31 volumio sudo[2473]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 10
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 10
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: false
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 10
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 10
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: false
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 10
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 10
Jul 21 19:30:31 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: false
Jul 21 19:30:31 volumio volumio[1261]: info: ------------------------------ 94ms
Jul 21 19:30:31 volumio volumio[1261]: info: ------------------------------ 95ms
Jul 21 19:30:31 volumio volumio[1261]: info: peppyspectrum Daemon Stop
Jul 21 19:30:31 volumio volumio[1261]: info: peppyspectrum Daemon Stop
Jul 21 19:30:31 volumio sudo[2473]: pam_unix(sudo:session): session closed for user root
Jul 21 19:30:31 volumio volumio[1261]: info: peppyspectrum Daemon Stop
Jul 21 19:30:31 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:31 volumio volumio[1261]: info: Prefetching next song
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:33 volumio volumio[1261]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jul 21 19:30:33 volumio volumio[1261]: info: FusionDsp - ---- read samplerate from file: 44100
Jul 21 19:30:33 volumio volumio[1261]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jul 21 19:30:33 volumio volumio[1261]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jul 21 19:30:33 volumio volumio[1261]: info: FusionDsp - ---- read samplerate from file: 44100
Jul 21 19:30:33 volumio volumio[1261]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand status took 8 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand status took 7 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand status took 7 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand status took 3 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:33 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:33 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:33 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:33 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:33 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:33 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:33 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:33 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:33 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 16ms
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 17ms
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 16ms
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand status took 7 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand status took 6 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:33 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:33 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:33 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 12ms
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:33 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:33 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:33 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:33 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:33 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:33 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 11ms
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 12ms
Jul 21 19:30:33 volumio volumio[1261]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Jul 21 19:30:33 volumio volumio[1261]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:33 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:33 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 5ms
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand status took 2 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 2ms
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand status took 1 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:33 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:33 volumio volumio[1261]: info:
Jul 21 19:30:33 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 2ms
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand status took 1 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:33 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:33 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:33 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:33 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:33 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:33 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 6ms
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 5ms
Jul 21 19:30:33 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 19:30:33 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:33 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:33 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:33 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:33 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:33 volumio volumio[1261]: info: ------------------------------ 3ms
Jul 21 19:30:34 volumio volumio[1261]: info:
Jul 21 19:30:34 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:34 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:34 volumio volumio[1261]: info:
Jul 21 19:30:34 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:34 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:34 volumio volumio[1261]: info:
Jul 21 19:30:34 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:34 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:34 volumio volumio[1261]: info:
Jul 21 19:30:34 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:34 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:34 volumio volumio[1261]: info:
Jul 21 19:30:34 volumio volumio[1261]: ---------------------------- MPD announces system playlist update
Jul 21 19:30:34 volumio volumio[1261]: info: Ignoring MPD Status Update
Jul 21 19:30:34 volumio volumio[1261]: info:
Jul 21 19:30:34 volumio volumio[1261]: ---------------------------- MPD announces state update: player
Jul 21 19:30:34 volumio volumio[1261]: info: ControllerMpd::getState
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:30:34 volumio volumio[1261]: info: ------------------------------ 3ms
Jul 21 19:30:34 volumio volumio[1261]: info: sendMpdCommand status took 2 milliseconds
Jul 21 19:30:34 volumio volumio[1261]: info: ------------------------------ 2ms
Jul 21 19:30:34 volumio volumio[1261]: info: sendMpdCommand status took 2 milliseconds
Jul 21 19:30:34 volumio volumio[1261]: info: ------------------------------ 1ms
Jul 21 19:30:34 volumio volumio[1261]: info: sendMpdCommand status took 1 milliseconds
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::parseState
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:30:34 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 21 19:30:34 volumio volumio[1261]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:34 volumio volumio[1261]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:30:34 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:34 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:34 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:34 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:34 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:34 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:34 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:34 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:34 volumio volumio[1261]: info: ControllerMpd::pushState
Jul 21 19:30:34 volumio volumio[1261]: info: CoreCommandRouter::servicePushState
Jul 21 19:30:34 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:34 volumio volumio[1261]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:30:34 volumio volumio[1261]: info: ------------------------------ 6ms
Jul 21 19:30:34 volumio volumio[1261]: info: ------------------------------ 5ms
Jul 21 19:30:34 volumio volumio[1261]: info: ------------------------------ 4ms
Jul 21 19:30:39 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 21 19:30:39 volumio volumio[1261]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 21 19:30:39 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 21 19:30:39 volumio volumio[1261]: info: Received Get System Version
Jul 21 19:30:39 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 21 19:30:39 volumio volumio[1261]: info: Received Get System Info
Jul 21 19:30:39 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 21 19:30:39 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 21 19:30:39 volumio volumio[1261]: info: Discovery: Getting this device information
Jul 21 19:30:39 volumio volumio[1261]: info: CoreCommandRouter::volumioGetState
Jul 21 19:30:39 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:30:39 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 21 19:30:50 volumio volumio[1261]: info: CoreCommandRouter::volumioPlay
Jul 21 19:30:50 volumio volumio[1261]: info: CoreStateMachine::play index undefined
Jul 21 19:30:50 volumio volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:30:50 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:01 volumio volumio[1261]: info: CoreCommandRouter::volumioSeek
Jul 21 19:31:01 volumio volumio[1261]: info: CoreStateMachine::seek
Jul 21 19:31:01 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:01 volumio volumio[1261]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"eighties","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music123/v4/ed/d0/78/edd078f9-2e7f-c0b9-8eb5-b9a44d4a8c9c/source/600x600bb.jpg","uri":"http://streams.80s80s.de/love/mp3-192/volumio","name":"America - The Last Unicorn","duration":"181","artist":"80s80s Love","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Jul 21 19:31:01 volumio volumio[1261]: info: CoreStateMachine::startPlaybackTimer
Jul 21 19:31:01 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:01 volumio volumio[1261]: info: [1721604661753] [80s80s] seek to 990000
Jul 21 19:31:01 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:01 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:01 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:01 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:01 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:01 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:31:01 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 10
Jul 21 19:31:01 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 10
Jul 21 19:31:01 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: false
Jul 21 19:31:01 volumio sudo[2553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:01 volumio sudo[2553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:01 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:31:01 volumio sudo[2553]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:01 volumio volumio[1261]: info: peppyspectrum Daemon Started
Jul 21 19:31:02 volumio volumio[2555]: No protocol specified
Jul 21 19:31:02 volumio volumio[2555]: No protocol specified
Jul 21 19:31:02 volumio volumio[2555]: pygame 1.9.4.post1
Jul 21 19:31:02 volumio volumio[2555]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:31:02 volumio volumio[2555]: Traceback (most recent call last):
Jul 21 19:31:02 volumio volumio[2555]: File "spectrum.py", line 715, in
Jul 21 19:31:02 volumio volumio[2555]: pm = Spectrum(None, True)
Jul 21 19:31:02 volumio volumio[2555]: File "spectrum.py", line 63, in __init__
Jul 21 19:31:02 volumio volumio[2555]: self.init_display()
Jul 21 19:31:02 volumio volumio[2555]: File "spectrum.py", line 104, in init_display
Jul 21 19:31:02 volumio volumio[2555]: pygame.display.init()
Jul 21 19:31:02 volumio volumio[2555]: pygame.error: Unable to open /dev/fb1
Jul 21 19:31:02 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:31:02 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:07 volumio volumio[1261]: info: CoreCommandRouter::volumioSeek
Jul 21 19:31:07 volumio volumio[1261]: info: CoreStateMachine::seek
Jul 21 19:31:07 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:07 volumio volumio[1261]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"eighties","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music123/v4/ed/d0/78/edd078f9-2e7f-c0b9-8eb5-b9a44d4a8c9c/source/600x600bb.jpg","uri":"http://streams.80s80s.de/love/mp3-192/volumio","name":"America - The Last Unicorn","duration":"181","artist":"80s80s Love","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Jul 21 19:31:07 volumio volumio[1261]: info: CoreStateMachine::startPlaybackTimer
Jul 21 19:31:07 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:07 volumio volumio[1261]: info: [1721604667588] [80s80s] seek to 6000
Jul 21 19:31:07 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:07 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:07 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:07 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:07 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:07 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:31:07 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 10
Jul 21 19:31:07 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 10
Jul 21 19:31:07 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: false
Jul 21 19:31:07 volumio sudo[2574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:07 volumio sudo[2574]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:07 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:31:07 volumio sudo[2574]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:07 volumio volumio[1261]: info: peppyspectrum Daemon Started
Jul 21 19:31:07 volumio volumio[2576]: No protocol specified
Jul 21 19:31:07 volumio volumio[2576]: No protocol specified
Jul 21 19:31:07 volumio volumio[2576]: pygame 1.9.4.post1
Jul 21 19:31:07 volumio volumio[2576]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:31:07 volumio volumio[2576]: Traceback (most recent call last):
Jul 21 19:31:07 volumio volumio[2576]: File "spectrum.py", line 715, in
Jul 21 19:31:07 volumio volumio[2576]: pm = Spectrum(None, True)
Jul 21 19:31:07 volumio volumio[2576]: File "spectrum.py", line 63, in __init__
Jul 21 19:31:07 volumio volumio[2576]: self.init_display()
Jul 21 19:31:07 volumio volumio[2576]: File "spectrum.py", line 104, in init_display
Jul 21 19:31:07 volumio volumio[2576]: pygame.display.init()
Jul 21 19:31:07 volumio volumio[2576]: pygame.error: Unable to open /dev/fb1
Jul 21 19:31:07 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:31:07 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:09 volumio volumio[1261]: info: CoreCommandRouter::volumioSeek
Jul 21 19:31:09 volumio volumio[1261]: info: CoreStateMachine::seek
Jul 21 19:31:09 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:09 volumio volumio[1261]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"eighties","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music123/v4/ed/d0/78/edd078f9-2e7f-c0b9-8eb5-b9a44d4a8c9c/source/600x600bb.jpg","uri":"http://streams.80s80s.de/love/mp3-192/volumio","name":"America - The Last Unicorn","duration":"181","artist":"80s80s Love","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Jul 21 19:31:09 volumio volumio[1261]: info: CoreStateMachine::startPlaybackTimer
Jul 21 19:31:09 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:09 volumio volumio[1261]: info: [1721604669034] [80s80s] seek to 10000
Jul 21 19:31:09 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:09 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:09 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:09 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:09 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:09 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:31:09 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 10
Jul 21 19:31:09 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 10
Jul 21 19:31:09 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: false
Jul 21 19:31:09 volumio sudo[2581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:09 volumio sudo[2581]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:09 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:31:09 volumio sudo[2581]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:09 volumio volumio[1261]: info: peppyspectrum Daemon Started
Jul 21 19:31:09 volumio volumio[2583]: No protocol specified
Jul 21 19:31:09 volumio volumio[2583]: No protocol specified
Jul 21 19:31:09 volumio volumio[2583]: pygame 1.9.4.post1
Jul 21 19:31:09 volumio volumio[2583]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:31:09 volumio volumio[2583]: Traceback (most recent call last):
Jul 21 19:31:09 volumio volumio[2583]: File "spectrum.py", line 715, in
Jul 21 19:31:09 volumio volumio[2583]: pm = Spectrum(None, True)
Jul 21 19:31:09 volumio volumio[2583]: File "spectrum.py", line 63, in __init__
Jul 21 19:31:09 volumio volumio[2583]: self.init_display()
Jul 21 19:31:09 volumio volumio[2583]: File "spectrum.py", line 104, in init_display
Jul 21 19:31:09 volumio volumio[2583]: pygame.display.init()
Jul 21 19:31:09 volumio volumio[2583]: pygame.error: Unable to open /dev/fb1
Jul 21 19:31:09 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:31:09 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:13 volumio volumio[1261]: info: VolumeController::SetAlsaVolume42
Jul 21 19:31:13 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:13 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:13 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:13 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:13 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:13 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 42
Jul 21 19:31:13 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 10
Jul 21 19:31:13 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 42
Jul 21 19:31:13 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:13 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 42
Jul 21 19:31:13 volumio sudo[2636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:13 volumio sudo[2636]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:13 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:31:13 volumio sudo[2636]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:13 volumio volumio[1261]: info: peppyspectrum Daemon Started
Jul 21 19:31:13 volumio volumio[2638]: No protocol specified
Jul 21 19:31:13 volumio volumio[2638]: No protocol specified
Jul 21 19:31:13 volumio volumio[2638]: pygame 1.9.4.post1
Jul 21 19:31:13 volumio volumio[2638]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:31:13 volumio volumio[2638]: Traceback (most recent call last):
Jul 21 19:31:13 volumio volumio[2638]: File "spectrum.py", line 715, in
Jul 21 19:31:13 volumio volumio[2638]: pm = Spectrum(None, True)
Jul 21 19:31:13 volumio volumio[2638]: File "spectrum.py", line 63, in __init__
Jul 21 19:31:13 volumio volumio[2638]: self.init_display()
Jul 21 19:31:13 volumio volumio[2638]: File "spectrum.py", line 104, in init_display
Jul 21 19:31:13 volumio volumio[2638]: pygame.display.init()
Jul 21 19:31:13 volumio volumio[2638]: pygame.error: Unable to open /dev/fb1
Jul 21 19:31:13 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:31:13 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:13 volumio volumio[1261]: info: VolumeController::SetAlsaVolume55
Jul 21 19:31:13 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:13 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:13 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:13 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:13 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:13 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 55
Jul 21 19:31:13 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 42
Jul 21 19:31:13 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 55
Jul 21 19:31:13 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:13 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 55
Jul 21 19:31:13 volumio sudo[2644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:13 volumio sudo[2644]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:13 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:31:13 volumio sudo[2644]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:13 volumio volumio[1261]: info: peppyspectrum Daemon Started
Jul 21 19:31:13 volumio volumio[2646]: No protocol specified
Jul 21 19:31:13 volumio volumio[2646]: No protocol specified
Jul 21 19:31:13 volumio volumio[2646]: pygame 1.9.4.post1
Jul 21 19:31:13 volumio volumio[2646]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:31:13 volumio volumio[2646]: Traceback (most recent call last):
Jul 21 19:31:13 volumio volumio[2646]: File "spectrum.py", line 715, in
Jul 21 19:31:13 volumio volumio[2646]: pm = Spectrum(None, True)
Jul 21 19:31:13 volumio volumio[2646]: File "spectrum.py", line 63, in __init__
Jul 21 19:31:13 volumio volumio[2646]: self.init_display()
Jul 21 19:31:13 volumio volumio[2646]: File "spectrum.py", line 104, in init_display
Jul 21 19:31:13 volumio volumio[2646]: pygame.display.init()
Jul 21 19:31:13 volumio volumio[2646]: pygame.error: Unable to open /dev/fb1
Jul 21 19:31:14 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:31:14 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:14 volumio volumio[1261]: info: VolumeController::SetAlsaVolume68
Jul 21 19:31:14 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:14 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:14 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:14 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:14 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 55
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 68
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:14 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 68
Jul 21 19:31:14 volumio sudo[2650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:14 volumio sudo[2650]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:14 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:31:14 volumio sudo[2650]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:14 volumio volumio[1261]: info: peppyspectrum Daemon Started
Jul 21 19:31:14 volumio volumio[2652]: No protocol specified
Jul 21 19:31:14 volumio volumio[2652]: No protocol specified
Jul 21 19:31:14 volumio volumio[2652]: pygame 1.9.4.post1
Jul 21 19:31:14 volumio volumio[2652]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:31:14 volumio volumio[2652]: Traceback (most recent call last):
Jul 21 19:31:14 volumio volumio[2652]: File "spectrum.py", line 715, in
Jul 21 19:31:14 volumio volumio[2652]: pm = Spectrum(None, True)
Jul 21 19:31:14 volumio volumio[2652]: File "spectrum.py", line 63, in __init__
Jul 21 19:31:14 volumio volumio[2652]: self.init_display()
Jul 21 19:31:14 volumio volumio[2652]: File "spectrum.py", line 104, in init_display
Jul 21 19:31:14 volumio volumio[2652]: pygame.display.init()
Jul 21 19:31:14 volumio volumio[2652]: pygame.error: Unable to open /dev/fb1
Jul 21 19:31:14 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:31:14 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:14 volumio volumio[1261]: info: VolumeController::SetAlsaVolume77
Jul 21 19:31:14 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:14 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:14 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:14 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:14 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 77
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 68
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 77
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:14 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 77
Jul 21 19:31:14 volumio sudo[2658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:14 volumio sudo[2658]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:14 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:31:14 volumio sudo[2658]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:14 volumio volumio[1261]: info: peppyspectrum Daemon Started
Jul 21 19:31:14 volumio volumio[2660]: No protocol specified
Jul 21 19:31:14 volumio volumio[2660]: No protocol specified
Jul 21 19:31:14 volumio volumio[2660]: pygame 1.9.4.post1
Jul 21 19:31:14 volumio volumio[2660]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:31:14 volumio volumio[2660]: Traceback (most recent call last):
Jul 21 19:31:14 volumio volumio[2660]: File "spectrum.py", line 715, in
Jul 21 19:31:14 volumio volumio[2660]: pm = Spectrum(None, True)
Jul 21 19:31:14 volumio volumio[2660]: File "spectrum.py", line 63, in __init__
Jul 21 19:31:14 volumio volumio[2660]: self.init_display()
Jul 21 19:31:14 volumio volumio[2660]: File "spectrum.py", line 104, in init_display
Jul 21 19:31:14 volumio volumio[2660]: pygame.display.init()
Jul 21 19:31:14 volumio volumio[2660]: pygame.error: Unable to open /dev/fb1
Jul 21 19:31:14 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:31:14 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:14 volumio volumio[1261]: info: VolumeController::SetAlsaVolume85
Jul 21 19:31:14 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:14 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:14 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:14 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:14 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 77
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 85
Jul 21 19:31:14 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:14 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 85
Jul 21 19:31:14 volumio sudo[2664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:14 volumio sudo[2664]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:15 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:31:15 volumio sudo[2664]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:15 volumio volumio[1261]: info: peppyspectrum Daemon Started
Jul 21 19:31:15 volumio volumio[2666]: No protocol specified
Jul 21 19:31:15 volumio volumio[2666]: No protocol specified
Jul 21 19:31:15 volumio volumio[2666]: pygame 1.9.4.post1
Jul 21 19:31:15 volumio volumio[2666]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:31:15 volumio volumio[2666]: Traceback (most recent call last):
Jul 21 19:31:15 volumio volumio[2666]: File "spectrum.py", line 715, in
Jul 21 19:31:15 volumio volumio[2666]: pm = Spectrum(None, True)
Jul 21 19:31:15 volumio volumio[2666]: File "spectrum.py", line 63, in __init__
Jul 21 19:31:15 volumio volumio[2666]: self.init_display()
Jul 21 19:31:15 volumio volumio[2666]: File "spectrum.py", line 104, in init_display
Jul 21 19:31:15 volumio volumio[2666]: pygame.display.init()
Jul 21 19:31:15 volumio volumio[2666]: pygame.error: Unable to open /dev/fb1
Jul 21 19:31:15 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:31:15 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:15 volumio volumio[1261]: info: VolumeController::SetAlsaVolume90
Jul 21 19:31:15 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:15 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:15 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:15 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:15 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 85
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 90
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:15 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 90
Jul 21 19:31:15 volumio sudo[2670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:15 volumio sudo[2670]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:15 volumio systemd[1]: peppyspectrum.service: Start request repeated too quickly.
Jul 21 19:31:15 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:15 volumio systemd[1]: Failed to start peppyspectrum Daemon.
Jul 21 19:31:15 volumio sudo[2670]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:15 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum failed to start. Check your configuration Error: Command failed: /usr/bin/sudo /bin/systemctl start peppyspectrum.service
Jul 21 19:31:15 volumio volumio[1261]: Job for peppyspectrum.service failed because the control process exited with error code.
Jul 21 19:31:15 volumio volumio[1261]: See "systemctl status peppyspectrum.service" and "journalctl -xe" for details.
Jul 21 19:31:15 volumio volumio[1261]: info: VolumeController::SetAlsaVolume95
Jul 21 19:31:15 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:15 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:15 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:15 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:15 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 90
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 95
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:15 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 95
Jul 21 19:31:15 volumio sudo[2676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:15 volumio sudo[2676]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:15 volumio systemd[1]: peppyspectrum.service: Start request repeated too quickly.
Jul 21 19:31:15 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:15 volumio systemd[1]: Failed to start peppyspectrum Daemon.
Jul 21 19:31:15 volumio sudo[2676]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:15 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum failed to start. Check your configuration Error: Command failed: /usr/bin/sudo /bin/systemctl start peppyspectrum.service
Jul 21 19:31:15 volumio volumio[1261]: Job for peppyspectrum.service failed because the control process exited with error code.
Jul 21 19:31:15 volumio volumio[1261]: See "systemctl status peppyspectrum.service" and "journalctl -xe" for details.
Jul 21 19:31:15 volumio volumio[1261]: info: VolumeController::SetAlsaVolume97
Jul 21 19:31:15 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:15 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:15 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:15 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:15 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 97
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 95
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 97
Jul 21 19:31:15 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:15 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 97
Jul 21 19:31:15 volumio sudo[2680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:15 volumio sudo[2680]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:15 volumio systemd[1]: peppyspectrum.service: Start request repeated too quickly.
Jul 21 19:31:15 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:15 volumio systemd[1]: Failed to start peppyspectrum Daemon.
Jul 21 19:31:15 volumio sudo[2680]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:15 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum failed to start. Check your configuration Error: Command failed: /usr/bin/sudo /bin/systemctl start peppyspectrum.service
Jul 21 19:31:15 volumio volumio[1261]: Job for peppyspectrum.service failed because the control process exited with error code.
Jul 21 19:31:15 volumio volumio[1261]: See "systemctl status peppyspectrum.service" and "journalctl -xe" for details.
Jul 21 19:31:16 volumio volumio[1261]: info: VolumeController::SetAlsaVolume100
Jul 21 19:31:16 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:16 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:16 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:16 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:16 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:16 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Jul 21 19:31:16 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 97
Jul 21 19:31:16 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 100
Jul 21 19:31:16 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:16 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 100
Jul 21 19:31:16 volumio sudo[2684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:16 volumio sudo[2684]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:16 volumio systemd[1]: peppyspectrum.service: Start request repeated too quickly.
Jul 21 19:31:16 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:16 volumio systemd[1]: Failed to start peppyspectrum Daemon.
Jul 21 19:31:16 volumio sudo[2684]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:16 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum failed to start. Check your configuration Error: Command failed: /usr/bin/sudo /bin/systemctl start peppyspectrum.service
Jul 21 19:31:16 volumio volumio[1261]: Job for peppyspectrum.service failed because the control process exited with error code.
Jul 21 19:31:16 volumio volumio[1261]: See "systemctl status peppyspectrum.service" and "journalctl -xe" for details.
Jul 21 19:31:17 volumio volumio[1261]: SPOTIFY: SETTING SPOTIFY VOLUME 100
Jul 21 19:31:17 volumio volumio[1261]: info: Sending Spotify command with payload to local API: /player/volume
Jul 21 19:31:24 volumio volumio[1261]: info: VolumeController::SetAlsaVolume48
Jul 21 19:31:24 volumio volumio[1261]: info: CoreStateMachine::pushState
Jul 21 19:31:24 volumio volumio[1261]: info: CorePlayQueue::getTrack 0
Jul 21 19:31:24 volumio volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:31:24 volumio volumio[1261]: info: CoreCommandRouter::volumioPushState
Jul 21 19:31:24 volumio volumio[1261]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:31:24 volumio volumio[1261]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48
Jul 21 19:31:24 volumio volumio[1261]: SPOTIFY: SPOTIFY VOLUME 100
Jul 21 19:31:24 volumio volumio[1261]: SPOTIFY: VOLUMIO VOLUME 48
Jul 21 19:31:24 volumio volumio[1261]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:31:24 volumio volumio[1261]: info: Setting Spotify Volume from Volumio: 48
Jul 21 19:31:24 volumio sudo[2707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:31:24 volumio sudo[2707]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:31:24 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:31:24 volumio sudo[2707]: pam_unix(sudo:session): session closed for user root
Jul 21 19:31:24 volumio volumio[1261]: info: peppyspectrum Daemon Started
Jul 21 19:31:24 volumio volumio[2709]: No protocol specified
Jul 21 19:31:24 volumio volumio[2709]: No protocol specified
Jul 21 19:31:24 volumio volumio[2709]: pygame 1.9.4.post1
Jul 21 19:31:24 volumio volumio[2709]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:31:24 volumio volumio[2709]: Traceback (most recent call last):
Jul 21 19:31:24 volumio volumio[2709]: File "spectrum.py", line 715, in
Jul 21 19:31:24 volumio volumio[2709]: pm = Spectrum(None, True)
Jul 21 19:31:24 volumio volumio[2709]: File "spectrum.py", line 63, in __init__
Jul 21 19:31:24 volumio volumio[2709]: self.init_display()
Jul 21 19:31:24 volumio volumio[2709]: File "spectrum.py", line 104, in init_display
Jul 21 19:31:24 volumio volumio[2709]: pygame.display.init()
Jul 21 19:31:24 volumio volumio[2709]: pygame.error: Unable to open /dev/fb1
Jul 21 19:31:24 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:31:24 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:31:25 volumio volumio[1261]: SPOTIFY: SETTING SPOTIFY VOLUME 48
Jul 21 19:31:25 volumio volumio[1261]: info: Sending Spotify command with payload to local API: /player/volume
Jul 21 19:31:30 volumio volumio[1261]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________
Jul 21 19:31:30 volumio volumio[1261]: info: PLUGIN onReboot : networkfs
Jul 21 19:31:30 volumio volumio[1261]: info: PLUGIN onReboot : audiophonicsonoff
Jul 21 19:31:30 volumio volumio[1261]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 21 19:31:30 volumio volumio[1261]: TypeError: Cannot read property 'writeSync' of undefined
Jul 21 19:31:30 volumio volumio[1261]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25)
Jul 21 19:31:30 volumio volumio[1261]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30)
Jul 21 19:31:30 volumio volumio[1261]: at HashMap. (/volumio/app/pluginmanager.js:668:31)
Jul 21 19:31:30 volumio volumio[1261]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Jul 21 19:31:30 volumio volumio[1261]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Jul 21 19:31:30 volumio volumio[1261]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20)
Jul 21 19:31:30 volumio volumio[1261]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22)
Jul 21 19:31:30 volumio volumio[1261]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:857:33)
Jul 21 19:31:30 volumio volumio[1261]: at Socket.emit (events.js:315:20)
Jul 21 19:31:30 volumio volumio[1261]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jul 21 19:31:30 volumio volumio[1261]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jul 21 19:31:30 volumio volumio[1261]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 21 19:31:30 volumio sudo[2732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 19:30
Jul 21 19:31:30 volumio sudo[2732]: 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"