-- Logs begin at Sat 2024-10-19 13:46:13 CEST, end at Sat 2024-10-19 17:36:43 CEST. --
Oct 19 17:35:00 volumio ntpd[669]: 178.239.19.58 local addr 192.168.1.66 ->
Oct 19 17:35:31 volumio volumio[853]: info: CALLMETHOD: system_hardware gpio_control saveConfig [object Object]
Oct 19 17:35:31 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: gpio_control , saveConfig
Oct 19 17:35:31 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
Oct 19 17:36:12 volumio volumio[853]: info: CALLMETHOD: system_hardware gpio_control saveConfig [object Object]
Oct 19 17:36:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: gpio_control , saveConfig
Oct 19 17:36:12 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
Oct 19 17:36:16 volumio volumio[853]: info: CoreCommandRouter::volumioGetState
Oct 19 17:36:41 volumio volumio[853]: info: CoreCommandRouter::volumioPause
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::pause
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::stPlaybackTimer
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::servicePause
Oct 19 17:36:41 volumio volumio[853]: info: CorePlayQueue::getTrack 16
Oct 19 17:36:41 volumio volumio[853]: info: CoreCommandRouter::servicePause
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 19 17:36:41 volumio volumio[853]: info: ControllerMpd::pause
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand pause
Oct 19 17:36:41 volumio volumio[853]: info: sendMpdCommand pause took 1 milliseconds
Oct 19 17:36:41 volumio volumio[853]: info: ControllerMpd::getState
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand status
Oct 19 17:36:41 volumio volumio[853]: info:
Oct 19 17:36:41 volumio volumio[853]: ---------------------------- MPD announces state update: player
Oct 19 17:36:41 volumio volumio[853]: info: ControllerMpd::getState
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand status
Oct 19 17:36:41 volumio volumio[853]: info:
Oct 19 17:36:41 volumio volumio[853]: ---------------------------- MPD announces state update: player
Oct 19 17:36:41 volumio volumio[853]: info: ControllerMpd::getState
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand status
Oct 19 17:36:41 volumio volumio[853]: info:
Oct 19 17:36:41 volumio volumio[853]: ---------------------------- MPD announces state update: player
Oct 19 17:36:41 volumio volumio[853]: info: ControllerMpd::getState
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand status
Oct 19 17:36:41 volumio volumio[853]: info: sendMpdCommand status took 5 milliseconds
Oct 19 17:36:41 volumio volumio[853]: info: sendMpdCommand status took 5 milliseconds
Oct 19 17:36:41 volumio volumio[853]: info: sendMpdCommand status took 3 milliseconds
Oct 19 17:36:41 volumio volumio[853]: info: sendMpdCommand status took 2 milliseconds
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::parseState
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::parseState
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::parseState
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::parseState
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 19 17:36:41 volumio volumio[853]: info: sendMpdCommand playlistinfo took 3 milliseconds
Oct 19 17:36:41 volumio volumio[853]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 19 17:36:41 volumio volumio[853]: info: sendMpdCommand playlistinfo took 3 milliseconds
Oct 19 17:36:41 volumio volumio[853]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::parseTrackInfo
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::parseTrackInfo
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::parseTrackInfo
Oct 19 17:36:41 volumio volumio[853]: verbose: ControllerMpd::parseTrackInfo
Oct 19 17:36:41 volumio volumio[853]: info: ControllerMpd::pushState
Oct 19 17:36:41 volumio volumio[853]: info: CoreCommandRouter::servicePushState
Oct 19 17:36:41 volumio volumio[853]: info: CorePlayQueue::getTrack 16
Oct 19 17:36:41 volumio volumio[853]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":292985,"duration":314,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Man On The Moon","artist":"R.E.M.","album":"Automatic For The People","uri":"https://rr4---sn-uhvcpaxoa-5hne.googlevideo.com/videoplayback?expire=1729373504&ei=4NATZ_HwK4aG6dsPocTX-QY&ip=188.88.79.188&id=o-AJ5p2-MX0PCb9-lb-9UesxpbgS-W1gnlCeG5REPTKtdX&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1729351904%2C&mh=S-&mm=31%2C29&mn=sn-uhvcpaxoa-5hne%2Csn-5hne6nsr&ms=au%2Crdu&mv=m&mvi=4&pcm2cms=yes&pl=19&rms=au%2Cau&ctier=A&pfa=5&gcr=nl&initcwndbps=2297500&hightc=yes&siu=1&bui=AXLXGFTujSgNz2vGTJ2CBBsGk8zCrMpzgPHXF3K_LDRygPg7j-wGXPYcr66RuXpP9Sdjo_dIwA&spc=54MbxdsQK3iymBDaMb8Sa5bpQ4BCGcTMhElTeYGIxGEed7SFWOUSVYYR0kTfbhw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QZrPhe0VlywNv9IHi6L9bLEQ&rqh=1&gir=yes&clen=10468598&dur=314.181&lmt=1714537605352657&mt=1729351519&fvip=3&keepalive=yes&fexp=51312688&c=WEB_REMIX&sefc=1&txp=5432434&n=1KCt1prGk7RvHQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACJ0pHgwRgIhAPoZJXcvBk8-b1V1YlWMTPb9IMdaDt6fZEUxujGfNhJtAiEApGjVdb8Hh42KwaYGX4uO_1DufDU0OrXs1YLIecyg-cE%3D&sig=AJfQdSswRQIgZNGHvwJ_r-L5xK97uSTGTxD1Emq28JhT5ZnDuydnhG8CIQDwra05OHEvlHc5f41MR7hty-GHNm99O_USIAJlX6Pr3A%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
Oct 19 17:36:41 volumio volumio[853]: verbose: CURRENT POSITION 16
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::syncState stateService pause
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::syncState currentStatus pause
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::pushState
Oct 19 17:36:41 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 19 17:36:41 volumio volumio[853]: info: CoreCommandRouter::volumioPushState
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::stPlaybackTimer
Oct 19 17:36:41 volumio volumio[853]: info: ControllerMpd::pushState
Oct 19 17:36:41 volumio volumio[853]: info: CoreCommandRouter::servicePushState
Oct 19 17:36:41 volumio volumio[853]: info: CorePlayQueue::getTrack 16
Oct 19 17:36:41 volumio volumio[853]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":292985,"duration":314,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Man On The Moon","artist":"R.E.M.","album":"Automatic For The People","uri":"https://rr4---sn-uhvcpaxoa-5hne.googlevideo.com/videoplayback?expire=1729373504&ei=4NATZ_HwK4aG6dsPocTX-QY&ip=188.88.79.188&id=o-AJ5p2-MX0PCb9-lb-9UesxpbgS-W1gnlCeG5REPTKtdX&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1729351904%2C&mh=S-&mm=31%2C29&mn=sn-uhvcpaxoa-5hne%2Csn-5hne6nsr&ms=au%2Crdu&mv=m&mvi=4&pcm2cms=yes&pl=19&rms=au%2Cau&ctier=A&pfa=5&gcr=nl&initcwndbps=2297500&hightc=yes&siu=1&bui=AXLXGFTujSgNz2vGTJ2CBBsGk8zCrMpzgPHXF3K_LDRygPg7j-wGXPYcr66RuXpP9Sdjo_dIwA&spc=54MbxdsQK3iymBDaMb8Sa5bpQ4BCGcTMhElTeYGIxGEed7SFWOUSVYYR0kTfbhw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QZrPhe0VlywNv9IHi6L9bLEQ&rqh=1&gir=yes&clen=10468598&dur=314.181&lmt=1714537605352657&mt=1729351519&fvip=3&keepalive=yes&fexp=51312688&c=WEB_REMIX&sefc=1&txp=5432434&n=1KCt1prGk7RvHQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACJ0pHgwRgIhAPoZJXcvBk8-b1V1YlWMTPb9IMdaDt6fZEUxujGfNhJtAiEApGjVdb8Hh42KwaYGX4uO_1DufDU0OrXs1YLIecyg-cE%3D&sig=AJfQdSswRQIgZNGHvwJ_r-L5xK97uSTGTxD1Emq28JhT5ZnDuydnhG8CIQDwra05OHEvlHc5f41MR7hty-GHNm99O_USIAJlX6Pr3A%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
Oct 19 17:36:41 volumio volumio[853]: verbose: CURRENT POSITION 16
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::syncState stateService pause
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::syncState currentStatus pause
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::pushState
Oct 19 17:36:41 volumio volumio[853]: info: CoreCommandRouter::volumioPushState
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::stPlaybackTimer
Oct 19 17:36:41 volumio volumio[853]: info: ControllerMpd::pushState
Oct 19 17:36:41 volumio volumio[853]: info: CoreCommandRouter::servicePushState
Oct 19 17:36:41 volumio volumio[853]: info: CorePlayQueue::getTrack 16
Oct 19 17:36:41 volumio volumio[853]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":292985,"duration":314,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Man On The Moon","artist":"R.E.M.","album":"Automatic For The People","uri":"https://rr4---sn-uhvcpaxoa-5hne.googlevideo.com/videoplayback?expire=1729373504&ei=4NATZ_HwK4aG6dsPocTX-QY&ip=188.88.79.188&id=o-AJ5p2-MX0PCb9-lb-9UesxpbgS-W1gnlCeG5REPTKtdX&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1729351904%2C&mh=S-&mm=31%2C29&mn=sn-uhvcpaxoa-5hne%2Csn-5hne6nsr&ms=au%2Crdu&mv=m&mvi=4&pcm2cms=yes&pl=19&rms=au%2Cau&ctier=A&pfa=5&gcr=nl&initcwndbps=2297500&hightc=yes&siu=1&bui=AXLXGFTujSgNz2vGTJ2CBBsGk8zCrMpzgPHXF3K_LDRygPg7j-wGXPYcr66RuXpP9Sdjo_dIwA&spc=54MbxdsQK3iymBDaMb8Sa5bpQ4BCGcTMhElTeYGIxGEed7SFWOUSVYYR0kTfbhw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=QZrPhe0VlywNv9IHi6L9bLEQ&rqh=1&gir=yes&clen=10468598&dur=314.181&lmt=1714537605352657&mt=1729351519&fvip=3&keepalive=yes&fexp=51312688&c=WEB_REMIX&sefc=1&txp=5432434&n=1KCt1prGk7RvHQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACJ0pHgwRgIhAPoZJXcvBk8-b1V1YlWMTPb9IMdaDt6fZEUxujGfNhJtAiEApGjVdb8Hh42KwaYGX4uO_1DufDU0OrXs1YLIecyg-cE%3D&sig=AJfQdSswRQIgZNGHvwJ_r-L5xK97uSTGTxD1Emq28JhT5ZnDuydnhG8CIQDwra05OHEvlHc5f41MR7hty-GHNm99O_USIAJlX6Pr3A%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
Oct 19 17:36:41 volumio volumio[853]: verbose: CURRENT POSITION 16
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::syncState stateService pause
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::syncState currentStatus pause
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::pushState
Oct 19 17:36:41 volumio volumio[853]: info: CoreCommandRouter::volumioPushState
Oct 19 17:36:41 volumio volumio[853]: info: CoreStateMachine::stPlaybackTimer
Oct 19 17:36:41 volumio volumio[853]: info: ------------------------------ 38ms
Oct 19 17:36:41 volumio volumio[853]: info: ------------------------------ 37ms
Oct 19 17:36:41 volumio volumio[853]: info: ------------------------------ 36ms
Oct 19 17:36:41 volumio volumio[853]: info: [ASDebug] CurState: pause PrevState: play
Oct 19 17:36:41 volumio volumio[853]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Oct 19 17:36:41 volumio volumio[853]: info: touch_display: Setting screensaver timeout to 1200 seconds.
Oct 19 17:36:41 volumio volumio[853]: info: [ASDebug] CurState: pause PrevState: play
Oct 19 17:36:41 volumio volumio[853]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Oct 19 17:36:41 volumio volumio[853]: info: [ASDebug] CurState: pause PrevState: play
Oct 19 17:36:41 volumio volumio[853]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Oct 19 17:36:42 volumio volumio[853]: info: [ASDebug] Togle GPIO: OFF
Oct 19 17:36:42 volumio volumio[853]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 19 17:36:42 volumio volumio[853]: Error: ENODEV: no such device, write
Oct 19 17:36:42 volumio volumio[853]: at Object.writeSync (fs.js:711:3)
Oct 19 17:36:42 volumio volumio[853]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8)
Oct 19 17:36:42 volumio volumio[853]: at AmpSwitchController.off (/data/plugins/system_controller/ampswitch/index.js:215:23)
Oct 19 17:36:42 volumio volumio[853]: at Timeout._onTimeout (/data/plugins/system_controller/ampswitch/index.js:187:88)
Oct 19 17:36:42 volumio volumio[853]: at listOnTimeout (internal/timers.js:554:17)
Oct 19 17:36:42 volumio volumio[853]: at processTimers (internal/timers.js:497:7) {
Oct 19 17:36:42 volumio volumio[853]: errno: -19,
Oct 19 17:36:42 volumio volumio[853]: syscall: 'write',
Oct 19 17:36:42 volumio volumio[853]: code: 'ENODEV'
Oct 19 17:36:42 volumio volumio[853]: }
Oct 19 17:36:42 volumio volumio[853]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 19 17:36:43 volumio sudo[3949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-19 17:35
Oct 19 17:36:43 volumio sudo[3949]: 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="9552505bba4239c163ac9ee7b0b87a56e0dd0574"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="3d3fc502273a5c173ba19f72c1a952bdb2bdd3b0"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 Feb 2024 06:28:23 PM CET"
VOLUMIO_VERSION="3.616"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="b343c71baf05cbc21bf1a530c8e51fc1"