-- Logs begin at Wed 2025-12-10 18:30:31 UTC, end at Thu 2025-12-11 10:48:21 UTC. --
Dec 11 10:48:11 volumio volumio[909]: info: CorePlayQueue::getTrack 3
Dec 11 10:48:11 volumio volumio[909]: info: CorePlayQueue::getTrack 2
Dec 11 10:48:11 volumio volumio[909]: info: Prefetching next song
Dec 11 10:48:11 volumio volumio[909]: info: DOING PREFETCH IN MPD
Dec 11 10:48:11 volumio volumio[909]: info: ControllerMpd::sendMpdCommand add "USB/My Passport_/Musik/Pause/Pause.mp3"
Dec 11 10:48:11 volumio volumio[909]: info: sending command...
Dec 11 10:48:11 volumio volumio[909]: info:
Dec 11 10:48:11 volumio volumio[909]: ---------------------------- MPD announces system playlist update
Dec 11 10:48:11 volumio volumio[909]: info: Ignoring MPD Status Update
Dec 11 10:48:11 volumio volumio[909]: info: parsing response...
Dec 11 10:48:11 volumio volumio[909]: info: ControllerMpd::sendMpdCommand consume 1
Dec 11 10:48:11 volumio volumio[909]: info: sending command...
Dec 11 10:48:11 volumio volumio[909]: info: ------------------------------ 4ms
Dec 11 10:48:11 volumio volumio[909]: info: parsing response...
Dec 11 10:48:15 volumio volumio[909]: info: CoreStateMachine::startPlaybackTimer
Dec 11 10:48:15 volumio volumio[909]: info: CorePlayQueue::getTrack 2
Dec 11 10:48:15 volumio volumio[909]: info: CorePlayQueue::getTrack 2
Dec 11 10:48:15 volumio volumio[909]: info: CorePlayQueue::getTrack 7
Dec 11 10:48:15 volumio volumio[909]: info:
Dec 11 10:48:15 volumio volumio[909]: ---------------------------- MPD announces system playlist update
Dec 11 10:48:15 volumio volumio[909]: info: Ignoring MPD Status Update
Dec 11 10:48:15 volumio volumio[909]: info:
Dec 11 10:48:15 volumio volumio[909]: ---------------------------- MPD announces state update: player
Dec 11 10:48:15 volumio volumio[909]: info: ControllerMpd::getState
Dec 11 10:48:15 volumio volumio[909]: info: ControllerMpd::sendMpdCommand status
Dec 11 10:48:15 volumio volumio[909]: info: sending command...
Dec 11 10:48:15 volumio volumio[909]: info: ------------------------------ 4ms
Dec 11 10:48:16 volumio volumio[909]: info:
Dec 11 10:48:16 volumio volumio[909]: ---------------------------- MPD announces state update: player
Dec 11 10:48:16 volumio volumio[909]: info: parsing response...
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::getState
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::sendMpdCommand status
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::parseState
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::sendMpdCommand playlistinfo
Dec 11 10:48:16 volumio volumio[909]: info: sending command...
Dec 11 10:48:16 volumio volumio[909]: info: sending command...
Dec 11 10:48:16 volumio volumio[909]: info: parsing response...
Dec 11 10:48:16 volumio volumio[909]: info: parsing response...
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::parseState
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::sendMpdCommand playlistinfo
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::parseTrackInfo
Dec 11 10:48:16 volumio volumio[909]: info: sending command...
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::pushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::servicePushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::syncState
Dec 11 10:48:16 volumio volumio[909]: info: CorePlayQueue::getTrack 2
Dec 11 10:48:16 volumio volumio[909]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Pause","artist":"Pause","album":null,"uri":"USB/My Passport_/Musik/Pause/Pause.mp3","trackType":"mp3"}
Dec 11 10:48:16 volumio volumio[909]: info: CURRENT POSITION 2
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::syncState stateService play
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus play
Dec 11 10:48:16 volumio volumio[909]: info: Received an update from plugin. extracting info from payload
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::pushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::getState
Dec 11 10:48:16 volumio volumio[909]: info: CorePlayQueue::getTrack 2
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 11 10:48:16 volumio volumio[909]: info: interfaceApi::pushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::pushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::getState
Dec 11 10:48:16 volumio volumio[909]: info: CorePlayQueue::getTrack 2
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 11 10:48:16 volumio volumio[909]: info: interfaceApi::pushState
Dec 11 10:48:16 volumio volumio[909]: info: ------------------------------ 507ms
Dec 11 10:48:16 volumio volumio[909]: info: parsing response...
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::parseTrackInfo
Dec 11 10:48:16 volumio volumio[909]: info: ControllerMpd::pushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::servicePushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::syncState
Dec 11 10:48:16 volumio volumio[909]: info: CorePlayQueue::getTrack 2
Dec 11 10:48:16 volumio volumio[909]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":5,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Pause","artist":"Pause","album":null,"uri":"USB/My Passport_/Musik/Pause/Pause.mp3","trackType":"mp3"}
Dec 11 10:48:16 volumio volumio[909]: info: CURRENT POSITION 2
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::syncState stateService play
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus play
Dec 11 10:48:16 volumio volumio[909]: info: Received an update from plugin. extracting info from payload
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::pushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::getState
Dec 11 10:48:16 volumio volumio[909]: info: CorePlayQueue::getTrack 2
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 11 10:48:16 volumio volumio[909]: info: interfaceApi::pushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::pushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreStateMachine::getState
Dec 11 10:48:16 volumio volumio[909]: info: CorePlayQueue::getTrack 2
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState
Dec 11 10:48:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 11 10:48:16 volumio volumio[909]: info: interfaceApi::pushState
Dec 11 10:48:16 volumio volumio[909]: info: ------------------------------ 90ms
Dec 11 10:48:16 volumio volumio[909]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/My Passport_/Musik/Pause/Pause.mp3","favourite":false}
Dec 11 10:48:16 volumio volumio[909]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/My Passport_/Musik/Pause/Pause.mp3","favourite":false}
Dec 11 10:48:16 volumio volumio[909]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/My Passport_/Musik/Pause/Pause.mp3","favourite":false}
Dec 11 10:48:16 volumio volumio[909]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/My Passport_/Musik/Pause/Pause.mp3","favourite":false}
Dec 11 10:48:20 volumio volumio[909]: info: CoreStateMachine::startPlaybackTimer
Dec 11 10:48:20 volumio volumio[909]: info: CorePlayQueue::getTrack 7
Dec 11 10:48:20 volumio volumio[909]: info: CorePlayQueue::getTrack 7
Dec 11 10:48:20 volumio volumio[909]: info: CorePlayQueue::getTrack 6
Dec 11 10:48:20 volumio volumio[909]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 11 10:48:20 volumio volumio[909]: TypeError: Cannot read property 'service' of undefined
Dec 11 10:48:20 volumio volumio[909]: at CoreStateMachine.increasePlaybackTimer (/volumio/app/statemachine.js:443:97)
Dec 11 10:48:20 volumio volumio[909]: at ontimeout (timers.js:482:11)
Dec 11 10:48:20 volumio volumio[909]: at tryOnTimeout (timers.js:317:5)
Dec 11 10:48:20 volumio volumio[909]: at Timer.listOnTimeout (timers.js:277:5)
Dec 11 10:48:20 volumio volumio[909]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 11 10:48:21 volumio sudo[30350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-11 10:47
Dec 11 10:48:21 volumio sudo[30350]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="d0d14b37ffe8e45861e4e0b9816241fbafb4eb91"
VOLUMIO_FE_VERSION="81c7100e9c7342b16fc9e0ca5908a26771e08c4f"
VOLUMIO_BE_VERSION="645f0e55945bdd625a662a1ee21ba0dfb11bd73e"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Jun 21 01:30:10 CEST 2018"
VOLUMIO_VERSION="2.413"
VOLUMIO_HARDWARE="pi"