Nov 23 15:28:54 volumio-pi4.lan volumio[31659]: info: [yt-cast-receiver] Connecting sender through DIAL... Nov 23 15:28:57 volumio-pi4.lan volumio[31659]: info: [yt-cast-receiver] (YouTube) Sender connected: Desktop (user: SY) Nov 23 15:28:57 volumio-pi4.lan volumio[31659]: info: [ytcr] ***** Sender connected ***** Nov 23 15:28:57 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: [yt-cast-receiver] Player.play(): XYMaIn2JEh0 @ 192s Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::volumioGetState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CorePlayQueue::getTrack 0 Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::volumioGetState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CorePlayQueue::getTrack 0 Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::volumioStop Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreStateMachine::stop Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: creating Innertube instance... Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::volumioGetState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CorePlayQueue::getTrack 0 Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::servicePushState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreStateMachine::pushState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::volumioPushState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::servicePushState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreStateMachine::pushState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::volumioPushState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::volumioGetState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::servicePushState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreStateMachine::pushState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CoreCommandRouter::volumioPushState Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: CorePlayQueue::getTrack 0 Nov 23 15:29:01 volumio-pi4.lan volumio[31659]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received ytcr Nov 23 15:29:04 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: obtaining po_token by visitorData... Nov 23 15:29:05 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: obtained po_token (expires in 43200 seconds) Nov 23 15:29:05 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: re-create Innertube instance with po_token Nov 23 15:29:05 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: creating Innertube instance with po_token... Nov 23 15:29:07 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: going to refresh po_token in 43100 seconds Nov 23 15:29:07 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: creating Innertube instance... Nov 23 15:29:09 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: obtaining po_token by visitorData... Nov 23 15:29:09 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: obtained po_token (expires in 43200 seconds) Nov 23 15:29:09 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: re-create Innertube instance with po_token Nov 23 15:29:09 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: creating Innertube instance with po_token... Nov 23 15:29:11 volumio-pi4.lan volumio[31659]: info: [ytcr] InnertubeLoader: going to refresh po_token in 43100 seconds Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: info: Ignoring MPD Status Update Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: MPDError: Failed to decode https://rr5---sn-i3b7knlk.googlevideo.com/videoplayback?expire=1732368552&ei=SIRBZ7GRL83K2roPgrT1sQg&ip=42.200.182.243&id=o-AMygkUcCuQ6HWZe6uV0N1o7aeRkq4pLqJe2mhxzuheFj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1732346952%2C&mh=cA&mm=31%2C29&mn=sn-i3b7knlk%2Csn-i3belnlz&ms=au%2Crdu&mv=m&mvi=5&pl=19&rms=au%2Cau&gcr=hk&initcwndbps=1833750&siu=1&bui=AQn3pFTFpLZBhFQAzX24X-8X-l_bvFA0R2dT4RRFHGhwUEpUq8ahJZhY-01ncuAmpFKFcZ5BBg&spc=qtApAXSnhsSjbhhzT-dNPWHB84gcqmb0DFPyYURhnDOPpoIkTzW1hioUf5XBt07Dz1N7I2UG6A9F&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=GfzJxyOJGIzvKHbYxllBrI0Q&rqh=1&gir=yes&clen=27313042&dur=1751.261&lmt=1727737683391510&mt=1732346236&fvip=1&keepalive=yes&fexp=51326932%2C51335594&c=WEB&sefc=1&txp=4432434&n=3hSntLm1QXht6Ov&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAKIkdbdtIhR4q_IGHu6s3P0sst5a82m3Q8j_t3xKS7dJAiEA2VPaAzR-YLGtVZ_5zoAQHMUnMBxDu4H6jAC9XxzfWe; CURL failed: The requested URL returned error: 403 Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: at MPDClient._receive (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:147:24) Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: at Socket.emit (node:events:514:28) Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: at addChunk (node:internal/streams/readable:343:12) Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: at readableAddChunk (node:internal/streams/readable:312:11) Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: at Readable.push (node:internal/streams/readable:253:10) Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) { Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: code: 'UNKNOWN', Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: errno: 5, Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: cmd_list_num: 0, Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: current_command: 'playid' Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: } Nov 23 15:29:13 volumio-pi4.lan volumio[31659]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 15:29:14 volumio-pi4.lan sudo[32611]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2024-11-23 15:28' Nov 23 15:29:14 volumio-pi4.lan sudo[32611]: 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"