-- Logs begin at Thu 2019-02-14 02:12:01 PST, end at Tue 2025-11-04 20:09:57 PST. -- Nov 04 20:08:09 volumio-nanopi volumio-remote-updater[712]: [2025-11-04 20:08:09] [connect] Successful connection Nov 04 20:08:19 volumio-nanopi volumio[1108]: error: [yt-cast-receiver] RPC connection error: Nov 04 20:08:19 volumio-nanopi volumio[1108]: (FetchError) request to https://www.youtube.com/api/lounge/bc/bind?AID=38&CI=0&RID=rpc&SID=88A80C0141C80E75&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=93QBEFl5Zdg4POcYFtxh0tJHZyGMdAx5&id=1ea68d25-a16c-475a-a2b2-b3326fd990fd&loungeIdToken=AGdO5p_CnIWNgGwPOEP3rAc1cyvZ14tP8T1h6Y2-Q4oo4axRoYvv7hGPTNdH4Ss7k6dCSFUknOlwt3Jp3-_az2d_0e_je7u9NI338wEuW1xY_cUvbwa4D5I&mdxVersion=2&name=YouTube%20on%20Volumio-NanoPi&obfuscatedGaiaId=&t=1&theme=m&v=2&zx=fe7160bb93c7 failed, reason: Client network socket disconnected before secure TLS connection was established Nov 04 20:08:19 volumio-nanopi volumio[1108]: FetchError: request to https://www.youtube.com/api/lounge/bc/bind?AID=38&CI=0&RID=rpc&SID=88A80C0141C80E75&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=93QBEFl5Zdg4POcYFtxh0tJHZyGMdAx5&id=1ea68d25-a16c-475a-a2b2-b3326fd990fd&loungeIdToken=AGdO5p_CnIWNgGwPOEP3rAc1cyvZ14tP8T1h6Y2-Q4oo4axRoYvv7hGPTNdH4Ss7k6dCSFUknOlwt3Jp3-_az2d_0e_je7u9NI338wEuW1xY_cUvbwa4D5I&mdxVersion=2&name=YouTube%20on%20Volumio-NanoPi&obfuscatedGaiaId=&t=1&theme=m&v=2&zx=fe7160bb93c7 failed, reason: Client network socket disconnected before secure TLS connection was established Nov 04 20:08:19 volumio-nanopi volumio[1108]: at ClientRequest. (/data/plugins/music_service/ytcr/node_modules/node-fetch/lib/index.js:1501:11) Nov 04 20:08:19 volumio-nanopi volumio[1108]: at ClientRequest.emit (events.js:400:28) Nov 04 20:08:19 volumio-nanopi volumio[1108]: at TLSSocket.socketErrorListener (_http_client.js:475:9) Nov 04 20:08:19 volumio-nanopi volumio[1108]: at TLSSocket.emit (events.js:400:28) Nov 04 20:08:19 volumio-nanopi volumio[1108]: at emitErrorNT (internal/streams/destroy.js:106:8) Nov 04 20:08:19 volumio-nanopi volumio[1108]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Nov 04 20:08:19 volumio-nanopi volumio[1108]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Nov 04 20:08:19 volumio-nanopi volumio[1108]: error: [yt-cast-receiver] Retrying 1 / 3 Nov 04 20:08:19 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100:3000 from 192.168.254.114 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Nov 04 20:08:20 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Nov 04 20:08:20 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 04 20:08:20 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 04 20:08:20 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 04 20:08:20 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 04 20:08:20 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 04 20:08:20 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Nov 04 20:08:20 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetVisibleSources Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: Received Get System Info Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: Discovery: Getting this device information Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: Listing playlists Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetQueue Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreStateMachine::getQueue Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 04 20:08:20 volumio-nanopi volumio[1108]: error: [yt-cast-receiver] (YouTube Music) RPC connection terminated due to error: Nov 04 20:08:20 volumio-nanopi volumio[1108]: (BadResponseError) RPC connection request returned bad response Nov 04 20:08:20 volumio-nanopi volumio[1108]: Error info: { Nov 04 20:08:20 volumio-nanopi volumio[1108]: url: 'https://www.youtube.com/api/lounge/bc/bind?AID=38&CI=0&RID=rpc&SID=88A80C0141C80E75&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=93QBEFl5Zdg4POcYFtxh0tJHZyGMdAx5&id=1ea68d25-a16c-475a-a2b2-b3326fd990fd&loungeIdToken=AGdO5p_CnIWNgGwPOEP3rAc1cyvZ14tP8T1h6Y2-Q4oo4axRoYvv7hGPTNdH4Ss7k6dCSFUknOlwt3Jp3-_az2d_0e_je7u9NI338wEuW1xY_cUvbwa4D5I&mdxVersion=2&name=YouTube%20on%20Volumio-NanoPi&obfuscatedGaiaId=&t=1&theme=m&v=2&zx=f403276e4795', Nov 04 20:08:20 volumio-nanopi volumio[1108]: response: Response { Nov 04 20:08:20 volumio-nanopi volumio[1108]: size: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: timeout: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: [Symbol(Body internals)]: { Nov 04 20:08:20 volumio-nanopi volumio[1108]: body: Gunzip { Nov 04 20:08:20 volumio-nanopi volumio[1108]: _writeState: Uint32Array(2) [ 0, 0 ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: _readableState: ReadableState { Nov 04 20:08:20 volumio-nanopi volumio[1108]: objectMode: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: highWaterMark: 16384, Nov 04 20:08:20 volumio-nanopi volumio[1108]: buffer: BufferList { head: null, tail: null, length: 0 }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: length: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: pipes: [], Nov 04 20:08:20 volumio-nanopi volumio[1108]: flowing: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: ended: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: endEmitted: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: reading: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: sync: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: needReadable: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: emittedReadable: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: readableListening: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: resumeScheduled: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: errorEmitted: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: emitClose: true, Nov 04 20:08:20 volumio-nanopi volumio[1108]: autoDestroy: true, Nov 04 20:08:20 volumio-nanopi volumio[1108]: destroyed: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: errored: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: closed: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: closeEmitted: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: defaultEncoding: 'utf8', Nov 04 20:08:20 volumio-nanopi volumio[1108]: awaitDrainWriters: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: multiAwaitDrain: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: readingMore: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: dataEmitted: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: decoder: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: encoding: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: [Symbol(kPaused)]: null Nov 04 20:08:20 volumio-nanopi volumio[1108]: }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _events: [Object: null prototype] { Nov 04 20:08:20 volumio-nanopi volumio[1108]: prefinish: [Function: prefinish], Nov 04 20:08:20 volumio-nanopi volumio[1108]: unpipe: [Function: onunpipe], Nov 04 20:08:20 volumio-nanopi volumio[1108]: error: [ [Function: onerror], [Function (anonymous)] ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: close: [Function: bound onceWrapper] { Nov 04 20:08:20 volumio-nanopi volumio[1108]: listener: [Function: onclose] Nov 04 20:08:20 volumio-nanopi volumio[1108]: }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: finish: [Function: bound onceWrapper] { Nov 04 20:08:20 volumio-nanopi volumio[1108]: listener: [Function: onfinish] Nov 04 20:08:20 volumio-nanopi volumio[1108]: } Nov 04 20:08:20 volumio-nanopi volumio[1108]: }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _eventsCount: 5, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _maxListeners: undefined, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _writableState: WritableState { Nov 04 20:08:20 volumio-nanopi volumio[1108]: objectMode: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: highWaterMark: 16384, Nov 04 20:08:20 volumio-nanopi volumio[1108]: finalCalled: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: needDrain: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: ending: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: ended: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: finished: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: destroyed: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: decodeStrings: true, Nov 04 20:08:20 volumio-nanopi volumio[1108]: defaultEncoding: 'utf8', Nov 04 20:08:20 volumio-nanopi volumio[1108]: length: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: writing: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: corked: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: sync: true, Nov 04 20:08:20 volumio-nanopi volumio[1108]: bufferProcessing: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: onwrite: [Function: bound onwrite], Nov 04 20:08:20 volumio-nanopi volumio[1108]: writecb: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: writelen: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: afterWriteTickInfo: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: buffered: [], Nov 04 20:08:20 volumio-nanopi volumio[1108]: bufferedIndex: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: allBuffers: true, Nov 04 20:08:20 volumio-nanopi volumio[1108]: allNoop: true, Nov 04 20:08:20 volumio-nanopi volumio[1108]: pendingcb: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: prefinished: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: errorEmitted: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: emitClose: true, Nov 04 20:08:20 volumio-nanopi volumio[1108]: autoDestroy: true, Nov 04 20:08:20 volumio-nanopi volumio[1108]: errored: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: closed: false Nov 04 20:08:20 volumio-nanopi volumio[1108]: }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: allowHalfOpen: true, Nov 04 20:08:20 volumio-nanopi volumio[1108]: bytesWritten: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _handle: Zlib { Nov 04 20:08:20 volumio-nanopi volumio[1108]: onerror: [Function: zlibOnError], Nov 04 20:08:20 volumio-nanopi volumio[1108]: [Symbol(owner_symbol)]: [Circular *1] Nov 04 20:08:20 volumio-nanopi volumio[1108]: }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _outBuffer: , Nov 04 20:08:20 volumio-nanopi volumio[1108]: _outOffset: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _chunkSize: 16384, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _defaultFlushFlag: 2, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _finishFlushFlag: 2, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _defaultFullFlushFlag: 3, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _info: undefined, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _maxOutputLength: 1073741823, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _level: -1, Nov 04 20:08:20 volumio-nanopi volumio[1108]: _strategy: 0, Nov 04 20:08:20 volumio-nanopi volumio[1108]: [Symbol(kCapture)]: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: [Symbol(kTransformState)]: { Nov 04 20:08:20 volumio-nanopi volumio[1108]: afterTransform: [Function: bound afterTransform], Nov 04 20:08:20 volumio-nanopi volumio[1108]: needTransform: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: transforming: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: writecb: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: writechunk: null, Nov 04 20:08:20 volumio-nanopi volumio[1108]: writeencoding: null Nov 04 20:08:20 volumio-nanopi volumio[1108]: }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: [Symbol(kError)]: null Nov 04 20:08:20 volumio-nanopi volumio[1108]: }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: disturbed: false, Nov 04 20:08:20 volumio-nanopi volumio[1108]: error: null Nov 04 20:08:20 volumio-nanopi volumio[1108]: }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: [Symbol(Response internals)]: { Nov 04 20:08:20 volumio-nanopi volumio[1108]: url: 'https://www.youtube.com/api/lounge/bc/bind?AID=38&CI=0&RID=rpc&SID=88A80C0141C80E75&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=93QBEFl5Zdg4POcYFtxh0tJHZyGMdAx5&id=1ea68d25-a16c-475a-a2b2-b3326fd990fd&loungeIdToken=AGdO5p_CnIWNgGwPOEP3rAc1cyvZ14tP8T1h6Y2-Q4oo4axRoYvv7hGPTNdH4Ss7k6dCSFUknOlwt3Jp3-_az2d_0e_je7u9NI338wEuW1xY_cUvbwa4D5I&mdxVersion=2&name=YouTube%20on%20Volumio-NanoPi&obfuscatedGaiaId=&t=1&theme=m&v=2&zx=f403276e4795', Nov 04 20:08:20 volumio-nanopi volumio[1108]: status: 400, Nov 04 20:08:20 volumio-nanopi volumio[1108]: statusText: 'Unknown SID', Nov 04 20:08:20 volumio-nanopi volumio[1108]: headers: Headers { Nov 04 20:08:20 volumio-nanopi volumio[1108]: [Symbol(map)]: [Object: null prototype] { Nov 04 20:08:20 volumio-nanopi volumio[1108]: 'cache-control': [ 'no-cache, no-store, max-age=0, must-revalidate' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: pragma: [ 'no-cache' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: expires: [ 'Mon, 01 Jan 1990 00:00:00 GMT' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: date: [ 'Wed, 05 Nov 2025 04:08:21 GMT' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: 'content-type': [ 'text/html; charset=UTF-8' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: 'content-encoding': [ 'gzip' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: 'x-content-type-options': [ 'nosniff' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: 'x-xss-protection': [ '1; mode=block' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: server: [ 'GSE' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: 'alt-svc': [ 'h3=":443"; ma=2592000,h3-29=":443"; ma=2592000' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: connection: [ 'close' ], Nov 04 20:08:20 volumio-nanopi volumio[1108]: 'transfer-encoding': [ 'chunked' ] Nov 04 20:08:20 volumio-nanopi volumio[1108]: } Nov 04 20:08:20 volumio-nanopi volumio[1108]: }, Nov 04 20:08:20 volumio-nanopi volumio[1108]: counter: 0 Nov 04 20:08:20 volumio-nanopi volumio[1108]: } Nov 04 20:08:20 volumio-nanopi volumio[1108]: } Nov 04 20:08:20 volumio-nanopi volumio[1108]: } Nov 04 20:08:20 volumio-nanopi volumio[1108]: Stack trace: Nov 04 20:08:20 volumio-nanopi volumio[1108]: BadResponseError: RPC connection request returned bad response Nov 04 20:08:20 volumio-nanopi volumio[1108]: at RPCConnection._RPCConnection_doConnect (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/RPCConnection.js:129:11) Nov 04 20:08:20 volumio-nanopi volumio[1108]: at runMicrotasks () Nov 04 20:08:20 volumio-nanopi volumio[1108]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Nov 04 20:08:20 volumio-nanopi volumio[1108]: at async RPCConnection._RPCConnection_handleDisconnect (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/RPCConnection.js:145:13) Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:20 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:08:21 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Nov 04 20:08:21 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Nov 04 20:08:24 volumio-nanopi volumio-remote-updater[712]: [2025-11-04 20:08:24] [connect] Successful connection Nov 04 20:08:39 volumio-nanopi volumio-remote-updater[712]: [2025-11-04 20:08:39] [connect] Successful connection Nov 04 20:08:54 volumio-nanopi volumio-remote-updater[712]: [2025-11-04 20:08:54] [connect] Successful connection Nov 04 20:08:59 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:08:59 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:08:59 volumio-nanopi volumio[1108]: info: [1762315739293] ControllerPandora::ExpireOldTracks::reaper Nov 04 20:08:59 volumio-nanopi volumio[1108]: info: [1762315739295] [Pandora] ExpireOldTracks::reaper: Expiring 3 tracks every 10 seconds Nov 04 20:09:01 volumio-nanopi volumio[1108]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Nov 04 20:09:01 volumio-nanopi volumio[1108]: LoungeScreenDisconnected { Nov 04 20:09:01 volumio-nanopi volumio[1108]: AID: null, Nov 04 20:09:01 volumio-nanopi volumio[1108]: name: 'loungeScreenDisconnected', Nov 04 20:09:01 volumio-nanopi volumio[1108]: payload: {} Nov 04 20:09:01 volumio-nanopi volumio[1108]: } Nov 04 20:09:01 volumio-nanopi volumio[1108]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Nov 04 20:09:01 volumio-nanopi volumio[1108]: Error info: { missing: [ 'SID', 'gsessionid' ] } Nov 04 20:09:01 volumio-nanopi volumio[1108]: Stack trace: Nov 04 20:09:01 volumio-nanopi volumio[1108]: IncompleteAPIDataError: Missing data required to construct query string from bind params Nov 04 20:09:01 volumio-nanopi volumio[1108]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Nov 04 20:09:01 volumio-nanopi volumio[1108]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Nov 04 20:09:01 volumio-nanopi volumio[1108]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Nov 04 20:09:01 volumio-nanopi volumio[1108]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Nov 04 20:09:01 volumio-nanopi volumio[1108]: at AsyncTaskQueue.setAutoStart (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:33:18) Nov 04 20:09:01 volumio-nanopi volumio[1108]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:389:59) Nov 04 20:09:01 volumio-nanopi volumio[1108]: at runMicrotasks () Nov 04 20:09:01 volumio-nanopi volumio[1108]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Nov 04 20:09:01 volumio-nanopi volumio[1108]: info: [1762315741993] ControllerPandora::pandoraListener Nov 04 20:09:01 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:01 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: Nov 04 20:09:02 volumio-nanopi volumio[1108]: ---------------------------- MPD announces state update: player Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: Nov 04 20:09:02 volumio-nanopi volumio[1108]: ---------------------------- MPD announces state update: player Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: Nov 04 20:09:02 volumio-nanopi volumio[1108]: ---------------------------- MPD announces state update: player Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: camilladsp spawned new process with pid 14663, instance 1, run: true Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 278 milliseconds Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 265 milliseconds Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 260 milliseconds Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 254 milliseconds Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: [1762315742302] ControllerPandora::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null,"trackType":"mp3"} Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: CURRENT POSITION 0 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::syncState stateService stop Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::syncState currentStatus play Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::play index undefined Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 1 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::setConsumeUpdateService pandora Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ControllerMpd::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 1 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ControllerMpd::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 1 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ControllerMpd::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 1 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 1 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::startPlaybackTimer Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 1 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: [1762315742448] ControllerPandora::clearAddPlayTrack Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ControllerMpd::clear Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand clear Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ------------------------------ 455ms Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ------------------------------ 441ms Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ------------------------------ 437ms Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100:3000 from 192.168.254.114 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: Nov 04 20:09:02 volumio-nanopi volumio[1108]: ---------------------------- MPD announces system playlist update Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: Ignoring MPD Status Update Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: sendMpdCommand clear took 263 milliseconds Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: [1762315742723] ControllerPandora::checkForExpiredStations Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: [1762315742724] [Pandora] checkForExpiredStations: Stations expired Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: [1762315742727] ControllerPandora::PandoraHandler::fillStationData Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.25 UA: Mozilla/5.0 (Linux; Android 11; LM-V600 Build/RKQ1.201105.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: Nov 04 20:09:02 volumio-nanopi volumio[1108]: ---------------------------- MPD announces system playlist update Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: Ignoring MPD Status Update Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: Nov 04 20:09:02 volumio-nanopi volumio[1108]: ---------------------------- MPD announces system playlist update Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: Ignoring MPD Status Update Nov 04 20:09:02 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Nov 04 20:09:02 volumio-nanopi volumio[1108]: error: updateQueue error: null Nov 04 20:09:02 volumio-nanopi volumio[1108]: error: updateQueue error: null Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ------------------------------ 236ms Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ------------------------------ 132ms Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: ------------------------------ 128ms Nov 04 20:09:02 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetVisibleSources Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: Received Get System Info Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: Discovery: Getting this device information Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: Listing playlists Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:03 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:03 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744366] ControllerPandora::removeTrack Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::removeQueueItem Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CorePlayQueue::removeQueueItem 0 Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CorePlayQueue::saveQueue Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushQueue Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744395] [Pandora] removeTrack: Removed track with uri: /pandora/stationToken=113294779785159402trackId=7434738068997263178 at queue index: 0 Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744414] ControllerPandora::appendTracksToMpd Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744417] [Pandora] appendTracksToMpd: Added 1 track(s) to mpd Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand addid Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand play Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetVisibleSources Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Received Get System Info Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Discovery: Getting this device information Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Listing playlists Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetQueue Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::getQueue Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Nov 04 20:09:04 volumio-nanopi volumio[1108]: ---------------------------- MPD announces system playlist update Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Ignoring MPD Status Update Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 406 milliseconds Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: sendMpdCommand addid took 380 milliseconds Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: sendMpdCommand play took 381 milliseconds Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744817] ControllerPandora::pushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null,"trackType":"mp3"} Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: CURRENT POSITION 0 Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::syncState stateService stop Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::syncState currentStatus stop Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: No code Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::setConsumeUpdateService pandora Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: MPD COMMAND [object Object] Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: MPD COMMAND [object Object] Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: MPD COMMAND [object Object] Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744867] ControllerPandora::pushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"A Balloon Enters Kyoto City","name":"A Balloon Enters Kyoto City","artist":"Exotic Animal Petting Zoo","album":"I Have Made My Bed In Darkness (Explicit)","albumart":"http://mediaserver-cont-dc6-1-v4v6.pandora.com/images/f2/d7/55/48/46d14df291133f698c159d3c/1080W_1080H.jpg","realUri":"http://audio-sv5-t2-1-v4v6.pandora.com/access/7730556362320332744.mp3?version=5&lid=1075995428&token=1y%2FZKGjvRtyspEUyr4lMMpUFg%2FpiGjz%2Fme2fjkIBAJZ3NkomBKDm8ULqirUYl25qqMTUvaoMowb7EdHFTjE2HK9I1AHQBI0g4Hzjk7F4d1jDvFiMmTjAcfJ%2F%2BGLeR0oN7Y%2FBNqWBFSBTRUY6ZbFgrdvBRqVfkzyQKrEgZ7K20amqzv72198uyKQSabl3heV3%2B1Oj0t23XcnI0jfvDpaLZdQMxKE6LH7TWDOewM5SMEADacDYdRccO6ZndwOU%2FwX2W2ESaQiLWPhCc6gzFdOxEPoG%2BX2CMPcXdmegJdm9z1kCUgtU3K8gkZIb9Im%2B5aSSaAagx1AUqeUH7AqH7SKQWQ%3D%3D","isStreaming":true,"duration":213,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://audio-sv5-t2-1-v4v6.pandora.com/access/7730556362320332744.mp3?version=5&lid=1075995428&token=1y%2FZKGjvRtyspEUyr4lMMpUFg%2FpiGjz%2Fme2fjkIBAJZ3NkomBKDm8ULqirUYl25qqMTUvaoMowb7EdHFTjE2HK9I1AHQBI0g4Hzjk7F4d1jDvFiMmTjAcfJ%2F%2BGLeR0oN7Y%2FBNqWBFSBTRUY6ZbFgrdvBRqVfkzyQKrEgZ7K20amqzv72198uyKQSabl3heV3%2B1Oj0t23XcnI0jfvDpaLZdQMxKE6LH7TWDOewM5SMEADacDYdRccO6ZndwOU%2FwX2W2ESaQiLWPhCc6gzFdOxEPoG%2BX2CMPcXdmegJdm9z1kCUgtU3K8gkZIb9Im%2B5aSSaAagx1AUqeUH7AqH7SKQWQ%3D%3D","seek":0,"status":"play"} Nov 04 20:09:04 volumio-nanopi volumio[1108]: verbose: CURRENT POSITION 0 Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::syncState stateService play Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::syncState currentStatus stop Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CoreStateMachine::setConsumeUpdateService pandora Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744892] ControllerPandora::fetchAndAddTracks Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744895] ControllerPandora::getStationTracks Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744900] [Pandora] PandoraHandler::getSongMaxDiff: -1 Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744905] ControllerPandora::fetchAndAddTracks::getSqInfo Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744906] ControllerPandora::getStationTracks Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744914] [Pandora] fetchAndAddTracks: diff1: -1 sQPos1: 0 Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744915] [Pandora] fetchAndAddTracks: Fetching tracks Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: [1762315744919] ControllerPandora::PandoraHandler::fillStationData Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Nov 04 20:09:04 volumio-nanopi volumio[1108]: ---------------------------- MPD announces system playlist update Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Ignoring MPD Status Update Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Nov 04 20:09:04 volumio-nanopi volumio[1108]: ---------------------------- MPD announces system playlist update Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Ignoring MPD Status Update Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Nov 04 20:09:04 volumio-nanopi volumio[1108]: ---------------------------- MPD announces system playlist update Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: Ignoring MPD Status Update Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: ------------------------------ 193ms Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: ------------------------------ 64ms Nov 04 20:09:04 volumio-nanopi volumio[1108]: info: ------------------------------ 60ms Nov 04 20:09:05 volumio-nanopi volumio[1108]: info: Nov 04 20:09:05 volumio-nanopi volumio[1108]: ---------------------------- MPD announces system playlist update Nov 04 20:09:05 volumio-nanopi volumio[1108]: info: Ignoring MPD Status Update Nov 04 20:09:05 volumio-nanopi volumio[1108]: info: Nov 04 20:09:05 volumio-nanopi volumio[1108]: ---------------------------- MPD announces system playlist update Nov 04 20:09:05 volumio-nanopi volumio[1108]: info: Ignoring MPD Status Update Nov 04 20:09:07 volumio-nanopi volumio[1108]: info: [1762315747812] ControllerPandora::pandoraListener Nov 04 20:09:07 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:07 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:07 volumio-nanopi volumio[1108]: info: Nov 04 20:09:07 volumio-nanopi volumio[1108]: ---------------------------- MPD announces state update: player Nov 04 20:09:07 volumio-nanopi volumio[1108]: info: ------------------------------ 2829ms Nov 04 20:09:07 volumio-nanopi volumio[1108]: info: ------------------------------ 2820ms Nov 04 20:09:07 volumio-nanopi volumio[1108]: info: ------------------------------ 2815ms Nov 04 20:09:07 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:07 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:07 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Nov 04 20:09:07 volumio-nanopi volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: Nov 04 20:09:08 volumio-nanopi volumio[1108]: ---------------------------- MPD announces state update: player Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 658 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 650 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: Nov 04 20:09:08 volumio-nanopi volumio[1108]: ---------------------------- MPD announces state update: player Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: Nov 04 20:09:08 volumio-nanopi volumio[1108]: ---------------------------- MPD announces state update: player Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: FusionDsp - Loudness is ON true Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 290 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand playlistinfo took 284 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand playlistinfo took 282 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 276 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 271 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseTrackInfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseTrackInfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: [1762315748803] ControllerPandora::pushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4354,"duration":213,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"A Balloon Enters Kyoto City","artist":"Exotic Animal Petting Zoo","album":"I Have Made My Bed In Darkness (Explicit)","uri":"http://audio-sv5-t2-1-v4v6.pandora.com/access/7730556362320332744.mp3?version=5&lid=1075995428&token=1y%2FZKGjvRtyspEUyr4lMMpUFg%2FpiGjz%2Fme2fjkIBAJZ3NkomBKDm8ULqirUYl25qqMTUvaoMowb7EdHFTjE2HK9I1AHQBI0g4Hzjk7F4d1jDvFiMmTjAcfJ%2F%2BGLeR0oN7Y%2FBNqWBFSBTRUY6ZbFgrdvBRqVfkzyQKrEgZ7K20amqzv72198uyKQSabl3heV3%2B1Oj0t23XcnI0jfvDpaLZdQMxKE6LH7TWDOewM5SMEADacDYdRccO6ZndwOU%2FwX2W2ESaQiLWPhCc6gzFdOxEPoG%2BX2CMPcXdmegJdm9z1kCUgtU3K8gkZIb9Im%2B5aSSaAagx1AUqeUH7AqH7SKQWQ%3D%3D","trackType":"mp3"} Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: CURRENT POSITION 0 Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreStateMachine::syncState stateService play Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreStateMachine::syncState currentStatus play Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: Received an update from plugin. extracting info from payload Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreStateMachine::pushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreStateMachine::setConsumeUpdateService pandora Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ControllerMpd::pushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ------------------------------ 1042ms Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: Nov 04 20:09:08 volumio-nanopi volumio[1108]: ---------------------------- MPD announces state update: player Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: Nov 04 20:09:08 volumio-nanopi volumio[1108]: ---------------------------- MPD announces state update: player Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand playlistinfo took 105 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand playlistinfo took 92 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand playlistinfo took 90 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 25 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 20 milliseconds Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseTrackInfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseTrackInfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseTrackInfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:08 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ControllerMpd::pushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ControllerMpd::pushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ControllerMpd::pushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ------------------------------ 454ms Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ------------------------------ 431ms Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: ------------------------------ 425ms Nov 04 20:09:08 volumio-nanopi volumio[1108]: info: [1762315748962] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: sendMpdCommand playlistinfo took 113 milliseconds Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: sendMpdCommand playlistinfo took 113 milliseconds Nov 04 20:09:09 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseTrackInfo Nov 04 20:09:09 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseTrackInfo Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: ControllerMpd::pushState Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: ControllerMpd::pushState Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::servicePushState Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CorePlayQueue::getTrack 0 Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: ------------------------------ 172ms Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: ------------------------------ 167ms Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioGetQueue Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CoreStateMachine::getQueue Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:09:09 volumio-nanopi volumio-remote-updater[712]: [2025-11-04 20:09:09] [connect] Successful connection Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: FusionDsp - volume level for loudness 47 gain applied 1.53 Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: FusionDsp - Loudness is ON true Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: FusionDsp - volume level for loudness 47 gain applied 1.53 Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: FusionDsp - Loudness is ON true Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: [1762315749909] ControllerPandora::removeTrack Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: [1762315749910] [Pandora] removeTrack: Not removing track with uri: /pandora/stationToken=113294779785159402trackId=7730556362320332744 at queue index: 0 Nov 04 20:09:09 volumio-nanopi volumio[1108]: info: [1762315749911] [Pandora] ExpireOldTracks::reaper::voorhees: Expired A Balloon Enters Kyoto City by Exotic Animal Petting Zoo Nov 04 20:09:10 volumio-nanopi volumio-remote-updater[712]: [2025-11-04 20:09:10] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1762315749 101 Nov 04 20:09:10 volumio-nanopi volumio[1108]: 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: 16 Nov 04 20:09:40 volumio-nanopi volumio-remote-updater[712]: [2025-11-04 20:09:40] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Nov 04 20:09:45 volumio-nanopi volumio-remote-updater[712]: [2025-11-04 20:09:45] [connect] Successful connection Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: [1762315789888] ControllerPandora::removeTrack Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: CoreStateMachine::removeQueueItem Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: CorePlayQueue::removeQueueItem 1 Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: CorePlayQueue::saveQueue Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushQueue Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: [1762315789964] [Pandora] removeTrack: Removed track with uri: /pandora/stationToken=113294779785159402trackId=8797686773195890576 at queue index: 1 Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:49 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:49 volumio-nanopi volumio[1108]: info: [1762315789972] [Pandora] ExpireOldTracks::reaper::voorhees: Expired Ephemeral by Pelican Nov 04 20:09:50 volumio-nanopi volumio[1108]: info: CorePlayQueue::getQueue Nov 04 20:09:50 volumio-nanopi volumio[1108]: info: [1762315790123] ControllerPandora::removeTrack Nov 04 20:09:50 volumio-nanopi volumio[1108]: info: CoreStateMachine::removeQueueItem Nov 04 20:09:50 volumio-nanopi volumio[1108]: info: CorePlayQueue::removeQueueItem 1 Nov 04 20:09:50 volumio-nanopi volumio[1108]: info: CorePlayQueue::saveQueue Nov 04 20:09:50 volumio-nanopi volumio[1108]: info: CoreCommandRouter::volumioPushQueue Nov 04 20:09:50 volumio-nanopi volumio[1108]: info: [1762315790141] [Pandora] removeTrack: Removed track with uri: /pandora/stationToken=113294779785159402trackId=7336565630848049686 at queue index: 1 Nov 04 20:09:50 volumio-nanopi volumio[1108]: info: ControllerMpd::getState Nov 04 20:09:50 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand status Nov 04 20:09:50 volumio-nanopi volumio[1108]: info: [1762315790145] [Pandora] ExpireOldTracks::reaper::voorhees: Expired 359° by Long Distance Calling Nov 04 20:09:53 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 3252 milliseconds Nov 04 20:09:53 volumio-nanopi volumio[1108]: info: sendMpdCommand status took 3082 milliseconds Nov 04 20:09:53 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:53 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 20:09:53 volumio-nanopi volumio[1108]: verbose: ControllerMpd::parseState Nov 04 20:09:53 volumio-nanopi volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 20:09:53 volumio-nanopi volumio[1108]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 20:09:53 volumio-nanopi volumio[1108]: SyntaxError: Unexpected end of JSON input Nov 04 20:09:53 volumio-nanopi volumio[1108]: at JSON.parse () Nov 04 20:09:53 volumio-nanopi volumio[1108]: at Request._callback (/data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:41:31) Nov 04 20:09:53 volumio-nanopi volumio[1108]: at Request.self.callback (/data/plugins/music_service/pandora/node_modules/request/request.js:185:22) Nov 04 20:09:53 volumio-nanopi volumio[1108]: at Request.emit (events.js:400:28) Nov 04 20:09:53 volumio-nanopi volumio[1108]: at Request. (/data/plugins/music_service/pandora/node_modules/request/request.js:1154:10) Nov 04 20:09:53 volumio-nanopi volumio[1108]: at Request.emit (events.js:400:28) Nov 04 20:09:53 volumio-nanopi volumio[1108]: at IncomingMessage. (/data/plugins/music_service/pandora/node_modules/request/request.js:1076:12) Nov 04 20:09:53 volumio-nanopi volumio[1108]: at Object.onceWrapper (events.js:519:28) Nov 04 20:09:53 volumio-nanopi volumio[1108]: at IncomingMessage.emit (events.js:412:35) Nov 04 20:09:53 volumio-nanopi volumio[1108]: at IncomingMessage. (/data/plugins/music_service/pandora/node_modules/request/request.js:993:23) Nov 04 20:09:53 volumio-nanopi volumio[1108]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 20:09:57 volumio-nanopi volumio-remote-updater[712]: [2025-11-04 20:09:57] [connect] Successful connection Nov 04 20:09:57 volumio-nanopi sudo[14818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-04 20:08 Nov 04 20:09:57 volumio-nanopi sudo[14818]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 29 Jul 2025 12:40:52 PM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_DEVICENAME="Orange Pi PC" VOLUMIO_HASH="053d26d2b7f23be800db334519309821"