-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Mon 2025-04-28 20:22:46 CEST. -- Apr 28 20:21:16 volumio volumio[1034]: info: Apr 28 20:21:16 volumio volumio[1034]: ---------------------------- MPD announces state update: player Apr 28 20:21:16 volumio volumio[1034]: info: ControllerMpd::getState Apr 28 20:21:16 volumio volumio[1034]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:21:16 volumio volumio[1034]: info: Apr 28 20:21:16 volumio volumio[1034]: ---------------------------- MPD announces state update: player Apr 28 20:21:16 volumio volumio[1034]: info: ControllerMpd::getState Apr 28 20:21:16 volumio volumio[1034]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:21:16 volumio volumio[1034]: info: sendMpdCommand status took 3 milliseconds Apr 28 20:21:16 volumio volumio[1034]: verbose: ControllerMpd::parseState Apr 28 20:21:16 volumio volumio[1034]: info: ControllerMpd::pushState Apr 28 20:21:16 volumio volumio[1034]: info: CoreCommandRouter::servicePushState Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::pushState Apr 28 20:21:16 volumio volumio[1034]: info: CoreCommandRouter::volumioPushState Apr 28 20:21:16 volumio volumio[1034]: info: CorePlayQueue::getTrack 0 Apr 28 20:21:16 volumio volumio[1034]: 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} Apr 28 20:21:16 volumio volumio[1034]: verbose: CURRENT POSITION 0 Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::syncState stateService stop Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::syncState currentStatus play Apr 28 20:21:16 volumio volumio[1034]: info: CoreCommandRouter::volumioPushState Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::stPlaybackTimer Apr 28 20:21:16 volumio volumio[1034]: info: ------------------------------ 14ms Apr 28 20:21:16 volumio volumio[1034]: info: sendMpdCommand status took 13 milliseconds Apr 28 20:21:16 volumio volumio[1034]: verbose: ControllerMpd::parseState Apr 28 20:21:16 volumio volumio[1034]: info: ControllerMpd::pushState Apr 28 20:21:16 volumio volumio[1034]: info: CoreCommandRouter::servicePushState Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::pushState Apr 28 20:21:16 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:21:16 volumio volumio[1034]: info: CoreCommandRouter::volumioPushState Apr 28 20:21:16 volumio volumio[1034]: info: CorePlayQueue::getTrack 0 Apr 28 20:21:16 volumio volumio[1034]: 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} Apr 28 20:21:16 volumio volumio[1034]: verbose: CURRENT POSITION 0 Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::syncState stateService stop Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::pushState Apr 28 20:21:16 volumio volumio[1034]: info: CoreCommandRouter::volumioPushState Apr 28 20:21:16 volumio volumio[1034]: info: No code Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::pushState Apr 28 20:21:16 volumio volumio[1034]: info: CoreCommandRouter::volumioPushState Apr 28 20:21:16 volumio volumio[1034]: info: ------------------------------ 27ms Apr 28 20:21:16 volumio volumio[1034]: info: CoreCommandRouter::volumioGetQueue Apr 28 20:21:16 volumio volumio[1034]: info: CoreStateMachine::getQueue Apr 28 20:21:16 volumio volumio[1034]: info: CorePlayQueue::getQueue Apr 28 20:21:16 volumio volumio[1034]: info: touch_display: Setting screensaver timeout to 1000000000000 seconds. Apr 28 20:21:16 volumio volumio[1034]: info: camilladsp spawned new process with pid 28167, instance 1, run: true Apr 28 20:21:39 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 20:21:39 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 20:21:39 volumio volumio[1034]: info: Discovery: Getting this device information Apr 28 20:21:39 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:39 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 20:21:39 volumio volumio[1034]: verbose: New Socket.io Connection to 192.168.1.97:3000 from 192.168.1.12 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Apr 28 20:21:39 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:39 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 28 20:21:39 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 28 20:21:40 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 20:21:40 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 20:21:40 volumio volumio[1034]: info: Discovery: Getting this device information Apr 28 20:21:40 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:40 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 20:21:48 volumio sudo[28302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 28 20:21:48 volumio sudo[28302]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 20:21:48 volumio sudo[28302]: pam_unix(sudo:session): session closed for user root Apr 28 20:21:48 volumio sudo[28305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 28 20:21:48 volumio sudo[28305]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 20:21:48 volumio sudo[28305]: pam_unix(sudo:session): session closed for user root Apr 28 20:21:48 volumio volumio[1034]: verbose: New Socket.io Connection to 192.168.1.97 from 192.168.1.12 UA: Mozilla/5.0 (Linux; Android 7.0; P00C Build/NRD90M; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/119.0.6045.193 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 28 20:21:49 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 28 20:21:49 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 28 20:21:50 volumio volumio[1034]: info: Received Get System Info Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 20:21:50 volumio volumio[1034]: info: Discovery: Getting this device information Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:50 volumio volumio[1034]: info: Listing playlists Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 28 20:21:50 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 28 20:21:50 volumio sudo[28308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 28 20:21:50 volumio sudo[28308]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 20:21:50 volumio sudo[28308]: pam_unix(sudo:session): session closed for user root Apr 28 20:21:50 volumio sudo[28311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 28 20:21:50 volumio sudo[28311]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 20:21:50 volumio sudo[28311]: pam_unix(sudo:session): session closed for user root Apr 28 20:21:51 volumio volumio[1034]: verbose: New Socket.io Connection to 192.168.1.97 from 192.168.1.12 UA: Mozilla/5.0 (Linux; Android 7.0; P00C Build/NRD90M; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/119.0.6045.193 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 28 20:21:52 volumio volumio[1034]: info: Received Get System Info Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 20:21:52 volumio volumio[1034]: info: Discovery: Getting this device information Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:52 volumio volumio[1034]: info: Listing playlists Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 20:21:52 volumio volumio[1034]: info: Received Get System Info Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 20:21:52 volumio volumio[1034]: info: Discovery: Getting this device information Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 20:21:52 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 28 20:21:53 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 28 20:21:55 volumio volumio[1034]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates. Apr 28 20:21:55 volumio volumio[1034]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:106:19) Apr 28 20:21:55 volumio volumio[1034]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:113:37) Apr 28 20:21:55 volumio volumio[1034]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13 Apr 28 20:21:55 volumio volumio[1034]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Apr 28 20:21:55 volumio volumio[1034]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:144:13) Apr 28 20:21:55 volumio volumio[1034]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:114:3) Apr 28 20:21:55 volumio volumio[1034]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Apr 28 20:21:55 volumio volumio[1034]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15 Apr 28 20:21:55 volumio volumio[1034]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14) Apr 28 20:21:55 volumio volumio[1034]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14) Apr 28 20:21:55 volumio volumio[1034]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3) Apr 28 20:21:55 volumio volumio[1034]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10) Apr 28 20:21:55 volumio volumio[1034]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3) Apr 28 20:21:55 volumio volumio[1034]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12) Apr 28 20:21:55 volumio volumio[1034]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Apr 28 20:21:56 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 20:21:56 volumio volumio[1034]: info: Received Get System Info Apr 28 20:21:56 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 20:21:56 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 20:21:56 volumio volumio[1034]: info: Discovery: Getting this device information Apr 28 20:21:56 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:21:56 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 20:22:01 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 28 20:22:09 volumio volumio[1034]: info: CoreCommandRouter::volumioGetQueue Apr 28 20:22:09 volumio volumio[1034]: info: CoreStateMachine::getQueue Apr 28 20:22:09 volumio volumio[1034]: info: CorePlayQueue::getQueue Apr 28 20:22:09 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 20:22:09 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 20:22:09 volumio volumio[1034]: info: Discovery: Getting this device information Apr 28 20:22:09 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:22:09 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 20:22:16 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:22:27 volumio volumio[1034]: info: CorePlayQueue::getTrack 0 Apr 28 20:22:27 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: mpd , goto Apr 28 20:22:27 volumio volumio[1034]: error: Listalbum songs error: null Apr 28 20:22:28 volumio volumio[1034]: info: No valid Plugin REST Endpoint Apr 28 20:22:28 volumio volumio[1034]: info: No valid Plugin REST Endpoint Apr 28 20:22:39 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 20:22:39 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 20:22:39 volumio volumio[1034]: info: Discovery: Getting this device information Apr 28 20:22:39 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:22:39 volumio volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 20:22:39 volumio volumio[1034]: info: CoreCommandRouter::volumioGetState Apr 28 20:22:46 volumio volumio[1034]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ Apr 28 20:22:46 volumio volumio[1034]: info: PLUGIN onShutdown : networkfs Apr 28 20:22:46 volumio volumio[1034]: info: PLUGIN onShutdown : audiophonicsonoff Apr 28 20:22:46 volumio volumio[1034]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 20:22:46 volumio volumio[1034]: TypeError: Cannot read property 'writeSync' of undefined Apr 28 20:22:46 volumio volumio[1034]: at ControllerAudiophonicsOnOff.onVolumioShutdown (/data/plugins/system_controller/audiophonicsonoff/index.js:43:25) Apr 28 20:22:46 volumio volumio[1034]: at PluginManager.onVolumioShutdownPlugin (/volumio/app/pluginmanager.js:638:30) Apr 28 20:22:46 volumio volumio[1034]: at HashMap. (/volumio/app/pluginmanager.js:621:31) Apr 28 20:22:46 volumio volumio[1034]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Apr 28 20:22:46 volumio volumio[1034]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Apr 28 20:22:46 volumio volumio[1034]: at PluginManager.onVolumioShutdown (/volumio/app/pluginmanager.js:619:20) Apr 28 20:22:46 volumio volumio[1034]: at CoreCommandRouter.shutdown (/volumio/app/index.js:1332:24) Apr 28 20:22:46 volumio volumio[1034]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:859:33) Apr 28 20:22:46 volumio volumio[1034]: at Socket.emit (events.js:315:20) Apr 28 20:22:46 volumio volumio[1034]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Apr 28 20:22:46 volumio volumio[1034]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 28 20:22:46 volumio volumio[1034]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 20:22:46 volumio sudo[28469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-28 20:21 Apr 28 20:22:46 volumio sudo[28469]: 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"