Dec 22 17:29:01 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: ytmusic , handleBrowseUri Dec 22 17:29:01 volumio volumio[1276]: info: [ytmusic-browse] browseUri: ytmusic/search@query=b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh/optionSelection@fromContinuationBundle=1@continuationBundle:o=%7B%22section%22%3A%7B%22title%22%3Anull%2C%22subtitle%22%3Anull%2C%22filters%22%3A%5B%7B%22type%22%3A%22option%22%2C%22subtype%22%3A%22chipCloud%22%2C%22optionValues%22%3A%5B%7B%22text%22%3A%22Videos%22%2C%22endpoint%22%3A%7B%22type%22%3A%22search%22%2C%22payload%22%3A%7B%22query%22%3A%22b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh%22%2C%22params%22%3A%22EgWKAQIQAWoOEAQQAxAJEAUQChAQEBE%253D%22%7D%7D%2C%22selected%22%3Afalse%2C%22isReset%22%3Afalse%7D%2C%7B%22text%22%3A%22Songs%22%2C%22endpoint%22%3A%7B%22type%22%3A%22search%22%2C%22payload%22%3A%7B%22query%22%3A%22b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh%22%2C%22params%22%3A%22EgWKAQIIAWoOEAQQAxAJEAUQChAQEBE%253D%22%7D%7D%2C%22selected%22%3Afalse%2C%22isReset%22%3Afalse%7D%2C%7B%22text%22%3A%22Albums%22%2C%22endpoint%22%3A%7B%22type%22%3A%22search%22%2C%22payload%22%3A%7B%22query%22%3A%22b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh%22%2C%22params%22%3A%22EgWKAQIYAWoOEAQQAxAJEAUQChAQEBE%253D%22%7D%7D%2C%22selected%22%3Afalse%2C%22isReset%22%3Afalse%7D%2C%7B%22text%22%3A%22Artists%22%2C%22endpoint%22%3A%7B%22type%22%3A%22search%22%2C%22payload%22%3A%7B%22query%22%3A%22b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh%22%2C%22params%22%3A%22EgWKAQIgAWoOEAQQAxAJEAUQChAQEBE%253D%22%7D%7D%2C%22selected%22%3Afalse%2C%22isReset%22%3Afalse%7D%2C%7B%22text%22%3A%22Community%20playlists%22%2C%22endpoint%22%3A%7B%22type%22%3A%22search%22%2C%22payload%22%3A%7B%22query%22%3A%22b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh%22%2C%22params%22%3A%22EgeKAQQoAEABag4QBBADEAkQBRAKEBAQEQ%253D%253D%22%7D%7D%2C%22selected%22%3Afalse%2C%22isReset%22%3Afalse%7D%2C%7B%22text%22%3A%22Episodes%22%2C%22endpoint%22%3A%7B%22type%22%3A%22search%22%2C%22payload%22%3A%7B%22query%22%3A%22b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh%22%2C%22params%22%3A%22EgWKAQJIAWoOEAQQAxAJEAUQChAQEBE%253D%22%7D%7D%2C%22selected%22%3Afalse%2C%22isReset%22%3Afalse%7D%2C%7B%22text%22%3A%22Podcasts%22%2C%22endpoint%22%3A%7B%22type%22%3A%22search%22%2C%22payload%22%3A%7B%22query%22%3A%22b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh%22%2C%22params%22%3A%22EgWKAQJQAWoOEAQQAxAJEAUQChAQEBE%253D%22%7D%7D%2C%22selected%22%3Afalse%2C%22isReset%22%3Afalse%7D%5D%7D%5D%2C%22buttons%22%3Anull%2C%22filtersFromParent%22%3Afalse%2C%22buttonsFromParent%22%3Afalse%7D%2C%22contents%22%3A%7B%22header%22%3A%7B%22type%22%3A%22search%22%2C%22title%22%3A%22YouTube%20Music%20results%20for%20%5C%22b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh%5C%22%22%7D%2C%22tabs%22%3A%5B%7B%22type%22%3A%22tab%22%2C%22text%22%3A%22YT%20Music%22%2C%22endpoint%22%3A%7B%22type%22%3A%22search%22%2C%22payload%22%3A%7B%22query%22%3A%22b%E1%BB%A9c%20t%C3%A2m%20th%C6%B0%20h%C3%A0%20thanh%22%7D%7D%2C%22selected%22%3Atrue%7D%5D%7D%7D@targetKey=section.filters.0@genericViewUri=search%40query%3Db%25E1%25BB%25A9c%2520t%25C3%25A2m%2520th%25C6%25B0%2520h%25C3%25A0%2520thanh Dec 22 17:29:01 volumio volumio[1276]: info: Preload queue cleared Dec 22 17:29:02 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 17:29:02 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 17:29:02 volumio volumio[1276]: info: Discovery: Getting this device information Dec 22 17:29:02 volumio volumio[1276]: info: CoreCommandRouter::volumioGetState Dec 22 17:29:02 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 17:29:02 volumio volumio[1276]: verbose: New Socket.io Connection to 192.168.1.83:3000 from 192.168.1.50 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Dec 22 17:29:02 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 17:29:02 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 17:29:04 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 22 17:29:05 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: soundcloud , handleBrowseUri Dec 22 17:29:05 volumio volumio[1276]: info: [soundcloud] browseUri: soundcloud Dec 22 17:29:06 volumio volumio[1276]: info: Preload queue cleared Dec 22 17:29:06 volumio volumio[1276]: info: Preload queue cleared Dec 22 17:29:10 volumio volumio[1276]: Searching plugin music_service/soundcloud Dec 22 17:29:10 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Dec 22 17:29:13 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 22 17:29:13 volumio volumio[1276]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 22 17:29:13 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 22 17:29:13 volumio volumio[1276]: info: Received Get System Version Dec 22 17:29:13 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 22 17:29:13 volumio volumio[1276]: info: Received Get System Info Dec 22 17:29:13 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 17:29:13 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 17:29:13 volumio volumio[1276]: info: Discovery: Getting this device information Dec 22 17:29:13 volumio volumio[1276]: info: CoreCommandRouter::volumioGetState Dec 22 17:29:13 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 17:29:13 volumio volumio[1276]: info: All search sources collected, pushing search results Dec 22 17:29:19 volumio volumio[1276]: Searching plugin music_service/soundcloud Dec 22 17:29:19 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Dec 22 17:29:21 volumio go-librespot[1533]: time="2025-12-22T17:29:21+07:00" level=trace msg="sent dealer ping" Dec 22 17:29:21 volumio go-librespot[1533]: time="2025-12-22T17:29:21+07:00" level=trace msg="received dealer pong" Dec 22 17:29:22 volumio volumio[1276]: info: All search sources collected, pushing search results Dec 22 17:29:24 volumio nmbd[1065]: [2025/12/22 17:29:24.701148, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 22 17:29:24 volumio nmbd[1065]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.83 for name WORKGROUP<1d>. Dec 22 17:29:24 volumio nmbd[1065]: This response was from IP 192.168.1.61, reporting an IP address of 192.168.1.61. Dec 22 17:29:24 volumio nmbd[1065]: [2025/12/22 17:29:24.701365, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 22 17:29:24 volumio nmbd[1065]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.1.83 for name WORKGROUP<1d>. Dec 22 17:29:24 volumio nmbd[1065]: This response was from IP 192.168.1.41, reporting an IP address of 192.168.1.61. Dec 22 17:29:29 volumio volumio[1276]: Searching plugin music_service/soundcloud Dec 22 17:29:29 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Dec 22 17:29:32 volumio volumio[1276]: info: All search sources collected, pushing search results Dec 22 17:29:39 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Dec 22 17:29:39 volumio volumio[1276]: info: In handleBrowseUri, curUri=spotify Dec 22 17:29:39 volumio volumio[1276]: info: Preload queue cleared Dec 22 17:29:39 volumio volumio[1276]: info: Preload queue cleared Dec 22 17:29:39 volumio volumio[1276]: info: Preload queue cleared Dec 22 17:29:39 volumio volumio[1276]: info: Preload queue cleared Dec 22 17:29:42 volumio volumio[1276]: Searching plugin music_service/spop Dec 22 17:29:42 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: spop , search Dec 22 17:29:43 volumio volumio[1276]: info: All search sources collected, pushing search results Dec 22 17:29:45 volumio volumio[1276]: Searching plugin music_service/spop Dec 22 17:29:45 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: spop , search Dec 22 17:29:45 volumio volumio[1276]: info: All search sources collected, pushing search results Dec 22 17:29:46 volumio volumio[1276]: Searching plugin music_service/spop Dec 22 17:29:46 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: spop , search Dec 22 17:29:46 volumio volumio[1276]: info: All search sources collected, pushing search results Dec 22 17:29:51 volumio go-librespot[1533]: time="2025-12-22T17:29:51+07:00" level=trace msg="sent dealer ping" Dec 22 17:29:51 volumio go-librespot[1533]: time="2025-12-22T17:29:51+07:00" level=trace msg="received dealer pong" Dec 22 17:29:52 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Dec 22 17:29:52 volumio volumio[1276]: info: In handleBrowseUri, curUri=spotify:album:3fk3B9DjOvRleZwimmlaeP Dec 22 17:29:53 volumio volumio[1276]: info: Preload queue cleared Dec 22 17:29:53 volumio volumio[1276]: info: Preloading song: spotify:track:2ZTCXuXxx39wghKsi0aHJm Dec 22 17:29:53 volumio volumio[1276]: info: Exploding uri spotify:track:2ZTCXuXxx39wghKsi0aHJm in service spop Dec 22 17:29:53 volumio volumio[1276]: SPOTIFY: EXPLODING URI:spotify:track:2ZTCXuXxx39wghKsi0aHJm Dec 22 17:29:53 volumio volumio[1276]: info: No valid Plugin REST Endpoint Dec 22 17:29:54 volumio volumio[1276]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2ZTCXuXxx39wghKsi0aHJm","service":"spop","name":"Việt Nam Những Chuyến Đi","artist":"Vicky Nhung","album":"Việt Nam Những Chuyến Đi","type":"song","duration":215,"albumart":"https://i.scdn.co/image/ab67616d0000b273886298a303f64fb7d8ccb9cf","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Dec 22 17:30:01 volumio volumio[1276]: info: Preload queue cleared Dec 22 17:30:01 volumio volumio[1276]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 22 17:30:01 volumio volumio[1276]: info: CoreStateMachine::ClearQueue Dec 22 17:30:01 volumio volumio[1276]: info: CoreStateMachine::stop Dec 22 17:30:01 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 17:30:01 volumio volumio[1276]: info: CoreStateMachine::stPlaybackTimer Dec 22 17:30:01 volumio volumio[1276]: info: CoreStateMachine::updateTrackBlock Dec 22 17:30:01 volumio volumio[1276]: info: CorePlayQueue::getTrackBlock Dec 22 17:30:01 volumio volumio[1276]: info: CoreStateMachine::pushState Dec 22 17:30:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Dec 22 17:30:01 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 17:30:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Dec 22 17:30:01 volumio volumio[1276]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 17:30:01 volumio volumio[1276]: Error: channel closed Dec 22 17:30:01 volumio volumio[1276]: at FerrumStreamingControlTechnology.updateStateOnPlayer (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:71:12) Dec 22 17:30:01 volumio volumio[1276]: at FerrumStreamingControlTechnology.pushState (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:182:10) Dec 22 17:30:01 volumio volumio[1276]: at /volumio/app/index.js:326:81 Dec 22 17:30:01 volumio volumio[1276]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Dec 22 17:30:01 volumio volumio[1276]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Dec 22 17:30:01 volumio volumio[1276]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:324:13) Dec 22 17:30:01 volumio volumio[1276]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:534:22) Dec 22 17:30:01 volumio volumio[1276]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1247:12) Dec 22 17:30:01 volumio volumio[1276]: at CoreStateMachine.clearQueue (/volumio/app/statemachine.js:277:8) Dec 22 17:30:01 volumio volumio[1276]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:494:21) Dec 22 17:30:01 volumio volumio[1276]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Dec 22 17:30:01 volumio volumio[1276]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Dec 22 17:30:01 volumio volumio[1276]: at Socket.emit (node:events:514:28) Dec 22 17:30:01 volumio volumio[1276]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 22 17:30:01 volumio volumio[1276]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Dec 22 17:30:01 volumio volumio[1276]: code: 'GenericFailure' Dec 22 17:30:01 volumio volumio[1276]: } Dec 22 17:30:01 volumio volumio[1276]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 17:30:01 volumio sudo[20350]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-22 17:29' Dec 22 17:30:01 volumio sudo[20350]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"