-- Logs begin at Sun 2024-07-21 19:34:55 EDT, end at Sun 2024-07-21 19:37:58 EDT. --
Jul 21 19:36:00 volumio wpa_supplicant[1195]: RRM: Ignoring radio measurement request: Not RRM network
Jul 21 19:36:04 volumio volumio[1296]: info: Preload queue cleared
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::ClearQueue
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::stop
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::clearPlayQueue
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::saveQueue
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::volumioPushQueue
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::addQueueItems
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::addQueueItems
Jul 21 19:36:04 volumio volumio[1296]: info: Preload queue cleared
Jul 21 19:36:04 volumio volumio[1296]: info: Adding Item to queue: webeighties/5
Jul 21 19:36:04 volumio volumio[1296]: info: Exploding uri webeighties/5 in service 80s80s
Jul 21 19:36:04 volumio volumio[1296]: info: [1721604964489] [80s80s] explodeUri: webeighties/5
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::volumioPushQueue
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::saveQueue
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::updateTrackBlock
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrackBlock
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::volumioPlay
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::play index 0
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::stop
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::play index undefined
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::startPlaybackTimer
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: info: [1721604964495] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio
Jul 21 19:36:04 volumio volumio[1296]: info: [1721604964495] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2
Jul 21 19:36:04 volumio ntpd[1107]: Soliciting pool server 155.138.155.0
Jul 21 19:36:04 volumio ntpd[1107]: Soliciting pool server 208.81.1.244
Jul 21 19:36:04 volumio ntpd[1107]: Soliciting pool server 192.99.168.180
Jul 21 19:36:04 volumio volumio[1296]: info: [1721604964848] [80s80s] received new event containing 2 songs.
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand stop
Jul 21 19:36:04 volumio volumio[1296]: info: sendMpdCommand stop took 1 milliseconds
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand clear
Jul 21 19:36:04 volumio volumio[1296]: info:
Jul 21 19:36:04 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:04 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:04 volumio volumio[1296]: info: sendMpdCommand clear took 1 milliseconds
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand consume 1
Jul 21 19:36:04 volumio volumio[1296]: info:
Jul 21 19:36:04 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:04 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:04 volumio volumio[1296]: info:
Jul 21 19:36:04 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:04 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:04 volumio volumio[1296]: error: updateQueue error: null
Jul 21 19:36:04 volumio volumio[1296]: info:
Jul 21 19:36:04 volumio volumio[1296]: ---------------------------- MPD announces state update: options
Jul 21 19:36:04 volumio volumio[1296]: error: updateQueue error: null
Jul 21 19:36:04 volumio volumio[1296]: error: updateQueue error: null
Jul 21 19:36:04 volumio volumio[1296]: info: ------------------------------ 3ms
Jul 21 19:36:04 volumio volumio[1296]: info: sendMpdCommand consume 1 took 2 milliseconds
Jul 21 19:36:04 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:04 volumio volumio[1296]: info: ------------------------------ 2ms
Jul 21 19:36:04 volumio volumio[1296]: info: ------------------------------ 2ms
Jul 21 19:36:04 volumio volumio[1296]: info: [1721604964853] [80s80s] adding url: http://streams.80s80s.de/italohits/mp3-192/volumio
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/italohits/mp3-192/volumio"
Jul 21 19:36:04 volumio volumio[1296]: info:
Jul 21 19:36:04 volumio volumio[1296]: ---------------------------- MPD announces state update: options
Jul 21 19:36:04 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:04 volumio volumio[1296]: info:
Jul 21 19:36:04 volumio volumio[1296]: ---------------------------- MPD announces state update: options
Jul 21 19:36:04 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:04 volumio volumio[1296]: info:
Jul 21 19:36:04 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:04 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:04 volumio volumio[1296]: info: sendMpdCommand status took 3 milliseconds
Jul 21 19:36:04 volumio volumio[1296]: info: sendMpdCommand add "http://streams.80s80s.de/italohits/mp3-192/volumio" took 2 milliseconds
Jul 21 19:36:04 volumio volumio[1296]: info: sendMpdCommand status took 2 milliseconds
Jul 21 19:36:04 volumio volumio[1296]: info: sendMpdCommand status took 1 milliseconds
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand play
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:04 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:04 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:04 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:04 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:04 volumio volumio[1296]: info: ------------------------------ 35ms
Jul 21 19:36:04 volumio volumio[1296]: info: ------------------------------ 35ms
Jul 21 19:36:04 volumio volumio[1296]: info: ------------------------------ 36ms
Jul 21 19:36:04 volumio volumio[1296]: info:
Jul 21 19:36:04 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:04 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:04 volumio volumio[1296]: info:
Jul 21 19:36:04 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:04 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:04 volumio volumio[1296]: info: ------------------------------ 38ms
Jul 21 19:36:04 volumio volumio[1296]: info: sendMpdCommand play took 22 milliseconds
Jul 21 19:36:04 volumio volumio[1296]: info: ------------------------------ 3ms
Jul 21 19:36:04 volumio volumio[1296]: info: ------------------------------ 3ms
Jul 21 19:36:04 volumio volumio[1296]: info: [1721604964894] [80s80s] Pushing the next song state: Gazebo - Telephone Mama
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:04 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:04 volumio volumio[1296]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music124/v4/ce/ce/d2/ceced2e4-9c4e-4f97-015c-3b1c085f21ec/source/600x600bb.jpg","name":"Gazebo - Telephone Mama","title":"Telephone Mama","artist":"80s80s Italo Disco","album":"","streaming":true,"disableUiControls":true,"duration":"310","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Jul 21 19:36:04 volumio volumio[1296]: verbose: CURRENT POSITION 0
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::syncState stateService play
Jul 21 19:36:04 volumio volumio[1296]: info: CoreStateMachine::syncState currentStatus stop
Jul 21 19:36:04 volumio volumio[1296]: info: [1721604964897] [80s80s] PlayNextTrack API delay: 30
Jul 21 19:36:04 volumio volumio[1296]: info: [1721604964902] [80s80s] Setting timer to: 310000 milliseconds.
Jul 21 19:36:04 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status stop
Jul 21 19:36:04 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status stop
Jul 21 19:36:04 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status stop
Jul 21 19:36:04 volumio sudo[2461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 21 19:36:04 volumio sudo[2461]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:04 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:36:04 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:36:04 volumio sudo[2461]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:04 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:36:04 volumio volumio[1296]: info: peppyspectrum Daemon Stop
Jul 21 19:36:04 volumio sudo[2459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 21 19:36:04 volumio sudo[2459]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:04 volumio sudo[2459]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:04 volumio sudo[2465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Jul 21 19:36:04 volumio sudo[2465]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:04 volumio volumio[1296]: info: peppyspectrum Daemon Stop
Jul 21 19:36:04 volumio sudo[2465]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:04 volumio volumio[1296]: info: peppyspectrum Daemon Stop
Jul 21 19:36:05 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:05 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:05 volumio volumio[1296]: info: Prefetching next song
Jul 21 19:36:05 volumio ntpd[1107]: Soliciting pool server 162.159.200.1
Jul 21 19:36:05 volumio ntpd[1107]: Soliciting pool server 174.142.148.226
Jul 21 19:36:05 volumio ntpd[1107]: Soliciting pool server 216.58.108.188
Jul 21 19:36:06 volumio ntpd[1107]: Soliciting pool server 23.130.139.90
Jul 21 19:36:06 volumio ntpd[1107]: Soliciting pool server 142.4.192.253
Jul 21 19:36:06 volumio ntpd[1107]: Soliciting pool server 162.159.200.123
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jul 21 19:36:07 volumio volumio[1296]: info: FusionDsp - ---- read samplerate from file: 44100
Jul 21 19:36:07 volumio volumio[1296]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jul 21 19:36:07 volumio volumio[1296]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jul 21 19:36:07 volumio volumio[1296]: info: FusionDsp - ---- read samplerate from file: 44100
Jul 21 19:36:07 volumio volumio[1296]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 8 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 8 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 8 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 3 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 2 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 1 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 17ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 17ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 17ms
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 14ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 11ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 11ms
Jul 21 19:36:07 volumio volumio[1296]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Jul 21 19:36:07 volumio volumio[1296]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:07 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:07 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:07 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:07 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:07 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:07 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 8ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 7ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 7ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 5ms
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 4 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 4ms
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 2 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 2ms
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 1 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 8ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 7ms
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 5ms
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:07 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:07 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces system playlist update
Jul 21 19:36:07 volumio volumio[1296]: info: Ignoring MPD Status Update
Jul 21 19:36:07 volumio volumio[1296]: info:
Jul 21 19:36:07 volumio volumio[1296]: ---------------------------- MPD announces state update: player
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::getState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 3ms
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 3 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 3ms
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 2 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 2ms
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand status took 1 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseState
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: verbose: ControllerMpd::parseTrackInfo
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ControllerMpd::pushState
Jul 21 19:36:07 volumio volumio[1296]: info: CoreCommandRouter::servicePushState
Jul 21 19:36:07 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:07 volumio volumio[1296]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 7ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 6ms
Jul 21 19:36:07 volumio volumio[1296]: info: ------------------------------ 5ms
Jul 21 19:36:07 volumio ntpd[1107]: Soliciting pool server 51.222.111.13
Jul 21 19:36:07 volumio ntpd[1107]: Soliciting pool server 173.183.146.26
Jul 21 19:36:07 volumio ntpd[1107]: Soliciting pool server 167.114.93.151
Jul 21 19:36:08 volumio ntpd[1107]: Soliciting pool server 2606:4700:f1::1
Jul 21 19:36:08 volumio ntpd[1107]: Soliciting pool server 206.108.0.132
Jul 21 19:36:09 volumio ntpd[1107]: Soliciting pool server 216.232.132.95
Jul 21 19:36:10 volumio ntpd[1107]: Soliciting pool server 216.6.2.70
Jul 21 19:36:11 volumio ntpd[1107]: Soliciting pool server 66.49.222.68
Jul 21 19:36:12 volumio ntpd[1107]: receive: Unexpected origin timestamp 0xea4819eb.bd470a2d does not match aorg 0000000000.00000000 from server@208.81.1.244 xmt 0xea4819ec.40006e89
Jul 21 19:36:31 volumio volumio[1296]: info: CoreCommandRouter::volumioPlay
Jul 21 19:36:31 volumio volumio[1296]: info: CoreStateMachine::play index undefined
Jul 21 19:36:31 volumio volumio[1296]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 19:36:31 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:41 volumio volumio[1296]: info: CoreCommandRouter::volumioSeek
Jul 21 19:36:41 volumio volumio[1296]: info: CoreStateMachine::seek
Jul 21 19:36:41 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:41 volumio volumio[1296]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"eighties","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music124/v4/ce/ce/d2/ceced2e4-9c4e-4f97-015c-3b1c085f21ec/source/600x600bb.jpg","uri":"http://streams.80s80s.de/italohits/mp3-192/volumio","name":"Gazebo - Telephone Mama","duration":"310","artist":"80s80s Italo Disco","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Jul 21 19:36:41 volumio volumio[1296]: info: CoreStateMachine::startPlaybackTimer
Jul 21 19:36:41 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:41 volumio volumio[1296]: info: [1721605001428] [80s80s] seek to 16000
Jul 21 19:36:41 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:41 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:41 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:36:41 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:41 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:36:41 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10
Jul 21 19:36:41 volumio sudo[2561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:36:41 volumio sudo[2561]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:41 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:36:41 volumio sudo[2561]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:41 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:36:41 volumio volumio[2563]: No protocol specified
Jul 21 19:36:41 volumio volumio[2563]: No protocol specified
Jul 21 19:36:41 volumio volumio[2563]: pygame 1.9.4.post1
Jul 21 19:36:41 volumio volumio[2563]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:36:41 volumio volumio[2563]: Traceback (most recent call last):
Jul 21 19:36:41 volumio volumio[2563]: File "spectrum.py", line 715, in
Jul 21 19:36:41 volumio volumio[2563]: pm = Spectrum(None, True)
Jul 21 19:36:41 volumio volumio[2563]: File "spectrum.py", line 63, in __init__
Jul 21 19:36:41 volumio volumio[2563]: self.init_display()
Jul 21 19:36:41 volumio volumio[2563]: File "spectrum.py", line 104, in init_display
Jul 21 19:36:41 volumio volumio[2563]: pygame.display.init()
Jul 21 19:36:41 volumio volumio[2563]: pygame.error: Unable to open /dev/fb1
Jul 21 19:36:41 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:36:41 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:36:49 volumio volumio[1296]: info: VolumeController::SetAlsaVolume79
Jul 21 19:36:49 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:49 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:49 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:36:49 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:49 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:36:49 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79
Jul 21 19:36:49 volumio volumio[1296]: SPOTIFY: SPOTIFY VOLUME 10
Jul 21 19:36:49 volumio volumio[1296]: SPOTIFY: VOLUMIO VOLUME 79
Jul 21 19:36:49 volumio volumio[1296]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:36:49 volumio volumio[1296]: info: Setting Spotify Volume from Volumio: 79
Jul 21 19:36:49 volumio sudo[2582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:36:49 volumio sudo[2582]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:49 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:36:49 volumio sudo[2582]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:49 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:36:49 volumio volumio[2584]: No protocol specified
Jul 21 19:36:49 volumio volumio[2584]: No protocol specified
Jul 21 19:36:49 volumio volumio[2584]: pygame 1.9.4.post1
Jul 21 19:36:49 volumio volumio[2584]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:36:49 volumio volumio[2584]: Traceback (most recent call last):
Jul 21 19:36:49 volumio volumio[2584]: File "spectrum.py", line 715, in
Jul 21 19:36:49 volumio volumio[2584]: pm = Spectrum(None, True)
Jul 21 19:36:49 volumio volumio[2584]: File "spectrum.py", line 63, in __init__
Jul 21 19:36:49 volumio volumio[2584]: self.init_display()
Jul 21 19:36:49 volumio volumio[2584]: File "spectrum.py", line 104, in init_display
Jul 21 19:36:49 volumio volumio[2584]: pygame.display.init()
Jul 21 19:36:49 volumio volumio[2584]: pygame.error: Unable to open /dev/fb1
Jul 21 19:36:49 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:36:49 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:36:49 volumio volumio[1296]: info: VolumeController::SetAlsaVolume87
Jul 21 19:36:49 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:49 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:49 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:36:49 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:49 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:36:49 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 87
Jul 21 19:36:49 volumio volumio[1296]: SPOTIFY: SPOTIFY VOLUME 79
Jul 21 19:36:49 volumio volumio[1296]: SPOTIFY: VOLUMIO VOLUME 87
Jul 21 19:36:49 volumio volumio[1296]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:36:49 volumio volumio[1296]: info: Setting Spotify Volume from Volumio: 87
Jul 21 19:36:49 volumio sudo[2590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:36:49 volumio sudo[2590]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:49 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:36:49 volumio sudo[2590]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:49 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:36:49 volumio volumio[2592]: No protocol specified
Jul 21 19:36:49 volumio volumio[2592]: No protocol specified
Jul 21 19:36:49 volumio volumio[2592]: pygame 1.9.4.post1
Jul 21 19:36:49 volumio volumio[2592]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:36:49 volumio volumio[2592]: Traceback (most recent call last):
Jul 21 19:36:49 volumio volumio[2592]: File "spectrum.py", line 715, in
Jul 21 19:36:49 volumio volumio[2592]: pm = Spectrum(None, True)
Jul 21 19:36:49 volumio volumio[2592]: File "spectrum.py", line 63, in __init__
Jul 21 19:36:49 volumio volumio[2592]: self.init_display()
Jul 21 19:36:49 volumio volumio[2592]: File "spectrum.py", line 104, in init_display
Jul 21 19:36:49 volumio volumio[2592]: pygame.display.init()
Jul 21 19:36:49 volumio volumio[2592]: pygame.error: Unable to open /dev/fb1
Jul 21 19:36:49 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:36:49 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:36:50 volumio volumio[1296]: info: VolumeController::SetAlsaVolume92
Jul 21 19:36:50 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:50 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:50 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:36:50 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:50 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:36:50 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 92
Jul 21 19:36:50 volumio volumio[1296]: SPOTIFY: SPOTIFY VOLUME 87
Jul 21 19:36:50 volumio volumio[1296]: SPOTIFY: VOLUMIO VOLUME 92
Jul 21 19:36:50 volumio volumio[1296]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:36:50 volumio volumio[1296]: info: Setting Spotify Volume from Volumio: 92
Jul 21 19:36:50 volumio sudo[2601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:36:50 volumio sudo[2601]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:50 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:36:50 volumio sudo[2601]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:50 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:36:50 volumio volumio[2603]: No protocol specified
Jul 21 19:36:50 volumio volumio[2603]: No protocol specified
Jul 21 19:36:50 volumio volumio[2603]: pygame 1.9.4.post1
Jul 21 19:36:50 volumio volumio[2603]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:36:50 volumio volumio[2603]: Traceback (most recent call last):
Jul 21 19:36:50 volumio volumio[2603]: File "spectrum.py", line 715, in
Jul 21 19:36:50 volumio volumio[2603]: pm = Spectrum(None, True)
Jul 21 19:36:50 volumio volumio[2603]: File "spectrum.py", line 63, in __init__
Jul 21 19:36:50 volumio volumio[2603]: self.init_display()
Jul 21 19:36:50 volumio volumio[2603]: File "spectrum.py", line 104, in init_display
Jul 21 19:36:50 volumio volumio[2603]: pygame.display.init()
Jul 21 19:36:50 volumio volumio[2603]: pygame.error: Unable to open /dev/fb1
Jul 21 19:36:50 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:36:50 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:36:52 volumio volumio[1296]: SPOTIFY: SETTING SPOTIFY VOLUME 92
Jul 21 19:36:52 volumio volumio[1296]: info: Sending Spotify command with payload to local API: /player/volume
Jul 21 19:36:52 volumio volumio[1296]: info: VolumeController::SetAlsaVolume95
Jul 21 19:36:52 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:52 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:52 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:36:52 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:52 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:36:52 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95
Jul 21 19:36:52 volumio volumio[1296]: SPOTIFY: SPOTIFY VOLUME 92
Jul 21 19:36:52 volumio volumio[1296]: SPOTIFY: VOLUMIO VOLUME 95
Jul 21 19:36:52 volumio volumio[1296]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:36:52 volumio volumio[1296]: info: Setting Spotify Volume from Volumio: 95
Jul 21 19:36:52 volumio sudo[2609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:36:52 volumio sudo[2609]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:52 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:36:52 volumio sudo[2609]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:52 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:36:52 volumio volumio[2611]: No protocol specified
Jul 21 19:36:52 volumio volumio[2611]: No protocol specified
Jul 21 19:36:52 volumio volumio[2611]: pygame 1.9.4.post1
Jul 21 19:36:52 volumio volumio[2611]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:36:52 volumio volumio[2611]: Traceback (most recent call last):
Jul 21 19:36:52 volumio volumio[2611]: File "spectrum.py", line 715, in
Jul 21 19:36:52 volumio volumio[2611]: pm = Spectrum(None, True)
Jul 21 19:36:52 volumio volumio[2611]: File "spectrum.py", line 63, in __init__
Jul 21 19:36:52 volumio volumio[2611]: self.init_display()
Jul 21 19:36:52 volumio volumio[2611]: File "spectrum.py", line 104, in init_display
Jul 21 19:36:52 volumio volumio[2611]: pygame.display.init()
Jul 21 19:36:52 volumio volumio[2611]: pygame.error: Unable to open /dev/fb1
Jul 21 19:36:52 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:36:52 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:36:53 volumio volumio[1296]: SPOTIFY: SETTING SPOTIFY VOLUME 95
Jul 21 19:36:53 volumio volumio[1296]: info: Sending Spotify command with payload to local API: /player/volume
Jul 21 19:36:54 volumio volumio[1296]: info: VolumeController::SetAlsaVolume50
Jul 21 19:36:54 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:54 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:54 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:36:54 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:54 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:36:54 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Jul 21 19:36:54 volumio volumio[1296]: SPOTIFY: SPOTIFY VOLUME 95
Jul 21 19:36:54 volumio volumio[1296]: SPOTIFY: VOLUMIO VOLUME 50
Jul 21 19:36:54 volumio volumio[1296]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:36:54 volumio volumio[1296]: info: Setting Spotify Volume from Volumio: 50
Jul 21 19:36:54 volumio sudo[2621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:36:54 volumio sudo[2621]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:54 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:36:54 volumio sudo[2621]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:54 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:36:54 volumio volumio[2623]: No protocol specified
Jul 21 19:36:54 volumio volumio[2623]: No protocol specified
Jul 21 19:36:54 volumio volumio[2623]: pygame 1.9.4.post1
Jul 21 19:36:54 volumio volumio[2623]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:36:54 volumio volumio[2623]: Traceback (most recent call last):
Jul 21 19:36:54 volumio volumio[2623]: File "spectrum.py", line 715, in
Jul 21 19:36:54 volumio volumio[2623]: pm = Spectrum(None, True)
Jul 21 19:36:54 volumio volumio[2623]: File "spectrum.py", line 63, in __init__
Jul 21 19:36:54 volumio volumio[2623]: self.init_display()
Jul 21 19:36:54 volumio volumio[2623]: File "spectrum.py", line 104, in init_display
Jul 21 19:36:54 volumio volumio[2623]: pygame.display.init()
Jul 21 19:36:54 volumio volumio[2623]: pygame.error: Unable to open /dev/fb1
Jul 21 19:36:54 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:36:54 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:36:55 volumio volumio[1296]: info: VolumeController::SetAlsaVolume31
Jul 21 19:36:55 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:55 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:55 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:36:55 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:55 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:36:55 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Jul 21 19:36:55 volumio volumio[1296]: SPOTIFY: SPOTIFY VOLUME 50
Jul 21 19:36:55 volumio volumio[1296]: SPOTIFY: VOLUMIO VOLUME 31
Jul 21 19:36:55 volumio volumio[1296]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:36:55 volumio volumio[1296]: info: Setting Spotify Volume from Volumio: 31
Jul 21 19:36:55 volumio sudo[2629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:36:55 volumio sudo[2629]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:55 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:36:55 volumio sudo[2629]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:55 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:36:55 volumio volumio[2631]: No protocol specified
Jul 21 19:36:55 volumio volumio[2631]: No protocol specified
Jul 21 19:36:55 volumio volumio[2631]: pygame 1.9.4.post1
Jul 21 19:36:55 volumio volumio[2631]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:36:55 volumio volumio[2631]: Traceback (most recent call last):
Jul 21 19:36:55 volumio volumio[2631]: File "spectrum.py", line 715, in
Jul 21 19:36:55 volumio volumio[2631]: pm = Spectrum(None, True)
Jul 21 19:36:55 volumio volumio[2631]: File "spectrum.py", line 63, in __init__
Jul 21 19:36:55 volumio volumio[2631]: self.init_display()
Jul 21 19:36:55 volumio volumio[2631]: File "spectrum.py", line 104, in init_display
Jul 21 19:36:55 volumio volumio[2631]: pygame.display.init()
Jul 21 19:36:55 volumio volumio[2631]: pygame.error: Unable to open /dev/fb1
Jul 21 19:36:55 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:36:55 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:36:56 volumio volumio[1296]: info: VolumeController::SetAlsaVolume20
Jul 21 19:36:56 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:36:56 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:36:56 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:36:56 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:36:56 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:36:56 volumio volumio[1296]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20
Jul 21 19:36:56 volumio volumio[1296]: SPOTIFY: SPOTIFY VOLUME 31
Jul 21 19:36:56 volumio volumio[1296]: SPOTIFY: VOLUMIO VOLUME 20
Jul 21 19:36:56 volumio volumio[1296]: SPOTIFY: DELTA VOLUME ENOUGH: true
Jul 21 19:36:56 volumio volumio[1296]: info: Setting Spotify Volume from Volumio: 20
Jul 21 19:36:56 volumio sudo[2637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:36:56 volumio sudo[2637]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:36:56 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:36:56 volumio sudo[2637]: pam_unix(sudo:session): session closed for user root
Jul 21 19:36:56 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:36:56 volumio volumio[2639]: No protocol specified
Jul 21 19:36:56 volumio volumio[2639]: No protocol specified
Jul 21 19:36:56 volumio volumio[2639]: pygame 1.9.4.post1
Jul 21 19:36:56 volumio volumio[2639]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:36:56 volumio volumio[2639]: Traceback (most recent call last):
Jul 21 19:36:56 volumio volumio[2639]: File "spectrum.py", line 715, in
Jul 21 19:36:56 volumio volumio[2639]: pm = Spectrum(None, True)
Jul 21 19:36:56 volumio volumio[2639]: File "spectrum.py", line 63, in __init__
Jul 21 19:36:56 volumio volumio[2639]: self.init_display()
Jul 21 19:36:56 volumio volumio[2639]: File "spectrum.py", line 104, in init_display
Jul 21 19:36:56 volumio volumio[2639]: pygame.display.init()
Jul 21 19:36:56 volumio volumio[2639]: pygame.error: Unable to open /dev/fb1
Jul 21 19:36:56 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:36:56 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:36:58 volumio volumio[1296]: SPOTIFY: SETTING SPOTIFY VOLUME 20
Jul 21 19:36:58 volumio volumio[1296]: info: Sending Spotify command with payload to local API: /player/volume
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 21 19:36:59 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 21 19:37:16 volumio volumio[1296]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object]
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions
Jul 21 19:37:16 volumio sudo[2731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 21 19:37:16 volumio sudo[2731]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:16 volumio sudo[2731]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:16 volumio volumio[1296]: info: MPD Permissions set
Jul 21 19:37:16 volumio sudo[2734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 21 19:37:16 volumio sudo[2734]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:16 volumio systemd[1]: Stopping Music Player Daemon...
Jul 21 19:37:16 volumio systemd[1]: mpd.service: Succeeded.
Jul 21 19:37:16 volumio systemd[1]: Stopped Music Player Daemon.
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:37:16 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:16 volumio systemd[1]: Starting Music Player Daemon...
Jul 21 19:37:16 volumio volumio[1296]: info: camilladsp spawned new process with pid 2741, instance 1, run: true
Jul 21 19:37:16 volumio sudo[2740]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 21 19:37:16 volumio sudo[2740]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:16 volumio sudo[2740]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:16 volumio mpd[2749]: Jul 21 19:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 21 19:37:16 volumio systemd[1]: Started Music Player Daemon.
Jul 21 19:37:16 volumio sudo[2734]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:16 volumio volumio[1296]: error: updateQueue error: null
Jul 21 19:37:17 volumio volumio[1296]: error: Upnp client error: Error: This socket has been ended by the other party
Jul 21 19:37:18 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:18 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:18 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:33 volumio volumio[1296]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object]
Jul 21 19:37:33 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions
Jul 21 19:37:33 volumio volumio[1296]: info: CoreCommandRouter::volumioGetState
Jul 21 19:37:33 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:37:33 volumio volumio[1296]: info: Restoring Previous Volume level: 100 false false
Jul 21 19:37:33 volumio volumio[1296]: info: Disable softmixer device for audio device
Jul 21 19:37:33 volumio volumio[1296]: info: Output device has changed, restarting MPD
Jul 21 19:37:33 volumio sudo[2784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 21 19:37:33 volumio sudo[2784]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:33 volumio sudo[2784]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:33 volumio volumio[1296]: info: Output device has changed, restarting Shairport Sync
Jul 21 19:37:33 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:33 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:37:33 volumio sudo[2787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 21 19:37:33 volumio sudo[2787]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:33 volumio systemd[1]: Stopping Music Player Daemon...
Jul 21 19:37:33 volumio systemd[1]: mpd.service: Succeeded.
Jul 21 19:37:33 volumio systemd[1]: Stopped Music Player Daemon.
Jul 21 19:37:33 volumio volumio[1296]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 21 19:37:33 volumio volumio[1296]: info: Volume configurations have been set
Jul 21 19:37:34 volumio systemd[1]: Starting Music Player Daemon...
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jul 21 19:37:34 volumio volumio[1296]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI 0 Out Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jul 21 19:37:34 volumio volumio[1296]: info: Disabling external Volume Control
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 21 19:37:34 volumio sudo[2792]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 21 19:37:34 volumio sudo[2792]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:34 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:37:34 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:37:34 volumio sudo[2792]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:34 volumio volumio[1296]: info: Soft Volume ALSA configuration file deleted
Jul 21 19:37:34 volumio volumio[1296]: info: Preparing to generate the ALSA configuration file
Jul 21 19:37:34 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:37:34 volumio volumio[1296]: info: MPD Permissions set
Jul 21 19:37:34 volumio volumio[1296]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jul 21 19:37:34 volumio volumio[1296]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
Jul 21 19:37:34 volumio volumio[1296]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf
Jul 21 19:37:34 volumio volumio[1296]: info: Reading ALSA contributions from plugins.
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio sudo[2799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:37:34 volumio sudo[2799]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:37:34 volumio sudo[2799]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 21 19:37:34 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:37:34 volumio volumio[1296]: info: Starting Shairport Sync
Jul 21 19:37:34 volumio sudo[2812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 21 19:37:34 volumio sudo[2812]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:34 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 21 19:37:34 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 21 19:37:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 21 19:37:34 volumio volumio[1296]: info: Asound.conf file written
Jul 21 19:37:34 volumio sudo[2816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jul 21 19:37:34 volumio sudo[2816]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 21 19:37:34 volumio sudo[2816]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:34 volumio sudo[2812]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:34 volumio volumio[1296]: info: Output device has changed, restarting MPD
Jul 21 19:37:34 volumio sudo[2824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 21 19:37:34 volumio sudo[2824]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:34 volumio sudo[2824]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:34 volumio volumio[1296]: info: Output device has changed, restarting Shairport Sync
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:37:34 volumio sudo[2826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 21 19:37:34 volumio sudo[2826]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:34 volumio volumio[2805]: No protocol specified
Jul 21 19:37:34 volumio volumio[2805]: No protocol specified
Jul 21 19:37:34 volumio volumio[2805]: pygame 1.9.4.post1
Jul 21 19:37:34 volumio volumio[2805]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:37:34 volumio volumio[2805]: Traceback (most recent call last):
Jul 21 19:37:34 volumio volumio[2805]: File "spectrum.py", line 715, in
Jul 21 19:37:34 volumio volumio[2805]: pm = Spectrum(None, True)
Jul 21 19:37:34 volumio volumio[2805]: File "spectrum.py", line 63, in __init__
Jul 21 19:37:34 volumio volumio[2805]: self.init_display()
Jul 21 19:37:34 volumio volumio[2805]: File "spectrum.py", line 104, in init_display
Jul 21 19:37:34 volumio volumio[2805]: pygame.display.init()
Jul 21 19:37:34 volumio volumio[2805]: pygame.error: Unable to open /dev/fb1
Jul 21 19:37:34 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jul 21 19:37:34 volumio systemd[1]: mpd.service: Succeeded.
Jul 21 19:37:34 volumio systemd[1]: Stopped Music Player Daemon.
Jul 21 19:37:34 volumio volumio[1296]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 21 19:37:34 volumio volumio[1296]: info: MPD Permissions set
Jul 21 19:37:34 volumio volumio[1296]: info: Shairport-Sync Started
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio systemd[1]: Starting Music Player Daemon...
Jul 21 19:37:34 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:37:34 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:34 volumio volumio[1296]: info: Starting Shairport Sync
Jul 21 19:37:34 volumio sudo[2837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 21 19:37:34 volumio sudo[2837]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:34 volumio sudo[2831]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 21 19:37:34 volumio sudo[2831]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:34 volumio sudo[2831]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:34 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 21 19:37:34 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 21 19:37:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 21 19:37:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 21 19:37:34 volumio sudo[2837]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:34 volumio volumio[1296]: info: Shairport-Sync Started
Jul 21 19:37:34 volumio volumio[1296]: error: Upnp client error: Error: This socket has been ended by the other party
Jul 21 19:37:34 volumio mpd[2840]: Jul 21 19:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 21 19:37:34 volumio systemd[1]: Started Music Player Daemon.
Jul 21 19:37:34 volumio sudo[2826]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:34 volumio sudo[2787]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:34 volumio volumio[1296]: error: MPD error: The expression evaluated to a falsy value:
Jul 21 19:37:34 volumio volumio[1296]: assert.ok(self.idling)
Jul 21 19:37:34 volumio volumio[1296]: error: The expression evaluated to a falsy value:
Jul 21 19:37:34 volumio volumio[1296]: assert.ok(self.idling)
Jul 21 19:37:34 volumio volumio[1296]: error: updateQueue error: null
Jul 21 19:37:35 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 21 19:37:35 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 21 19:37:35 volumio volumio[1296]: info: [squeezelite_mc] Restarting Squeezelite service with params: {"type":"basic","playerName":"volumio","dsdFormat":null,"card":"0","mixerType":"None","mixer":null}
Jul 21 19:37:35 volumio volumio[1296]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Jul 21 19:37:35 volumio sudo[2851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Jul 21 19:37:35 volumio sudo[2851]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:35 volumio sudo[2851]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:35 volumio volumio[1296]: info: [squeezelite_mc] Executing alsactl -L -R nrestore
Jul 21 19:37:35 volumio sudo[2855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore
Jul 21 19:37:35 volumio sudo[2855]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:35 volumio sudo[2855]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:35 volumio volumio[1296]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service
Jul 21 19:37:35 volumio sudo[2859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service
Jul 21 19:37:35 volumio sudo[2859]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:35 volumio sudo[2859]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:35 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true
Jul 21 19:37:35 volumio sudo[2862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Jul 21 19:37:35 volumio sudo[2862]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:36 volumio systemd[1]: Reloading.
Jul 21 19:37:36 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Jul 21 19:37:36 volumio systemd[1]: squeezelite.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Jul 21 19:37:36 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway.
Jul 21 19:37:36 volumio sudo[2862]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:36 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 21 19:37:36 volumio sudo[2878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 21 19:37:36 volumio sudo[2878]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:36 volumio sudo[2878]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:36 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true
Jul 21 19:37:36 volumio sudo[2881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite
Jul 21 19:37:36 volumio sudo[2881]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:36 volumio systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator...
Jul 21 19:37:36 volumio systemd[1]: squeezelite.service: Succeeded.
Jul 21 19:37:36 volumio systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator.
Jul 21 19:37:36 volumio sudo[2881]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:36 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 21 19:37:36 volumio sudo[2887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 21 19:37:36 volumio sudo[2887]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:36 volumio sudo[2887]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:36 volumio volumio[1296]: info: [squeezelite_mc] Executing rm /tmp/squeezelite.log
Jul 21 19:37:36 volumio sudo[2891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /tmp/squeezelite.log
Jul 21 19:37:36 volumio sudo[2891]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:36 volumio sudo[2891]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:36 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true
Jul 21 19:37:36 volumio sudo[2894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite
Jul 21 19:37:36 volumio sudo[2894]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:36 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator...
Jul 21 19:37:36 volumio sudo[2894]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:36 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator.
Jul 21 19:37:37 volumio volumio[1296]: info: camilladsp spawned new process with pid 2900, instance 1, run: true
Jul 21 19:37:37 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 21 19:37:37 volumio sudo[2909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 21 19:37:37 volumio sudo[2909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:37 volumio sudo[2909]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:37 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 21 19:37:38 volumio sudo[2914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 21 19:37:38 volumio sudo[2914]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:38 volumio sudo[2914]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:38 volumio volumio[1296]: info: VolumeController::SetAlsaVolume100
Jul 21 19:37:38 volumio volumio[1296]: info: CoreStateMachine::pushState
Jul 21 19:37:38 volumio volumio[1296]: info: CorePlayQueue::getTrack 0
Jul 21 19:37:38 volumio volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 19:37:38 volumio volumio[1296]: info: CoreCommandRouter::volumioPushState
Jul 21 19:37:38 volumio volumio[1296]: info: PeppySpectrum ---peppyspectrum status play
Jul 21 19:37:38 volumio sudo[2917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jul 21 19:37:38 volumio sudo[2917]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:38 volumio systemd[1]: Started peppyspectrum Daemon.
Jul 21 19:37:38 volumio sudo[2917]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:38 volumio volumio[1296]: info: peppyspectrum Daemon Started
Jul 21 19:37:38 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 21 19:37:38 volumio sudo[2922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 21 19:37:38 volumio sudo[2922]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:38 volumio sudo[2922]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:38 volumio volumio[2919]: No protocol specified
Jul 21 19:37:38 volumio volumio[2919]: No protocol specified
Jul 21 19:37:38 volumio volumio[2919]: pygame 1.9.4.post1
Jul 21 19:37:38 volumio volumio[2919]: Hello from the pygame community. https://www.pygame.org/contribute.html
Jul 21 19:37:38 volumio volumio[2919]: Traceback (most recent call last):
Jul 21 19:37:38 volumio volumio[2919]: File "spectrum.py", line 715, in
Jul 21 19:37:38 volumio volumio[2919]: pm = Spectrum(None, True)
Jul 21 19:37:38 volumio volumio[2919]: File "spectrum.py", line 63, in __init__
Jul 21 19:37:38 volumio volumio[2919]: self.init_display()
Jul 21 19:37:38 volumio volumio[2919]: File "spectrum.py", line 104, in init_display
Jul 21 19:37:38 volumio volumio[2919]: pygame.display.init()
Jul 21 19:37:38 volumio volumio[2919]: pygame.error: Unable to open /dev/fb1
Jul 21 19:37:38 volumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE
Jul 21 19:37:38 volumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'.
Jul 21 19:37:39 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 21 19:37:39 volumio sudo[2927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 21 19:37:39 volumio sudo[2927]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:39 volumio sudo[2927]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:39 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 21 19:37:39 volumio sudo[2930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 21 19:37:39 volumio sudo[2930]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:39 volumio sudo[2930]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:39 volumio volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 21 19:37:39 volumio volumio[1296]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 21 19:37:39 volumio sudo[2933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 21 19:37:39 volumio sudo[2933]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 19:37:39 volumio sudo[2933]: pam_unix(sudo:session): session closed for user root
Jul 21 19:37:58 volumio volumio[1296]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________
Jul 21 19:37:58 volumio volumio[1296]: info: PLUGIN onReboot : networkfs
Jul 21 19:37:58 volumio volumio[1296]: info: PLUGIN onReboot : audiophonicsonoff
Jul 21 19:37:58 volumio volumio[1296]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 21 19:37:58 volumio volumio[1296]: TypeError: Cannot read property 'writeSync' of undefined
Jul 21 19:37:58 volumio volumio[1296]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25)
Jul 21 19:37:58 volumio volumio[1296]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30)
Jul 21 19:37:58 volumio volumio[1296]: at HashMap. (/volumio/app/pluginmanager.js:668:31)
Jul 21 19:37:58 volumio volumio[1296]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Jul 21 19:37:58 volumio volumio[1296]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Jul 21 19:37:58 volumio volumio[1296]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20)
Jul 21 19:37:58 volumio volumio[1296]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22)
Jul 21 19:37:58 volumio volumio[1296]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:857:33)
Jul 21 19:37:58 volumio volumio[1296]: at Socket.emit (events.js:315:20)
Jul 21 19:37:58 volumio volumio[1296]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jul 21 19:37:58 volumio volumio[1296]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jul 21 19:37:58 volumio volumio[1296]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 21 19:37:58 volumio sudo[3028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 19:36
Jul 21 19:37:58 volumio sudo[3028]: 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"