-- Logs begin at Fri 2025-10-31 11:51:03 GMT, end at Fri 2025-10-31 11:53:47 GMT. --
Oct 31 11:52:04 main-jukebox-pi5 volumiologrotate[768]: ls: cannot access '/var/log/samba/log.wb-MAIN': No such file or directory
Oct 31 11:52:04 main-jukebox-pi5 volumiologrotate[768]: ls: cannot access 'JUKEBOX': No such file or directory
Oct 31 11:52:04 main-jukebox-pi5 volumiologrotate[768]: ls: cannot access 'PI5': No such file or directory
Oct 31 11:52:12 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 176.58.109.184
Oct 31 11:52:13 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 131.111.8.63
Oct 31 11:52:13 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 193.57.144.50
Oct 31 11:52:14 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 176.58.124.166
Oct 31 11:52:14 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 109.74.192.97
Oct 31 11:52:14 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 139.143.5.31
Oct 31 11:52:15 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 176.58.120.34
Oct 31 11:52:15 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 45.154.197.106
Oct 31 11:52:15 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 82.219.4.30
Oct 31 11:52:16 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 178.79.184.152
Oct 31 11:52:16 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 63.135.73.82
Oct 31 11:52:16 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 212.71.233.40
Oct 31 11:52:17 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 185.177.149.33
Oct 31 11:52:17 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 109.74.206.120
Oct 31 11:52:18 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 91.109.118.94
Oct 31 11:52:18 main-jukebox-pi5 ntpd[1039]: Soliciting pool server 2001:8b0:1827:ef43::13:1
Oct 31 11:52:22 main-jukebox-pi5 ntpd[1039]: receive: Unexpected origin timestamp 0xecaf2175.7957770f does not match aorg 0000000000.00000000 from server@193.57.144.50 xmt 0xecaf2176.27e1d4fe
Oct 31 11:52:22 main-jukebox-pi5 ntpd[1039]: receive: Unexpected origin timestamp 0xecaf2175.7950768a does not match aorg 0000000000.00000000 from server@212.71.233.40 xmt 0xecaf2176.27fb37f1
Oct 31 11:52:22 main-jukebox-pi5 ntpd[1039]: receive: Unexpected origin timestamp 0xecaf2175.794f554b does not match aorg 0000000000.00000000 from server@185.177.149.33 xmt 0xecaf2176.27bd7fa7
Oct 31 11:52:22 main-jukebox-pi5 ntpd[1039]: receive: Unexpected origin timestamp 0xecaf2175.79586f67 does not match aorg 0000000000.00000000 from server@131.111.8.63 xmt 0xecaf2176.282e1202
Oct 31 11:52:22 main-jukebox-pi5 ntpd[1039]: receive: Unexpected origin timestamp 0xecaf2175.794c6a2c does not match aorg 0000000000.00000000 from server@91.109.118.94 xmt 0xecaf2176.282cffa3
Oct 31 11:52:22 main-jukebox-pi5 ntpd[1039]: receive: Unexpected origin timestamp 0xecaf2175.7953cc45 does not match aorg 0000000000.00000000 from server@45.154.197.106 xmt 0xecaf2176.28ac710c
Oct 31 11:52:22 main-jukebox-pi5 ntpd[1039]: receive: Unexpected origin timestamp 0xecaf2175.7954bd42 does not match aorg 0000000000.00000000 from server@139.143.5.31 xmt 0xecaf2176.2801b094
Oct 31 11:52:22 main-jukebox-pi5 ntpd[1039]: receive: Unexpected origin timestamp 0xecaf2175.795291d7 does not match aorg 0000000000.00000000 from server@82.219.4.30 xmt 0xecaf2176.28e65271
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: Discovery: Getting this device information
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: verbose: New Socket.io Connection to 192.168.59.244:3000 from 192.168.59.47 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 31 11:53:03 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 31 11:53:04 main-jukebox-pi5 volumiologrotate[768]: ls: cannot access '/var/log/samba/log.wb-MAIN': No such file or directory
Oct 31 11:53:04 main-jukebox-pi5 volumiologrotate[768]: ls: cannot access 'JUKEBOX': No such file or directory
Oct 31 11:53:04 main-jukebox-pi5 volumiologrotate[768]: ls: cannot access 'PI5': No such file or directory
Oct 31 11:53:05 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:05 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:06 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 31 11:53:06 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 31 11:53:06 main-jukebox-pi5 volumio[1201]: info: Discovery: Getting this device information
Oct 31 11:53:06 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:06 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:06 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 31 11:53:06 main-jukebox-pi5 sudo[1955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 31 11:53:06 main-jukebox-pi5 sudo[1955]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 31 11:53:06 main-jukebox-pi5 sudo[1955]: pam_unix(sudo:session): session closed for user root
Oct 31 11:53:06 main-jukebox-pi5 sudo[1958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 31 11:53:06 main-jukebox-pi5 sudo[1958]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 31 11:53:06 main-jukebox-pi5 sudo[1958]: pam_unix(sudo:session): session closed for user root
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: verbose: New Socket.io Connection to 192.168.59.244 from 192.168.59.47 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9
Oct 31 11:53:07 main-jukebox-pi5 sudo[1964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 31 11:53:07 main-jukebox-pi5 sudo[1964]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 31 11:53:07 main-jukebox-pi5 sudo[1964]: pam_unix(sudo:session): session closed for user root
Oct 31 11:53:07 main-jukebox-pi5 sudo[1967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 31 11:53:07 main-jukebox-pi5 sudo[1967]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 31 11:53:07 main-jukebox-pi5 sudo[1967]: pam_unix(sudo:session): session closed for user root
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: verbose: New Socket.io Connection to 192.168.59.244 from 192.168.59.47 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: Received Get System Info
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: Discovery: Getting this device information
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: Listing playlists
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 31 11:53:07 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 31 11:53:09 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 31 11:53:09 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 31 11:53:09 main-jukebox-pi5 volumio[1201]: info: Received Get System Info
Oct 31 11:53:09 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 31 11:53:09 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 31 11:53:09 main-jukebox-pi5 volumio[1201]: info: Discovery: Getting this device information
Oct 31 11:53:09 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:09 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:09 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetQueue
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::getQueue
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getQueue
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: Received Get System Info
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: Discovery: Getting this device information
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:10 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioPlay
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::play index 0
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::stop
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::play index undefined
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::startPlaybackTimer
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Terence Trent D'Arby/Introducing The Hardline According To Terence Trent D'Arby/10 - As Yet Untitled.flac
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::sendMpdCommand stop
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: sendMpdCommand stop took 3 milliseconds
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::sendMpdCommand clear
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info:
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: ---------------------------- MPD announces system playlist update
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: Ignoring MPD Status Update
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: sendMpdCommand clear took 1 milliseconds
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Terence Trent D'Arby/Introducing The Hardline According To Terence Trent D'Arby/10 - As Yet Untitled.flac"
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: error: updateQueue error: null
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info:
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: ---------------------------- MPD announces system playlist update
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: Ignoring MPD Status Update
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: ------------------------------ 2ms
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: sendMpdCommand add "NAS/NAS/Terence Trent D'Arby/Introducing The Hardline According To Terence Trent D'Arby/10 - As Yet Untitled.flac" took 1 milliseconds
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::sendMpdCommand play
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: ------------------------------ 1ms
Oct 31 11:53:13 main-jukebox-pi5 volumio[1201]: info: sendMpdCommand play took 1 milliseconds
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info:
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: ---------------------------- MPD announces state update: player
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: ControllerMpd::getState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::sendMpdCommand status
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info:
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: ---------------------------- MPD announces state update: player
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: ControllerMpd::getState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::sendMpdCommand status
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: sendMpdCommand status took 134 milliseconds
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::parseState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: sendMpdCommand status took 3 milliseconds
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::parseState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::parseTrackInfo
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: ControllerMpd::pushState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::servicePushState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5612,"duration":332,"samplerate":"96 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1408 Kbps","isStreaming":false,"title":"As Yet Untitled","artist":"Terence Trent D'Arby","album":"Introducing The Hardline According To Terence Trent D'Arby","uri":"NAS/NAS/Terence Trent D'Arby/Introducing The Hardline According To Terence Trent D'Arby/10 - As Yet Untitled.flac","trackType":"flac"}
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: CURRENT POSITION 0
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::syncState stateService play
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::syncState currentStatus stop
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: ------------------------------ 138ms
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: sendMpdCommand playlistinfo took 3 milliseconds
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: ControllerMpd::parseTrackInfo
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: ControllerMpd::pushState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::servicePushState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5738,"duration":332,"samplerate":"96 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1408 Kbps","isStreaming":false,"title":"As Yet Untitled","artist":"Terence Trent D'Arby","album":"Introducing The Hardline According To Terence Trent D'Arby","uri":"NAS/NAS/Terence Trent D'Arby/Introducing The Hardline According To Terence Trent D'Arby/10 - As Yet Untitled.flac","trackType":"flac"}
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: verbose: CURRENT POSITION 0
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::syncState stateService play
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::syncState currentStatus play
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: Received an update from plugin. extracting info from payload
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::pushState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioPushState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: MRS: Pushing multiroomSync output update for this device
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: MRS: Pushing multiroomSync output
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreStateMachine::pushState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioPushState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: MRS: Pushing multiroomSync output update for this device
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: MRS: Pushing multiroomSync output
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: ------------------------------ 27ms
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: [ASDebug] CurState: play PrevState: stop
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: [ASDebug] Togle GPIO: ON
Oct 31 11:53:17 main-jukebox-pi5 volumio[1201]: info: [ASDebug] CurState: play PrevState: play
Oct 31 11:53:20 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 31 11:53:20 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: Received Get System Version
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: Received Get System Info
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: Discovery: Getting this device information
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:26 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 31 11:53:27 main-jukebox-pi5 volumio[1201]: info: [ASDebug] Port: 24
Oct 31 11:53:27 main-jukebox-pi5 volumio[1201]: info: [ASDebug] Inverted: false
Oct 31 11:53:27 main-jukebox-pi5 volumio[1201]: info: [ASDebug] Delay: 720
Oct 31 11:53:31 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 31 11:53:31 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 31 11:53:31 main-jukebox-pi5 volumio[1201]: info: Discovery: Getting this device information
Oct 31 11:53:31 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::volumioGetState
Oct 31 11:53:31 main-jukebox-pi5 volumio[1201]: info: CorePlayQueue::getTrack 0
Oct 31 11:53:31 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 31 11:53:36 main-jukebox-pi5 volumio[1201]: info: Starting Uninstall of plugin user_interface - touch_display
Oct 31 11:53:36 main-jukebox-pi5 volumio[1201]: info: Uninstalling plugin touch_display
Oct 31 11:53:36 main-jukebox-pi5 volumio[1201]: info: Disabling plugin touch_display
Oct 31 11:53:36 main-jukebox-pi5 volumio[1201]: info: Checking if uninstall.sh is present
Oct 31 11:53:36 main-jukebox-pi5 volumio[1201]: info: Executing uninstall.sh
Oct 31 11:53:36 main-jukebox-pi5 sudo[2022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/touch_display/uninstall.sh
Oct 31 11:53:36 main-jukebox-pi5 sudo[2022]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 31 11:53:37 main-jukebox-pi5 systemd[1]: Reloading.
Oct 31 11:53:37 main-jukebox-pi5 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.
Oct 31 11:53:37 main-jukebox-pi5 systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Oct 31 11:53:37 main-jukebox-pi5 systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Oct 31 11:53:37 main-jukebox-pi5 sudo[2022]: pam_unix(sudo:session): session closed for user root
Oct 31 11:53:37 main-jukebox-pi5 volumio[1201]: info: Uninstall script completed
Oct 31 11:53:37 main-jukebox-pi5 volumio[1201]: info: Removing plugin touch_display from configuration
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Successfully removed touch_display configuration files
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Plugin folders cleanup
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning into folder /volumio/app/plugins/
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning category audio_interface
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning category miscellanea
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning category music_service
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning category plugins.json
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning category system_controller
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning category user_interface
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning into folder /data/plugins/
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning category system_controller
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Scanning category user_interface
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Cleaning folder for touch_display
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: Plugin folders cleanup completed
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: [{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Backup & Restore Data","name":"backup_restore","category":"system_controller","version":"0.7.4","icon":"fa-floppy-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Randomizer","name":"randomizer","category":"user_interface","version":"3.1.2","icon":"fa-random","isManuallyInstalled":false,"enabled":true,"active":true}]
Oct 31 11:53:38 main-jukebox-pi5 volumio[1201]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: info: Starting Uninstall of plugin system_controller - ampswitch
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: info: Uninstalling plugin ampswitch
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: info: [ASDebug] Port: 24
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: info: [ASDebug] Inverted: false
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: info: [ASDebug] Delay: 720
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: Error: EBADF: bad file descriptor, close
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at Object.closeSync (fs.js:439:3)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1260:45)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at Socket.emit (events.js:315:20)
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: errno: -9,
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: syscall: 'close',
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: code: 'EBADF'
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: }
Oct 31 11:53:47 main-jukebox-pi5 volumio[1201]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 31 11:53:47 main-jukebox-pi5 sudo[2093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-31 11:52
Oct 31 11:53:47 main-jukebox-pi5 sudo[2093]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"