-- Logs begin at Thu 2024-10-17 09:27:28 CST, end at Thu 2024-10-17 09:31:55 CST. -- Oct 17 09:30:01 volumio sudo[2077]: pam_unix(sudo:session): session closed for user root Oct 17 09:30:04 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:30:04 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 17 09:30:07 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 09:30:07 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 17 09:30:11 volumio volumio[880]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 09:30:11 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:30:12 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:30:12 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 17 09:30:12 volumio sudo[2119]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 17 09:30:12 volumio sudo[2119]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 09:30:17 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 6 Oct 17 09:30:17 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:30:17 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 17 09:30:18 volumio sudo[2119]: pam_unix(sudo:session): session closed for user root Oct 17 09:30:24 volumio volumio[880]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Oct 17 09:30:24 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Oct 17 09:30:24 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:30:24 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:30:24 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:30:24 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:30:24 volumio volumio[880]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 09:30:24 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:30:29 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:30:29 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 17 09:30:29 volumio sudo[2162]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 17 09:30:29 volumio sudo[2162]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 09:30:33 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 6 Oct 17 09:30:33 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:30:33 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 17 09:30:33 volumio sudo[2162]: pam_unix(sudo:session): session closed for user root Oct 17 09:30:37 volumio volumio[880]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 17 09:30:37 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 17 09:30:37 volumio volumio[880]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 09:30:37 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioNext Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::next Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::stop Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::stPlaybackTimer Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::updateTrackBlock Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrackBlock Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::serviceStop Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::serviceStop Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::stop Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand stop took 75 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::getState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::play index undefined Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::startPlaybackTimer Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::clearAddPlayTracks USB/Kiroro - 未来へ.flac Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::updateTrackBlock Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrackBlock Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand status took 6 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand stop took 2 milliseconds Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand clear Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::getState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 17 09:30:43 volumio volumio[880]: info: Ignoring MPD Status Update Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand clear took 4 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand status took 3 milliseconds Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseTrackInfo Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand add "USB/Kiroro - 未来へ.flac" Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::pushState Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"長い間","artist":"Kiroro","album":"Nagai Aida ~Kiroro no Mori~","uri":"USB/Kiroro - 長い間.flac","trackType":"flac"} Oct 17 09:30:43 volumio volumio[880]: verbose: CURRENT POSITION 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState stateService stop Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: No code Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::pushState Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 17 09:30:43 volumio volumio[880]: verbose: CURRENT POSITION 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState stateService stop Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: No code Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 88ms Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 80ms Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 17 09:30:43 volumio volumio[880]: info: Ignoring MPD Status Update Oct 17 09:30:43 volumio volumio[880]: error: updateQueue error: null Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 17 09:30:43 volumio volumio[880]: info: Ignoring MPD Status Update Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 82ms Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand add "USB/Kiroro - 未来へ.flac" took 80 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 4ms Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand play Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 17 09:30:43 volumio volumio[880]: info: Ignoring MPD Status Update Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 35ms Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand play took 33 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 32ms Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::getState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::getState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::getState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand status took 8 milliseconds Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 09:30:43 volumio volumio[880]: info: Oct 17 09:30:43 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::getState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand status took 11 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand status took 7 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseTrackInfo Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::pushState Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未来へ","artist":"Kiroro","album":"Nagai Aida ~Kiroro no Mori~","uri":"USB/Kiroro - 未来へ.flac","trackType":"flac"} Oct 17 09:30:43 volumio volumio[880]: verbose: CURRENT POSITION 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState stateService play Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 22ms Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand status took 9 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseTrackInfo Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::pushState Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未来へ","artist":"Kiroro","album":"Nagai Aida ~Kiroro no Mori~","uri":"USB/Kiroro - 未来へ.flac","trackType":"flac"} Oct 17 09:30:43 volumio volumio[880]: verbose: CURRENT POSITION 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState stateService play Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus play Oct 17 09:30:43 volumio volumio[880]: info: Received an update from plugin. extracting info from payload Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::pushState Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未来へ","artist":"Kiroro","album":"Nagai Aida ~Kiroro no Mori~","uri":"USB/Kiroro - 未来へ.flac","trackType":"flac"} Oct 17 09:30:43 volumio volumio[880]: verbose: CURRENT POSITION 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState stateService play Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus play Oct 17 09:30:43 volumio volumio[880]: info: Received an update from plugin. extracting info from payload Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 77ms Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 74ms Oct 17 09:30:43 volumio volumio[880]: info: sendMpdCommand playlistinfo took 58 milliseconds Oct 17 09:30:43 volumio volumio[880]: verbose: ControllerMpd::parseTrackInfo Oct 17 09:30:43 volumio volumio[880]: info: ControllerMpd::pushState Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未来へ","artist":"Kiroro","album":"Nagai Aida ~Kiroro no Mori~","uri":"USB/Kiroro - 未来へ.flac","trackType":"flac"} Oct 17 09:30:43 volumio volumio[880]: verbose: CURRENT POSITION 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState stateService play Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus play Oct 17 09:30:43 volumio volumio[880]: info: Received an update from plugin. extracting info from payload Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:30:43 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:43 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:30:43 volumio volumio[880]: info: ------------------------------ 103ms Oct 17 09:30:45 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:30:45 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:45 volumio sudo[2195]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 17 09:30:45 volumio sudo[2195]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 09:30:49 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 6 Oct 17 09:30:49 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:30:49 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:50 volumio sudo[2195]: pam_unix(sudo:session): session closed for user root Oct 17 09:30:53 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:30:53 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:30:55 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 09:30:55 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 17 09:31:01 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:31:01 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:01 volumio sudo[2278]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 17 09:31:01 volumio sudo[2278]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 09:31:01 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:31:01 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:05 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 6 Oct 17 09:31:05 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:31:05 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:10 volumio sudo[2278]: pam_unix(sudo:session): session closed for user root Oct 17 09:31:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 09:31:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 17 09:31:19 volumio volumio[880]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 09:31:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:31:21 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:31:21 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:21 volumio sudo[2317]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 17 09:31:21 volumio sudo[2317]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 09:31:26 volumio kernel: python3[2335]: segfault at 7fdd780008d0 ip 00007fdd780008d0 sp 00007fdd7fffe298 error 15 likely on CPU 0 (core 0, socket 0) Oct 17 09:31:26 volumio kernel: Code: 00 00 00 b0 c0 01 00 00 00 00 00 b0 c0 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 55 02 00 00 00 00 00 00 <07> 07 07 07 05 04 02 07 07 07 02 00 00 00 02 00 01 02 03 01 00 00 Oct 17 09:31:26 volumio sudo[2317]: pam_unix(sudo:session): session closed for user root Oct 17 09:31:26 volumio screensaver.sh[625]: /home/volumio/peppy_screensaver/screensaver.sh: line 24: 2317 Segmentation fault sudo python3 ./screensaver/volumio_peppymeter.py Oct 17 09:31:33 volumio volumio[880]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Oct 17 09:31:33 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Oct 17 09:31:33 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:31:33 volumio volumio[880]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 09:31:33 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:31:37 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:31:37 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:37 volumio sudo[2342]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 17 09:31:37 volumio sudo[2342]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 09:31:40 volumio volumio[880]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 17 09:31:40 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 17 09:31:40 volumio volumio[880]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 09:31:40 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 09:31:42 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 6 Oct 17 09:31:42 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:31:42 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:52 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 17 09:31:52 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:54 volumio volumio[880]: info: CoreCommandRouter::volumioPause Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::pause Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::stPlaybackTimer Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::servicePause Oct 17 09:31:54 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:54 volumio volumio[880]: info: CoreCommandRouter::servicePause Oct 17 09:31:54 volumio volumio[880]: info: ControllerMpd::pause Oct 17 09:31:54 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand pause Oct 17 09:31:54 volumio volumio[880]: info: Oct 17 09:31:54 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 17 09:31:54 volumio volumio[880]: info: sendMpdCommand pause took 5 milliseconds Oct 17 09:31:54 volumio volumio[880]: info: ControllerMpd::getState Oct 17 09:31:54 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 17 09:31:54 volumio volumio[880]: info: Oct 17 09:31:54 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 17 09:31:54 volumio volumio[880]: info: ControllerMpd::getState Oct 17 09:31:54 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 17 09:31:54 volumio volumio[880]: info: sendMpdCommand status took 5 milliseconds Oct 17 09:31:54 volumio volumio[880]: info: sendMpdCommand status took 2 milliseconds Oct 17 09:31:54 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 17 09:31:54 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 09:31:54 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 17 09:31:54 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 09:31:54 volumio volumio[880]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 17 09:31:54 volumio volumio[880]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 17 09:31:54 volumio volumio[880]: verbose: ControllerMpd::parseTrackInfo Oct 17 09:31:54 volumio volumio[880]: verbose: ControllerMpd::parseTrackInfo Oct 17 09:31:54 volumio volumio[880]: info: ControllerMpd::pushState Oct 17 09:31:54 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 17 09:31:54 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:54 volumio volumio[880]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":71532,"duration":325,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5095 Kbps","isStreaming":false,"title":"未来へ","artist":"Kiroro","album":"Nagai Aida ~Kiroro no Mori~","uri":"USB/Kiroro - 未来へ.flac","trackType":"flac"} Oct 17 09:31:54 volumio volumio[880]: verbose: CURRENT POSITION 1 Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::syncState stateService pause Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus pause Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:31:54 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:54 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 09:31:54 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::stPlaybackTimer Oct 17 09:31:54 volumio volumio[880]: info: ControllerMpd::pushState Oct 17 09:31:54 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 17 09:31:54 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:54 volumio volumio[880]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":71532,"duration":325,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5095 Kbps","isStreaming":false,"title":"未来へ","artist":"Kiroro","album":"Nagai Aida ~Kiroro no Mori~","uri":"USB/Kiroro - 未来へ.flac","trackType":"flac"} Oct 17 09:31:54 volumio volumio[880]: verbose: CURRENT POSITION 1 Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::syncState stateService pause Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus pause Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::pushState Oct 17 09:31:54 volumio volumio[880]: info: CorePlayQueue::getTrack 1 Oct 17 09:31:54 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 17 09:31:54 volumio volumio[880]: info: CoreStateMachine::stPlaybackTimer Oct 17 09:31:54 volumio volumio[880]: info: ------------------------------ 63ms Oct 17 09:31:54 volumio volumio[880]: info: ------------------------------ 60ms Oct 17 09:31:54 volumio volumio[880]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 09:31:55 volumio volumio[880]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 17 09:31:55 volumio volumio[880]: at Object.readdirSync (fs.js:1048:3) Oct 17 09:31:55 volumio volumio[880]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Oct 17 09:31:55 volumio volumio[880]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Oct 17 09:31:55 volumio volumio[880]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Oct 17 09:31:55 volumio volumio[880]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Oct 17 09:31:55 volumio volumio[880]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Oct 17 09:31:55 volumio volumio[880]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 09:31:55 volumio volumio[880]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Oct 17 09:31:55 volumio volumio[880]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Oct 17 09:31:55 volumio volumio[880]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 17 09:31:55 volumio volumio[880]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 09:31:55 volumio volumio[880]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Oct 17 09:31:55 volumio volumio[880]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 17 09:31:55 volumio volumio[880]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 09:31:55 volumio volumio[880]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Oct 17 09:31:55 volumio volumio[880]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Oct 17 09:31:55 volumio volumio[880]: errno: -20, Oct 17 09:31:55 volumio volumio[880]: syscall: 'scandir', Oct 17 09:31:55 volumio volumio[880]: code: 'ENOTDIR', Oct 17 09:31:55 volumio volumio[880]: path: '/tmp/peppyrunning' Oct 17 09:31:55 volumio volumio[880]: } Oct 17 09:31:55 volumio volumio[880]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 09:31:55 volumio sudo[2432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-17 09:30 Oct 17 09:31:55 volumio sudo[2432]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"