-- Logs begin at Fri 2025-08-01 12:13:44 EEST, end at Fri 2025-09-12 01:47:48 EEST. -- Sep 12 01:46:05 volumio volumio[789]: verbose: New Socket.io Connection to 192.168.100.197 from 192.168.100.100 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::volumioGetState Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::volumioGetQueue Sep 12 01:46:05 volumio volumio[789]: info: CoreStateMachine::getQueue Sep 12 01:46:05 volumio volumio[789]: info: CorePlayQueue::getQueue Sep 12 01:46:05 volumio volumio[789]: info: Listing playlists Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 12 01:46:05 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Sep 12 01:46:05 volumio volumio[789]: info: Received Get System Info Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 01:46:05 volumio volumio[789]: info: Discovery: Getting this device information Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::volumioGetState Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::volumioGetState Sep 12 01:46:05 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 12 01:46:11 volumio volumio[789]: Searching all installed plugins Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:46:11 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:46:11 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:46:12 volumio volumio[789]: Searching all installed plugins Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:46:12 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:46:12 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:46:12 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:12 volumio volumio[789]: command_run: { startIndex: 0, length: 45, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:12 volumio volumio[789]: input_data: { Sep 12 01:46:12 volumio volumio[789]: content: 'Gopnik McBlyat - Snakes in Tracksuits · 4:21', Sep 12 01:46:12 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:12 volumio volumio[789]: }, Sep 12 01:46:12 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:12 volumio volumio[789]: { Sep 12 01:46:12 volumio volumio[789]: text: 'Gopnik McBlyat - Snakes in Tracksuits · 4:21', Sep 12 01:46:12 volumio volumio[789]: startIndex: 0 Sep 12 01:46:12 volumio volumio[789]: } Sep 12 01:46:12 volumio volumio[789]: ] Sep 12 01:46:12 volumio volumio[789]: } Sep 12 01:46:12 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:12 volumio volumio[789]: command_run: { startIndex: 0, length: 45, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:12 volumio volumio[789]: input_data: { Sep 12 01:46:12 volumio volumio[789]: content: 'DJ BLYATMAN - GOPNIK (Official Audio) · 3:13', Sep 12 01:46:12 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:12 volumio volumio[789]: }, Sep 12 01:46:12 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:12 volumio volumio[789]: { Sep 12 01:46:12 volumio volumio[789]: text: 'DJ BLYATMAN - GOPNIK (Official Audio) · 3:13', Sep 12 01:46:12 volumio volumio[789]: startIndex: 0 Sep 12 01:46:12 volumio volumio[789]: } Sep 12 01:46:12 volumio volumio[789]: ] Sep 12 01:46:12 volumio volumio[789]: } Sep 12 01:46:13 volumio volumio[789]: info: searchQOBUZUri took 1205 milliseconds Sep 12 01:46:13 volumio volumio[789]: info: searchQOBUZUri took 1171 milliseconds Sep 12 01:46:13 volumio volumio[789]: Searching all installed plugins Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:46:13 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:46:13 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:46:15 volumio volumio[789]: Searching all installed plugins Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:46:15 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:46:15 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:46:15 volumio volumio[789]: info: searchQOBUZUri took 1779 milliseconds Sep 12 01:46:16 volumio volumio[789]: info: All search sources collected, pushing search results Sep 12 01:46:16 volumio volumio[789]: Searching all installed plugins Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:46:16 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:46:16 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:46:16 volumio volumio[789]: info: searchQOBUZUri took 1264 milliseconds Sep 12 01:46:17 volumio volumio[789]: error: Search in plugin soundcloud timed out Sep 12 01:46:17 volumio volumio[789]: error: Search in plugin youtube2 timed out Sep 12 01:46:17 volumio volumio[789]: info: All search sources collected, pushing search results Sep 12 01:46:18 volumio volumio[789]: error: Failed search in plugin soundcloud: Error: Unable to resolve or reject the same promise twice Sep 12 01:46:18 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:18 volumio volumio[789]: command_run: { startIndex: 0, length: 35, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:18 volumio volumio[789]: input_data: { Sep 12 01:46:18 volumio volumio[789]: content: 'Nightfall (Remastered 2007) · 5:35', Sep 12 01:46:18 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:18 volumio volumio[789]: }, Sep 12 01:46:18 volumio volumio[789]: parsed_runs: [ { text: 'Nightfall (Remastered 2007) · 5:35', startIndex: 0 } ] Sep 12 01:46:18 volumio volumio[789]: } Sep 12 01:46:18 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:18 volumio volumio[789]: command_run: { startIndex: 0, length: 35, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:18 volumio volumio[789]: input_data: { Sep 12 01:46:18 volumio volumio[789]: content: 'The Eldar (Remastered 2007) · 3:39', Sep 12 01:46:18 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:18 volumio volumio[789]: }, Sep 12 01:46:18 volumio volumio[789]: parsed_runs: [ { text: 'The Eldar (Remastered 2007) · 3:39', startIndex: 0 } ] Sep 12 01:46:18 volumio volumio[789]: } Sep 12 01:46:18 volumio volumio[789]: error: Failed search in plugin youtube2: Error: Unable to resolve or reject the same promise twice Sep 12 01:46:18 volumio volumio[789]: error: Search in plugin soundcloud timed out Sep 12 01:46:18 volumio volumio[789]: error: Search in plugin youtube2 timed out Sep 12 01:46:18 volumio volumio[789]: info: All search sources collected, pushing search results Sep 12 01:46:19 volumio volumio[789]: info: searchQOBUZUri took 2770 milliseconds Sep 12 01:46:20 volumio volumio[789]: error: Failed search in plugin soundcloud: Error: Unable to resolve or reject the same promise twice Sep 12 01:46:20 volumio volumio[789]: error: Search in plugin soundcloud timed out Sep 12 01:46:20 volumio volumio[789]: error: Search in plugin youtube2 timed out Sep 12 01:46:20 volumio volumio[789]: info: All search sources collected, pushing search results Sep 12 01:46:20 volumio volumio[789]: error: Failed search in plugin soundcloud: Error: Unable to resolve or reject the same promise twice Sep 12 01:46:21 volumio volumio[789]: error: Failed search in plugin youtube2: Error: Unable to resolve or reject the same promise twice Sep 12 01:46:21 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:21 volumio volumio[789]: command_run: { startIndex: 0, length: 83, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:21 volumio volumio[789]: input_data: { Sep 12 01:46:21 volumio volumio[789]: content: "Blind Faith ~ Can't Find My Way Home ~ (Original Acoustic Version) HQ Audio · 3:19", Sep 12 01:46:21 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:21 volumio volumio[789]: }, Sep 12 01:46:21 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:21 volumio volumio[789]: { Sep 12 01:46:21 volumio volumio[789]: text: "Blind Faith ~ Can't Find My Way Home ~ (Original Acoustic Version) HQ Audio · 3:19", Sep 12 01:46:21 volumio volumio[789]: startIndex: 0 Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: ] Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:21 volumio volumio[789]: command_run: { startIndex: 0, length: 31, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:21 volumio volumio[789]: input_data: { Sep 12 01:46:21 volumio volumio[789]: content: 'TRAFFIC Dear Mr.Fantasy · 5:30', Sep 12 01:46:21 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:21 volumio volumio[789]: }, Sep 12 01:46:21 volumio volumio[789]: parsed_runs: [ { text: 'TRAFFIC Dear Mr.Fantasy · 5:30', startIndex: 0 } ] Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:21 volumio volumio[789]: command_run: { startIndex: 0, length: 65, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:21 volumio volumio[789]: input_data: { Sep 12 01:46:21 volumio volumio[789]: content: 'Blind Faith Had to Cry Today with Lyrics in Description · 8:49', Sep 12 01:46:21 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:21 volumio volumio[789]: }, Sep 12 01:46:21 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:21 volumio volumio[789]: { Sep 12 01:46:21 volumio volumio[789]: text: 'Blind Faith Had to Cry Today with Lyrics in Description · 8:49', Sep 12 01:46:21 volumio volumio[789]: startIndex: 0 Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: ] Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:21 volumio volumio[789]: command_run: { startIndex: 0, length: 71, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:21 volumio volumio[789]: input_data: { Sep 12 01:46:21 volumio volumio[789]: content: "Blind Faith Can't Find My Way Home with Lyrics in Description · 3:18", Sep 12 01:46:21 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:21 volumio volumio[789]: }, Sep 12 01:46:21 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:21 volumio volumio[789]: { Sep 12 01:46:21 volumio volumio[789]: text: "Blind Faith Can't Find My Way Home with Lyrics in Description · 3:18", Sep 12 01:46:21 volumio volumio[789]: startIndex: 0 Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: ] Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:21 volumio volumio[789]: command_run: { startIndex: 0, length: 58, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:21 volumio volumio[789]: input_data: { Sep 12 01:46:21 volumio volumio[789]: content: 'Harve Presnell They call the Wind Maria remastered · 3:03', Sep 12 01:46:21 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:21 volumio volumio[789]: }, Sep 12 01:46:21 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:21 volumio volumio[789]: { Sep 12 01:46:21 volumio volumio[789]: text: 'Harve Presnell They call the Wind Maria remastered · 3:03', Sep 12 01:46:21 volumio volumio[789]: startIndex: 0 Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: ] Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:21 volumio volumio[789]: command_run: { startIndex: 0, length: 79, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:21 volumio volumio[789]: input_data: { Sep 12 01:46:21 volumio volumio[789]: content: 'The Jimi Hendrix Experience - All Along The Watchtower (Official Audio) · 4:02', Sep 12 01:46:21 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:21 volumio volumio[789]: }, Sep 12 01:46:21 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:21 volumio volumio[789]: { Sep 12 01:46:21 volumio volumio[789]: text: 'The Jimi Hendrix Experience - All Along The Watchtower (Official Audio) · 4:02', Sep 12 01:46:21 volumio volumio[789]: startIndex: 0 Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: ] Sep 12 01:46:21 volumio volumio[789]: } Sep 12 01:46:21 volumio volumio[789]: error: Failed search in plugin youtube2: Error: Unable to resolve or reject the same promise twice Sep 12 01:46:21 volumio volumio[789]: error: Search in plugin youtube2 timed out Sep 12 01:46:21 volumio volumio[789]: info: All search sources collected, pushing search results Sep 12 01:46:22 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:22 volumio volumio[789]: command_run: { startIndex: 0, length: 66, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:22 volumio volumio[789]: input_data: { Sep 12 01:46:22 volumio volumio[789]: content: 'Blind (Frankie Knuckles Remix) - Hercules And Love Affair · 7:55', Sep 12 01:46:22 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:22 volumio volumio[789]: }, Sep 12 01:46:22 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:22 volumio volumio[789]: { Sep 12 01:46:22 volumio volumio[789]: text: 'Blind (Frankie Knuckles Remix) - Hercules And Love Affair · 7:55', Sep 12 01:46:22 volumio volumio[789]: startIndex: 0 Sep 12 01:46:22 volumio volumio[789]: } Sep 12 01:46:22 volumio volumio[789]: ] Sep 12 01:46:22 volumio volumio[789]: } Sep 12 01:46:22 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:22 volumio volumio[789]: command_run: { startIndex: 0, length: 57, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:22 volumio volumio[789]: input_data: { Sep 12 01:46:22 volumio volumio[789]: content: 'POLO & PAN — Bilboquet (Sirba) (official audio) · 3:17', Sep 12 01:46:22 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:22 volumio volumio[789]: }, Sep 12 01:46:22 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:22 volumio volumio[789]: { Sep 12 01:46:22 volumio volumio[789]: text: 'POLO & PAN — Bilboquet (Sirba) (official audio) · 3:17', Sep 12 01:46:22 volumio volumio[789]: startIndex: 0 Sep 12 01:46:22 volumio volumio[789]: } Sep 12 01:46:22 volumio volumio[789]: ] Sep 12 01:46:22 volumio volumio[789]: } Sep 12 01:46:22 volumio volumio[789]: error: Failed search in plugin youtube2: Error: Unable to resolve or reject the same promise twice Sep 12 01:46:27 volumio volumio[789]: Searching all installed plugins Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:46:27 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:46:27 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:46:28 volumio volumio[789]: info: searchQOBUZUri took 1094 milliseconds Sep 12 01:46:28 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:28 volumio volumio[789]: command_run: { startIndex: 0, length: 49, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:28 volumio volumio[789]: input_data: { Sep 12 01:46:28 volumio volumio[789]: content: 'The House of Madness | Fran Bow | Part 1 · 31:35', Sep 12 01:46:28 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:28 volumio volumio[789]: }, Sep 12 01:46:28 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:28 volumio volumio[789]: { Sep 12 01:46:28 volumio volumio[789]: text: 'The House of Madness | Fran Bow | Part 1 · 31:35', Sep 12 01:46:28 volumio volumio[789]: startIndex: 0 Sep 12 01:46:28 volumio volumio[789]: } Sep 12 01:46:28 volumio volumio[789]: ] Sep 12 01:46:28 volumio volumio[789]: } Sep 12 01:46:28 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:28 volumio volumio[789]: command_run: { startIndex: 0, length: 45, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:28 volumio volumio[789]: input_data: { Sep 12 01:46:28 volumio volumio[789]: content: 'Little Red Pills | Fran Bow | Part 2 · 25:31', Sep 12 01:46:28 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:28 volumio volumio[789]: }, Sep 12 01:46:28 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:28 volumio volumio[789]: { Sep 12 01:46:28 volumio volumio[789]: text: 'Little Red Pills | Fran Bow | Part 2 · 25:31', Sep 12 01:46:28 volumio volumio[789]: startIndex: 0 Sep 12 01:46:28 volumio volumio[789]: } Sep 12 01:46:28 volumio volumio[789]: ] Sep 12 01:46:28 volumio volumio[789]: } Sep 12 01:46:28 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:28 volumio volumio[789]: command_run: { startIndex: 0, length: 48, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:28 volumio volumio[789]: input_data: { Sep 12 01:46:28 volumio volumio[789]: content: 'Hallo-stream | Fran Bow, Introduction · 1:11:40', Sep 12 01:46:28 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:28 volumio volumio[789]: }, Sep 12 01:46:28 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:28 volumio volumio[789]: { Sep 12 01:46:28 volumio volumio[789]: text: 'Hallo-stream | Fran Bow, Introduction · 1:11:40', Sep 12 01:46:28 volumio volumio[789]: startIndex: 0 Sep 12 01:46:28 volumio volumio[789]: } Sep 12 01:46:28 volumio volumio[789]: ] Sep 12 01:46:28 volumio volumio[789]: } Sep 12 01:46:28 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:28 volumio volumio[789]: command_run: { startIndex: 0, length: 45, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:28 volumio volumio[789]: input_data: { Sep 12 01:46:28 volumio volumio[789]: content: 'The Yellow Door | Fran Bow, Part 2 · 1:47:26', Sep 12 01:46:28 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:28 volumio volumio[789]: }, Sep 12 01:46:28 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:28 volumio volumio[789]: { Sep 12 01:46:28 volumio volumio[789]: text: 'The Yellow Door | Fran Bow, Part 2 · 1:47:26', Sep 12 01:46:28 volumio volumio[789]: startIndex: 0 Sep 12 01:46:28 volumio volumio[789]: } Sep 12 01:46:28 volumio volumio[789]: ] Sep 12 01:46:28 volumio volumio[789]: } Sep 12 01:46:29 volumio volumio[789]: info: All search sources collected, pushing search results Sep 12 01:46:31 volumio volumio[789]: Searching all installed plugins Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:46:31 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:46:31 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:46:32 volumio volumio[789]: info: searchQOBUZUri took 888 milliseconds Sep 12 01:46:32 volumio volumio[789]: Searching all installed plugins Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:46:32 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:46:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:46:33 volumio volumio[789]: info: searchQOBUZUri took 1021 milliseconds Sep 12 01:46:34 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:34 volumio volumio[789]: command_run: { startIndex: 0, length: 38, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:34 volumio volumio[789]: input_data: { Sep 12 01:46:34 volumio volumio[789]: content: 'Blind (Frankie Knuckles Remix) · 7:52', Sep 12 01:46:34 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:34 volumio volumio[789]: }, Sep 12 01:46:34 volumio volumio[789]: parsed_runs: [ { text: 'Blind (Frankie Knuckles Remix) · 7:52', startIndex: 0 } ] Sep 12 01:46:34 volumio volumio[789]: } Sep 12 01:46:34 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:34 volumio volumio[789]: command_run: { startIndex: 0, length: 55, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:34 volumio volumio[789]: input_data: { Sep 12 01:46:34 volumio volumio[789]: content: 'Gregory Porter - Liquid Spirit (Claptone Remix) · 6:24', Sep 12 01:46:34 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:34 volumio volumio[789]: }, Sep 12 01:46:34 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:34 volumio volumio[789]: { Sep 12 01:46:34 volumio volumio[789]: text: 'Gregory Porter - Liquid Spirit (Claptone Remix) · 6:24', Sep 12 01:46:34 volumio volumio[789]: startIndex: 0 Sep 12 01:46:34 volumio volumio[789]: } Sep 12 01:46:34 volumio volumio[789]: ] Sep 12 01:46:34 volumio volumio[789]: } Sep 12 01:46:34 volumio volumio[789]: info: All search sources collected, pushing search results Sep 12 01:46:36 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:36 volumio volumio[789]: command_run: { startIndex: 0, length: 55, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:36 volumio volumio[789]: input_data: { Sep 12 01:46:36 volumio volumio[789]: content: 'Gregory Porter - Liquid Spirit (Claptone Remix) · 6:24', Sep 12 01:46:36 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:36 volumio volumio[789]: }, Sep 12 01:46:36 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:36 volumio volumio[789]: { Sep 12 01:46:36 volumio volumio[789]: text: 'Gregory Porter - Liquid Spirit (Claptone Remix) · 6:24', Sep 12 01:46:36 volumio volumio[789]: startIndex: 0 Sep 12 01:46:36 volumio volumio[789]: } Sep 12 01:46:36 volumio volumio[789]: ] Sep 12 01:46:36 volumio volumio[789]: } Sep 12 01:46:36 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:36 volumio volumio[789]: command_run: { startIndex: 0, length: 38, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:36 volumio volumio[789]: input_data: { Sep 12 01:46:36 volumio volumio[789]: content: 'Blind (Frankie Knuckles Remix) · 7:52', Sep 12 01:46:36 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:36 volumio volumio[789]: }, Sep 12 01:46:36 volumio volumio[789]: parsed_runs: [ { text: 'Blind (Frankie Knuckles Remix) · 7:52', startIndex: 0 } ] Sep 12 01:46:36 volumio volumio[789]: } Sep 12 01:46:36 volumio volumio[789]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Sep 12 01:46:36 volumio volumio[789]: command_run: { startIndex: 0, length: 54, onTap: { innertubeCommand: [Object] } }, Sep 12 01:46:36 volumio volumio[789]: input_data: { Sep 12 01:46:36 volumio volumio[789]: content: "Groove Armada - Superstylin' (Live at Brixton) · 7:21", Sep 12 01:46:36 volumio volumio[789]: commandRuns: [ [Object] ] Sep 12 01:46:36 volumio volumio[789]: }, Sep 12 01:46:36 volumio volumio[789]: parsed_runs: [ Sep 12 01:46:36 volumio volumio[789]: { Sep 12 01:46:36 volumio volumio[789]: text: "Groove Armada - Superstylin' (Live at Brixton) · 7:21", Sep 12 01:46:36 volumio volumio[789]: startIndex: 0 Sep 12 01:46:36 volumio volumio[789]: } Sep 12 01:46:36 volumio volumio[789]: ] Sep 12 01:46:36 volumio volumio[789]: } Sep 12 01:46:36 volumio volumio[789]: info: All search sources collected, pushing search results Sep 12 01:47:32 volumio volumio[789]: Searching all installed plugins Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:47:32 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:47:32 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:47:33 volumio volumio[789]: info: An error occurred while querying SHOUTCAST Sep 12 01:47:34 volumio volumio[789]: Searching all installed plugins Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:47:34 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:47:34 volumio volumio[789]: info: searchQOBUZUri took 1646 milliseconds Sep 12 01:47:34 volumio volumio[789]: Searching all installed plugins Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:47:34 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:47:34 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:47:35 volumio volumio[789]: Searching all installed plugins Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 12 01:47:35 volumio volumio[789]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: spop , search Sep 12 01:47:35 volumio volumio[789]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 12 01:47:35 volumio volumio[789]: info: searchQOBUZUri took 1298 milliseconds Sep 12 01:47:35 volumio volumio[789]: info: searchQOBUZUri took 1140 milliseconds Sep 12 01:47:35 volumio volumio[789]: info: searchQOBUZUri took 404 milliseconds Sep 12 01:47:37 volumio volumio[789]: <--- Last few GCs ---> Sep 12 01:47:37 volumio volumio[789]: [789:0x4492780] 16265842 ms: Scavenge (reduce) 213.1 (216.6) -> 212.8 (217.1) MB, 5.1 / 0.0 ms (average mu = 0.943, current mu = 0.466) allocation failure Sep 12 01:47:37 volumio volumio[789]: [789:0x4492780] 16265893 ms: Scavenge (reduce) 213.7 (218.6) -> 213.2 (218.1) MB, 4.8 / 0.0 ms (average mu = 0.943, current mu = 0.466) allocation failure Sep 12 01:47:37 volumio volumio[789]: [789:0x4492780] 16266132 ms: Scavenge (reduce) 214.1 (217.4) -> 213.7 (218.7) MB, 97.5 / 0.0 ms (average mu = 0.943, current mu = 0.466) task Sep 12 01:47:37 volumio volumio[789]: <--- JS stacktrace ---> Sep 12 01:47:37 volumio volumio[789]: FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory Sep 12 01:47:37 volumio vtcs[1406]: [2025-09-12 01:47:37.850] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Sep 12 01:47:37 volumio qobuz-connect[1336]: 20250912 01:47:37.852 [1336.1336] INFO SampleApp: Socket closed Sep 12 01:47:37 volumio volumio-remote-updater[558]: [2025-09-12 01:47:37] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Sep 12 01:47:37 volumio volumio-remote-updater[558]: [2025-09-12 01:47:37] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Sep 12 01:47:37 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=6/ABRT Sep 12 01:47:37 volumio go-librespot[1126]: time="2025-09-12T01:47:37+03:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Sep 12 01:47:37 volumio systemd[1]: volumio.service: Failed with result 'signal'. Sep 12 01:47:37 volumio systemd[1]: Started dynamicswap service. Sep 12 01:47:37 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 12 01:47:37 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Sep 12 01:47:37 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Sep 12 01:47:37 volumio systemd[1]: Stopped Volumio Backend Module. Sep 12 01:47:37 volumio systemd[1]: Started Volumio Backend Module. Sep 12 01:47:37 volumio systemd[1]: Started dynamicswap service. Sep 12 01:47:38 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 12 01:47:39 volumio volumio[5737]: info: ------------------------------------------- Sep 12 01:47:39 volumio volumio[5737]: info: ----- Volumio3 ---- Sep 12 01:47:39 volumio volumio[5737]: info: ------------------------------------------- Sep 12 01:47:39 volumio volumio[5737]: info: ----- System startup ---- Sep 12 01:47:39 volumio volumio[5737]: info: ------------------------------------------- Sep 12 01:47:40 volumio volumio[5737]: info: MYVOLUMIO Environment detected Sep 12 01:47:40 volumio volumio[5737]: info: Plugin folders cleanup Sep 12 01:47:40 volumio volumio[5737]: info: Scanning into folder /volumio/app/plugins/ Sep 12 01:47:40 volumio volumio[5737]: info: Scanning category audio_interface Sep 12 01:47:40 volumio volumio[5737]: info: Scanning category miscellanea Sep 12 01:47:40 volumio volumio[5737]: info: Scanning category music_service Sep 12 01:47:40 volumio volumio[5737]: info: Scanning category plugins.json Sep 12 01:47:40 volumio volumio[5737]: info: Scanning category system_controller Sep 12 01:47:40 volumio volumio[5737]: info: Scanning category user_interface Sep 12 01:47:40 volumio volumio[5737]: info: Scanning into folder /data/plugins/ Sep 12 01:47:40 volumio volumio[5737]: info: Scanning category music_service Sep 12 01:47:40 volumio volumio[5737]: info: Plugin folders cleanup completed Sep 12 01:47:40 volumio volumio[5737]: info: ------------------------------------------- Sep 12 01:47:40 volumio volumio[5737]: info: ----- Core plugins startup ---- Sep 12 01:47:40 volumio volumio[5737]: info: ------------------------------------------- Sep 12 01:47:40 volumio volumio[5737]: info: Loading plugins from folder /volumio/app/plugins/ Sep 12 01:47:40 volumio volumio[5737]: info: Adding plugin upnp to MyMusic Plugins Sep 12 01:47:40 volumio volumio[5737]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 12 01:47:40 volumio volumio[5737]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 12 01:47:40 volumio volumio[5737]: info: Loading plugins from folder /data/plugins/ Sep 12 01:47:40 volumio volumio[5737]: info: Loading plugin "system"... Sep 12 01:47:40 volumio volumio[5737]: info: Loading plugin "appearance"... Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "network"... Sep 12 01:47:41 volumio volumio[5737]: info: Refreshing Cached IP Addresses Sep 12 01:47:41 volumio sudo[5766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 01:47:41 volumio sudo[5766]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 01:47:41 volumio sudo[5766]: pam_unix(sudo:session): session closed for user root Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "services"... Sep 12 01:47:41 volumio sudo[5768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "alsa_controller"... Sep 12 01:47:41 volumio sudo[5768]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 01:47:41 volumio sudo[5768]: pam_unix(sudo:session): session closed for user root Sep 12 01:47:41 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "wizard"... Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "networkfs"... Sep 12 01:47:41 volumio volumio[5737]: info: Starting Udev Watcher for removable devices Sep 12 01:47:41 volumio volumio[5737]: info: Ignoring mount for partition: boot Sep 12 01:47:41 volumio volumio[5737]: info: Ignoring mount for partition: volumio Sep 12 01:47:41 volumio volumio[5737]: info: Ignoring mount for partition: volumio_data Sep 12 01:47:41 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "volumio_command_line_client"... Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "upnp"... Sep 12 01:47:41 volumio volumio[5737]: info: [1757630861560] Starting Upmpd Daemon Sep 12 01:47:41 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "my_music"... Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "mpd"... Sep 12 01:47:41 volumio volumio[5737]: info: Loading plugin "upnp_browser"... Sep 12 01:47:42 volumio volumio[5737]: info: Loading plugin "alarm-clock"... Sep 12 01:47:42 volumio volumio[5737]: info: Loading plugin "airplay_emulation"... Sep 12 01:47:42 volumio volumio[5737]: info: Starting Shairport Sync Sep 12 01:47:42 volumio volumio[5737]: info: Loading plugin "last_100"... Sep 12 01:47:42 volumio volumio[5737]: info: Loading plugin "webradio"... Sep 12 01:47:42 volumio volumio[5737]: info: Loading plugin "i2s_dacs"... Sep 12 01:47:42 volumio volumio[5737]: info: Loading plugin "volumiodiscovery"... Sep 12 01:47:42 volumio volumio[5737]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 12 01:47:42 volumio volumio[5737]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 12 01:47:42 volumio volumio[5737]: *** WARNING *** For more information see Sep 12 01:47:42 volumio volumio[5737]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 12 01:47:42 volumio node[5737]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 12 01:47:42 volumio volumio[5737]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 12 01:47:42 volumio volumio[5737]: *** WARNING *** For more information see Sep 12 01:47:42 volumio node[5737]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 12 01:47:42 volumio node[5737]: *** WARNING *** For more information see Sep 12 01:47:42 volumio node[5737]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 12 01:47:42 volumio node[5737]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 12 01:47:42 volumio node[5737]: *** WARNING *** For more information see Sep 12 01:47:42 volumio volumio[5737]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 12 01:47:42 volumio volumio[5737]: info: Discovery: Started advertising with name: Volumio Sep 12 01:47:42 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 12 01:47:42 volumio volumio[5737]: info: Loading plugin "soundcloud"... Sep 12 01:47:42 volumio volumio-remote-updater[558]: [2025-09-12 01:47:42] [connect] Successful connection Sep 12 01:47:42 volumio volumio[5737]: info: Loading plugin "spop"... Sep 12 01:47:43 volumio volumio[5737]: info: Loading plugin "youtube2"... Sep 12 01:47:46 volumio volumio[5737]: info: Loading plugin "outputs"... Sep 12 01:47:46 volumio volumio[5737]: info: Loading plugin "albumart"... Sep 12 01:47:46 volumio volumio[5737]: info: Plugin example_plugin is not enabled Sep 12 01:47:46 volumio volumio[5737]: info: Loading plugin "inputs"... Sep 12 01:47:46 volumio volumio[5737]: info: Loading plugin "updater_comm"... Sep 12 01:47:46 volumio volumio[5737]: info: Plugin mpdemulation is not enabled Sep 12 01:47:46 volumio volumio[5737]: info: Loading plugin "rest_api"... Sep 12 01:47:46 volumio volumio[5737]: info: Loading plugin "websocket"... Sep 12 01:47:46 volumio volumio[5737]: info: Starting Socket.io Server version 2.3.0 Sep 12 01:47:46 volumio volumio[5737]: info: Loading i18n strings for locale en Sep 12 01:47:46 volumio volumio[5737]: Updating browse sources language Sep 12 01:47:46 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:47:47 volumio volumio[5737]: Forking 3 albumart workers Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::initPlayerControls Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: Express server listening on port 3000 Sep 12 01:47:47 volumio volumio[5737]: [Metrics] WebUI: 8s 69.82ms Sep 12 01:47:47 volumio volumio[5737]: info: CoreStateMachine::resetVolumioState Sep 12 01:47:47 volumio volumio[5737]: info: CoreStateMachine::getcurrentVolume Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::volumioRetrievevolume Sep 12 01:47:47 volumio volumio[5737]: info: CoreStateMachine::pushState Sep 12 01:47:47 volumio volumio[5737]: info: CorePlayQueue::getTrack 0 Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::volumioPushState Sep 12 01:47:47 volumio volumio[5737]: info: Volumio Network Manager: Network status updated: 1 Sep 12 01:47:47 volumio volumio[5737]: verbose: New Socket.io Connection to 192.168.100.197 from 192.168.100.100 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 1 Sep 12 01:47:47 volumio volumio-remote-updater[558]: [2025-09-12 01:47:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1757630862 101 Sep 12 01:47:47 volumio volumio[5737]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Sep 12 01:47:47 volumio volumio[5737]: verbose: New Socket.io Connection to 192.168.100.197 from 192.168.100.100 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 3 Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 01:47:47 volumio volumio[5737]: info: Reloading queue from file Sep 12 01:47:47 volumio volumio[5737]: info: Setting Device type: Raspberry PI Sep 12 01:47:47 volumio volumio[5737]: info: CoreStateMachine::setRepeat false single undefined Sep 12 01:47:47 volumio volumio[5737]: info: CoreStateMachine::pushState Sep 12 01:47:47 volumio volumio[5737]: info: CorePlayQueue::getTrack 0 Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::volumioPushState Sep 12 01:47:47 volumio volumio[5737]: info: CoreStateMachine::setRandom null Sep 12 01:47:47 volumio volumio[5737]: info: CoreStateMachine::pushState Sep 12 01:47:47 volumio volumio[5737]: info: CorePlayQueue::getTrack 0 Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::volumioPushState Sep 12 01:47:47 volumio volumio[5737]: Searching all installed plugins Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: , search Sep 12 01:47:47 volumio volumio[5737]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 12 01:47:47 volumio volumio[5737]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 01:47:47 volumio volumio[5737]: TypeError: Cannot read property 'then' of undefined Sep 12 01:47:47 volumio volumio[5737]: at ControllerMpd.search (/volumio/app/plugins/music_service/mpd/index.js:1583:17) Sep 12 01:47:47 volumio volumio[5737]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Sep 12 01:47:47 volumio volumio[5737]: at CoreMusicLibrary.searchOnPlugin (/volumio/app/musiclibrary.js:668:44) Sep 12 01:47:47 volumio volumio[5737]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:455:27) Sep 12 01:47:47 volumio volumio[5737]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Sep 12 01:47:47 volumio volumio[5737]: at Socket.emit (events.js:315:20) Sep 12 01:47:47 volumio volumio[5737]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Sep 12 01:47:47 volumio volumio[5737]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Sep 12 01:47:47 volumio volumio[5737]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 01:47:47 volumio volumio[5737]: Starting albumart workers Sep 12 01:47:48 volumio volumio[5737]: Starting albumart workers Sep 12 01:47:48 volumio volumio[5737]: Starting albumart workers Sep 12 01:47:48 volumio sudo[5839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-12 01:46 Sep 12 01:47:48 volumio sudo[5839]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"