-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Wed 2024-11-27 19:00:50 CST. -- Nov 27 18:59:00 volumio volumio[900]: info: MyVolumio token set successfully Nov 27 18:59:00 volumio volumio[900]: info: MYVOLUMIO: Adding device Nov 27 18:59:00 volumio volumio[900]: info: MYVOLUMIO: Evaluating Server Nov 27 18:59:00 volumio volumio-remote-updater[588]: [2024-11-27 18:59:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732705137 101 Nov 27 18:59:00 volumio volumio[900]: STREAMING PROXY: Starting server on port 3245 Nov 27 18:59:00 volumio volumio[900]: Node JS runtime: 14 Nov 27 18:59:02 volumio volumio[900]: info: MyVolumio status changed Nov 27 18:59:02 volumio volumio[900]: info: Streaming services startup Nov 27 18:59:02 volumio volumio[900]: info: Starting Streaming Daemon Nov 27 18:59:02 volumio volumio[900]: info: Removing browser output: myVolumio user plan is not superstar Nov 27 18:59:04 volumio volumio[900]: info: Removing audio output: Nov 27 18:59:04 volumio volumio[900]: info: Stoppping Tunnel 1 Nov 27 18:59:06 volumio sudo[2052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 27 18:59:06 volumio sudo[2059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 27 18:59:06 volumio sudo[2052]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:59:06 volumio sudo[2059]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:59:06 volumio sudo[2052]: pam_unix(sudo:session): session closed for user root Nov 27 18:59:06 volumio volumio[900]: error: Cannot start Volumio Streaming Daemon Nov 27 18:59:06 volumio volumio[900]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 27 18:59:06 volumio volumio[900]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 27 18:59:06 volumio sudo[2059]: pam_unix(sudo:session): session closed for user root Nov 27 18:59:06 volumio volumio[900]: info: Remote SSH Stopped Nov 27 18:59:06 volumio volumio[900]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Nov 27 18:59:07 volumio volumio[900]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 27 18:59:07 volumio volumio[900]: info: Completed starting MyVolumio Plugin Nov 27 18:59:07 volumio volumio[900]: [Metrics] CommandRouter: 129s 610.01ms Nov 27 18:59:07 volumio volumio[900]: info: CoreCommandRouter::volumiosetStartupVolume Nov 27 18:59:07 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:59:07 volumio volumio[900]: info: VolumeController:: Setting startup Volume 5 Nov 27 18:59:07 volumio volumio[900]: info: VolumeController::SetAlsaVolume5 Nov 27 18:59:07 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:59:07 volumio volumio[900]: info: CoreCommandRouter::Close All Modals sent Nov 27 18:59:07 volumio volumio[900]: info: CoreCommandRouter::Close All Modals sent Nov 27 18:59:07 volumio volumio[900]: info: CoreStateMachine::pushState Nov 27 18:59:07 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:07 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:59:07 volumio volumio[900]: info: CoreCommandRouter::volumioPushState Nov 27 18:59:07 volumio volumio[900]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=30.27995&lon=120.16221: Error: Response error: 401 - Unauthorized Nov 27 18:59:07 volumio volumio[900]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 27 18:59:07 volumio volumio[900]: at runMicrotasks () Nov 27 18:59:07 volumio volumio[900]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 27 18:59:07 volumio volumio[900]: at async Promise.all (index 1) Nov 27 18:59:07 volumio volumio[900]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Nov 27 18:59:07 volumio volumio[900]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Nov 27 18:59:07 volumio volumio[900]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Nov 27 18:59:07 volumio volumio[900]: info: [now-playing] Fetching API key... Nov 27 18:59:07 volumio volumio[900]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=30.27995&lon=120.16221: Error: Response error: 401 - Unauthorized Nov 27 18:59:07 volumio volumio[900]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 27 18:59:07 volumio volumio[900]: at runMicrotasks () Nov 27 18:59:07 volumio volumio[900]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 27 18:59:07 volumio volumio[900]: at async Promise.all (index 0) Nov 27 18:59:07 volumio volumio[900]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 27 18:59:07 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 27 18:59:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 27 18:59:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 27 18:59:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 27 18:59:09 volumio volumio[900]: info: Listing playlists Nov 27 18:59:09 volumio volumio[900]: info: CoreCommandRouter::volumioGetQueue Nov 27 18:59:09 volumio volumio[900]: info: CoreStateMachine::getQueue Nov 27 18:59:09 volumio volumio[900]: info: CorePlayQueue::getQueue Nov 27 18:59:09 volumio volumio[900]: info: CoreCommandRouter::volumioGetVisibleSources Nov 27 18:59:09 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:59:10 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:10 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:10 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 27 18:59:10 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:10 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:10 volumio volumio[900]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Nov 27 18:59:10 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:11 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:15 volumio avahi-daemon[569]: avahi_normalize_name() failed. Nov 27 18:59:16 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:59:16 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:59:16 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 27 18:59:16 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 27 18:59:16 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 27 18:59:16 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 27 18:59:16 volumio volumio[900]: info: CoreCommandRouter::volumioGetBrowseSources Nov 27 18:59:16 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 18:59:16 volumio volumio[900]: info: BOOT COMPLETED Nov 27 18:59:17 volumio volumio[900]: info: Setting Geolocation for MyVolumio to us2 Nov 27 18:59:17 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:59:17 volumio volumio[900]: info: volroon::Roon Core Paired: 192.168.2.210:9330 with ID of: 66172c63-26dc-4d6a-a759-1fec387ac1d8 Nov 27 18:59:17 volumio volumio[900]: error: volroon::Metadata - ReferenceError: roonPausedTimer is not defined Nov 27 18:59:17 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 18:59:17 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Nov 27 18:59:17 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 18:59:17 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 18:59:18 volumio volumio[900]: info: Updating MyVolumio device info Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:59:18 volumio volumio[900]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Nov 27 18:59:18 volumio volumio[900]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 27 18:59:18 volumio volumio[900]: info: Listing playlists Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::volumioGetQueue Nov 27 18:59:18 volumio volumio[900]: info: CoreStateMachine::getQueue Nov 27 18:59:18 volumio volumio[900]: info: CorePlayQueue::getQueue Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::volumioGetVisibleSources Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:18 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:18 volumio volumio[900]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 27 18:59:18 volumio volumio[900]: info: Listing playlists Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::volumioGetQueue Nov 27 18:59:18 volumio volumio[900]: info: CoreStateMachine::getQueue Nov 27 18:59:18 volumio volumio[900]: info: CorePlayQueue::getQueue Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::volumioGetVisibleSources Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:59:18 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:18 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:18 volumio volumio[900]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 27 18:59:18 volumio volumio[900]: info: [now-playing] OpenWeatherMap API key obtained. Nov 27 18:59:18 volumio volumio[900]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 27 18:59:19 volumio volumio[900]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=30.27995&lon=120.16221: Error: Response error: 401 - Unauthorized Nov 27 18:59:19 volumio volumio[900]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 27 18:59:19 volumio volumio[900]: at runMicrotasks () Nov 27 18:59:19 volumio volumio[900]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 27 18:59:19 volumio volumio[900]: at async Promise.all (index 0) Nov 27 18:59:19 volumio volumio[900]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Nov 27 18:59:19 volumio volumio[900]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Nov 27 18:59:19 volumio volumio[900]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Nov 27 18:59:19 volumio volumio[900]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not fetch weather: Response error: 401 - Unauthorized Nov 27 18:59:19 volumio volumio[900]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:114:19) Nov 27 18:59:19 volumio volumio[900]: at runMicrotasks () Nov 27 18:59:19 volumio volumio[900]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 27 18:59:19 volumio volumio[900]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:113:28) Nov 27 18:59:19 volumio volumio[900]: (node:900) UnhandledPromiseRejectionWarning: Error: Response error: 401 - Unauthorized Nov 27 18:59:19 volumio volumio[900]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 27 18:59:19 volumio volumio[900]: at runMicrotasks () Nov 27 18:59:19 volumio volumio[900]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 27 18:59:19 volumio volumio[900]: at async Promise.all (index 0) Nov 27 18:59:19 volumio volumio[900]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Nov 27 18:59:19 volumio volumio[900]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Nov 27 18:59:19 volumio volumio[900]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Nov 27 18:59:19 volumio volumio[900]: (node:900) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 4) Nov 27 18:59:19 volumio volumio[900]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=30.27995&lon=120.16221: Error: Response error: 401 - Unauthorized Nov 27 18:59:19 volumio volumio[900]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 27 18:59:19 volumio volumio[900]: at runMicrotasks () Nov 27 18:59:19 volumio volumio[900]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 27 18:59:19 volumio volumio[900]: at async Promise.all (index 1) Nov 27 18:59:19 volumio volumio[900]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Nov 27 18:59:19 volumio volumio[900]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 27 18:59:19 volumio volumio[900]: info: Listing playlists Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::volumioGetQueue Nov 27 18:59:19 volumio volumio[900]: info: CoreStateMachine::getQueue Nov 27 18:59:19 volumio volumio[900]: info: CorePlayQueue::getQueue Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::volumioGetVisibleSources Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:19 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:19 volumio volumio[900]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 27 18:59:19 volumio volumio[900]: info: Listing playlists Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::volumioGetQueue Nov 27 18:59:19 volumio volumio[900]: info: CoreStateMachine::getQueue Nov 27 18:59:19 volumio volumio[900]: info: CorePlayQueue::getQueue Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::volumioGetVisibleSources Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:19 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:19 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:19 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:19 volumio volumio[900]: info: Listing playlists Nov 27 18:59:19 volumio volumio[900]: info: Listing playlists Nov 27 18:59:22 volumio volumio[900]: info: MYVOLUMIO: Adding device Nov 27 18:59:22 volumio volumio[900]: info: MYVOLUMIO: Evaluating Server Nov 27 18:59:22 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 18:59:24 volumio volumio[900]: info: Setting Geolocation for MyVolumio to us2 Nov 27 18:59:24 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:59:24 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:59:25 volumio volumio[900]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 27 18:59:25 volumio volumio[900]: info: Updating MyVolumio device info Nov 27 18:59:25 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:59:25 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:59:26 volumio volumio[900]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 27 18:59:29 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:29 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:39 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:39 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:39 volumio volumio[900]: info: Listing playlists Nov 27 18:59:49 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:49 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:55 volumio avahi-daemon[569]: avahi_normalize_name() failed. Nov 27 18:59:59 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 18:59:59 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 18:59:59 volumio volumio[900]: info: Listing playlists Nov 27 18:59:59 volumio volumio[900]: info: Listing playlists Nov 27 19:00:09 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 19:00:09 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 19:00:15 volumio avahi-daemon[569]: avahi_normalize_name() failed. Nov 27 19:00:19 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 19:00:19 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 19:00:20 volumio volumio[900]: info: Listing playlists Nov 27 19:00:20 volumio volumio[900]: info: volroon::getState Nov 27 19:00:20 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 19:00:20 volumio volumio[900]: info: CoreCommandRouter::volumioClearQueue Nov 27 19:00:20 volumio volumio[900]: info: CoreStateMachine::ClearQueue Nov 27 19:00:20 volumio volumio[900]: info: CoreStateMachine::stop Nov 27 19:00:20 volumio volumio[900]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 19:00:20 volumio volumio[900]: info: CorePlayQueue::clearPlayQueue Nov 27 19:00:20 volumio volumio[900]: info: CorePlayQueue::saveQueue Nov 27 19:00:20 volumio volumio[900]: info: CoreCommandRouter::volumioPushState Nov 27 19:00:20 volumio volumio[900]: info: CoreCommandRouter::volumioPushQueue Nov 27 19:00:20 volumio volumio[900]: info: CoreCommandRouter::volumioStop Nov 27 19:00:20 volumio volumio[900]: info: CoreStateMachine::stop Nov 27 19:00:20 volumio volumio[900]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 19:00:20 volumio volumio[900]: verbose: volroon::State snapshot: {"status":"play","service":"volroon","title":"学不会","artist":"林俊杰","album":"学不会","albumart":"http://192.168.2.210:9330/api/image/c9d1cf8e3df7e98ed8b92f86aa8e4d68","uri":"","trackType":"roon","seek":220000,"duration":229,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false} Nov 27 19:00:20 volumio volumio[900]: info: volroon::pushState Nov 27 19:00:20 volumio volumio[900]: info: CoreCommandRouter::servicePushState Nov 27 19:00:20 volumio volumio[900]: info: CorePlayQueue::getTrack 0 Nov 27 19:00:20 volumio volumio[900]: verbose: STATE SERVICE {"status":"play","service":"volroon","title":"学不会","artist":"林俊杰","album":"学不会","albumart":"http://192.168.2.210:9330/api/image/c9d1cf8e3df7e98ed8b92f86aa8e4d68","uri":"","trackType":"roon","seek":220000,"duration":229,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false} Nov 27 19:00:20 volumio volumio[900]: verbose: CURRENT POSITION 0 Nov 27 19:00:20 volumio volumio[900]: info: CoreStateMachine::syncState stateService play Nov 27 19:00:20 volumio volumio[900]: info: CoreStateMachine::syncState currentStatus stop Nov 27 19:00:20 volumio volumio[900]: info: CoreStateMachine::resetVolumioState Nov 27 19:00:20 volumio volumio[900]: info: CoreStateMachine::getcurrentVolume Nov 27 19:00:20 volumio volumio[900]: info: CoreCommandRouter::volumioRetrievevolume Nov 27 19:00:21 volumio volumio[900]: info: volroon::Setting volatile state to volroon Nov 27 19:00:21 volumio volumio[900]: info: volroon::pushState Nov 27 19:00:21 volumio volumio[900]: info: CoreCommandRouter::servicePushState Nov 27 19:00:21 volumio volumio[900]: info: CoreStateMachine::pushState Nov 27 19:00:21 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:00:21 volumio volumio[900]: info: CoreCommandRouter::volumioPushState Nov 27 19:00:22 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 19:00:25 volumio avahi-daemon[569]: avahi_normalize_name() failed. Nov 27 19:00:29 volumio volumio[900]: verbose: volroon::State snapshot: {"status":"pause","service":"volroon","title":"匆匆那年","artist":"王菲","album":"匆匆那年 电影原声带","albumart":"http://192.168.2.210:9330/api/image/840821d26a1183a98f3c855bb2fb6efe","uri":"","trackType":"roon","seek":0,"duration":241,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false,"codec":"","repeatMode":"all"} Nov 27 19:00:29 volumio volumio[900]: info: volroon::pushState Nov 27 19:00:29 volumio volumio[900]: info: CoreCommandRouter::servicePushState Nov 27 19:00:29 volumio volumio[900]: info: CoreStateMachine::pushState Nov 27 19:00:29 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:00:29 volumio volumio[900]: info: CoreCommandRouter::volumioPushState Nov 27 19:00:29 volumio volumio[900]: verbose: volroon::State snapshot: {"status":"play","service":"volroon","title":"匆匆那年","artist":"王菲","album":"匆匆那年 电影原声带","albumart":"http://192.168.2.210:9330/api/image/840821d26a1183a98f3c855bb2fb6efe","uri":"","trackType":"roon","seek":0,"duration":241,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false,"codec":"","repeatMode":"all"} Nov 27 19:00:30 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 19:00:30 volumio volumio[900]: info: volroon::pushState Nov 27 19:00:30 volumio volumio[900]: info: CoreCommandRouter::servicePushState Nov 27 19:00:30 volumio volumio[900]: info: CoreStateMachine::pushState Nov 27 19:00:30 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:00:30 volumio volumio[900]: info: CoreCommandRouter::volumioPushState Nov 27 19:00:30 volumio volumio[900]: info: CoreCommandRouter::volumioGetState Nov 27 19:00:31 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 19:00:31 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 19:00:31 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 19:00:35 volumio avahi-daemon[569]: avahi_normalize_name() failed. Nov 27 19:00:42 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 19:00:42 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Nov 27 19:00:42 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Nov 27 19:00:42 volumio volumio[900]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 27 19:00:42 volumio volumio[900]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 19:00:42 volumio volumio[900]: TypeError: Cannot read property 'ping' of undefined Nov 27 19:00:42 volumio volumio[900]: at Timeout._onTimeout (/data/plugins/music_service/volroon/node_modules/node-roon-api/transport-websocket.js:26:21) Nov 27 19:00:42 volumio volumio[900]: at listOnTimeout (internal/timers.js:554:17) Nov 27 19:00:42 volumio volumio[900]: at processTimers (internal/timers.js:497:7) Nov 27 19:00:42 volumio volumio[900]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 19:00:50 volumio sudo[2675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 18:59 Nov 27 19:00:50 volumio sudo[2675]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"