-- Logs begin at Wed 2024-04-24 19:36:17 EEST, end at Wed 2024-04-24 20:56:23 EEST. --
Apr 24 20:55:32 coro ntpd[660]: 83.137.41.14 local addr 192.168.1.243 ->
Apr 24 20:55:40 coro volumio[4221]: info: Starting Uninstall of plugin system_hardware - gpio-buttons
Apr 24 20:55:40 coro volumio[4221]: info: Uninstalling plugin gpio-buttons
Apr 24 20:55:40 coro volumio[4221]: info: Disabling plugin gpio-buttons
Apr 24 20:55:40 coro volumio[4221]: info: Checking if uninstall.sh is present
Apr 24 20:55:40 coro volumio[4221]: info: Executing uninstall.sh
Apr 24 20:55:40 coro sudo[4861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/gpio-buttons/uninstall.sh
Apr 24 20:55:40 coro sudo[4861]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 20:55:40 coro sudo[4861]: pam_unix(sudo:session): session closed for user root
Apr 24 20:55:40 coro volumio[4221]: info: Uninstall script completed
Apr 24 20:55:40 coro volumio[4221]: info: Removing plugin gpio-buttons from configuration
Apr 24 20:55:40 coro volumio[4221]: info: Successfully removed gpio-buttons configuration files
Apr 24 20:55:40 coro volumio[4221]: info: Plugin folders cleanup
Apr 24 20:55:40 coro volumio[4221]: info: Scanning into folder /volumio/app/plugins/
Apr 24 20:55:40 coro volumio[4221]: info: Scanning category audio_interface
Apr 24 20:55:40 coro volumio[4221]: info: Scanning category miscellanea
Apr 24 20:55:40 coro volumio[4221]: info: Scanning category music_service
Apr 24 20:55:40 coro volumio[4221]: info: Scanning category plugins.json
Apr 24 20:55:40 coro volumio[4221]: info: Scanning category system_controller
Apr 24 20:55:40 coro volumio[4221]: info: Scanning category user_interface
Apr 24 20:55:40 coro volumio[4221]: info: Scanning into folder /data/plugins/
Apr 24 20:55:40 coro volumio[4221]: info: Scanning category music_service
Apr 24 20:55:40 coro volumio[4221]: info: Scanning category system_controller
Apr 24 20:55:40 coro volumio[4221]: info: Scanning category system_hardware
Apr 24 20:55:40 coro volumio[4221]: info: Cleaning folder for gpio-buttons
Apr 24 20:55:41 coro volumio[4221]: info: Scanning category user_interface
Apr 24 20:55:41 coro volumio[4221]: info: Plugin folders cleanup completed
Apr 24 20:55:41 coro volumio[4221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 24 20:55:41 coro volumio[4221]: info: [{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Calm Radio","name":"calmradio","category":"music_service","version":"1.2.4","icon":"fa-heartbeat","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.0.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.0","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Music Services Shield","name":"music_services_shield","category":"system_hardware","version":"1.3.1","icon":"fa-shield","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Rotary Encoder II","name":"rotaryencoder2","category":"system_hardware","version":"1.0.22","icon":"fa-circle-o-notch","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"PeppyMeter Screensaver","name":"peppy_screensaver","category":"user_interface","version":"2.0.0","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":false,"active":false},{"prettyName":"Touch Display","name":"touch_display","category":"user_interface","version":"3.4.0","icon":"fa-hand-pointer-o","isManuallyInstalled":false,"enabled":true,"active":true}]
Apr 24 20:55:41 coro volumio[4221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Apr 24 20:56:02 coro volumio[4221]: info: Starting Uninstall of plugin system_controller - ampswitch
Apr 24 20:56:02 coro volumio[4221]: info: Uninstalling plugin ampswitch
Apr 24 20:56:02 coro volumio[4221]: info: [ASDebug] Port: 24
Apr 24 20:56:02 coro volumio[4221]: info: [ASDebug] Inverted: false
Apr 24 20:56:02 coro volumio[4221]: info: [ASDebug] Delay: 720
Apr 24 20:56:10 coro volumio[4221]: info: Enabling plugin ampswitch
Apr 24 20:56:10 coro volumio[4221]: info: Loading plugin "ampswitch"...
Apr 24 20:56:10 coro volumio[4221]: info: Applying required configuration parameters for plugin ampswitch
Apr 24 20:56:10 coro volumio[4221]: info: PLUGIN START: ampswitch
Apr 24 20:56:10 coro volumio[4221]: info: Done.
Apr 24 20:56:10 coro volumio[4221]: info: CoreCommandRouter::volumioGetState
Apr 24 20:56:10 coro volumio[4221]: info: CorePlayQueue::getTrack 0
Apr 24 20:56:10 coro volumio[4221]: info: [ASDebug] CurState: stop PrevState: stop
Apr 24 20:56:10 coro volumio[4221]: info: [ASDebug] CurState: stop PrevState: stop
Apr 24 20:56:10 coro volumio[4221]: info: [ASDebug] CurState: stop PrevState: stop
Apr 24 20:56:14 coro volumio[4221]: info: Starting Uninstall of plugin system_controller - ampswitch
Apr 24 20:56:14 coro volumio[4221]: info: Uninstalling plugin ampswitch
Apr 24 20:56:14 coro volumio[4221]: info: [ASDebug] Port: 24
Apr 24 20:56:14 coro volumio[4221]: info: [ASDebug] Inverted: false
Apr 24 20:56:14 coro volumio[4221]: info: [ASDebug] Delay: 720
Apr 24 20:56:21 coro volumio[4221]: info: CoreCommandRouter::volumioPlay
Apr 24 20:56:21 coro volumio[4221]: info: CoreStateMachine::play index undefined
Apr 24 20:56:21 coro volumio[4221]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 24 20:56:21 coro volumio[4221]: info: CorePlayQueue::getTrack 0
Apr 24 20:56:21 coro volumio[4221]: info: CoreStateMachine::startPlaybackTimer
Apr 24 20:56:21 coro volumio[4221]: info: CorePlayQueue::getTrack 0
Apr 24 20:56:21 coro volumio[4221]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 24 20:56:21 coro volumio[4221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 20:56:21 coro volumio[4221]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 24 20:56:21 coro volumio[4221]: info: [1713981381018] ControllerWebradio::clearAddPlayTrack
Apr 24 20:56:21 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand stop
Apr 24 20:56:21 coro volumio[4221]: info: sendMpdCommand stop took 2 milliseconds
Apr 24 20:56:21 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand clear
Apr 24 20:56:21 coro volumio[4221]: info:
Apr 24 20:56:21 coro volumio[4221]: ---------------------------- MPD announces system playlist update
Apr 24 20:56:21 coro volumio[4221]: info: Ignoring MPD Status Update
Apr 24 20:56:21 coro volumio[4221]: info: sendMpdCommand clear took 8 milliseconds
Apr 24 20:56:21 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand load "http://online.kissfm.ua/KissFM_Digital"
Apr 24 20:56:21 coro volumio[4221]: error: updateQueue error: null
Apr 24 20:56:21 coro volumio[4221]: info: ------------------------------ 9ms
Apr 24 20:56:21 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand add "http://online.kissfm.ua/KissFM_Digital"
Apr 24 20:56:21 coro volumio[4221]: info:
Apr 24 20:56:21 coro volumio[4221]: ---------------------------- MPD announces system playlist update
Apr 24 20:56:21 coro volumio[4221]: info: Ignoring MPD Status Update
Apr 24 20:56:21 coro volumio[4221]: info: sendMpdCommand add "http://online.kissfm.ua/KissFM_Digital" took 4 milliseconds
Apr 24 20:56:21 coro volumio[4221]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 24 20:56:21 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand play
Apr 24 20:56:21 coro volumio[4221]: info: ------------------------------ 12ms
Apr 24 20:56:21 coro volumio[4221]: info: sendMpdCommand play took 6 milliseconds
Apr 24 20:56:22 coro volumio[4221]: info:
Apr 24 20:56:22 coro volumio[4221]: ---------------------------- MPD announces state update: player
Apr 24 20:56:22 coro volumio[4221]: info: ControllerMpd::getState
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand status
Apr 24 20:56:22 coro volumio[4221]: info:
Apr 24 20:56:22 coro volumio[4221]: ---------------------------- MPD announces system playlist update
Apr 24 20:56:22 coro volumio[4221]: info: Ignoring MPD Status Update
Apr 24 20:56:22 coro volumio[4221]: info:
Apr 24 20:56:22 coro volumio[4221]: ---------------------------- MPD announces state update: player
Apr 24 20:56:22 coro volumio[4221]: info: sendMpdCommand status took 42 milliseconds
Apr 24 20:56:22 coro volumio[4221]: info: ControllerMpd::getState
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand status
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::parseState
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 24 20:56:22 coro volumio[4221]: info:
Apr 24 20:56:22 coro volumio[4221]: ---------------------------- MPD announces system playlist update
Apr 24 20:56:22 coro volumio[4221]: info: Ignoring MPD Status Update
Apr 24 20:56:22 coro volumio[4221]: info:
Apr 24 20:56:22 coro volumio[4221]: ---------------------------- MPD announces state update: player
Apr 24 20:56:22 coro volumio[4221]: info: ------------------------------ 26ms
Apr 24 20:56:22 coro volumio[4221]: info: sendMpdCommand status took 13 milliseconds
Apr 24 20:56:22 coro volumio[4221]: info: ControllerMpd::getState
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand status
Apr 24 20:56:22 coro volumio[4221]: info: sendMpdCommand playlistinfo took 13 milliseconds
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::parseState
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::parseTrackInfo
Apr 24 20:56:22 coro volumio[4221]: info: ControllerMpd::pushState
Apr 24 20:56:22 coro volumio[4221]: info: CoreCommandRouter::servicePushState
Apr 24 20:56:22 coro volumio[4221]: info: CorePlayQueue::getTrack 0
Apr 24 20:56:22 coro volumio[4221]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Wassermann - W.I.R. (Dj Hell Mix)","artist":"Kiss FM Digital","album":null,"uri":"http://online.kissfm.ua/KissFM_Digital","trackType":""}
Apr 24 20:56:22 coro volumio[4221]: verbose: CURRENT POSITION 0
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::syncState stateService play
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::syncState currentStatus stop
Apr 24 20:56:22 coro volumio[4221]: info: ------------------------------ 82ms
Apr 24 20:56:22 coro volumio[4221]: info: ------------------------------ 24ms
Apr 24 20:56:22 coro volumio[4221]: info: sendMpdCommand status took 16 milliseconds
Apr 24 20:56:22 coro volumio[4221]: info: sendMpdCommand playlistinfo took 15 milliseconds
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::parseState
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::parseTrackInfo
Apr 24 20:56:22 coro volumio[4221]: info: ControllerMpd::pushState
Apr 24 20:56:22 coro volumio[4221]: info: CoreCommandRouter::servicePushState
Apr 24 20:56:22 coro volumio[4221]: info: CorePlayQueue::getTrack 0
Apr 24 20:56:22 coro volumio[4221]: verbose: STATE SERVICE {"status":"play","position":0,"seek":377,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Wassermann - W.I.R. (Dj Hell Mix)","artist":"Kiss FM Digital","album":null,"uri":"http://online.kissfm.ua/KissFM_Digital","trackType":""}
Apr 24 20:56:22 coro volumio[4221]: verbose: CURRENT POSITION 0
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::syncState stateService play
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::syncState currentStatus play
Apr 24 20:56:22 coro volumio[4221]: info: Received an update from plugin. extracting info from payload
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::pushState
Apr 24 20:56:22 coro volumio[4221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 20:56:22 coro volumio[4221]: info: CoreCommandRouter::volumioPushState
Apr 24 20:56:22 coro volumio[4221]: info: MRS: Pushing multiroomSync output update for this device
Apr 24 20:56:22 coro volumio[4221]: info: MRS: Pushing multiroomSync output
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::pushState
Apr 24 20:56:22 coro volumio[4221]: info: CoreCommandRouter::volumioPushState
Apr 24 20:56:22 coro volumio[4221]: info: MRS: Pushing multiroomSync output update for this device
Apr 24 20:56:22 coro volumio[4221]: info: MRS: Pushing multiroomSync output
Apr 24 20:56:22 coro volumio[4221]: info: ------------------------------ 172ms
Apr 24 20:56:22 coro volumio[4221]: info: sendMpdCommand playlistinfo took 126 milliseconds
Apr 24 20:56:22 coro volumio[4221]: verbose: ControllerMpd::parseTrackInfo
Apr 24 20:56:22 coro volumio[4221]: info: ControllerMpd::pushState
Apr 24 20:56:22 coro volumio[4221]: info: CoreCommandRouter::servicePushState
Apr 24 20:56:22 coro volumio[4221]: info: CorePlayQueue::getTrack 0
Apr 24 20:56:22 coro volumio[4221]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Wassermann - W.I.R. (Dj Hell Mix)","artist":"Kiss FM Digital","album":null,"uri":"http://online.kissfm.ua/KissFM_Digital","trackType":""}
Apr 24 20:56:22 coro volumio[4221]: verbose: CURRENT POSITION 0
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::syncState stateService play
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::syncState currentStatus play
Apr 24 20:56:22 coro volumio[4221]: info: Received an update from plugin. extracting info from payload
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::pushState
Apr 24 20:56:22 coro volumio[4221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 20:56:22 coro volumio[4221]: info: CoreCommandRouter::volumioPushState
Apr 24 20:56:22 coro volumio[4221]: info: MRS: Pushing multiroomSync output update for this device
Apr 24 20:56:22 coro volumio[4221]: info: MRS: Pushing multiroomSync output
Apr 24 20:56:22 coro volumio[4221]: info: CoreStateMachine::pushState
Apr 24 20:56:22 coro volumio[4221]: info: CoreCommandRouter::volumioPushState
Apr 24 20:56:22 coro volumio[4221]: info: MRS: Pushing multiroomSync output update for this device
Apr 24 20:56:22 coro volumio[4221]: info: MRS: Pushing multiroomSync output
Apr 24 20:56:22 coro volumio[4221]: info: ------------------------------ 200ms
Apr 24 20:56:22 coro volumio[4221]: info: [ASDebug] CurState: play PrevState: stop
Apr 24 20:56:22 coro volumio[4221]: info: [ASDebug] Togle GPIO: ON
Apr 24 20:56:22 coro volumio[4221]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 24 20:56:22 coro volumio[4221]: Error: ESPIPE: invalid seek, write
Apr 24 20:56:22 coro volumio[4221]: at Object.writeSync (fs.js:711:3)
Apr 24 20:56:22 coro volumio[4221]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8)
Apr 24 20:56:22 coro volumio[4221]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:199:23)
Apr 24 20:56:22 coro volumio[4221]: at AmpSwitchController.parseStatus (/data/plugins/system_controller/ampswitch/index.js:182:86)
Apr 24 20:56:22 coro volumio[4221]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20)
Apr 24 20:56:22 coro volumio[4221]: at Socket.onevent (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:278:10)
Apr 24 20:56:22 coro volumio[4221]: at Socket.onpacket (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:236:12)
Apr 24 20:56:22 coro volumio[4221]: at Manager. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15)
Apr 24 20:56:22 coro volumio[4221]: at Manager.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20)
Apr 24 20:56:22 coro volumio[4221]: at Manager.ondecoded (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:349:8)
Apr 24 20:56:22 coro volumio[4221]: at Decoder. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15)
Apr 24 20:56:22 coro volumio[4221]: at Decoder.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20)
Apr 24 20:56:22 coro volumio[4221]: at Decoder.add (/data/plugins/system_controller/ampswitch/node_modules/socket.io-parser/index.js:251:12)
Apr 24 20:56:22 coro volumio[4221]: at Manager.ondata (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:339:16)
Apr 24 20:56:22 coro volumio[4221]: at Socket. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15)
Apr 24 20:56:22 coro volumio[4221]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) {
Apr 24 20:56:22 coro volumio[4221]: errno: -29,
Apr 24 20:56:22 coro volumio[4221]: syscall: 'write',
Apr 24 20:56:22 coro volumio[4221]: code: 'ESPIPE'
Apr 24 20:56:22 coro volumio[4221]: }
Apr 24 20:56:22 coro volumio[4221]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 24 20:56:23 coro sudo[4940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-24 20:55
Apr 24 20:56:23 coro sudo[4940]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d"
VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee"
VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623"
VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST"
VOLUMIO_VERSION="3.661"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"