Nov 23 15:59:53 volumio-pi4.lan volumio[2518]: info: CoreCommandRouter::volumioGetState Nov 23 15:59:53 volumio-pi4.lan volumio[2518]: info: CorePlayQueue::getTrack 0 Nov 23 15:59:54 volumio-pi4.lan volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 23 15:59:54 volumio-pi4.lan volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 23 16:00:00 volumio-pi4.lan volumio[2518]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 23 16:00:07 volumio-pi4.lan volumio[2518]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Nov 23 16:00:07 volumio-pi4.lan volumio[2518]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Nov 23 16:00:08 volumio-pi4.lan volumio[2518]: info: CoreCommandRouter::volumioGetState Nov 23 16:00:08 volumio-pi4.lan volumio[2518]: info: CorePlayQueue::getTrack 0 Nov 23 16:00:11 volumio-pi4.lan volumio[2518]: verbose: ----------------------------------- Nov 23 16:00:11 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (AID: 9) (YouTube Music) Incoming message: 'noop' Nov 23 16:00:11 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (AID: 9) (YouTube Music) Not handled: 'noop' Nov 23 16:00:17 volumio-pi4.lan volumio[2518]: verbose: ----------------------------------- Nov 23 16:00:17 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (AID: 9) (YouTube) Incoming message: 'noop' Nov 23 16:00:17 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (AID: 9) (YouTube) Not handled: 'noop' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: info: Enabling plugin ytcr Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: info: Loading plugin "ytcr"... Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: info: PLUGIN START: ytcr Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] Setting app pid to stored value: 041c0c8a-3c70-4683-929e-7be998fcbb49 Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] Starting YouTubeApp... Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube) Configuring session with stored MDX context: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: deviceId: 'e51b1e88-f053-4186-962f-ce8ccf3afe93', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: screenId: '32e1gnpip48vt1vl414pl5uueb' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube Music) Configuring session with stored MDX context: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: deviceId: 'd853d13c-b91f-4aad-9acb-da67a89e0159', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: screenId: '9uoemca4112tcmoagt22mi16u1' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube Music) Obtained lounge token: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: screenId: '9uoemca4112tcmoagt22mi16u1', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: refreshIntervalInMillis: 1123200000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: remoteRefreshIntervalMs: 79200000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: refreshIntervalMs: 1123200000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: loungeTokenLifespanMs: 1209600000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: loungeToken: 'AGdO5p-_BPlimB07QW7u_-Ldk_G9ENaBKwui_CWgvRHEXUOPyYgq-rYC0TLtJPnulYCxkHxjdSN-30nqKGuVMH20u_RtgmEcRJ2NFOfvIrhKeR6KBj56fLA', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: remoteRefreshIntervalInMillis: 79200000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: expiration: 1733472018513 Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube) Obtained lounge token: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: screenId: '32e1gnpip48vt1vl414pl5uueb', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: refreshIntervalInMillis: 1123200000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: remoteRefreshIntervalMs: 79200000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: refreshIntervalMs: 1123200000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: loungeTokenLifespanMs: 1209600000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: loungeToken: 'AGdO5p_TlEs74oWSkw-xB6rle6naZUe8Jm16gtFcNhvBcDxFsLSeJi162GFsmUnNxch1zqgZTD_eWTHzLjnfeJLuQ8NsHtA2AqYTrcDfNC6T8_wfiwlb5mg', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: remoteRefreshIntervalInMillis: 79200000, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: expiration: 1733472018515 Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube) Received messages for establishing session: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: [ Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: Message { AID: 0, name: 'c', payload: [ 'BECD3422FFDC241A', '', 8 ] }, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: Message { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: AID: 1, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: name: 'S', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: payload: 'B8SgsM1BlzopZSnjsJC1tdhJRawBEN9e' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: }, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: Message { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: AID: 2, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: name: 'loungeStatus', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: payload: { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: queueId: 'RQ6f6GCqDENMhjqKgJxFxsrcpMINs', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: devices: '[{"app":"ytcr","capabilities":"dsp,mic,dpa,ntb,que,mus","clientName":"unknown","experiments":"","name":"YouTube on volumio-pi4.lan","theme":"cl","id":"e51b1e88-f053-4186-962f-ce8ccf3afe93","type":"LOUNGE_SCREEN","hasCc":"true","deviceInfo":"{\\"year\\":0,\\"os\\":\\"Windows\\",\\"osVersion\\":\\"10.0\\",\\"chipset\\":\\"\\",\\"clientName\\":\\"TVHTML5\\",\\"dialAdditionalDataSupportLevel\\":\\"unsupported\\",\\"mdxDialServerType\\":\\"MDX_DIAL_SERVER_TYPE_UNKNOWN\\",\\"brand\\":\\"Generic\\",\\"model\\":\\"SmartTV\\"}","receiverIdentityMatchStatus":"IS_RECEIVER"}]', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: connectionEventDetails: '{"deviceId":"e51b1e88-f053-4186-962f-ce8ccf3afe93"}' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: }, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: Message { AID: 3, name: 'getNowPlaying', payload: {} } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: ] Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: ----------------------------------- Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (AID: 2) (YouTube) Incoming message: 'loungeStatus' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] Connecting to RPC URL: https://www.youtube.com/api/lounge/bc/bind?AID=3&CI=0&RID=rpc&SID=BECD3422FFDC241A&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=B8SgsM1BlzopZSnjsJC1tdhJRawBEN9e&id=e51b1e88-f053-4186-962f-ce8ccf3afe93&loungeIdToken=AGdO5p_TlEs74oWSkw-xB6rle6naZUe8Jm16gtFcNhvBcDxFsLSeJi162GFsmUnNxch1zqgZTD_eWTHzLjnfeJLuQ8NsHtA2AqYTrcDfNC6T8_wfiwlb5mg&mdxVersion=2&name=YouTube%20on%20volumio-pi4.lan&obfuscatedGaiaId=&t=1&theme=cl&v=2&zx=363337fc5a81 Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] RPC connection established. Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube) Session established. Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube) Saving MDX context to data store: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: deviceId: 'e51b1e88-f053-4186-962f-ce8ccf3afe93', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: screenId: '32e1gnpip48vt1vl414pl5uueb' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: ----------------------------------- Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (AID: 4) (YouTube) Incoming message: 'noop' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (AID: 4) (YouTube) Not handled: 'noop' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube Music) Received messages for establishing session: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: [ Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: Message { AID: 0, name: 'c', payload: [ 'D0D867A9FCA79B90', '', 8 ] }, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: Message { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: AID: 1, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: name: 'S', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: payload: 'pfr_j92YLdpy0jb5nniE53BB2cgLN0Pc' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: }, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: Message { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: AID: 2, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: name: 'loungeStatus', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: payload: { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: queueId: 'RQ50xYirVdCdGr3buagygr0wnb0WA', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: devices: '[{"app":"ytcr","capabilities":"dsp,mic,dpa,ntb","clientName":"unknown","experiments":"","name":"YouTube on volumio-pi4.lan","theme":"m","id":"d853d13c-b91f-4aad-9acb-da67a89e0159","type":"LOUNGE_SCREEN","hasCc":"true","deviceInfo":"{\\"year\\":0,\\"os\\":\\"Windows\\",\\"osVersion\\":\\"10.0\\",\\"chipset\\":\\"\\",\\"clientName\\":\\"TVHTML5\\",\\"dialAdditionalDataSupportLevel\\":\\"unsupported\\",\\"mdxDialServerType\\":\\"MDX_DIAL_SERVER_TYPE_UNKNOWN\\",\\"brand\\":\\"Generic\\",\\"model\\":\\"SmartTV\\"}","receiverIdentityMatchStatus":"IS_RECEIVER"}]', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: connectionEventDetails: '{"deviceId":"d853d13c-b91f-4aad-9acb-da67a89e0159"}' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: }, Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: Message { AID: 3, name: 'getNowPlaying', payload: {} } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: ] Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: ----------------------------------- Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (AID: 2) (YouTube Music) Incoming message: 'loungeStatus' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] Connecting to RPC URL: https://www.youtube.com/api/lounge/bc/bind?AID=3&CI=0&RID=rpc&SID=D0D867A9FCA79B90&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=pfr_j92YLdpy0jb5nniE53BB2cgLN0Pc&id=d853d13c-b91f-4aad-9acb-da67a89e0159&loungeIdToken=AGdO5p-_BPlimB07QW7u_-Ldk_G9ENaBKwui_CWgvRHEXUOPyYgq-rYC0TLtJPnulYCxkHxjdSN-30nqKGuVMH20u_RtgmEcRJ2NFOfvIrhKeR6KBj56fLA&mdxVersion=2&name=YouTube%20on%20volumio-pi4.lan&obfuscatedGaiaId=&t=1&theme=m&v=2&zx=322916e46b30 Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] RPC connection established. Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube Music) Session established. Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube Music) Saving MDX context to data store: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: { Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: deviceId: 'd853d13c-b91f-4aad-9acb-da67a89e0159', Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: screenId: '9uoemca4112tcmoagt22mi16u1' Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] Starting DIAL server... Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: error: [yt-cast-receiver] Failed to start receiver: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: (DialServerError) Failed to start DIAL server Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: --->(Error) listen EADDRINUSE: address already in use :::8098 Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: Stack trace: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: DialServerError: Failed to start DIAL server Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: at Server. (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/dial/DialServer.js:104:28) Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: at Server.emit (node:events:514:28) Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: at emitErrorNT (node:net:1899:8) Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] Stopping YouTubeApp... Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: info: [yt-cast-receiver] Player.reset() Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] Closing RPC connection... Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube) Sending message 'loungeScreenDisconnected' with payload: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: { count: 1, ofs: '0', req0__sc: 'loungeScreenDisconnected' } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] Closing RPC connection... Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: verbose: [yt-cast-receiver] (YouTube Music) Sending message 'loungeScreenDisconnected' with payload: Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: { count: 1, ofs: '0', req0__sc: 'loungeScreenDisconnected' } Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: TypeError: Cannot read properties of undefined (reading 'getVolume') Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: at MPDPlayer.doGetVolume (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:195:75) Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: at MPDPlayer.getVolume (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/Player.js:241:30) Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: at MPDPlayer.getState (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/Player.js:303:32) Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: at async MPDPlayer._Player_setStatusAndEmit (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/Player.js:333:73) Nov 23 16:00:18 volumio-pi4.lan volumio[2518]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 16:00:19 volumio-pi4.lan sudo[3189]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2024-11-23 15:59' Nov 23 16:00:19 volumio-pi4.lan sudo[3189]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="6a71b1b8f832c66e3bde56982bbc4fb0dcc139a1" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="572bccfe6facd2cbc0b66d419c4ed66a3b0126c1" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Oct 19 20:30:59 UTC 2024" VOLUMIO_VERSION="0.012" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="68e75b944cee4d40104b64931fbc3e36"