Mar 24 11:55:06 volumio volumio[20654]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 24 11:55:08 volumio go-librespot[20875]: time="2026-03-24T11:55:08+01:00" level=trace msg="sent dealer ping" Mar 24 11:55:08 volumio go-librespot[20875]: time="2026-03-24T11:55:08+01:00" level=trace msg="received dealer pong" Mar 24 11:55:09 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 24 11:55:09 volumio volumio[20654]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 24 11:55:09 volumio volumio[20654]: info: CoreCommandRouter::volumioGetState Mar 24 11:55:09 volumio volumio[20654]: info: CorePlayQueue::getTrack 0 Mar 24 11:55:09 volumio volumio[20654]: info: MyVolumio token set successfully Mar 24 11:55:09 volumio volumio[20654]: info: MYVOLUMIO: Adding device Mar 24 11:55:09 volumio volumio[20654]: info: MYVOLUMIO: Evaluating Server Mar 24 11:55:10 volumio volumio[20654]: info: MyVolumio status changed Mar 24 11:55:10 volumio volumio[20654]: info: Streaming services startup Mar 24 11:55:10 volumio volumio[20654]: info: Starting Streaming Daemon Mar 24 11:55:10 volumio volumio[20654]: info: Removing browser output: myVolumio user plan is not superstar Mar 24 11:55:10 volumio volumio[20654]: info: Removing audio output: Mar 24 11:55:10 volumio volumio[20654]: info: Stoppping Tunnel 1 Mar 24 11:55:10 volumio sudo[21034]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 24 11:55:10 volumio sudo[21034]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 11:55:10 volumio sudo[21036]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 24 11:55:10 volumio sudo[21036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 11:55:10 volumio sudo[21034]: pam_unix(sudo:session): session closed for user root Mar 24 11:55:10 volumio volumio[20654]: error: Cannot start Volumio Streaming Daemon Mar 24 11:55:10 volumio volumio[20654]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 24 11:55:10 volumio volumio[20654]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 24 11:55:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 24 11:55:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 24 11:55:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 24 11:55:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 24 11:55:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 24 11:55:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 24 11:55:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 24 11:55:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 24 11:55:10 volumio sudo[21036]: pam_unix(sudo:session): session closed for user root Mar 24 11:55:10 volumio volumio[20654]: info: Remote SSH Stopped Mar 24 11:55:13 volumio volumio[20654]: info: Setting Geolocation for MyVolumio to eu11 Mar 24 11:55:13 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:13 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:13 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:13 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:13 volumio volumio[20654]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 24 11:55:14 volumio volumio[20654]: info: Updating MyVolumio device info Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:14 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:14 volumio volumio[20654]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 24 11:55:16 volumio volumio[20654]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 24 11:55:16 volumio volumio[20654]: info: Completed starting MyVolumio Plugin Mar 24 11:55:16 volumio volumio[20654]: [Metrics] CommandRouter: 77s 546.08ms Mar 24 11:55:16 volumio volumio[20654]: info: CoreCommandRouter::volumiosetStartupVolume Mar 24 11:55:16 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 11:55:16 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:16 volumio volumio[20654]: info: CoreCommandRouter::Close All Modals sent Mar 24 11:55:16 volumio volumio[20654]: info: CoreCommandRouter::Close All Modals sent Mar 24 11:55:17 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 24 11:55:17 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 24 11:55:17 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 24 11:55:17 volumio volumio[20654]: info: MYVOLUMIO: Adding device Mar 24 11:55:17 volumio volumio[20654]: info: MYVOLUMIO: Evaluating Server Mar 24 11:55:21 volumio volumio[20654]: info: Setting Geolocation for MyVolumio to eu6 Mar 24 11:55:21 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:21 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:21 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:21 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:22 volumio volumio[20654]: info: Updating MyVolumio device info Mar 24 11:55:22 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:22 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:22 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:22 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 11:55:23 volumio volumio[20654]: info: BOOT COMPLETED Mar 24 11:55:24 volumio volumio[20654]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 24 11:55:25 volumio volumio[20654]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 24 11:55:29 volumio volumio[20654]: info: [jellyfin-poller] Polled http://192.168.0.200:8097: offline Mar 24 11:55:38 volumio go-librespot[20875]: time="2026-03-24T11:55:38+01:00" level=trace msg="sent dealer ping" Mar 24 11:55:38 volumio go-librespot[20875]: time="2026-03-24T11:55:38+01:00" level=trace msg="received dealer pong" Mar 24 11:56:02 volumio volumio[20654]: info: [jellyfin-poller] Polled http://192.168.0.200:8097: offline Mar 24 11:56:08 volumio go-librespot[20875]: time="2026-03-24T11:56:08+01:00" level=trace msg="sent dealer ping" Mar 24 11:56:08 volumio go-librespot[20875]: time="2026-03-24T11:56:08+01:00" level=trace msg="received dealer pong" Mar 24 11:56:14 volumio volumio[20654]: info: [yt-cast-receiver] Connecting sender through DIAL... Mar 24 11:56:31 volumio go-librespot[20875]: time="2026-03-24T11:56:31+01:00" level=trace msg="received accesspoint ping" Mar 24 11:56:31 volumio go-librespot[20875]: time="2026-03-24T11:56:31+01:00" level=trace msg="received accesspoint pong ack" Mar 24 11:56:35 volumio volumio[20654]: info: [jellyfin-poller] Polled http://192.168.0.200:8097: offline Mar 24 11:56:36 volumio volumio[20654]: info: [yt-cast-receiver] (YouTube) Sender connected: Desktop (user: undefined) Mar 24 11:56:36 volumio volumio[20654]: info: [ytcr] ***** Sender connected ***** Mar 24 11:56:36 volumio volumio[20654]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 11:56:37 volumio volumio[20654]: info: [yt-cast-receiver] Player.setVolume(): Mar 24 11:56:37 volumio volumio[20654]: { level: 100, muted: false } Mar 24 11:56:37 volumio volumio[20654]: info: CoreCommandRouter::volumioGetState Mar 24 11:56:37 volumio volumio[20654]: info: CorePlayQueue::getTrack 0 Mar 24 11:56:37 volumio volumio[20654]: info: [yt-cast-receiver] Player.resume() Mar 24 11:56:37 volumio volumio[20654]: info: [yt-cast-receiver] Player.play(): UFuZc_2zyQo @ 0s Mar 24 11:56:37 volumio volumio[20654]: info: CoreCommandRouter::volumioGetState Mar 24 11:56:37 volumio volumio[20654]: info: CorePlayQueue::getTrack 0 Mar 24 11:56:37 volumio volumio[20654]: info: CoreCommandRouter::volumioGetState Mar 24 11:56:37 volumio volumio[20654]: info: CorePlayQueue::getTrack 0 Mar 24 11:56:37 volumio volumio[20654]: info: CoreCommandRouter::volumioStop Mar 24 11:56:37 volumio volumio[20654]: info: CoreStateMachine::stop Mar 24 11:56:37 volumio volumio[20654]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 11:56:38 volumio go-librespot[20875]: time="2026-03-24T11:56:38+01:00" level=trace msg="sent dealer ping" Mar 24 11:56:38 volumio go-librespot[20875]: time="2026-03-24T11:56:38+01:00" level=trace msg="received dealer pong" Mar 24 11:56:51 volumio volumio[20654]: info: [ytcr] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version Mar 24 11:56:51 volumio volumio[20654]: info: [ytcr] Innertube support service: Start service with Node Mar 24 11:56:51 volumio volumio[20654]: info: CoreCommandRouter::volumioGetState Mar 24 11:56:51 volumio volumio[20654]: info: CorePlayQueue::getTrack 0 Mar 24 11:56:51 volumio volumio[20654]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 11:56:51 volumio volumio[20654]: info: CoreCommandRouter::servicePushState Mar 24 11:56:51 volumio volumio[20654]: info: CoreStateMachine::pushState Mar 24 11:56:51 volumio volumio[20654]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 11:56:51 volumio volumio[20654]: info: CoreCommandRouter::volumioPushState Mar 24 11:56:51 volumio volumio[20654]: info: CoreCommandRouter::servicePushState Mar 24 11:56:51 volumio volumio[20654]: info: CoreStateMachine::pushState Mar 24 11:56:51 volumio volumio[20654]: info: CoreCommandRouter::volumioPushState Mar 24 11:56:51 volumio volumio[20654]: info: CoreCommandRouter::volumioGetState Mar 24 11:56:51 volumio volumio[20654]: error: [ytcr] Failed to obtain manual pairing code: timeout. Mar 24 11:56:51 volumio volumio[20654]: SPOTIFY: RECEIVED VOLUMIO VOLUME 6 Mar 24 11:56:51 volumio volumio[20654]: SPOTIFY: RECEIVED VOLUMIO VOLUME 6 Mar 24 11:56:51 volumio volumio[20654]: error: [yt-cast-receiver] Caught error sending message: Mar 24 11:56:51 volumio volumio[20654]: (ConnectionError) (YouTube) Connection error in sending messages 'onAutoplayModeChanged' (AID: 9) Mar 24 11:56:51 volumio volumio[20654]: Error info: { Mar 24 11:56:51 volumio volumio[20654]: url: 'https://www.youtube.com/api/lounge/bc/bind?AID=9&RID=45354&SID=5CD7567658BACE6A&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&deviceInfo=%7B%22year%22%3A0%2C%22os%22%3A%22Windows%22%2C%22osVersion%22%3A%2210.0%22%2C%22chipset%22%3A%22%22%2C%22clientName%22%3A%22TVHTML5%22%2C%22dialAdditionalDataSupportLevel%22%3A%22unsupported%22%2C%22mdxDialServerType%22%3A%22MDX_DIAL_SERVER_TYPE_UNKNOWN%22%2C%22brand%22%3A%22Generic%22%2C%22model%22%3A%22SmartTV%22%7D&gsessionid=3dBsPcFd45AjRRESIaFde02cKkr4rPpi&id=ea183e24-cbb4-4f11-8c86-c52405d8b88d&loungeIdToken=AGdO5p9N1nYsb0u_fqNUzEmxtPbYealy_7JZkU_HPATUgwg85Zc9lLdBQwmq4lGuWDk3b5Vt8Y982PK6sbtVKZSkjWElXE3vGMrcxRtccRpTiyeeNOK-WRE&mdxVersion=2&name=YouTube%20on%20Volumio&obfuscatedGaiaId=&t=1&theme=cl&v=2&zx=a6ba19258a81' Mar 24 11:56:51 volumio volumio[20654]: } Mar 24 11:56:51 volumio volumio[20654]: --->(TypeError) fetch failed Mar 24 11:56:51 volumio volumio[20654]: Stack trace: Mar 24 11:56:51 volumio volumio[20654]: ConnectionError: (YouTube) Connection error in sending messages 'onAutoplayModeChanged' (AID: 9) Mar 24 11:56:51 volumio volumio[20654]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:510:16) Mar 24 11:56:51 volumio volumio[20654]: at processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 24 11:56:51 volumio volumio[20654]: at runNextTicks (node:internal/process/task_queues:64:3) Mar 24 11:56:51 volumio volumio[20654]: at process.processImmediate (node:internal/timers:449:9) Mar 24 11:56:51 volumio volumio[20654]: at async SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:558:9) Mar 24 11:56:51 volumio volumio[20654]: at async AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/utils/AsyncTaskQueue.js:52:21) Mar 24 11:56:51 volumio volumio[20654]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 11:56:51 volumio volumio[20654]: ConnectionError: Connection error in fetching pairing code Mar 24 11:56:51 volumio volumio[20654]: at PairingCodeRequestService._PairingCodeRequestService_getCodeAndEmit (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/PairingCodeRequestService.js:126:17) Mar 24 11:56:51 volumio volumio[20654]: at processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 24 11:56:51 volumio volumio[20654]: at runNextTicks (node:internal/process/task_queues:64:3) Mar 24 11:56:51 volumio volumio[20654]: at process.processImmediate (node:internal/timers:449:9) { Mar 24 11:56:51 volumio volumio[20654]: cause: TypeError: fetch failed Mar 24 11:56:51 volumio volumio[20654]: at Object.fetch (node:internal/deps/undici/undici:11576:11) Mar 24 11:56:51 volumio volumio[20654]: at processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 24 11:56:51 volumio volumio[20654]: at runNextTicks (node:internal/process/task_queues:64:3) Mar 24 11:56:51 volumio volumio[20654]: at process.processImmediate (node:internal/timers:449:9) Mar 24 11:56:51 volumio volumio[20654]: at async PairingCodeRequestService._PairingCodeRequestService_getCodeAndEmit (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/PairingCodeRequestService.js:120:20) { Mar 24 11:56:51 volumio volumio[20654]: cause: ConnectTimeoutError: Connect Timeout Error Mar 24 11:56:51 volumio volumio[20654]: at onConnectTimeout (node:internal/deps/undici/undici:8522:28) Mar 24 11:56:51 volumio volumio[20654]: at node:internal/deps/undici/undici:8480:50 Mar 24 11:56:51 volumio volumio[20654]: at Immediate._onImmediate (node:internal/deps/undici/undici:8511:13) Mar 24 11:56:51 volumio volumio[20654]: at process.processImmediate (node:internal/timers:478:21) { Mar 24 11:56:51 volumio volumio[20654]: code: 'UND_ERR_CONNECT_TIMEOUT' Mar 24 11:56:51 volumio volumio[20654]: } Mar 24 11:56:51 volumio volumio[20654]: }, Mar 24 11:56:51 volumio volumio[20654]: info: { Mar 24 11:56:51 volumio volumio[20654]: url: 'https://www.youtube.com/api/lounge/pairing/get_pairing_code?ctx=pair' Mar 24 11:56:51 volumio volumio[20654]: } Mar 24 11:56:51 volumio volumio[20654]: } Mar 24 11:56:51 volumio volumio[20654]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 11:56:53 volumio sudo[21298]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-24 11:55' Mar 24 11:56:53 volumio sudo[21298]: 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="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"