Aug 28 22:42:03 volumio volumio[1078]: info: CoreCommandRouter::volumioGetState Aug 28 22:42:18 volumio volumio[1078]: info: CoreCommandRouter::volumioGetState Aug 28 22:42:33 volumio volumio[1078]: info: CoreCommandRouter::volumioGetState Aug 28 22:42:48 volumio volumio[1078]: info: CoreCommandRouter::volumioGetState Aug 28 22:42:58 volumio volumio[1078]: info: Aug 28 22:42:58 volumio volumio[1078]: ---------------------------- MPD announces system playlist update Aug 28 22:42:58 volumio volumio[1078]: info: Ignoring MPD Status Update Aug 28 22:42:58 volumio volumio[1078]: info: Aug 28 22:42:58 volumio volumio[1078]: ---------------------------- MPD announces state update: player Aug 28 22:42:58 volumio volumio[1078]: info: ControllerMpd::getState Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:42:58 volumio volumio[1078]: info: Aug 28 22:42:58 volumio volumio[1078]: ---------------------------- MPD announces system playlist update Aug 28 22:42:58 volumio volumio[1078]: info: Ignoring MPD Status Update Aug 28 22:42:58 volumio volumio[1078]: info: Aug 28 22:42:58 volumio volumio[1078]: ---------------------------- MPD announces state update: player Aug 28 22:42:58 volumio volumio[1078]: info: ControllerMpd::getState Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:42:58 volumio volumio[1078]: info: Aug 28 22:42:58 volumio volumio[1078]: ---------------------------- MPD announces system playlist update Aug 28 22:42:58 volumio volumio[1078]: info: Ignoring MPD Status Update Aug 28 22:42:58 volumio volumio[1078]: info: Aug 28 22:42:58 volumio volumio[1078]: ---------------------------- MPD announces state update: player Aug 28 22:42:58 volumio volumio[1078]: info: ControllerMpd::getState Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:42:58 volumio volumio[1078]: info: ------------------------------ 2ms Aug 28 22:42:58 volumio volumio[1078]: info: sendMpdCommand status took 1 milliseconds Aug 28 22:42:58 volumio volumio[1078]: info: ------------------------------ 1ms Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::parseState Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:42:58 volumio volumio[1078]: info: sendMpdCommand status took 2 milliseconds Aug 28 22:42:58 volumio volumio[1078]: info: ------------------------------ 2ms Aug 28 22:42:58 volumio volumio[1078]: info: sendMpdCommand status took 2 milliseconds Aug 28 22:42:58 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::parseState Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::parseState Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:42:58 volumio volumio[1078]: info: ControllerMpd::pushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::servicePushState Aug 28 22:42:58 volumio volumio[1078]: info: CorePlayQueue::getTrack 0 Aug 28 22:42:58 volumio volumio[1078]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42273206,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gregory Goodloe / Bob Baldwin - Cool Like That","artist":"SMOOTH JAZZ DELUXE","album":null,"uri":"https://cast1.torontocast.com:4490/","trackType":"com:4490/"} Aug 28 22:42:58 volumio volumio[1078]: verbose: CURRENT POSITION 0 Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::syncState stateService play Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus play Aug 28 22:42:58 volumio volumio[1078]: info: Received an update from plugin. extracting info from payload Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::pushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::pushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState Aug 28 22:42:58 volumio volumio[1078]: info: ------------------------------ 11ms Aug 28 22:42:58 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 28 22:42:58 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 11 milliseconds Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:42:58 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:42:58 volumio volumio[1078]: info: ControllerMpd::pushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::servicePushState Aug 28 22:42:58 volumio volumio[1078]: info: CorePlayQueue::getTrack 0 Aug 28 22:42:58 volumio volumio[1078]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42273206,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gregory Goodloe / Bob Baldwin - Cool Like That","artist":"SMOOTH JAZZ DELUXE","album":null,"uri":"https://cast1.torontocast.com:4490/","trackType":"com:4490/"} Aug 28 22:42:58 volumio volumio[1078]: verbose: CURRENT POSITION 0 Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::syncState stateService play Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus play Aug 28 22:42:58 volumio volumio[1078]: info: Received an update from plugin. extracting info from payload Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::pushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::pushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState Aug 28 22:42:58 volumio volumio[1078]: info: ControllerMpd::pushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::servicePushState Aug 28 22:42:58 volumio volumio[1078]: info: CorePlayQueue::getTrack 0 Aug 28 22:42:58 volumio volumio[1078]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42273206,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Gregory Goodloe / Bob Baldwin - Cool Like That","artist":"SMOOTH JAZZ DELUXE","album":null,"uri":"https://cast1.torontocast.com:4490/","trackType":"com:4490/"} Aug 28 22:42:58 volumio volumio[1078]: verbose: CURRENT POSITION 0 Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::syncState stateService play Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus play Aug 28 22:42:58 volumio volumio[1078]: info: Received an update from plugin. extracting info from payload Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::pushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreStateMachine::pushState Aug 28 22:42:58 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState Aug 28 22:42:58 volumio volumio[1078]: info: ------------------------------ 24ms Aug 28 22:42:58 volumio volumio[1078]: info: ------------------------------ 24ms Aug 28 22:43:19 volumio volumio[1078]: info: CoreCommandRouter::volumioGetState Aug 28 22:43:30 volumio volumio[1078]: info: [ytmusic] Refresh session PO token Aug 28 22:43:30 volumio volumio[1078]: info: [ytmusic] Obtained session PO token using visitorData (expires in 43101 seconds) Aug 28 22:43:30 volumio volumio[1078]: info: [ytmusic] Going to refresh session PO token in 43001 seconds Aug 28 22:43:30 volumio volumio[1078]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 22:43:30 volumio volumio[1078]: TypeError: Chaining cycle detected for promise # Aug 28 22:43:30 volumio volumio[1078]: at #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:128:21) Aug 28 22:43:30 volumio volumio[1078]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 22:43:30 volumio volumio[1078]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 22:43:30 volumio sudo[224534]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 22:42' Aug 28 22:43:30 volumio sudo[224534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"