Dec 06 01:21:11 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:21:11 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:26 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:21:26 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: Prefetching next song
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: DOING PREFETCH IN MPD
Dec 06 01:21:40 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape"
Dec 06 01:21:40 volumio4.072 volumio[1165]: info:
Dec 06 01:21:40 volumio4.072 volumio[1165]: ---------------------------- MPD announces system playlist update
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: Ignoring MPD Status Update
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: sendMpdCommand add "INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape" took 2 milliseconds
Dec 06 01:21:40 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand consume 1
Dec 06 01:21:40 volumio4.072 volumio[1165]: info:
Dec 06 01:21:40 volumio4.072 volumio[1165]: ---------------------------- MPD announces system playlist update
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: Ignoring MPD Status Update
Dec 06 01:21:40 volumio4.072 volumio[1165]: info:
Dec 06 01:21:40 volumio4.072 volumio[1165]: ---------------------------- MPD announces system playlist update
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: Ignoring MPD Status Update
Dec 06 01:21:40 volumio4.072 volumio[1165]: info:
Dec 06 01:21:40 volumio4.072 volumio[1165]: ---------------------------- MPD announces system playlist update
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: Ignoring MPD Status Update
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: ------------------------------ 3ms
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: sendMpdCommand consume 1 took 3 milliseconds
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: ------------------------------ 4ms
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: ------------------------------ 4ms
Dec 06 01:21:40 volumio4.072 volumio[1165]: info: ------------------------------ 4ms
Dec 06 01:21:41 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:21:41 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info:
Dec 06 01:21:44 volumio4.072 volumio[1165]: ---------------------------- MPD announces system playlist update
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: Ignoring MPD Status Update
Dec 06 01:21:44 volumio4.072 volumio[1165]: info:
Dec 06 01:21:44 volumio4.072 volumio[1165]: ---------------------------- MPD announces state update: player
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ControllerMpd::getState
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 01:21:44 volumio4.072 volumio[1165]: info:
Dec 06 01:21:44 volumio4.072 volumio[1165]: ---------------------------- MPD announces system playlist update
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: Ignoring MPD Status Update
Dec 06 01:21:44 volumio4.072 volumio[1165]: info:
Dec 06 01:21:44 volumio4.072 volumio[1165]: ---------------------------- MPD announces state update: player
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ControllerMpd::getState
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 01:21:44 volumio4.072 volumio[1165]: info:
Dec 06 01:21:44 volumio4.072 volumio[1165]: ---------------------------- MPD announces system playlist update
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: Ignoring MPD Status Update
Dec 06 01:21:44 volumio4.072 volumio[1165]: info:
Dec 06 01:21:44 volumio4.072 volumio[1165]: ---------------------------- MPD announces state update: player
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ControllerMpd::getState
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 01:21:44 volumio4.072 volumio[1165]: info:
Dec 06 01:21:44 volumio4.072 volumio[1165]: ---------------------------- MPD announces system playlist update
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: Ignoring MPD Status Update
Dec 06 01:21:44 volumio4.072 volumio[1165]: info:
Dec 06 01:21:44 volumio4.072 volumio[1165]: ---------------------------- MPD announces state update: player
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ControllerMpd::getState
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ------------------------------ 4ms
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: sendMpdCommand status took 4 milliseconds
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ------------------------------ 4ms
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: sendMpdCommand status took 3 milliseconds
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ------------------------------ 3ms
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: sendMpdCommand status took 3 milliseconds
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ------------------------------ 3ms
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: sendMpdCommand status took 3 milliseconds
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseState
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseState
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseState
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseState
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ControllerMpd::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Going Home (Adagio from the 'The New World', K. by Dvorak)","artist":"James Last & His Orchestra","album":"Romantic Dreams","uri":"INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape","trackType":"ape"}
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: CURRENT POSITION 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState stateService play
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState currentStatus play
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: Received an update from plugin. extracting info from payload
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ControllerMpd::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Going Home (Adagio from the 'The New World', K. by Dvorak)","artist":"James Last & His Orchestra","album":"Romantic Dreams","uri":"INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape","trackType":"ape"}
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: CURRENT POSITION 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState stateService play
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState currentStatus play
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: Received an update from plugin. extracting info from payload
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ControllerMpd::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Going Home (Adagio from the 'The New World', K. by Dvorak)","artist":"James Last & His Orchestra","album":"Romantic Dreams","uri":"INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape","trackType":"ape"}
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: CURRENT POSITION 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState stateService play
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState currentStatus play
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: Received an update from plugin. extracting info from payload
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ControllerMpd::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Going Home (Adagio from the 'The New World', K. by Dvorak)","artist":"James Last & His Orchestra","album":"Romantic Dreams","uri":"INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape","trackType":"ape"}
Dec 06 01:21:44 volumio4.072 volumio[1165]: verbose: CURRENT POSITION 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState stateService play
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState currentStatus play
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: Received an update from plugin. extracting info from payload
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 1
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ------------------------------ 43ms
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ------------------------------ 43ms
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ------------------------------ 43ms
Dec 06 01:21:44 volumio4.072 volumio[1165]: info: ------------------------------ 45ms
Dec 06 01:21:45 volumio4.072 volumio[1165]: info: CoreStateMachine::startPlaybackTimer
Dec 06 01:21:45 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:21:45 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:21:45 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:21:45 volumio4.072 volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 06 01:21:45 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:21:46 volumio4.072 screensaver.sh[4749]: X Error of failed request: BadValue (integer parameter out of range for operation)
Dec 06 01:21:46 volumio4.072 screensaver.sh[4749]: Major opcode of failed request: 132 (MIT-SHM)
Dec 06 01:21:46 volumio4.072 screensaver.sh[4749]: Minor opcode of failed request: 3 (X_ShmPutImage)
Dec 06 01:21:46 volumio4.072 screensaver.sh[4749]: Value in failed request: 0xfffb5000
Dec 06 01:21:46 volumio4.072 screensaver.sh[4749]: Serial number of failed request: 6140
Dec 06 01:21:46 volumio4.072 screensaver.sh[4749]: Current serial number in output stream: 6141
Dec 06 01:21:46 volumio4.072 sudo[4748]: pam_unix(sudo:session): session closed for user root
Dec 06 01:21:56 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:21:56 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:21:58 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:21:58 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:21:58 volumio4.072 sudo[5215]: root : PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Dec 06 01:21:58 volumio4.072 sudo[5215]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 06 01:21:59 volumio4.072 volumio[1165]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.28.1 Engine version: 3 Transport: polling Total Clients: 6
Dec 06 01:21:59 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:21:59 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:21:59 volumio4.072 volumio[1165]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.28.1 Engine version: 3 Transport: polling Total Clients: 7
Dec 06 01:21:59 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:21:59 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:00 volumio4.072 screensaver.sh[5216]: X Error of failed request: BadValue (integer parameter out of range for operation)
Dec 06 01:22:00 volumio4.072 screensaver.sh[5216]: Major opcode of failed request: 132 (MIT-SHM)
Dec 06 01:22:00 volumio4.072 screensaver.sh[5216]: Minor opcode of failed request: 3 (X_ShmPutImage)
Dec 06 01:22:00 volumio4.072 screensaver.sh[5216]: Value in failed request: 0xd78c8000
Dec 06 01:22:00 volumio4.072 screensaver.sh[5216]: Serial number of failed request: 386
Dec 06 01:22:00 volumio4.072 screensaver.sh[5216]: Current serial number in output stream: 387
Dec 06 01:22:00 volumio4.072 sudo[5215]: pam_unix(sudo:session): session closed for user root
Dec 06 01:22:11 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:22:11 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:12 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:22:12 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:12 volumio4.072 sudo[5315]: root : PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Dec 06 01:22:12 volumio4.072 sudo[5315]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 06 01:22:13 volumio4.072 volumio[1165]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.28.1 Engine version: 3 Transport: polling Total Clients: 6
Dec 06 01:22:13 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:22:13 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:13 volumio4.072 volumio[1165]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.28.1 Engine version: 3 Transport: polling Total Clients: 7
Dec 06 01:22:13 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:22:13 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:13 volumio4.072 screensaver.sh[5317]: X Error of failed request: BadValue (integer parameter out of range for operation)
Dec 06 01:22:13 volumio4.072 screensaver.sh[5317]: Major opcode of failed request: 132 (MIT-SHM)
Dec 06 01:22:13 volumio4.072 screensaver.sh[5317]: Minor opcode of failed request: 3 (X_ShmPutImage)
Dec 06 01:22:13 volumio4.072 screensaver.sh[5317]: Value in failed request: 0x1f7b4000
Dec 06 01:22:13 volumio4.072 screensaver.sh[5317]: Serial number of failed request: 439
Dec 06 01:22:13 volumio4.072 screensaver.sh[5317]: Current serial number in output stream: 440
Dec 06 01:22:13 volumio4.072 sudo[5315]: pam_unix(sudo:session): session closed for user root
Dec 06 01:22:22 volumio4.072 kernel: usb 2-2.1: reset full-speed USB device number 4 using uhci_hcd
Dec 06 01:22:26 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:22:26 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:26 volumio4.072 sudo[5413]: root : PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Dec 06 01:22:26 volumio4.072 sudo[5413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 06 01:22:26 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:22:26 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:27 volumio4.072 volumio[1165]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.28.1 Engine version: 3 Transport: polling Total Clients: 6
Dec 06 01:22:27 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:22:27 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:27 volumio4.072 volumio[1165]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.28.1 Engine version: 3 Transport: polling Total Clients: 7
Dec 06 01:22:27 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 06 01:22:27 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:27 volumio4.072 kernel: llvmpipe-1[5448]: segfault at 0 ip 00007fd756664b35 sp 00007fd73674a900 error 6 likely on CPU 0 (core 0, socket 0)
Dec 06 01:22:27 volumio4.072 kernel: Code: 61 e3 c5 f1 69 cb c5 e9 61 d8 c5 e9 69 c0 c5 d9 6c d1 c5 d9 6d c9 c5 e1 6c e0 c5 e1 6d c0 8d 14 09 48 63 d2 8d 34 49 48 63 f6 f9 7f 10 c5 f9 7f 0c 08 c5 f9 7f 24 10 c5 f9 7f 04 30 48 8d 65
Dec 06 01:22:27 volumio4.072 kernel: llvmpipe-0[5447]: segfault at 141100 ip 00007fd756664b35 sp 00007fd736f4b900 error 6 likely on CPU 1 (core 0, socket 2)
Dec 06 01:22:27 volumio4.072 kernel: Code: 61 e3 c5 f1 69 cb c5 e9 61 d8 c5 e9 69 c0 c5 d9 6c d1 c5 d9 6d c9 c5 e1 6c e0 c5 e1 6d c0 8d 14 09 48 63 d2 8d 34 49 48 63 f6 f9 7f 10 c5 f9 7f 0c 08 c5 f9 7f 24 10 c5 f9 7f 04 30 48 8d 65
Dec 06 01:22:27 volumio4.072 sudo[5413]: pam_unix(sudo:session): session closed for user root
Dec 06 01:22:27 volumio4.072 screensaver.sh[2198]: /home/volumio/PeppyMeter/screensaver.sh: line 12: 5413 Segmentation fault sudo python3 ./screensaver/volumio_peppymeter.py
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::servicePause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::servicePause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ControllerMpd::pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info:
Dec 06 01:22:34 volumio4.072 volumio[1165]: ---------------------------- MPD announces state update: player
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: sendMpdCommand pause took 4 milliseconds
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ControllerMpd::getState
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 01:22:34 volumio4.072 volumio[1165]: info:
Dec 06 01:22:34 volumio4.072 volumio[1165]: ---------------------------- MPD announces state update: player
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ControllerMpd::getState
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 01:22:34 volumio4.072 volumio[1165]: info:
Dec 06 01:22:34 volumio4.072 volumio[1165]: ---------------------------- MPD announces state update: player
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ControllerMpd::getState
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 01:22:34 volumio4.072 volumio[1165]: info:
Dec 06 01:22:34 volumio4.072 volumio[1165]: ---------------------------- MPD announces state update: player
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ControllerMpd::getState
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: sendMpdCommand status took 2 milliseconds
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: sendMpdCommand status took 2 milliseconds
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: sendMpdCommand status took 1 milliseconds
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseState
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseState
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseState
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: sendMpdCommand status took 4 milliseconds
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseState
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ControllerMpd::pushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":49342,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Going Home (Adagio from the 'The New World', K. by Dvorak)","artist":"James Last & His Orchestra","album":"Romantic Dreams","uri":"INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape","trackType":"ape"}
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: CURRENT POSITION 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ControllerMpd::pushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":49342,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Going Home (Adagio from the 'The New World', K. by Dvorak)","artist":"James Last & His Orchestra","album":"Romantic Dreams","uri":"INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape","trackType":"ape"}
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: CURRENT POSITION 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ControllerMpd::pushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":49342,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Going Home (Adagio from the 'The New World', K. by Dvorak)","artist":"James Last & His Orchestra","album":"Romantic Dreams","uri":"INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape","trackType":"ape"}
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: CURRENT POSITION 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ------------------------------ 25ms
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ------------------------------ 24ms
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ------------------------------ 24ms
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: sendMpdCommand playlistinfo took 19 milliseconds
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ControllerMpd::pushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":49342,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Going Home (Adagio from the 'The New World', K. by Dvorak)","artist":"James Last & His Orchestra","album":"Romantic Dreams","uri":"INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01. Going Home (Adagio from the 'The New World', K. by Dvorak).ape","trackType":"ape"}
Dec 06 01:22:34 volumio4.072 volumio[1165]: verbose: CURRENT POSITION 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::pushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CorePlayQueue::getTrack 2
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 06 01:22:34 volumio4.072 volumio[1165]: info: ------------------------------ 35ms
Dec 06 01:22:34 volumio4.072 volumio[1165]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 06 01:22:34 volumio4.072 volumio[1165]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Object.readdirSync (node:fs:1543:3)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12)
Dec 06 01:22:34 volumio4.072 volumio[1165]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) {
Dec 06 01:22:34 volumio4.072 volumio[1165]: errno: -20,
Dec 06 01:22:34 volumio4.072 volumio[1165]: syscall: 'scandir',
Dec 06 01:22:34 volumio4.072 volumio[1165]: code: 'ENOTDIR',
Dec 06 01:22:34 volumio4.072 volumio[1165]: path: '/tmp/peppyrunning'
Dec 06 01:22:34 volumio4.072 volumio[1165]: }
Dec 06 01:22:34 volumio4.072 volumio[1165]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 06 01:22:34 volumio4.072 sudo[5518]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-06 01:21'
Dec 06 01:22:34 volumio4.072 sudo[5518]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Dec 2 12:15:37 UTC 2025"
VOLUMIO_VERSION="4.072"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="3ca59a0b3ec3a926fd3274a2fb539106"