-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2025-08-29 17:58:27 CEST. --
Aug 29 17:57:02 volumio sudo[1805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 29 17:57:02 volumio sudo[1805]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 29 17:57:02 volumio sudo[1805]: pam_unix(sudo:session): session closed for user root
Aug 29 17:57:02 volumio sudo[1807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 29 17:57:02 volumio sudo[1807]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 29 17:57:02 volumio sudo[1807]: pam_unix(sudo:session): session closed for user root
Aug 29 17:57:02 volumio volumio[1131]: verbose: New Socket.io Connection to 192.168.1.174 from 192.168.1.24 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:02 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:02 volumio volumio[1131]: info: Received Get System Info
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 29 17:57:02 volumio volumio[1131]: info: Discovery: Getting this device information
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:02 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:02 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:02 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:02 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 29 17:57:02 volumio volumio[1131]: info: Received Get System Info
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 29 17:57:02 volumio volumio[1131]: info: Discovery: Getting this device information
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:02 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:02 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:02 volumio volumio[1131]: info: Listing playlists
Aug 29 17:57:02 volumio volumio[1131]: info: Received Get System Info
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 29 17:57:02 volumio volumio[1131]: info: Discovery: Getting this device information
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:02 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:02 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:02 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Aug 29 17:57:03 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:03 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:05 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Aug 29 17:57:10 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Aug 29 17:57:12 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Aug 29 17:57:17 volumio volumio[1131]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object]
Aug 29 17:57:17 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions
Aug 29 17:57:17 volumio sudo[1830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 29 17:57:17 volumio sudo[1830]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 29 17:57:17 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 29 17:57:17 volumio sudo[1830]: pam_unix(sudo:session): session closed for user root
Aug 29 17:57:17 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 29 17:57:17 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 29 17:57:17 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 29 17:57:17 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 29 17:57:17 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 29 17:57:17 volumio sudo[1832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 29 17:57:17 volumio sudo[1832]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 29 17:57:17 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 29 17:57:17 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 29 17:57:17 volumio systemd[1]: Stopping Music Player Daemon...
Aug 29 17:57:17 volumio volumio[1131]: info: MPD Permissions set
Aug 29 17:57:17 volumio systemd[1]: mpd.service: Succeeded.
Aug 29 17:57:17 volumio systemd[1]: Stopped Music Player Daemon.
Aug 29 17:57:17 volumio systemd[1]: Starting Music Player Daemon...
Aug 29 17:57:17 volumio sudo[1839]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Aug 29 17:57:17 volumio sudo[1839]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 29 17:57:17 volumio sudo[1839]: pam_unix(sudo:session): session closed for user root
Aug 29 17:57:18 volumio mpd[1841]: Aug 29 17:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 29 17:57:18 volumio systemd[1]: Started Music Player Daemon.
Aug 29 17:57:18 volumio sudo[1832]: pam_unix(sudo:session): session closed for user root
Aug 29 17:57:18 volumio volumio[1131]: error: updateQueue error: null
Aug 29 17:57:22 volumio volumio[1131]: info: CoreCommandRouter::volumioSeek
Aug 29 17:57:22 volumio volumio[1131]: info: CoreStateMachine::seek
Aug 29 17:57:22 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:22 volumio volumio[1131]: [420B blob data]
Aug 29 17:57:22 volumio volumio[1131]: info: CoreStateMachine::startPlaybackTimer
Aug 29 17:57:22 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:22 volumio volumio[1131]: info: ControllerMpd::seek
Aug 29 17:57:22 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:22 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:22 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:22 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:22 volumio volumio[1131]: error: [2@0] {seek} Bad song index
Aug 29 17:57:22 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:27 volumio volumio[1131]: info: VolumeController::SetAlsaVolume89
Aug 29 17:57:27 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:27 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:27 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:27 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:27 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:28 volumio volumio[1131]: info: VolumeController::SetAlsaVolume85
Aug 29 17:57:28 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:28 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:28 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:28 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:28 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:39 volumio volumio[1131]: info: CoreCommandRouter::volumioPause
Aug 29 17:57:39 volumio volumio[1131]: info: CoreStateMachine::pause
Aug 29 17:57:39 volumio volumio[1131]: info: CoreStateMachine::stPlaybackTimer
Aug 29 17:57:39 volumio volumio[1131]: info: CoreStateMachine::servicePause
Aug 29 17:57:39 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:39 volumio volumio[1131]: info: CoreCommandRouter::servicePause
Aug 29 17:57:39 volumio volumio[1131]: info: ControllerMpd::pause
Aug 29 17:57:39 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand pause
Aug 29 17:57:39 volumio volumio[1131]: info: sendMpdCommand pause took 2 milliseconds
Aug 29 17:57:42 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState
Aug 29 17:57:42 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:42 volumio volumio[1131]: info: CoreCommandRouter::volumioPlay
Aug 29 17:57:42 volumio volumio[1131]: info: CoreStateMachine::play index undefined
Aug 29 17:57:42 volumio volumio[1131]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 29 17:57:42 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:42 volumio volumio[1131]: info: CoreStateMachine::startPlaybackTimer
Aug 29 17:57:42 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:42 volumio volumio[1131]: info: ControllerMpd::resume
Aug 29 17:57:42 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand play
Aug 29 17:57:42 volumio volumio[1131]: info: sendMpdCommand play took 1 milliseconds
Aug 29 17:57:44 volumio volumio[1131]: info: CoreCommandRouter::volumioPlay
Aug 29 17:57:44 volumio volumio[1131]: info: CoreStateMachine::play index undefined
Aug 29 17:57:44 volumio volumio[1131]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 29 17:57:44 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:44 volumio volumio[1131]: info: CoreStateMachine::startPlaybackTimer
Aug 29 17:57:44 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:44 volumio volumio[1131]: info: ControllerMpd::resume
Aug 29 17:57:44 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand play
Aug 29 17:57:44 volumio volumio[1131]: info: sendMpdCommand play took 1 milliseconds
Aug 29 17:57:46 volumio volumio[1131]: info: CoreCommandRouter::volumioPrevious
Aug 29 17:57:46 volumio volumio[1131]: info: CoreStateMachine::previous
Aug 29 17:57:46 volumio volumio[1131]: info: CoreStateMachine::updateTrackBlock
Aug 29 17:57:46 volumio volumio[1131]: info: CorePlayQueue::getTrackBlock
Aug 29 17:57:46 volumio volumio[1131]: info: CoreStateMachine::serviceClearAddPlay
Aug 29 17:57:46 volumio volumio[1131]: info: CoreCommandRouter::serviceClearAddPlayTracks
Aug 29 17:57:46 volumio volumio[1131]: error: WARNING: No clearAddPlayTracks method for service mpd
Aug 29 17:57:48 volumio volumio[1131]: info: CoreCommandRouter::volumioNext
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::next
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::stop
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::updateTrackBlock
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrackBlock
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::stPlaybackTimer
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrack 2
Aug 29 17:57:48 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:48 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::serviceStop
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrack 2
Aug 29 17:57:48 volumio volumio[1131]: info: CoreCommandRouter::serviceStop
Aug 29 17:57:48 volumio volumio[1131]: info: ControllerMpd::stop
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand stop
Aug 29 17:57:48 volumio volumio[1131]: info: [ASDebug] CurState: stop PrevState: play
Aug 29 17:57:48 volumio volumio[1131]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Aug 29 17:57:48 volumio volumio[1131]: info: sendMpdCommand stop took 18 milliseconds
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::play index undefined
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::startPlaybackTimer
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::clearAddPlayTracks USB/2513-57F5/2Pierwsza_Brygada.mp3
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand stop
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::updateTrackBlock
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrackBlock
Aug 29 17:57:48 volumio volumio[1131]: info: sendMpdCommand stop took 2 milliseconds
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand clear
Aug 29 17:57:48 volumio volumio[1131]: info:
Aug 29 17:57:48 volumio volumio[1131]: ---------------------------- MPD announces system playlist update
Aug 29 17:57:48 volumio volumio[1131]: info: Ignoring MPD Status Update
Aug 29 17:57:48 volumio volumio[1131]: info: sendMpdCommand clear took 2 milliseconds
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand add "USB/2513-57F5/2Pierwsza_Brygada.mp3"
Aug 29 17:57:48 volumio volumio[1131]: error: updateQueue error: null
Aug 29 17:57:48 volumio volumio[1131]: info:
Aug 29 17:57:48 volumio volumio[1131]: ---------------------------- MPD announces system playlist update
Aug 29 17:57:48 volumio volumio[1131]: info: Ignoring MPD Status Update
Aug 29 17:57:48 volumio volumio[1131]: info: ------------------------------ 6ms
Aug 29 17:57:48 volumio volumio[1131]: info: sendMpdCommand add "USB/2513-57F5/2Pierwsza_Brygada.mp3" took 4 milliseconds
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand play
Aug 29 17:57:48 volumio volumio[1131]: info: ------------------------------ 3ms
Aug 29 17:57:48 volumio volumio[1131]: info:
Aug 29 17:57:48 volumio volumio[1131]: ---------------------------- MPD announces state update: player
Aug 29 17:57:48 volumio volumio[1131]: info: sendMpdCommand play took 5 milliseconds
Aug 29 17:57:48 volumio volumio[1131]: info: ControllerMpd::getState
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status
Aug 29 17:57:48 volumio volumio[1131]: info:
Aug 29 17:57:48 volumio volumio[1131]: ---------------------------- MPD announces state update: player
Aug 29 17:57:48 volumio volumio[1131]: info: sendMpdCommand status took 3 milliseconds
Aug 29 17:57:48 volumio volumio[1131]: info: ControllerMpd::getState
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::parseState
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 29 17:57:48 volumio volumio[1131]: info: sendMpdCommand status took 2 milliseconds
Aug 29 17:57:48 volumio volumio[1131]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::parseState
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::parseTrackInfo
Aug 29 17:57:48 volumio volumio[1131]: info: ControllerMpd::pushState
Aug 29 17:57:48 volumio volumio[1131]: info: CoreCommandRouter::servicePushState
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:48 volumio volumio[1131]: [361B blob data]
Aug 29 17:57:48 volumio volumio[1131]: verbose: CURRENT POSITION 3
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::syncState stateService play
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus stop
Aug 29 17:57:48 volumio volumio[1131]: info: ------------------------------ 13ms
Aug 29 17:57:48 volumio volumio[1131]: info: sendMpdCommand playlistinfo took 4 milliseconds
Aug 29 17:57:48 volumio volumio[1131]: verbose: ControllerMpd::parseTrackInfo
Aug 29 17:57:48 volumio volumio[1131]: info: ControllerMpd::pushState
Aug 29 17:57:48 volumio volumio[1131]: info: CoreCommandRouter::servicePushState
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:48 volumio volumio[1131]: [361B blob data]
Aug 29 17:57:48 volumio volumio[1131]: verbose: CURRENT POSITION 3
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::syncState stateService play
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus play
Aug 29 17:57:48 volumio volumio[1131]: info: Received an update from plugin. extracting info from payload
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:48 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:48 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:48 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:48 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:48 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:48 volumio volumio[1131]: info: ------------------------------ 47ms
Aug 29 17:57:48 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:48 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:51 volumio volumio[1131]: info: CoreCommandRouter::volumioSeek
Aug 29 17:57:51 volumio volumio[1131]: info: CoreStateMachine::seek
Aug 29 17:57:51 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:51 volumio volumio[1131]: [420B blob data]
Aug 29 17:57:51 volumio volumio[1131]: info: CoreStateMachine::startPlaybackTimer
Aug 29 17:57:51 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:51 volumio volumio[1131]: info: ControllerMpd::seek
Aug 29 17:57:51 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:51 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:51 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:51 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:51 volumio volumio[1131]: error: null
Aug 29 17:57:51 volumio volumio[1131]: info:
Aug 29 17:57:51 volumio volumio[1131]: ---------------------------- MPD announces state update: player
Aug 29 17:57:51 volumio volumio[1131]: info: ControllerMpd::getState
Aug 29 17:57:51 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status
Aug 29 17:57:51 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:51 volumio volumio[1131]: info: sendMpdCommand status took 9 milliseconds
Aug 29 17:57:51 volumio volumio[1131]: verbose: ControllerMpd::parseState
Aug 29 17:57:51 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 29 17:57:51 volumio volumio[1131]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 29 17:57:51 volumio volumio[1131]: verbose: ControllerMpd::parseTrackInfo
Aug 29 17:57:51 volumio volumio[1131]: info: ControllerMpd::pushState
Aug 29 17:57:51 volumio volumio[1131]: info: CoreCommandRouter::servicePushState
Aug 29 17:57:51 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:51 volumio volumio[1131]: [371B blob data]
Aug 29 17:57:51 volumio volumio[1131]: verbose: CURRENT POSITION 3
Aug 29 17:57:51 volumio volumio[1131]: info: CoreStateMachine::syncState stateService play
Aug 29 17:57:51 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus play
Aug 29 17:57:51 volumio volumio[1131]: info: Received an update from plugin. extracting info from payload
Aug 29 17:57:51 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:51 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:51 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:51 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:51 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:51 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:51 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:51 volumio volumio[1131]: info: ------------------------------ 45ms
Aug 29 17:57:51 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:51 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::volumioNext
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::next
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::stop
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::stPlaybackTimer
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::updateTrackBlock
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrackBlock
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::serviceStop
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 3
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::serviceStop
Aug 29 17:57:52 volumio volumio[1131]: info: ControllerMpd::stop
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand stop
Aug 29 17:57:52 volumio volumio[1131]: info: [ASDebug] CurState: stop PrevState: play
Aug 29 17:57:52 volumio volumio[1131]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Aug 29 17:57:52 volumio volumio[1131]: info:
Aug 29 17:57:52 volumio volumio[1131]: ---------------------------- MPD announces state update: player
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand stop took 13 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: info: ControllerMpd::getState
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::play index undefined
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::startPlaybackTimer
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::clearAddPlayTracks USB/2513-57F5/9Szlak_Powstania_Wielkopolskiego.wav
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand stop
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::updateTrackBlock
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrackBlock
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand status took 14 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand stop took 12 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::parseState
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand clear
Aug 29 17:57:52 volumio volumio[1131]: info:
Aug 29 17:57:52 volumio volumio[1131]: ---------------------------- MPD announces system playlist update
Aug 29 17:57:52 volumio volumio[1131]: info: Ignoring MPD Status Update
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand playlistinfo took 5 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand clear took 4 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::parseTrackInfo
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand add "USB/2513-57F5/9Szlak_Powstania_Wielkopolskiego.wav"
Aug 29 17:57:52 volumio volumio[1131]: info: ControllerMpd::pushState
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::servicePushState
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: [358B blob data]
Aug 29 17:57:52 volumio volumio[1131]: verbose: CURRENT POSITION 4
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::syncState stateService stop
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus stop
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:52 volumio volumio[1131]: info: No code
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:52 volumio volumio[1131]: info: ------------------------------ 64ms
Aug 29 17:57:52 volumio volumio[1131]: error: updateQueue error: null
Aug 29 17:57:52 volumio volumio[1131]: info:
Aug 29 17:57:52 volumio volumio[1131]: ---------------------------- MPD announces system playlist update
Aug 29 17:57:52 volumio volumio[1131]: info: Ignoring MPD Status Update
Aug 29 17:57:52 volumio volumio[1131]: info: ------------------------------ 47ms
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand add "USB/2513-57F5/9Szlak_Powstania_Wielkopolskiego.wav" took 45 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand play
Aug 29 17:57:52 volumio volumio[1131]: info: [ASDebug] CurState: stop PrevState: play
Aug 29 17:57:52 volumio volumio[1131]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Aug 29 17:57:52 volumio volumio[1131]: info: [ASDebug] CurState: stop PrevState: play
Aug 29 17:57:52 volumio volumio[1131]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Aug 29 17:57:52 volumio volumio[1131]: info: [ASDebug] CurState: stop PrevState: play
Aug 29 17:57:52 volumio volumio[1131]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Aug 29 17:57:52 volumio volumio[1131]: info: ------------------------------ 21ms
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand play took 20 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: info:
Aug 29 17:57:52 volumio volumio[1131]: ---------------------------- MPD announces state update: player
Aug 29 17:57:52 volumio volumio[1131]: info: ControllerMpd::getState
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status
Aug 29 17:57:52 volumio volumio[1131]: info:
Aug 29 17:57:52 volumio volumio[1131]: ---------------------------- MPD announces state update: player
Aug 29 17:57:52 volumio volumio[1131]: info: ControllerMpd::getState
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand status took 3 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::parseState
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand status took 6 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand playlistinfo took 5 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::parseState
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::parseTrackInfo
Aug 29 17:57:52 volumio volumio[1131]: info: ControllerMpd::pushState
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::servicePushState
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":91,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"9Szlak_Powstania_Wielkopolskiego.wav","artist":null,"album":null,"uri":"USB/2513-57F5/9Szlak_Powstania_Wielkopolskiego.wav","trackType":"wav"}
Aug 29 17:57:52 volumio volumio[1131]: verbose: CURRENT POSITION 4
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::syncState stateService play
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus stop
Aug 29 17:57:52 volumio volumio[1131]: info: ------------------------------ 15ms
Aug 29 17:57:52 volumio volumio[1131]: info: sendMpdCommand playlistinfo took 5 milliseconds
Aug 29 17:57:52 volumio volumio[1131]: verbose: ControllerMpd::parseTrackInfo
Aug 29 17:57:52 volumio volumio[1131]: info: ControllerMpd::pushState
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::servicePushState
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":91,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"9Szlak_Powstania_Wielkopolskiego.wav","artist":null,"album":null,"uri":"USB/2513-57F5/9Szlak_Powstania_Wielkopolskiego.wav","trackType":"wav"}
Aug 29 17:57:52 volumio volumio[1131]: verbose: CURRENT POSITION 4
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::syncState stateService play
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus play
Aug 29 17:57:52 volumio volumio[1131]: info: Received an update from plugin. extracting info from payload
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:52 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:52 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:52 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:53 volumio volumio[1131]: info: ------------------------------ 44ms
Aug 29 17:57:53 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:53 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:54 volumio volumio[1131]: info: CoreCommandRouter::volumioSeek
Aug 29 17:57:54 volumio volumio[1131]: info: CoreStateMachine::seek
Aug 29 17:57:54 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:54 volumio volumio[1131]: info: TRACKBLOCK {"uri":"mnt/USB/2513-57F5/9Szlak_Powstania_Wielkopolskiego.wav","service":"mpd","name":"9Szlak_Powstania_Wielkopolskiego.wav","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=366&web=//extralarge&path=%2FUSB%2F2513-57F5&metadata=false","duration":91,"trackType":"wav","samplerate":48,"bitdepth":"32 bit","channels":2}
Aug 29 17:57:54 volumio volumio[1131]: info: CoreStateMachine::startPlaybackTimer
Aug 29 17:57:54 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:54 volumio volumio[1131]: info: ControllerMpd::seek
Aug 29 17:57:54 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:54 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:54 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 29 17:57:54 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:54 volumio volumio[1131]: error: null
Aug 29 17:57:54 volumio volumio[1131]: info:
Aug 29 17:57:54 volumio volumio[1131]: ---------------------------- MPD announces state update: player
Aug 29 17:57:54 volumio volumio[1131]: info: ControllerMpd::getState
Aug 29 17:57:54 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status
Aug 29 17:57:54 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:54 volumio volumio[1131]: info: sendMpdCommand status took 7 milliseconds
Aug 29 17:57:54 volumio volumio[1131]: verbose: ControllerMpd::parseState
Aug 29 17:57:54 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 29 17:57:54 volumio volumio[1131]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 29 17:57:54 volumio volumio[1131]: verbose: ControllerMpd::parseTrackInfo
Aug 29 17:57:54 volumio volumio[1131]: info: ControllerMpd::pushState
Aug 29 17:57:54 volumio volumio[1131]: info: CoreCommandRouter::servicePushState
Aug 29 17:57:54 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:54 volumio volumio[1131]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17000,"duration":91,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"9Szlak_Powstania_Wielkopolskiego.wav","artist":null,"album":null,"uri":"USB/2513-57F5/9Szlak_Powstania_Wielkopolskiego.wav","trackType":"wav"}
Aug 29 17:57:54 volumio volumio[1131]: verbose: CURRENT POSITION 4
Aug 29 17:57:54 volumio volumio[1131]: info: CoreStateMachine::syncState stateService play
Aug 29 17:57:54 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus play
Aug 29 17:57:54 volumio volumio[1131]: info: Received an update from plugin. extracting info from payload
Aug 29 17:57:54 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:54 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:54 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:54 volumio volumio[1131]: info: CoreStateMachine::pushState
Aug 29 17:57:54 volumio volumio[1131]: info: CorePlayQueue::getTrack 4
Aug 29 17:57:54 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState
Aug 29 17:57:55 volumio volumio[1131]: info: ------------------------------ 41ms
Aug 29 17:57:55 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:57:55 volumio volumio[1131]: info: [ASDebug] CurState: play PrevState: play
Aug 29 17:58:16 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 29 17:58:16 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 29 17:58:21 volumio volumio[1131]: info: Starting Uninstall of plugin system_controller - ampswitch
Aug 29 17:58:21 volumio volumio[1131]: info: Uninstalling plugin ampswitch
Aug 29 17:58:21 volumio volumio[1131]: info: [ASDebug] Port: 24
Aug 29 17:58:21 volumio volumio[1131]: info: [ASDebug] Inverted: false
Aug 29 17:58:21 volumio volumio[1131]: info: [ASDebug] Delay: 720
Aug 29 17:58:26 volumio volumio[1131]: info: [ASDebug] Port: 24
Aug 29 17:58:26 volumio volumio[1131]: info: [ASDebug] Inverted: false
Aug 29 17:58:26 volumio volumio[1131]: info: [ASDebug] Delay: 720
Aug 29 17:58:26 volumio volumio[1131]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 29 17:58:26 volumio volumio[1131]: Error: EBADF: bad file descriptor, close
Aug 29 17:58:26 volumio volumio[1131]: at Object.closeSync (fs.js:439:3)
Aug 29 17:58:26 volumio volumio[1131]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20)
Aug 29 17:58:26 volumio volumio[1131]: at Object. (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27)
Aug 29 17:58:26 volumio volumio[1131]: at Object.closeSync (/data/plugins/system_hardware/gpio-buttons/node_modules/graceful-fs/graceful-fs.js:51:27)
Aug 29 17:58:26 volumio volumio[1131]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8)
Aug 29 17:58:26 volumio volumio[1131]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19)
Aug 29 17:58:26 volumio volumio[1131]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10)
Aug 29 17:58:26 volumio volumio[1131]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Aug 29 17:58:26 volumio volumio[1131]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8)
Aug 29 17:58:26 volumio volumio[1131]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) {
Aug 29 17:58:26 volumio volumio[1131]: errno: -9,
Aug 29 17:58:26 volumio volumio[1131]: syscall: 'close',
Aug 29 17:58:26 volumio volumio[1131]: code: 'EBADF'
Aug 29 17:58:26 volumio volumio[1131]: }
Aug 29 17:58:26 volumio volumio[1131]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 29 17:58:27 volumio sudo[2010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-29 17:57
Aug 29 17:58:27 volumio sudo[2010]: 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"