-- Logs begin at Mon 2024-04-29 21:29:08 UTC, end at Mon 2024-04-29 22:01:01 UTC. -- Apr 29 22:00:21 volumiobox volumio[913]: info: CALLMETHOD: system_controller gpio-buttons saveConfig [object Object] Apr 29 22:00:21 volumiobox volumio[913]: info: CoreCommandRouter::executeOnPlugin: gpio-buttons , saveConfig Apr 29 22:00:21 volumiobox volumio[913]: info: GPIO-Buttons: Destroying trigger 0 Apr 29 22:00:21 volumiobox volumio[913]: info: GPIO-Buttons: Reading config and creating triggers... Apr 29 22:00:21 volumiobox volumio[913]: info: GPIO-Buttons: playPause on pin 6 Apr 29 22:00:27 volumiobox volumio[913]: info: CoreCommandRouter::volumioGetState Apr 29 22:00:27 volumiobox volumio[913]: info: CoreCommandRouter::volumioStop Apr 29 22:00:27 volumiobox volumio[913]: info: CoreStateMachine::stop Apr 29 22:00:27 volumiobox volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 22:00:27 volumiobox volumio[913]: verbose: UNSET VOLATILE Apr 29 22:00:31 volumiobox volumio[913]: info: CoreCommandRouter::volumioGetState Apr 29 22:00:31 volumiobox volumio[913]: info: CorePlayQueue::getTrack 0 Apr 29 22:00:31 volumiobox volumio[913]: info: CoreCommandRouter::volumioPlay Apr 29 22:00:31 volumiobox volumio[913]: verbose: UNSET VOLATILE Apr 29 22:00:31 volumiobox volumio[913]: info: CoreStateMachine::play index undefined Apr 29 22:00:31 volumiobox volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 22:00:31 volumiobox volumio[913]: info: CorePlayQueue::getTrack 0 Apr 29 22:00:31 volumiobox volumio[913]: info: CoreStateMachine::startPlaybackTimer Apr 29 22:00:31 volumiobox volumio[913]: info: CorePlayQueue::getTrack 0 Apr 29 22:00:31 volumiobox volumio[913]: info: [1714428031026] ControllerWebradio::clearAddPlayTrack Apr 29 22:00:31 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand stop Apr 29 22:00:31 volumiobox volumio[913]: info: sendMpdCommand stop took 12 milliseconds Apr 29 22:00:31 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand clear Apr 29 22:00:31 volumiobox volumio[913]: info: Apr 29 22:00:31 volumiobox volumio[913]: ---------------------------- MPD announces system playlist update Apr 29 22:00:31 volumiobox volumio[913]: info: Ignoring MPD Status Update Apr 29 22:00:31 volumiobox volumio[913]: info: sendMpdCommand clear took 3 milliseconds Apr 29 22:00:31 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664" Apr 29 22:00:31 volumiobox volumio[913]: error: updateQueue error: null Apr 29 22:00:31 volumiobox volumio[913]: info: ------------------------------ 7ms Apr 29 22:00:31 volumiobox volumio[913]: info: Apr 29 22:00:31 volumiobox volumio[913]: ---------------------------- MPD announces system playlist update Apr 29 22:00:31 volumiobox volumio[913]: info: Ignoring MPD Status Update Apr 29 22:00:31 volumiobox volumio[913]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664" took 239 milliseconds Apr 29 22:00:31 volumiobox volumio[913]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 29 22:00:31 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand play Apr 29 22:00:31 volumiobox volumio[913]: info: ------------------------------ 11ms Apr 29 22:00:31 volumiobox volumio[913]: info: sendMpdCommand play took 8 milliseconds Apr 29 22:00:37 volumiobox volumio[913]: info: CoreCommandRouter::volumioGetState Apr 29 22:00:37 volumiobox volumio[913]: info: CoreCommandRouter::volumioStop Apr 29 22:00:37 volumiobox volumio[913]: info: CoreStateMachine::stop Apr 29 22:00:37 volumiobox volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 22:00:37 volumiobox volumio[913]: verbose: UNSET VOLATILE Apr 29 22:00:44 volumiobox volumio[913]: info: CoreCommandRouter::volumioGetState Apr 29 22:00:44 volumiobox volumio[913]: info: CorePlayQueue::getTrack 0 Apr 29 22:00:44 volumiobox volumio[913]: info: CoreCommandRouter::volumioPlay Apr 29 22:00:44 volumiobox volumio[913]: verbose: UNSET VOLATILE Apr 29 22:00:44 volumiobox volumio[913]: info: CoreStateMachine::play index undefined Apr 29 22:00:44 volumiobox volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 22:00:44 volumiobox volumio[913]: info: CorePlayQueue::getTrack 0 Apr 29 22:00:44 volumiobox volumio[913]: info: CoreStateMachine::startPlaybackTimer Apr 29 22:00:44 volumiobox volumio[913]: info: CorePlayQueue::getTrack 0 Apr 29 22:00:44 volumiobox volumio[913]: info: [1714428044978] ControllerWebradio::clearAddPlayTrack Apr 29 22:00:44 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand stop Apr 29 22:00:45 volumiobox volumio[913]: info: sendMpdCommand stop took 28 milliseconds Apr 29 22:00:45 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand clear Apr 29 22:00:45 volumiobox volumio[913]: info: Apr 29 22:00:45 volumiobox volumio[913]: ---------------------------- MPD announces state update: player Apr 29 22:00:45 volumiobox volumio[913]: info: Apr 29 22:00:45 volumiobox volumio[913]: ---------------------------- MPD announces system playlist update Apr 29 22:00:45 volumiobox volumio[913]: info: Ignoring MPD Status Update Apr 29 22:00:45 volumiobox volumio[913]: info: ControllerMpd::getState Apr 29 22:00:45 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand status Apr 29 22:00:45 volumiobox volumio[913]: info: sendMpdCommand clear took 4 milliseconds Apr 29 22:00:45 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664" Apr 29 22:00:45 volumiobox volumio[913]: error: updateQueue error: null Apr 29 22:00:45 volumiobox volumio[913]: info: sendMpdCommand status took 5 milliseconds Apr 29 22:00:45 volumiobox volumio[913]: info: ------------------------------ 8ms Apr 29 22:00:45 volumiobox volumio[913]: verbose: ControllerMpd::parseState Apr 29 22:00:45 volumiobox volumio[913]: info: ControllerMpd::pushState Apr 29 22:00:45 volumiobox volumio[913]: info: CoreCommandRouter::servicePushState Apr 29 22:00:45 volumiobox volumio[913]: info: CoreStateMachine::pushState Apr 29 22:00:45 volumiobox volumio[913]: info: CorePlayQueue::getTrack 0 Apr 29 22:00:45 volumiobox volumio[913]: info: CoreCommandRouter::volumioPushState Apr 29 22:00:45 volumiobox volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 22:00:45 volumiobox volumio[913]: info: CorePlayQueue::getTrack 0 Apr 29 22:00:45 volumiobox volumio[913]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 29 22:00:45 volumiobox volumio[913]: info: ------------------------------ 25ms Apr 29 22:00:45 volumiobox volumio[913]: info: [GPIO_Control] Turning GPIO 20 Off (musicStop) Apr 29 22:00:45 volumiobox volumio[913]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664" took 101 milliseconds Apr 29 22:00:45 volumiobox volumio[913]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 29 22:00:45 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand play Apr 29 22:00:45 volumiobox volumio[913]: info: Apr 29 22:00:45 volumiobox volumio[913]: ---------------------------- MPD announces system playlist update Apr 29 22:00:45 volumiobox volumio[913]: info: Ignoring MPD Status Update Apr 29 22:00:45 volumiobox volumio[913]: info: sendMpdCommand play took 3 milliseconds Apr 29 22:00:45 volumiobox volumio[913]: info: ------------------------------ 8ms Apr 29 22:00:59 volumiobox volumio[913]: info: Apr 29 22:00:59 volumiobox volumio[913]: ---------------------------- MPD announces state update: player Apr 29 22:00:59 volumiobox volumio[913]: info: ControllerMpd::getState Apr 29 22:00:59 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand status Apr 29 22:00:59 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 29 22:00:59 volumiobox volumio[913]: info: sendMpdCommand status took 10 milliseconds Apr 29 22:00:59 volumiobox volumio[913]: verbose: ControllerMpd::parseState Apr 29 22:00:59 volumiobox volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 22:00:59 volumiobox volumio[913]: info: sendMpdCommand clearerror took 6 milliseconds Apr 29 22:00:59 volumiobox volumio[913]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 29 22:00:59 volumiobox volumio[913]: verbose: ControllerMpd::parseTrackInfo Apr 29 22:00:59 volumiobox volumio[913]: info: ControllerMpd::pushState Apr 29 22:00:59 volumiobox volumio[913]: info: CoreCommandRouter::servicePushState Apr 29 22:00:59 volumiobox volumio[913]: info: CoreStateMachine::pushState Apr 29 22:00:59 volumiobox volumio[913]: info: CoreCommandRouter::volumioPushState Apr 29 22:00:59 volumiobox volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 22:00:59 volumiobox volumio[913]: info: CorePlayQueue::getTrack 0 Apr 29 22:00:59 volumiobox volumio[913]: verbose: STATE SERVICE {"status":"stop","position":21,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":"(#22 - 571/10005) ANTENA1 | 94,7 FM","album":null,"uri":"https://51.79.17.214:8232/stream/1","trackType":""} Apr 29 22:00:59 volumiobox volumio[913]: verbose: CURRENT POSITION 0 Apr 29 22:00:59 volumiobox volumio[913]: info: CoreStateMachine::syncState stateService stop Apr 29 22:00:59 volumiobox volumio[913]: info: CoreStateMachine::syncState currentStatus stop Apr 29 22:00:59 volumiobox volumio[913]: info: CoreStateMachine::pushState Apr 29 22:00:59 volumiobox volumio[913]: info: CoreCommandRouter::volumioPushState Apr 29 22:00:59 volumiobox volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 22:00:59 volumiobox volumio[913]: info: No code Apr 29 22:00:59 volumiobox volumio[913]: info: CoreStateMachine::pushState Apr 29 22:00:59 volumiobox volumio[913]: info: CoreCommandRouter::volumioPushState Apr 29 22:00:59 volumiobox volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 22:00:59 volumiobox volumio[913]: info: ------------------------------ 71ms Apr 29 22:00:59 volumiobox volumio[913]: info: [GPIO_Control] Turning GPIO 15 On (musicPlay) Apr 29 22:00:59 volumiobox volumio[913]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 22:00:59 volumiobox volumio[913]: { Error: ENODEV: no such device, write Apr 29 22:00:59 volumiobox volumio[913]: at Object.fs.writeSync (fs.js:735:20) Apr 29 22:00:59 volumiobox volumio[913]: at Gpio.writeSync (/data/plugins/system_controller/gpio_control/node_modules/onoff/onoff.js:212:6) Apr 29 22:00:59 volumiobox volumio[913]: at /data/plugins/system_controller/gpio_control/index.js:297:9 Apr 29 22:00:59 volumiobox volumio[913]: at Array.forEach () Apr 29 22:00:59 volumiobox volumio[913]: at GPIOControl.handleEvent (/data/plugins/system_controller/gpio_control/index.js:294:13) Apr 29 22:00:59 volumiobox volumio[913]: at GPIOControl.statusChanged (/data/plugins/system_controller/gpio_control/index.js:283:8) Apr 29 22:00:59 volumiobox volumio[913]: at Socket.Emitter.emit (/data/plugins/system_controller/gpio_control/node_modules/component-emitter/index.js:133:20) Apr 29 22:00:59 volumiobox volumio[913]: at Socket.onevent (/data/plugins/system_controller/gpio_control/node_modules/socket.io-client/lib/socket.js:270:10) Apr 29 22:00:59 volumiobox volumio[913]: at Socket.onpacket (/data/plugins/system_controller/gpio_control/node_modules/socket.io-client/lib/socket.js:228:12) Apr 29 22:00:59 volumiobox volumio[913]: at Manager. (/data/plugins/system_controller/gpio_control/node_modules/component-bind/index.js:21:15) Apr 29 22:00:59 volumiobox volumio[913]: at Manager.Emitter.emit (/data/plugins/system_controller/gpio_control/node_modules/component-emitter/index.js:133:20) Apr 29 22:00:59 volumiobox volumio[913]: at Manager.ondecoded (/data/plugins/system_controller/gpio_control/node_modules/socket.io-client/lib/manager.js:332:8) Apr 29 22:00:59 volumiobox volumio[913]: at Decoder. (/data/plugins/system_controller/gpio_control/node_modules/component-bind/index.js:21:15) Apr 29 22:00:59 volumiobox volumio[913]: at Decoder.Emitter.emit (/data/plugins/system_controller/gpio_control/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Apr 29 22:00:59 volumiobox volumio[913]: at Decoder.add (/data/plugins/system_controller/gpio_control/node_modules/socket.io-parser/index.js:246:12) Apr 29 22:00:59 volumiobox volumio[913]: at Manager.ondata (/data/plugins/system_controller/gpio_control/node_modules/socket.io-client/lib/manager.js:322:16) errno: -19, code: 'ENODEV', syscall: 'write' } Apr 29 22:00:59 volumiobox volumio[913]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 22:01:01 volumiobox sudo[5577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-29 22:00 Apr 29 22:01:01 volumiobox sudo[5577]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"