-- Logs begin at Mon 2025-05-26 06:53:09 UTC, end at Mon 2025-05-26 10:21:17 UTC. -- May 26 10:20:00 volumio volumio[1054]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 26 10:20:00 volumio volumio[1054]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 26 10:20:00 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 10:20:00 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 10:20:00 volumio volumio[1054]: info: Starting MyVolumio Remote Streaming Endpoints May 26 10:20:00 volumio volumio[1054]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 26 10:20:00 volumio volumio[1054]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 26 10:20:00 volumio volumio[1054]: info: Streaming services startup May 26 10:20:00 volumio volumio[1054]: info: Starting Streaming Daemon May 26 10:20:00 volumio sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 26 10:20:00 volumio sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 10:20:00 volumio volumio[1054]: info: MyVolumio not started May 26 10:20:00 volumio volumio[1054]: info: Initializing device activation check May 26 10:20:00 volumio systemd[1]: Stopping Volumio Streaming Daemon... May 26 10:20:00 volumio volumio[1054]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 26 10:20:00 volumio systemd[1]: Starting Volumio Streaming Daemon... May 26 10:20:00 volumio systemd[1]: Started Volumio Streaming Daemon. May 26 10:20:00 volumio sudo[1306]: pam_unix(sudo:session): session closed for user root May 26 10:20:00 volumio volumio-streaming-daemon[1316]: ############################ May 26 10:20:00 volumio volumio-streaming-daemon[1316]: # Volumio Streaming Daemon # May 26 10:20:00 volumio volumio-streaming-daemon[1316]: # Running on port 7777 # May 26 10:20:00 volumio volumio-streaming-daemon[1316]: ############################ May 26 10:20:00 volumio volumio-streaming-daemon[1316]: Environment: production May 26 10:20:00 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 10:20:00 volumio volumio[1054]: info: Listing playlists May 26 10:20:00 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 10:20:00 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 10:20:00 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 10:20:00 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 10:20:02 volumio volumio-streaming-daemon[1316]: Environment: production May 26 10:20:02 volumio volumio[1054]: info: Fetching Streaming Services browse cache May 26 10:20:11 volumio kernel: Voltage normalised (0x00000000) May 26 10:20:16 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 10:20:16 volumio volumio[1054]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 26 10:20:16 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 26 10:20:16 volumio volumio[1054]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio May 26 10:20:16 volumio volumio[1054]: info: Received Get System Version May 26 10:20:16 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 10:20:19 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 10:20:19 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 10:20:22 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 26 10:20:52 volumio volumio[1054]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 10:21:07 volumio volumio[1054]: info: CALLMETHOD: user_interface ledstatus saveSettings [object Object] May 26 10:21:07 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: ledstatus , saveSettings May 26 10:21:07 volumio volumio[1054]: error: Failed callmethod call: Error: The value NaN is not a number May 26 10:21:14 volumio volumio[1054]: info: CoreCommandRouter::volumioPlay May 26 10:21:14 volumio volumio[1054]: verbose: UNSET VOLATILE May 26 10:21:14 volumio volumio[1054]: info: CoreStateMachine::play index undefined May 26 10:21:14 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined May 26 10:21:14 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 26 10:21:14 volumio volumio[1054]: info: CoreStateMachine::startPlaybackTimer May 26 10:21:14 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 26 10:21:14 volumio volumio[1054]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/The Beatles/12 Abbey Road/01 Come Together.m4a May 26 10:21:14 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop May 26 10:21:14 volumio volumio[1054]: info: sendMpdCommand stop took 9 milliseconds May 26 10:21:14 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clear May 26 10:21:14 volumio volumio[1054]: info: May 26 10:21:14 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 26 10:21:14 volumio volumio[1054]: info: Ignoring MPD Status Update May 26 10:21:14 volumio volumio[1054]: info: sendMpdCommand clear took 4 milliseconds May 26 10:21:14 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/The Beatles/12 Abbey Road/01 Come Together.m4a" May 26 10:21:14 volumio volumio[1054]: error: updateQueue error: null May 26 10:21:14 volumio volumio[1054]: info: May 26 10:21:14 volumio volumio[1054]: ---------------------------- MPD announces system playlist update May 26 10:21:14 volumio volumio[1054]: info: Ignoring MPD Status Update May 26 10:21:14 volumio volumio[1054]: info: ------------------------------ 8ms May 26 10:21:14 volumio volumio[1054]: info: sendMpdCommand add "INTERNAL/The Beatles/12 Abbey Road/01 Come Together.m4a" took 5 milliseconds May 26 10:21:14 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand play May 26 10:21:14 volumio volumio[1054]: info: ------------------------------ 6ms May 26 10:21:14 volumio volumio[1054]: info: sendMpdCommand play took 3 milliseconds May 26 10:21:15 volumio volumio[1054]: info: May 26 10:21:15 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 26 10:21:15 volumio volumio[1054]: info: ControllerMpd::getState May 26 10:21:15 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 26 10:21:15 volumio volumio[1054]: info: May 26 10:21:15 volumio volumio[1054]: ---------------------------- MPD announces state update: player May 26 10:21:15 volumio volumio[1054]: info: sendMpdCommand status took 6 milliseconds May 26 10:21:15 volumio volumio[1054]: info: ControllerMpd::getState May 26 10:21:15 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status May 26 10:21:15 volumio volumio[1054]: verbose: ControllerMpd::parseState May 26 10:21:15 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 26 10:21:15 volumio volumio[1054]: info: sendMpdCommand status took 10 milliseconds May 26 10:21:15 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 5 milliseconds May 26 10:21:15 volumio volumio[1054]: verbose: ControllerMpd::parseState May 26 10:21:15 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 26 10:21:15 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 26 10:21:15 volumio volumio[1054]: info: ControllerMpd::pushState May 26 10:21:15 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 26 10:21:15 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 26 10:21:15 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come Together","artist":"The Beatles","album":"Abbey Road","uri":"INTERNAL/The Beatles/12 Abbey Road/01 Come Together.m4a","trackType":"m4a"} May 26 10:21:15 volumio volumio[1054]: verbose: CURRENT POSITION 0 May 26 10:21:15 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play May 26 10:21:15 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop May 26 10:21:15 volumio volumio[1054]: info: CoreStateMachine::pushState May 26 10:21:15 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 26 10:21:15 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 26 10:21:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 10:21:15 volumio volumio[1054]: info: ------------------------------ 66ms May 26 10:21:15 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 41 milliseconds May 26 10:21:15 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo May 26 10:21:15 volumio volumio[1054]: info: ControllerMpd::pushState May 26 10:21:15 volumio volumio[1054]: info: CoreCommandRouter::servicePushState May 26 10:21:15 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 26 10:21:15 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"819 Kbps","isStreaming":false,"title":"Come Together","artist":"The Beatles","album":"Abbey Road","uri":"INTERNAL/The Beatles/12 Abbey Road/01 Come Together.m4a","trackType":"m4a"} May 26 10:21:15 volumio volumio[1054]: verbose: CURRENT POSITION 0 May 26 10:21:15 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play May 26 10:21:15 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play May 26 10:21:15 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload May 26 10:21:15 volumio volumio[1054]: info: CoreStateMachine::pushState May 26 10:21:15 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 26 10:21:15 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 26 10:21:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 10:21:15 volumio volumio[1054]: info: CoreStateMachine::pushState May 26 10:21:15 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 May 26 10:21:15 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState May 26 10:21:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 10:21:15 volumio volumio[1054]: info: ------------------------------ 99ms May 26 10:21:15 volumio volumio[1054]: info: LedStatus: state = play May 26 10:21:15 volumio volumio[1054]: info: LedStatus: play => start blinking led May 26 10:21:15 volumio volumio[1054]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 10:21:15 volumio volumio[1054]: Error: The value undefined is not a number May 26 10:21:15 volumio volumio[1054]: at Config.forceToType (/data/plugins/user_interface/ledstatus/node_modules/v-conf/index.js:322:20) May 26 10:21:15 volumio volumio[1054]: at Config.get (/data/plugins/user_interface/ledstatus/node_modules/v-conf/index.js:137:21) May 26 10:21:15 volumio volumio[1054]: at ledstatus.startBlink (/data/plugins/user_interface/ledstatus/index.js:93:31) May 26 10:21:15 volumio volumio[1054]: at Socket. (/data/plugins/user_interface/ledstatus/index.js:41:26) May 26 10:21:15 volumio volumio[1054]: at Socket.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/component-emitter/index.js:133:20) May 26 10:21:15 volumio volumio[1054]: at Socket.onevent (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/socket.js:270:10) May 26 10:21:15 volumio volumio[1054]: at Socket.onpacket (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/socket.js:228:12) May 26 10:21:15 volumio volumio[1054]: at Manager. (/data/plugins/user_interface/ledstatus/node_modules/component-bind/index.js:21:15) May 26 10:21:15 volumio volumio[1054]: at Manager.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/component-emitter/index.js:133:20) May 26 10:21:15 volumio volumio[1054]: at Manager.ondecoded (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/manager.js:332:8) May 26 10:21:15 volumio volumio[1054]: at Decoder. (/data/plugins/user_interface/ledstatus/node_modules/component-bind/index.js:21:15) May 26 10:21:15 volumio volumio[1054]: at Decoder.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) May 26 10:21:15 volumio volumio[1054]: at Decoder.add (/data/plugins/user_interface/ledstatus/node_modules/socket.io-parser/index.js:246:12) May 26 10:21:15 volumio volumio[1054]: at Manager.ondata (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/manager.js:322:16) May 26 10:21:15 volumio volumio[1054]: at Socket. (/data/plugins/user_interface/ledstatus/node_modules/component-bind/index.js:21:15) May 26 10:21:15 volumio volumio[1054]: at Socket.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/component-emitter/index.js:133:20) May 26 10:21:15 volumio volumio[1054]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 10:21:17 volumio sudo[1516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-26 10:20 May 26 10:21:17 volumio sudo[1516]: 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"