-- Logs begin at Thu 2019-02-14 04:11:59 CST, end at Wed 2025-05-28 02:17:49 CDT. -- May 28 02:16:01 volumiopi3 volumio[1175]: info: MRS: Starting sonos device: uuid:RINCON_48A6B850F8AE01400 May 28 02:16:01 volumiopi3 volumio[1175]: info: Refreshing Cached IP Addresses May 28 02:16:01 volumiopi3 sudo[11003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 02:16:01 volumiopi3 sudo[11003]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:16:01 volumiopi3 sudo[11003]: pam_unix(sudo:session): session closed for user root May 28 02:16:01 volumiopi3 sudo[11006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 02:16:01 volumiopi3 sudo[11006]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:16:01 volumiopi3 sudo[11006]: pam_unix(sudo:session): session closed for user root May 28 02:16:01 volumiopi3 volumio[1175]: error: MRS: Error starting sonos device: uuid:RINCON_48A6B850F8AE01400:Error: upnp: statusCode 500 & upnpErrorCode s:ClientUPnPError800 May 28 02:16:06 volumiopi3 volumio[1175]: info: CoreCommandRouter::volumioGetQueue May 28 02:16:06 volumiopi3 volumio[1175]: info: CoreStateMachine::getQueue May 28 02:16:06 volumiopi3 volumio[1175]: info: CorePlayQueue::getQueue May 28 02:16:11 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri May 28 02:16:11 volumiopi3 volumio[1175]: info: browseTIDALUri took 238 milliseconds May 28 02:16:11 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:11 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:20 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri May 28 02:16:20 volumiopi3 volumio[1175]: info: browseTIDALUri took 172 milliseconds May 28 02:16:20 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:22 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri May 28 02:16:22 volumiopi3 volumio[1175]: info: browseTIDALUri took 280 milliseconds May 28 02:16:22 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:22 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:26 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri May 28 02:16:26 volumiopi3 volumio[1175]: info: browseTIDALUri took 168 milliseconds May 28 02:16:26 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:26 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:30 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri May 28 02:16:30 volumiopi3 volumio[1175]: info: browseTIDALUri took 156 milliseconds May 28 02:16:30 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:30 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:36 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri May 28 02:16:36 volumiopi3 volumio[1175]: info: browseTIDALUri took 156 milliseconds May 28 02:16:36 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:36 volumiopi3 volumio[1175]: info: Preload queue cleared May 28 02:16:50 volumiopi3 volumio[1175]: Searching all installed plugins May 28 02:16:50 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 02:16:50 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: , search May 28 02:16:50 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 28 02:16:50 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search May 28 02:16:50 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: last_100 , search May 28 02:16:50 volumiopi3 volumio[1175]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 May 28 02:16:50 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 28 02:16:50 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: tidal , search May 28 02:16:50 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: jellyfin , search May 28 02:16:50 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 28 02:16:50 volumiopi3 volumio[1175]: info: [youtube2] InnertubeLoader: creating Innertube instance... May 28 02:16:50 volumiopi3 volumio[1175]: info: searchTIDALUri took 370 milliseconds May 28 02:16:50 volumiopi3 volumio[1175]: info: search took 372 milliseconds May 28 02:16:59 volumiopi3 volumio[1175]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. May 28 02:16:59 volumiopi3 volumio[1175]: info: [youtube2] InnertubeLoader: obtaining po_token by visitorData... May 28 02:16:59 volumiopi3 volumio[1175]: error: Search in plugin youtube2 timed out May 28 02:16:59 volumiopi3 volumio[1175]: info: All search sources collected, pushing search results May 28 02:16:59 volumiopi3 volumio[1175]: Searching all installed plugins May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: last_100 , search May 28 02:16:59 volumiopi3 volumio[1175]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: tidal , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: jellyfin , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 28 02:16:59 volumiopi3 volumio[1175]: Searching all installed plugins May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: last_100 , search May 28 02:16:59 volumiopi3 volumio[1175]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: tidal , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: jellyfin , search May 28 02:16:59 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 28 02:17:01 volumiopi3 volumio[1175]: info: searchTIDALUri took 1403 milliseconds May 28 02:17:01 volumiopi3 volumio[1175]: info: search took 1406 milliseconds May 28 02:17:01 volumiopi3 volumio[1175]: info: searchTIDALUri took 1402 milliseconds May 28 02:17:01 volumiopi3 volumio[1175]: info: search took 1403 milliseconds May 28 02:17:01 volumiopi3 volumio[1175]: info: [youtube2] InnertubeLoader: obtained po_token (expires in 43200 seconds) May 28 02:17:01 volumiopi3 volumio[1175]: info: [youtube2] InnertubeLoader: re-create Innertube instance with po_token May 28 02:17:01 volumiopi3 volumio[1175]: info: [youtube2] InnertubeLoader: creating Innertube instance with po_token... May 28 02:17:08 volumiopi3 volumio[1175]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. May 28 02:17:08 volumiopi3 volumio[1175]: info: [youtube2] InnertubeLoader: going to refresh po_token in 43100 seconds May 28 02:17:08 volumiopi3 volumio[1175]: error: Search in plugin youtube2 timed out May 28 02:17:08 volumiopi3 volumio[1175]: info: All search sources collected, pushing search results May 28 02:17:08 volumiopi3 volumio[1175]: error: Search in plugin youtube2 timed out May 28 02:17:08 volumiopi3 volumio[1175]: info: All search sources collected, pushing search results May 28 02:17:09 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:09 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 30, onTap: { innertubeCommand: [Object] } }, May 28 02:17:09 volumiopi3 volumio[1175]: input_data: { May 28 02:17:09 volumiopi3 volumio[1175]: content: 'Dreams (2004 Remaster) · 4:18', May 28 02:17:09 volumiopi3 volumio[1175]: commandRuns: [ [Object] ] May 28 02:17:09 volumiopi3 volumio[1175]: }, May 28 02:17:09 volumiopi3 volumio[1175]: parsed_runs: [ { text: 'Dreams (2004 Remaster) · 4:18', startIndex: 0 } ] May 28 02:17:09 volumiopi3 volumio[1175]: } May 28 02:17:09 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:09 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 33, onTap: { innertubeCommand: [Object] } }, May 28 02:17:09 volumiopi3 volumio[1175]: input_data: { May 28 02:17:09 volumiopi3 volumio[1175]: content: 'The Chain (2004 Remaster) · 4:30', May 28 02:17:09 volumiopi3 volumio[1175]: commandRuns: [ [Object] ] May 28 02:17:09 volumiopi3 volumio[1175]: }, May 28 02:17:09 volumiopi3 volumio[1175]: parsed_runs: [ { text: 'The Chain (2004 Remaster) · 4:30', startIndex: 0 } ] May 28 02:17:09 volumiopi3 volumio[1175]: } May 28 02:17:09 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:09 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 16, onTap: { innertubeCommand: [Object] } }, May 28 02:17:09 volumiopi3 volumio[1175]: input_data: { content: 'Rhiannon · 4:13', commandRuns: [ [Object] ] }, May 28 02:17:09 volumiopi3 volumio[1175]: parsed_runs: [ { text: 'Rhiannon · 4:13', startIndex: 0 } ] May 28 02:17:09 volumiopi3 volumio[1175]: } May 28 02:17:09 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:09 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 18, onTap: { innertubeCommand: [Object] } }, May 28 02:17:09 volumiopi3 volumio[1175]: input_data: { content: "Don't Stop · 3:11", commandRuns: [ [Object] ] }, May 28 02:17:09 volumiopi3 volumio[1175]: parsed_runs: [ { text: "Don't Stop · 3:11", startIndex: 0 } ] May 28 02:17:09 volumiopi3 volumio[1175]: } May 28 02:17:09 volumiopi3 volumio[1175]: error: Failed search in plugin youtube2: Error: Unable to resolve or reject the same promise twice May 28 02:17:09 volumiopi3 volumio[1175]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 28 02:17:09 volumiopi3 volumio[1175]: info: CoreCommandRouter::volumioGetState May 28 02:17:09 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:09 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 55, onTap: { innertubeCommand: [Object] } }, May 28 02:17:09 volumiopi3 volumio[1175]: input_data: { May 28 02:17:09 volumiopi3 volumio[1175]: content: 'Greta Van Fleet - Highway Tune (Official Video) · 3:02', May 28 02:17:09 volumiopi3 volumio[1175]: commandRuns: [ [Object] ] May 28 02:17:09 volumiopi3 volumio[1175]: }, May 28 02:17:09 volumiopi3 volumio[1175]: parsed_runs: [ May 28 02:17:09 volumiopi3 volumio[1175]: { May 28 02:17:09 volumiopi3 volumio[1175]: text: 'Greta Van Fleet - Highway Tune (Official Video) · 3:02', May 28 02:17:09 volumiopi3 volumio[1175]: startIndex: 0 May 28 02:17:09 volumiopi3 volumio[1175]: } May 28 02:17:09 volumiopi3 volumio[1175]: ] May 28 02:17:09 volumiopi3 volumio[1175]: } May 28 02:17:09 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:09 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 47, onTap: { innertubeCommand: [Object] } }, May 28 02:17:09 volumiopi3 volumio[1175]: input_data: { May 28 02:17:09 volumiopi3 volumio[1175]: content: 'Greta Van Fleet - Watching Over (Audio) · 4:29', May 28 02:17:09 volumiopi3 volumio[1175]: commandRuns: [ [Object] ] May 28 02:17:09 volumiopi3 volumio[1175]: }, May 28 02:17:09 volumiopi3 volumio[1175]: parsed_runs: [ May 28 02:17:09 volumiopi3 volumio[1175]: { May 28 02:17:09 volumiopi3 volumio[1175]: text: 'Greta Van Fleet - Watching Over (Audio) · 4:29', May 28 02:17:09 volumiopi3 volumio[1175]: startIndex: 0 May 28 02:17:09 volumiopi3 volumio[1175]: } May 28 02:17:09 volumiopi3 volumio[1175]: ] May 28 02:17:09 volumiopi3 volumio[1175]: } May 28 02:17:10 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:10 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 54, onTap: { innertubeCommand: [Object] } }, May 28 02:17:10 volumiopi3 volumio[1175]: input_data: { May 28 02:17:10 volumiopi3 volumio[1175]: content: 'We Trapped DEMON KING😱| FLEET SMP FINALE · 1:17:54', May 28 02:17:10 volumiopi3 volumio[1175]: commandRuns: [ [Object] ] May 28 02:17:10 volumiopi3 volumio[1175]: }, May 28 02:17:10 volumiopi3 volumio[1175]: parsed_runs: [ May 28 02:17:10 volumiopi3 volumio[1175]: { May 28 02:17:10 volumiopi3 volumio[1175]: text: 'We Trapped DEMON KING😱| FLEET SMP FINALE · 1:17:54', May 28 02:17:10 volumiopi3 volumio[1175]: startIndex: 0 May 28 02:17:10 volumiopi3 volumio[1175]: } May 28 02:17:10 volumiopi3 volumio[1175]: ] May 28 02:17:10 volumiopi3 volumio[1175]: } May 28 02:17:10 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:10 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 76, onTap: { innertubeCommand: [Object] } }, May 28 02:17:10 volumiopi3 volumio[1175]: input_data: { May 28 02:17:10 volumiopi3 volumio[1175]: content: 'My Friends BETRAYED Me In PVP Tournament😱| FLEET SMP Minecraft · 1:01:59', May 28 02:17:10 volumiopi3 volumio[1175]: commandRuns: [ [Object] ] May 28 02:17:10 volumiopi3 volumio[1175]: }, May 28 02:17:10 volumiopi3 volumio[1175]: parsed_runs: [ May 28 02:17:10 volumiopi3 volumio[1175]: { May 28 02:17:10 volumiopi3 volumio[1175]: text: 'My Friends BETRAYED Me In PVP Tournament😱| FLEET SMP Minecraft · 1:01:59', May 28 02:17:10 volumiopi3 volumio[1175]: startIndex: 0 May 28 02:17:10 volumiopi3 volumio[1175]: } May 28 02:17:10 volumiopi3 volumio[1175]: ] May 28 02:17:10 volumiopi3 volumio[1175]: } May 28 02:17:10 volumiopi3 volumio[1175]: error: Failed search in plugin youtube2: Error: Unable to resolve or reject the same promise twice May 28 02:17:10 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:10 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 30, onTap: { innertubeCommand: [Object] } }, May 28 02:17:10 volumiopi3 volumio[1175]: input_data: { May 28 02:17:10 volumiopi3 volumio[1175]: content: 'Dreams (2004 Remaster) · 4:18', May 28 02:17:10 volumiopi3 volumio[1175]: commandRuns: [ [Object] ] May 28 02:17:10 volumiopi3 volumio[1175]: }, May 28 02:17:10 volumiopi3 volumio[1175]: parsed_runs: [ { text: 'Dreams (2004 Remaster) · 4:18', startIndex: 0 } ] May 28 02:17:10 volumiopi3 volumio[1175]: } May 28 02:17:10 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:10 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 33, onTap: { innertubeCommand: [Object] } }, May 28 02:17:10 volumiopi3 volumio[1175]: input_data: { May 28 02:17:10 volumiopi3 volumio[1175]: content: 'The Chain (2004 Remaster) · 4:30', May 28 02:17:10 volumiopi3 volumio[1175]: commandRuns: [ [Object] ] May 28 02:17:10 volumiopi3 volumio[1175]: }, May 28 02:17:10 volumiopi3 volumio[1175]: parsed_runs: [ { text: 'The Chain (2004 Remaster) · 4:30', startIndex: 0 } ] May 28 02:17:10 volumiopi3 volumio[1175]: } May 28 02:17:10 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:10 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 16, onTap: { innertubeCommand: [Object] } }, May 28 02:17:10 volumiopi3 volumio[1175]: input_data: { content: 'Rhiannon · 4:13', commandRuns: [ [Object] ] }, May 28 02:17:10 volumiopi3 volumio[1175]: parsed_runs: [ { text: 'Rhiannon · 4:13', startIndex: 0 } ] May 28 02:17:10 volumiopi3 volumio[1175]: } May 28 02:17:10 volumiopi3 volumio[1175]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 28 02:17:10 volumiopi3 volumio[1175]: command_run: { startIndex: 0, length: 18, onTap: { innertubeCommand: [Object] } }, May 28 02:17:10 volumiopi3 volumio[1175]: input_data: { content: "Don't Stop · 3:11", commandRuns: [ [Object] ] }, May 28 02:17:10 volumiopi3 volumio[1175]: parsed_runs: [ { text: "Don't Stop · 3:11", startIndex: 0 } ] May 28 02:17:10 volumiopi3 volumio[1175]: } May 28 02:17:10 volumiopi3 volumio[1175]: error: Failed search in plugin youtube2: Error: Unable to resolve or reject the same promise twice May 28 02:17:14 volumiopi3 volumio[1175]: info: CoreCommandRouter::volumioPrevious May 28 02:17:14 volumiopi3 volumio[1175]: info: CoreStateMachine::previous May 28 02:17:14 volumiopi3 volumio[1175]: info: CoreStateMachine::updateTrackBlock May 28 02:17:14 volumiopi3 volumio[1175]: info: CorePlayQueue::getTrackBlock May 28 02:17:14 volumiopi3 volumio[1175]: info: CoreStateMachine::serviceClearAddPlay May 28 02:17:14 volumiopi3 volumio[1175]: info: CoreCommandRouter::serviceClearAddPlayTracks May 28 02:17:14 volumiopi3 volumio[1175]: error: WARNING: No clearAddPlayTracks method for service tidal May 28 02:17:15 volumiopi3 volumio[1175]: info: CoreCommandRouter::volumioPause May 28 02:17:15 volumiopi3 volumio[1175]: info: CoreStateMachine::pause May 28 02:17:17 volumiopi3 volumio[1175]: info: CoreCommandRouter::volumioPause May 28 02:17:17 volumiopi3 volumio[1175]: info: CoreStateMachine::pause May 28 02:17:18 volumiopi3 volumio[1175]: info: CoreCommandRouter::volumioNext May 28 02:17:18 volumiopi3 volumio[1175]: info: CoreStateMachine::next May 28 02:17:18 volumiopi3 volumio[1175]: info: ControllerMpd::next May 28 02:17:18 volumiopi3 volumio[1175]: verbose: ControllerMpd::sendMpdCommand next May 28 02:17:23 volumiopi3 volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 02:17:24 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 28 02:17:24 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 28 02:17:24 volumiopi3 sudo[11229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 28 02:17:24 volumiopi3 sudo[11229]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:24 volumiopi3 sudo[11229]: pam_unix(sudo:session): session closed for user root May 28 02:17:24 volumiopi3 sudo[11235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 28 02:17:24 volumiopi3 sudo[11235]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:24 volumiopi3 sudo[11235]: pam_unix(sudo:session): session closed for user root May 28 02:17:24 volumiopi3 sudo[11243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 28 02:17:24 volumiopi3 sudo[11243]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:24 volumiopi3 sudo[11243]: pam_unix(sudo:session): session closed for user root May 28 02:17:24 volumiopi3 sudo[11249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 28 02:17:24 volumiopi3 sudo[11249]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:24 volumiopi3 sudo[11249]: pam_unix(sudo:session): session closed for user root May 28 02:17:24 volumiopi3 sudo[11255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 02:17:24 volumiopi3 sudo[11255]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:24 volumiopi3 sudo[11255]: pam_unix(sudo:session): session closed for user root May 28 02:17:24 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 28 02:17:24 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 28 02:17:24 volumiopi3 sudo[11258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 02:17:24 volumiopi3 sudo[11258]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:24 volumiopi3 sudo[11258]: pam_unix(sudo:session): session closed for user root May 28 02:17:24 volumiopi3 sudo[11261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 28 02:17:24 volumiopi3 sudo[11261]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:25 volumiopi3 sudo[11261]: pam_unix(sudo:session): session closed for user root May 28 02:17:41 volumiopi3 volumio[1175]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] May 28 02:17:41 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet May 28 02:17:42 volumiopi3 volumio[1175]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] May 28 02:17:42 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet May 28 02:17:42 volumiopi3 sudo[11282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces May 28 02:17:42 volumiopi3 sudo[11282]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:42 volumiopi3 sudo[11282]: pam_unix(sudo:session): session closed for user root May 28 02:17:42 volumiopi3 sudo[11284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf May 28 02:17:42 volumiopi3 sudo[11284]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:42 volumiopi3 sudo[11284]: pam_unix(sudo:session): session closed for user root May 28 02:17:42 volumiopi3 volumio[1175]: info: Permissions for /etc/network/interfaces set May 28 02:17:42 volumiopi3 volumio[1175]: info: Restarting Wireless Network May 28 02:17:42 volumiopi3 volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart May 28 02:17:42 volumiopi3 volumio[1175]: info: Discovery: Restarting Advertising due to device name change May 28 02:17:42 volumiopi3 sudo[11287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service May 28 02:17:42 volumiopi3 sudo[11287]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:42 volumiopi3 systemd[1]: wireless.service: Killing process 886 (wpa_supplicant) with signal SIGKILL. May 28 02:17:42 volumiopi3 systemd[1]: wireless.service: Killing process 983 (dhcpcd) with signal SIGKILL. May 28 02:17:42 volumiopi3 systemd[1]: Stopping Wireless Services... May 28 02:17:42 volumiopi3 volumio[1175]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 02:17:42 volumiopi3 systemd[1]: wireless.service: Succeeded. May 28 02:17:42 volumiopi3 systemd[1]: Stopped Wireless Services. May 28 02:17:42 volumiopi3 volumio[1175]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 28 02:17:43 volumiopi3 systemd[1]: Starting Wireless Services... May 28 02:17:43 volumiopi3 volumio[1175]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 02:17:43 volumiopi3 wireless.js[11290]: Cleaning previous... May 28 02:17:43 volumiopi3 volumio[1175]: info: Discovery: A device disappeared from network May 28 02:17:43 volumiopi3 volumio[1175]: info: Discovery: Device volumiopi3 disappeared from network May 28 02:17:43 volumiopi3 volumio[1175]: info: Discovery: A device disappeared from network May 28 02:17:43 volumiopi3 sudo[11318]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 28 02:17:43 volumiopi3 sudo[11318]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:43 volumiopi3 avahi-daemon[654]: Withdrawing address record for 192.168.4.235 on wlan0. May 28 02:17:43 volumiopi3 avahi-daemon[654]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.4.235. May 28 02:17:43 volumiopi3 avahi-daemon[654]: Interface wlan0.IPv4 no longer relevant for mDNS. May 28 02:17:43 volumiopi3 sudo[11318]: pam_unix(sudo:session): session closed for user root May 28 02:17:43 volumiopi3 sudo[11320]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 28 02:17:43 volumiopi3 sudo[11320]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 02:17:44 volumiopi3 sudo[11320]: pam_unix(sudo:session): session closed for user root May 28 02:17:44 volumiopi3 wireless.js[11290]: Stopped aP May 28 02:17:44 volumiopi3 wireless.js[11290]: Wireless Networking DISABLED, not starting wireless flow May 28 02:17:44 volumiopi3 systemd[1]: wireless.service: Succeeded. May 28 02:17:44 volumiopi3 systemd[1]: Started Wireless Services. May 28 02:17:44 volumiopi3 sudo[11287]: pam_unix(sudo:session): session closed for user root May 28 02:17:45 volumiopi3 ntpd[800]: Deleting interface #4 wlan0, 192.168.4.235#123, interface stats: received=0, sent=0, dropped=0, active_time=632 secs May 28 02:17:47 volumiopi3 volumio[1175]: info: Discovery: Started advertising with name: VolumioPi3 May 28 02:17:48 volumiopi3 volumio[1175]: info: Discovery: adding b0884161-b61f-473e-b6fd-e9dcf7208a23 May 28 02:17:48 volumiopi3 volumio[1175]: info: Discovery: Found device VolumioPi3 May 28 02:17:48 volumiopi3 volumio[1175]: info: CoreCommandRouter::volumioGetState May 28 02:17:48 volumiopi3 volumio[1175]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 02:17:48 volumiopi3 volumio[1175]: Error: The value NaN is not a number May 28 02:17:48 volumiopi3 volumio[1175]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) May 28 02:17:48 volumiopi3 volumio[1175]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) May 28 02:17:48 volumiopi3 volumio[1175]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) May 28 02:17:48 volumiopi3 volumio[1175]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) May 28 02:17:48 volumiopi3 volumio[1175]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) May 28 02:17:48 volumiopi3 volumio[1175]: at Browser.emit (events.js:315:20) May 28 02:17:48 volumiopi3 volumio[1175]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) May 28 02:17:48 volumiopi3 volumio[1175]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) May 28 02:17:48 volumiopi3 volumio[1175]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) May 28 02:17:48 volumiopi3 volumio[1175]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) May 28 02:17:48 volumiopi3 volumio[1175]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 May 28 02:17:48 volumiopi3 volumio[1175]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) May 28 02:17:48 volumiopi3 volumio[1175]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) May 28 02:17:48 volumiopi3 volumio[1175]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 02:17:49 volumiopi3 sudo[11342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-28 02:16 May 28 02:17:49 volumiopi3 sudo[11342]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"