-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Thu 2025-01-16 19:03:26 +07. -- Jan 16 19:02:05 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:02:11 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:02:17 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:02:23 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:02:29 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:02:35 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:02:42 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:02:48 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:02:54 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:03:11 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:03:17 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:03:23 volumio wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 5 Jan 16 19:03:23 volumio volumio[958]: info: Prefetching next song Jan 16 19:03:23 volumio volumio[958]: info: Doing Prefetch in UPNP Jan 16 19:03:23 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.131:10243/WMPNSSv4/3726294527/0_MTRfNTU1OGM0YTFfYmJjM2ZjMGEtMTUxOTQ.mp3" Jan 16 19:03:23 volumio volumio[958]: info: Jan 16 19:03:23 volumio volumio[958]: ---------------------------- MPD announces system playlist update Jan 16 19:03:23 volumio volumio[958]: info: Ignoring MPD Status Update Jan 16 19:03:23 volumio volumio[958]: info: sendMpdCommand add "http://192.168.0.131:10243/WMPNSSv4/3726294527/0_MTRfNTU1OGM0YTFfYmJjM2ZjMGEtMTUxOTQ.mp3" took 4 milliseconds Jan 16 19:03:23 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 16 19:03:23 volumio volumio[958]: info: Jan 16 19:03:23 volumio volumio[958]: ---------------------------- MPD announces system playlist update Jan 16 19:03:23 volumio volumio[958]: info: Ignoring MPD Status Update Jan 16 19:03:23 volumio volumio[958]: info: Jan 16 19:03:23 volumio volumio[958]: ---------------------------- MPD announces state update: options Jan 16 19:03:23 volumio volumio[958]: info: ------------------------------ 8ms Jan 16 19:03:23 volumio volumio[958]: info: sendMpdCommand consume 1 took 5 milliseconds Jan 16 19:03:23 volumio volumio[958]: info: ControllerMpd::getState Jan 16 19:03:23 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Jan 16 19:03:23 volumio volumio[958]: info: ------------------------------ 6ms Jan 16 19:03:23 volumio volumio[958]: info: Jan 16 19:03:23 volumio volumio[958]: ---------------------------- MPD announces state update: options Jan 16 19:03:23 volumio volumio[958]: info: ControllerMpd::getState Jan 16 19:03:23 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Jan 16 19:03:23 volumio volumio[958]: info: sendMpdCommand status took 3 milliseconds Jan 16 19:03:23 volumio volumio[958]: info: sendMpdCommand status took 1 milliseconds Jan 16 19:03:23 volumio volumio[958]: verbose: ControllerMpd::parseState Jan 16 19:03:23 volumio volumio[958]: verbose: ControllerMpd::parseState Jan 16 19:03:23 volumio volumio[958]: info: ControllerMpd::pushState Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::servicePushState Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::pushState Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Jan 16 19:03:23 volumio volumio[958]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 16 19:03:23 volumio volumio[958]: verbose: CURRENT POSITION 4 Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::syncState stateService stop Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::pushState Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 5 Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::pushState Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 5 Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Jan 16 19:03:23 volumio volumio[958]: info: ControllerMpd::pushState Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::servicePushState Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::pushState Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 5 Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 5 Jan 16 19:03:23 volumio volumio[958]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 16 19:03:23 volumio volumio[958]: verbose: CURRENT POSITION 5 Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::syncState stateService stop Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::pushState Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 5 Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Jan 16 19:03:23 volumio volumio[958]: info: No code Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::pushState Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getTrack 5 Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Jan 16 19:03:23 volumio volumio[958]: info: ------------------------------ 51ms Jan 16 19:03:23 volumio volumio[958]: info: ------------------------------ 49ms Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] CurState: play PrevState: play Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] CurState: stop PrevState: play Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] CurState: stop PrevState: play Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] CurState: stop PrevState: play Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] CurState: stop PrevState: play Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] CurState: stop PrevState: play Jan 16 19:03:23 volumio volumio[958]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 16 19:03:23 volumio volumio[958]: info: CoreCommandRouter::volumioGetQueue Jan 16 19:03:23 volumio volumio[958]: info: CoreStateMachine::getQueue Jan 16 19:03:23 volumio volumio[958]: info: CorePlayQueue::getQueue Jan 16 19:03:24 volumio volumio[958]: info: touch_display: Setting screensaver timeout to 3600 seconds. Jan 16 19:03:24 volumio volumio[958]: info: [ASDebug] Togle GPIO: OFF Jan 16 19:03:24 volumio volumio[958]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 16 19:03:24 volumio volumio[958]: Error: ESPIPE: invalid seek, write Jan 16 19:03:24 volumio volumio[958]: at Object.writeSync (fs.js:711:3) Jan 16 19:03:24 volumio volumio[958]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) Jan 16 19:03:24 volumio volumio[958]: at AmpSwitchController.off (/data/plugins/system_controller/ampswitch/index.js:221:23) Jan 16 19:03:24 volumio volumio[958]: at Timeout._onTimeout (/data/plugins/system_controller/ampswitch/index.js:195:88) Jan 16 19:03:24 volumio volumio[958]: at listOnTimeout (internal/timers.js:554:17) Jan 16 19:03:24 volumio volumio[958]: at processTimers (internal/timers.js:497:7) { Jan 16 19:03:24 volumio volumio[958]: errno: -29, Jan 16 19:03:24 volumio volumio[958]: syscall: 'write', Jan 16 19:03:24 volumio volumio[958]: code: 'ESPIPE' Jan 16 19:03:24 volumio volumio[958]: } Jan 16 19:03:24 volumio volumio[958]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 16 19:03:26 volumio sudo[11296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-16 19:02 Jan 16 19:03:26 volumio sudo[11296]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"