-- Logs begin at Thu 2019-02-14 19:11:59 KST, end at Tue 2025-05-06 12:58:15 KST. -- May 06 12:57:01 hswhdx volumio[776]: Searching all installed plugins May 06 12:57:01 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 12:57:01 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 06 12:57:01 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: last_100 , search May 06 12:57:01 hswhdx volumio[776]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 May 06 12:57:01 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 06 12:57:01 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 06 12:57:01 hswhdx volumio[776]: info: [youtube2] InnertubeLoader: creating Innertube instance... May 06 12:57:02 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: personal_radio , search May 06 12:57:02 hswhdx volumio[776]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin personal_radio May 06 12:57:02 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: tidal , search May 06 12:57:03 hswhdx volumio[776]: info: searchTIDALUri took 844 milliseconds May 06 12:57:03 hswhdx volumio[776]: info: search took 846 milliseconds May 06 12:57:03 hswhdx volumio[776]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. May 06 12:57:12 hswhdx volumio-remote-updater[544]: [2025-05-06 12:57:12] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] May 06 12:57:17 hswhdx volumio-remote-updater[544]: [2025-05-06 12:57:17] [connect] Successful connection May 06 12:57:22 hswhdx volumio[776]: info: [youtube2] InnertubeLoader: obtaining po_token by visitorData... May 06 12:57:22 hswhdx volumio[776]: error: Search in plugin youtube2 timed out May 06 12:57:22 hswhdx volumio[776]: info: All search sources collected, pushing search results May 06 12:57:23 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 12:57:23 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 12:57:23 hswhdx volumio[776]: info: Discovery: Getting this device information May 06 12:57:23 hswhdx volumio[776]: info: CoreCommandRouter::volumioGetState May 06 12:57:23 hswhdx volumio[776]: info: CorePlayQueue::getTrack 0 May 06 12:57:23 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 12:57:24 hswhdx volumio[776]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 May 06 12:57:24 hswhdx volumio[776]: 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 06 12:57:24 hswhdx volumio[776]: info: CoreCommandRouter::volumioGetState May 06 12:57:24 hswhdx volumio[776]: info: CorePlayQueue::getTrack 0 May 06 12:57:24 hswhdx volumio[776]: info: CoreCommandRouter::volumioGetState May 06 12:57:24 hswhdx volumio[776]: info: CorePlayQueue::getTrack 0 May 06 12:57:24 hswhdx volumio[776]: info: [youtube2] InnertubeLoader: obtained po_token (expires in 43200 seconds) May 06 12:57:24 hswhdx volumio[776]: info: [youtube2] InnertubeLoader: re-create Innertube instance with po_token May 06 12:57:24 hswhdx volumio[776]: info: [youtube2] InnertubeLoader: creating Innertube instance with po_token... May 06 12:57:25 hswhdx volumio[776]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. May 06 12:57:30 hswhdx volumio-remote-updater[544]: [2025-05-06 12:57:30] [connect] Successful connection May 06 12:57:41 hswhdx volumio[776]: info: [youtube2] InnertubeLoader: going to refresh po_token in 43100 seconds May 06 12:57:41 hswhdx volumio[776]: verbose: New Socket.io Connection to 192.168.50.160 from 192.168.50.62 UA: Mozilla/5.0 (Linux; Android 14; SM-A235N Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 06 12:57:41 hswhdx volumio[776]: verbose: New Socket.io Connection to 192.168.50.160:3000 from 192.168.50.62 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 May 06 12:57:41 hswhdx volumio[776]: verbose: New Socket.io Connection to 192.168.50.160 from 192.168.50.62 UA: Mozilla/5.0 (Linux; Android 14; SM-A235N Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 May 06 12:57:41 hswhdx volumio[776]: verbose: New Socket.io Connection to 192.168.50.160 from 192.168.50.62 UA: Mozilla/5.0 (Linux; Android 14; SM-A235N Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 May 06 12:57:41 hswhdx volumio[776]: verbose: New Socket.io Connection to 192.168.50.160 from 192.168.50.62 UA: Mozilla/5.0 (Linux; Android 14; SM-A235N Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 06 12:57:41 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 12:57:41 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 12:57:41 hswhdx volumio[776]: info: Discovery: Getting this device information May 06 12:57:41 hswhdx volumio[776]: info: CoreCommandRouter::volumioGetState May 06 12:57:41 hswhdx volumio[776]: info: CorePlayQueue::getTrack 0 May 06 12:57:41 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 12:57:41 hswhdx volumio[776]: info: CoreCommandRouter::volumioGetState May 06 12:57:41 hswhdx volumio[776]: info: CorePlayQueue::getTrack 0 May 06 12:57:41 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 06 12:57:41 hswhdx volumio[776]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 06 12:57:41 hswhdx volumio[776]: info: Listing playlists May 06 12:57:41 hswhdx volumio[776]: info: CoreCommandRouter::volumioGetVisibleSources May 06 12:57:41 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 12:57:41 hswhdx volumio[776]: info: CoreCommandRouter::volumioGetQueue May 06 12:57:41 hswhdx volumio[776]: info: CoreStateMachine::getQueue May 06 12:57:41 hswhdx volumio[776]: info: CorePlayQueue::getQueue May 06 12:57:42 hswhdx volumio[776]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 06 12:57:42 hswhdx volumio[776]: command_run: { startIndex: 0, length: 82, onTap: { innertubeCommand: [Object] } }, May 06 12:57:42 hswhdx volumio[776]: input_data: { May 06 12:57:42 hswhdx volumio[776]: content: 'Symphony No. 6 in B Minor, Op. 74 "Pathetique" - Pyotr Ilyich Tchaikovsky · 49:53', May 06 12:57:42 hswhdx volumio[776]: commandRuns: [ [Object] ] May 06 12:57:42 hswhdx volumio[776]: }, May 06 12:57:42 hswhdx volumio[776]: parsed_runs: [ May 06 12:57:42 hswhdx volumio[776]: { May 06 12:57:42 hswhdx volumio[776]: text: 'Symphony No. 6 in B Minor, Op. 74 "Pathetique" - Pyotr Ilyich Tchaikovsky · 49:53', May 06 12:57:42 hswhdx volumio[776]: startIndex: 0 May 06 12:57:42 hswhdx volumio[776]: } May 06 12:57:42 hswhdx volumio[776]: ] May 06 12:57:42 hswhdx volumio[776]: } May 06 12:57:42 hswhdx volumio[776]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 06 12:57:42 hswhdx volumio[776]: command_run: { startIndex: 0, length: 40, onTap: { innertubeCommand: [Object] } }, May 06 12:57:42 hswhdx volumio[776]: input_data: { May 06 12:57:42 hswhdx volumio[776]: content: 'I See The Light (From "Tangled") · 3:53', May 06 12:57:42 hswhdx volumio[776]: commandRuns: [ [Object] ] May 06 12:57:42 hswhdx volumio[776]: }, May 06 12:57:42 hswhdx volumio[776]: parsed_runs: [ May 06 12:57:42 hswhdx volumio[776]: { text: 'I See The Light (From "Tangled") · 3:53', startIndex: 0 } May 06 12:57:42 hswhdx volumio[776]: ] May 06 12:57:42 hswhdx volumio[776]: } May 06 12:57:42 hswhdx volumio[776]: error: Failed search in plugin youtube2: Error: Unable to resolve or reject the same promise twice May 06 12:57:45 hswhdx volumio-remote-updater[544]: [2025-05-06 12:57:45] [connect] Successful connection May 06 12:57:45 hswhdx volumio-remote-updater[544]: [2025-05-06 12:57:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1746503865 101 May 06 12:57:45 hswhdx volumio[776]: 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: 12 May 06 12:57:47 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri May 06 12:57:48 hswhdx volumio[776]: info: browseTIDALUri took 828 milliseconds May 06 12:57:48 hswhdx volumio[776]: info: Preload queue cleared May 06 12:57:48 hswhdx volumio[776]: info: Preloading song: tidal://song/4684751 May 06 12:57:48 hswhdx volumio[776]: info: Preloading song: tidal://song/4684752 May 06 12:57:48 hswhdx volumio[776]: info: Preloading song: tidal://song/4684753 May 06 12:57:48 hswhdx volumio[776]: info: Preloading song: tidal://song/4684754 May 06 12:57:48 hswhdx volumio[776]: info: Exploding uri tidal://song/4684751 in service tidal May 06 12:57:48 hswhdx volumio[776]: info: Exploding uri tidal://song/4684752 in service tidal May 06 12:57:48 hswhdx volumio[776]: info: Exploding uri tidal://song/4684753 in service tidal May 06 12:57:48 hswhdx volumio[776]: info: Exploding uri tidal://song/4684754 in service tidal May 06 12:57:48 hswhdx volumio[776]: info: explodeTIDALUri took 488 milliseconds May 06 12:57:48 hswhdx volumio[776]: info: explodeTIDALUri took 531 milliseconds May 06 12:57:49 hswhdx volumio[776]: info: explodeTIDALUri took 531 milliseconds May 06 12:57:49 hswhdx volumio[776]: info: explodeTIDALUri took 530 milliseconds May 06 12:57:54 hswhdx volumio[776]: info: Preload queue cleared May 06 12:57:54 hswhdx volumio[776]: info: CoreCommandRouter::volumioReplaceandPlayItems May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::ClearQueue May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::stop May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::clearPlayQueue May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::saveQueue May 06 12:57:54 hswhdx volumio[776]: info: CoreCommandRouter::volumioPushQueue May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::addQueueItems May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::addQueueItems May 06 12:57:54 hswhdx volumio[776]: info: Preload queue cleared May 06 12:57:54 hswhdx volumio[776]: info: Adding Item to queue: tidal://song/4684751 May 06 12:57:54 hswhdx volumio[776]: info: Using cached record of: tidal://song/4684751 May 06 12:57:54 hswhdx volumio[776]: info: CoreCommandRouter::volumioPushQueue May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::saveQueue May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::updateTrackBlock May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::getTrackBlock May 06 12:57:54 hswhdx volumio[776]: info: CoreCommandRouter::volumioPlay May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::play index 0 May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::addQueueItems May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::addQueueItems May 06 12:57:54 hswhdx volumio[776]: info: Preload queue cleared May 06 12:57:54 hswhdx volumio[776]: info: Adding Item to queue: tidal://song/4684752 May 06 12:57:54 hswhdx volumio[776]: info: Using cached record of: tidal://song/4684752 May 06 12:57:54 hswhdx volumio[776]: info: Adding Item to queue: tidal://song/4684753 May 06 12:57:54 hswhdx volumio[776]: info: Using cached record of: tidal://song/4684753 May 06 12:57:54 hswhdx volumio[776]: info: Adding Item to queue: tidal://song/4684754 May 06 12:57:54 hswhdx volumio[776]: info: Using cached record of: tidal://song/4684754 May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::stop May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 12:57:54 hswhdx volumio[776]: info: CoreCommandRouter::volumioPushQueue May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::saveQueue May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::play index undefined May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::updateTrackBlock May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::getTrackBlock May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::getTrack 0 May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::startPlaybackTimer May 06 12:57:54 hswhdx volumio[776]: info: CorePlayQueue::getTrack 0 May 06 12:57:54 hswhdx volumio[776]: info: [1746503874524] ControllerTidal::clearAddPlayTrack May 06 12:57:54 hswhdx volumio[776]: info: Getting stream with soundQuality LOSSLESS May 06 12:57:54 hswhdx volumio[776]: verbose: ControllerMpd::sendMpdCommand stop May 06 12:57:54 hswhdx volumio[776]: info: sendMpdCommand stop took 15 milliseconds May 06 12:57:54 hswhdx volumio[776]: verbose: ControllerMpd::sendMpdCommand clear May 06 12:57:54 hswhdx volumio[776]: info: May 06 12:57:54 hswhdx volumio[776]: ---------------------------- MPD announces system playlist update May 06 12:57:54 hswhdx volumio[776]: info: Ignoring MPD Status Update May 06 12:57:54 hswhdx volumio[776]: info: sendMpdCommand clear took 6 milliseconds May 06 12:57:54 hswhdx volumio[776]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/4684751&soundQuality=LOSSLESS" May 06 12:57:54 hswhdx volumio[776]: error: updateQueue error: null May 06 12:57:54 hswhdx volumio[776]: info: May 06 12:57:54 hswhdx volumio[776]: ---------------------------- MPD announces system playlist update May 06 12:57:54 hswhdx volumio[776]: info: Ignoring MPD Status Update May 06 12:57:54 hswhdx volumio[776]: info: ------------------------------ 9ms May 06 12:57:54 hswhdx volumio[776]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/4684751&soundQuality=LOSSLESS" took 7 milliseconds May 06 12:57:54 hswhdx volumio[776]: info: CoreStateMachine::setConsumeUpdateService mpd May 06 12:57:54 hswhdx volumio[776]: verbose: ControllerMpd::sendMpdCommand play May 06 12:57:54 hswhdx volumio[776]: STREAMING PROXY: Handling url /?data=tidal://song/4684751&soundQuality=LOSSLESS May 06 12:57:54 hswhdx volumio[776]: info: ------------------------------ 8ms May 06 12:57:54 hswhdx volumio[776]: info: sendMpdCommand play took 6 milliseconds May 06 12:57:54 hswhdx volumio[776]: info: Executing endpoint getStreamUrltidal May 06 12:57:54 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 06 12:57:55 hswhdx volumio[776]: info: getStreamUrl took 744 milliseconds May 06 12:57:55 hswhdx volumio[776]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEicwOGZmNjcyNDViMTY3OTY5NTlkZTk1YzBiZDQ0ZTE5OV82MS5tcDQ/0.flac?Expires=1746507475&Signature=wnnLjJSD5gx~IXQANhCIHPGkrVLxpFicAguXKF2UJo6jmJowD0~XIuo0Dl3I8O18c16vB2X5GrREVgbQxOtoY8aMQkiRJrmBNFgvETmzNGHkk28wAd2kAkXVouNL3eu1u6RcC1ZxwTRCOawsviOl43eWJNR8ig6Lboa-oIeRAho9olJ4DfqiRd8PIBU~Hc80HtoUHPj7AxRkq-1ReI5x7sfUdBwzXbXT6-5UlgGLXmqpZ8WihU29ZqiFxGuB3879ToDge8biBZdCcz3QtCxv06Si6R56cQ4vIKAQgDJykd7nH0aoTp1KgCdZcS1Vi1Xy0iHu6idFg-QYskgdeqMYbA__&Key-Pair-Id=K14LZCZ9QUI4JL May 06 12:57:55 hswhdx volumio[776]: STREAMING PROXY: Response: 200, length: 87445962 May 06 12:57:55 hswhdx volumio[776]: info: May 06 12:57:55 hswhdx volumio[776]: ---------------------------- MPD announces state update: player May 06 12:57:55 hswhdx volumio[776]: info: ControllerMpd::getState May 06 12:57:55 hswhdx volumio[776]: verbose: ControllerMpd::sendMpdCommand status May 06 12:57:55 hswhdx volumio[776]: info: May 06 12:57:55 hswhdx volumio[776]: ---------------------------- MPD announces state update: player May 06 12:57:55 hswhdx volumio[776]: info: ControllerMpd::getState May 06 12:57:55 hswhdx volumio[776]: verbose: ControllerMpd::sendMpdCommand status May 06 12:57:55 hswhdx volumio[776]: info: sendMpdCommand status took 3 milliseconds May 06 12:57:55 hswhdx volumio[776]: verbose: ControllerMpd::parseState May 06 12:57:55 hswhdx volumio[776]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 12:57:55 hswhdx volumio[776]: info: sendMpdCommand status took 5 milliseconds May 06 12:57:55 hswhdx volumio[776]: info: sendMpdCommand playlistinfo took 2 milliseconds May 06 12:57:55 hswhdx volumio[776]: verbose: ControllerMpd::parseState May 06 12:57:55 hswhdx volumio[776]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 12:57:55 hswhdx volumio[776]: verbose: ControllerMpd::parseTrackInfo May 06 12:57:55 hswhdx volumio[776]: info: ControllerMpd::pushState May 06 12:57:55 hswhdx volumio[776]: info: CoreCommandRouter::servicePushState May 06 12:57:55 hswhdx volumio[776]: info: CorePlayQueue::getTrack 0 May 06 12:57:55 hswhdx volumio[776]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1061,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4684751&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/4684751&soundQuality=LOSSLESS","trackType":"tidal"} May 06 12:57:55 hswhdx volumio[776]: verbose: CURRENT POSITION 0 May 06 12:57:55 hswhdx volumio[776]: info: CoreStateMachine::syncState stateService play May 06 12:57:55 hswhdx volumio[776]: info: CoreStateMachine::syncState currentStatus stop May 06 12:57:55 hswhdx volumio[776]: info: ------------------------------ 19ms May 06 12:57:55 hswhdx volumio[776]: info: sendMpdCommand playlistinfo took 9 milliseconds May 06 12:57:55 hswhdx volumio[776]: verbose: ControllerMpd::parseTrackInfo May 06 12:57:55 hswhdx volumio[776]: info: ControllerMpd::pushState May 06 12:57:55 hswhdx volumio[776]: info: CoreCommandRouter::servicePushState May 06 12:57:55 hswhdx volumio[776]: info: CorePlayQueue::getTrack 0 May 06 12:57:55 hswhdx volumio[776]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1061,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4684751&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/4684751&soundQuality=LOSSLESS","trackType":"tidal"} May 06 12:57:55 hswhdx volumio[776]: verbose: CURRENT POSITION 0 May 06 12:57:55 hswhdx volumio[776]: info: CoreStateMachine::syncState stateService play May 06 12:57:55 hswhdx volumio[776]: info: CoreStateMachine::syncState currentStatus play May 06 12:57:55 hswhdx volumio[776]: info: Received an update from plugin. extracting info from payload May 06 12:57:55 hswhdx volumio[776]: info: CoreStateMachine::pushState May 06 12:57:55 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 12:57:55 hswhdx volumio[776]: info: CoreCommandRouter::volumioPushState May 06 12:57:55 hswhdx volumio[776]: info: CoreStateMachine::pushState May 06 12:57:55 hswhdx volumio[776]: info: CoreCommandRouter::volumioPushState May 06 12:57:55 hswhdx volumio[776]: info: ------------------------------ 43ms May 06 12:57:56 hswhdx volumio[776]: info: touch_display: Setting screensaver timeout to 0 seconds. May 06 12:58:04 hswhdx volumio[776]: STREAMING PROXY: Client dropped request, destroying May 06 12:58:14 hswhdx volumio[776]: info: CoreCommandRouter::volumioSaveQueueToPlaylist May 06 12:58:14 hswhdx volumio[776]: info: CoreStateMachine::getQueue May 06 12:58:14 hswhdx volumio[776]: info: CorePlayQueue::getQueue May 06 12:58:14 hswhdx volumio[776]: info: Saving Cloud item Tchaikovsky Symphony No.6 in B minor, Op.74 “Pathétique” May 06 12:58:14 hswhdx volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_volumio , saveCloudItem May 06 12:58:14 hswhdx volumio[776]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 12:58:14 hswhdx volumio[776]: Error: Reference.child failed: First argument was an invalid path = "/user_data/Y1tqxwgnPBO41HjZ1ERZzk9xxef1/myPlaylists/Tchaikovsky Symphony No.6 in B minor, Op.74 “Pathétique”". Paths must be non-empty strings and can't contain ".", "#", "$", "[", or "]" May 06 12:58:14 hswhdx volumio[776]: at validatePathString (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:1667:15) May 06 12:58:14 hswhdx volumio[776]: at validateRootPathString (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:1679:5) May 06 12:58:14 hswhdx volumio[776]: at Reference.child (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:13737:17) May 06 12:58:14 hswhdx volumio[776]: at Database.ref (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:15115:48) May 06 12:58:14 hswhdx volumio[776]: at myVolumio.syncJSONToCloud (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:28817) May 06 12:58:14 hswhdx volumio[776]: at myVolumio.saveCloudMyPlaylist (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:23840) May 06 12:58:14 hswhdx volumio[776]: at myVolumio.saveCloudItem (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:18337) May 06 12:58:14 hswhdx volumio[776]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) May 06 12:58:14 hswhdx volumio[776]: at PlaylistManager.saveJSONFile (/volumio/app/playlistManager.js:613:31) May 06 12:58:14 hswhdx volumio[776]: at PlaylistManager.commonAddItemsToPlaylist (/volumio/app/playlistManager.js:834:8) May 06 12:58:14 hswhdx volumio[776]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 12:58:15 hswhdx sudo[5192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-06 12:57 May 06 12:58:15 hswhdx sudo[5192]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"