-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2026-04-03 02:35:52 UTC. -- Apr 03 02:34:05 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 02:34:05 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 02:34:05 volumiobed volumio[1526]: info: Discovery: Getting this device information Apr 03 02:34:05 volumiobed volumio[1526]: info: CoreCommandRouter::volumioGetState Apr 03 02:34:05 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:05 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 02:34:05 volumiobed volumio[1526]: verbose: New Socket.io Connection to 192.168.219.144:3000 from 192.168.219.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Apr 03 02:34:05 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 02:34:05 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 02:34:06 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 02:34:06 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 02:34:06 volumiobed volumio[1526]: info: Discovery: Getting this device information Apr 03 02:34:06 volumiobed volumio[1526]: info: CoreCommandRouter::volumioGetState Apr 03 02:34:06 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:06 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 02:34:06 volumiobed volumio[1526]: verbose: New Socket.io Connection to 192.168.219.145:3000 from 192.168.219.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Apr 03 02:34:06 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 02:34:06 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 02:34:08 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 02:34:08 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 02:34:08 volumiobed volumio[1526]: info: Discovery: Getting this device information Apr 03 02:34:08 volumiobed volumio[1526]: info: CoreCommandRouter::volumioGetState Apr 03 02:34:08 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:08 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 02:34:08 volumiobed volumio[1526]: verbose: New Socket.io Connection to 192.168.219.144:3000 from 192.168.219.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Apr 03 02:34:08 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 02:34:08 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 02:34:08 volumiobed volumio5-onboarding[1839]: time=2026-04-03T02:34:08.885Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.219.112:50882 Apr 03 02:34:08 volumiobed volumio5-onboarding[1839]: time=2026-04-03T02:34:08.899Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.219.112:46610 Apr 03 02:34:10 volumiobed volumio[1526]: info: [fetchProgramInfo] https://radio.yuntae.in/api/onair/program?stn=kbs&ch=1fm -> KBS 음악실 Apr 03 02:34:10 volumiobed volumio[1526]: info: [programRefresh] fetched: KBS 음악실 Apr 03 02:34:10 volumiobed volumio[1526]: info: ControllerMpd::getState Apr 03 02:34:10 volumiobed volumio[1526]: verbose: ControllerMpd::sendMpdCommand status Apr 03 02:34:10 volumiobed volumio[1526]: info: sendMpdCommand status took 1 milliseconds Apr 03 02:34:10 volumiobed volumio[1526]: verbose: ControllerMpd::parseState Apr 03 02:34:10 volumiobed volumio[1526]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 02:34:10 volumiobed volumio[1526]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 03 02:34:10 volumiobed volumio[1526]: verbose: ControllerMpd::parseTrackInfo Apr 03 02:34:10 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:10 volumiobed volumio[1526]: info: CoreCommandRouter::servicePushState Apr 03 02:34:10 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:10 volumiobed volumio[1526]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5320862,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"198 Kbps","isStreaming":false,"title":"KBS ClassicFM","artist":"KBS 음악실","album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLyoiLCJDb25kaXRpb24iOnsiRGF0ZUxlc3NUaGFuIjp7IkFXUzpFcG9jaFRpbWUiOjE3NzUzNTAxMTN9fX1dfQ__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA&Signature=BNBodi9ThChyhQ1clBiHt4TssM2HQD4aqfnWe85~Yagptljam-LC6ym1OzHCnh~X3ZdQQ7cdD0zEBj47IcQoqeqgzO6SeY3zo37PRoDOethkOL3n8nOCWhjJHScBuX0RcGVuHHIT4yP-tnwLMrtaAx7x79DqGv5fJBRyzvIirSIHcqaJWanriT6z4n6U01VlZmApC-EgxuIebkX0s52IfnYUYhEWXgMX77Wntola5MQuPDvsGB62X47OxhSqKWyq3XNE21QYIBbPN2WSx-DSOTAIQBDakyDC5r32YwrwwCKTTHbPqg~ihIZ0p39dLSlmmmMSivKTNiBSyztaAyFnfA__","trackType":"","service":"carrot_radio","albumart":"https://padmin.static.kbs.co.kr/live/2021/5/28/1622175310040_252323.jpg"} Apr 03 02:34:10 volumiobed volumio[1526]: verbose: CURRENT POSITION 2 Apr 03 02:34:10 volumiobed volumio[1526]: info: CoreStateMachine::syncState stateService pause Apr 03 02:34:10 volumiobed volumio[1526]: info: CoreStateMachine::syncState currentStatus play Apr 03 02:34:10 volumiobed volumio[1526]: info: CoreStateMachine::pushState Apr 03 02:34:10 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:10 volumiobed volumio[1526]: info: CoreCommandRouter::volumioPushState Apr 03 02:34:10 volumiobed volumio[1526]: info: [programRefresh] queue updated Apr 03 02:34:10 volumiobed volumio[1526]: info: [programRefresh] pushed: KBS 음악실 Apr 03 02:34:10 volumiobed volumio5-onboarding[1839]: time=2026-04-03T02:34:10.781Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.219.112:50882,192.168.219.112:46610 @ 0x1a48630" state=STATUS_PLAYING positionMs=5317229 volume=100 Apr 03 02:34:10 volumiobed volumio5-onboarding[1839]: time=2026-04-03T02:34:10.782Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.219.112:50882,192.168.219.112:46610 @ 0x1a48630" id=webcarrot/3 title="KBS ClassicFM" Apr 03 02:34:27 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 02:34:27 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 02:34:27 volumiobed volumio[1526]: info: Discovery: Getting this device information Apr 03 02:34:27 volumiobed volumio[1526]: info: CoreCommandRouter::volumioGetState Apr 03 02:34:27 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:27 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 02:34:28 volumiobed volumio[1526]: verbose: New Socket.io Connection to 192.168.219.145:3000 from 192.168.219.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Apr 03 02:34:28 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 02:34:28 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 02:34:28 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 02:34:28 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 02:34:28 volumiobed volumio[1526]: info: Discovery: Getting this device information Apr 03 02:34:28 volumiobed volumio[1526]: info: CoreCommandRouter::volumioGetState Apr 03 02:34:28 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:28 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 02:34:28 volumiobed volumio[1526]: verbose: New Socket.io Connection to 192.168.219.144:3000 from 192.168.219.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Apr 03 02:34:28 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 02:34:28 volumiobed volumio[1526]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 02:34:40 volumiobed volumio[1526]: info: [fetchProgramInfo] https://radio.yuntae.in/api/onair/program?stn=kbs&ch=1fm -> KBS 음악실 Apr 03 02:34:40 volumiobed volumio[1526]: info: [programRefresh] fetched: KBS 음악실 Apr 03 02:34:40 volumiobed volumio[1526]: info: ControllerMpd::getState Apr 03 02:34:40 volumiobed volumio[1526]: verbose: ControllerMpd::sendMpdCommand status Apr 03 02:34:40 volumiobed volumio[1526]: info: sendMpdCommand status took 1 milliseconds Apr 03 02:34:40 volumiobed volumio[1526]: verbose: ControllerMpd::parseState Apr 03 02:34:40 volumiobed volumio[1526]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 02:34:40 volumiobed volumio[1526]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 03 02:34:40 volumiobed volumio[1526]: verbose: ControllerMpd::parseTrackInfo Apr 03 02:34:40 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:40 volumiobed volumio[1526]: info: CoreCommandRouter::servicePushState Apr 03 02:34:40 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:40 volumiobed volumio[1526]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5320862,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"198 Kbps","isStreaming":false,"title":"KBS ClassicFM","artist":"KBS 음악실","album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLyoiLCJDb25kaXRpb24iOnsiRGF0ZUxlc3NUaGFuIjp7IkFXUzpFcG9jaFRpbWUiOjE3NzUzNTAxMTN9fX1dfQ__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA&Signature=BNBodi9ThChyhQ1clBiHt4TssM2HQD4aqfnWe85~Yagptljam-LC6ym1OzHCnh~X3ZdQQ7cdD0zEBj47IcQoqeqgzO6SeY3zo37PRoDOethkOL3n8nOCWhjJHScBuX0RcGVuHHIT4yP-tnwLMrtaAx7x79DqGv5fJBRyzvIirSIHcqaJWanriT6z4n6U01VlZmApC-EgxuIebkX0s52IfnYUYhEWXgMX77Wntola5MQuPDvsGB62X47OxhSqKWyq3XNE21QYIBbPN2WSx-DSOTAIQBDakyDC5r32YwrwwCKTTHbPqg~ihIZ0p39dLSlmmmMSivKTNiBSyztaAyFnfA__","trackType":"","service":"carrot_radio","albumart":"https://padmin.static.kbs.co.kr/live/2021/5/28/1622175310040_252323.jpg"} Apr 03 02:34:40 volumiobed volumio[1526]: verbose: CURRENT POSITION 2 Apr 03 02:34:40 volumiobed volumio[1526]: info: CoreStateMachine::syncState stateService pause Apr 03 02:34:40 volumiobed volumio[1526]: info: CoreStateMachine::syncState currentStatus play Apr 03 02:34:40 volumiobed volumio[1526]: info: CoreStateMachine::pushState Apr 03 02:34:40 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:34:40 volumiobed volumio[1526]: info: CoreCommandRouter::volumioPushState Apr 03 02:34:40 volumiobed volumio[1526]: info: [programRefresh] queue updated Apr 03 02:34:40 volumiobed volumio[1526]: info: [programRefresh] pushed: KBS 음악실 Apr 03 02:34:40 volumiobed volumio5-onboarding[1839]: time=2026-04-03T02:34:40.774Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.219.112:50882,192.168.219.112:46610 @ 0x1a48630" state=STATUS_PLAYING positionMs=5317229 volume=100 Apr 03 02:34:40 volumiobed volumio5-onboarding[1839]: time=2026-04-03T02:34:40.775Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.219.112:50882,192.168.219.112:46610 @ 0x1a48630" id=webcarrot/3 title="KBS ClassicFM" Apr 03 02:35:10 volumiobed volumio[1526]: info: [fetchProgramInfo] https://radio.yuntae.in/api/onair/program?stn=kbs&ch=1fm -> KBS 음악실 Apr 03 02:35:10 volumiobed volumio[1526]: info: [programRefresh] fetched: KBS 음악실 Apr 03 02:35:10 volumiobed volumio[1526]: info: ControllerMpd::getState Apr 03 02:35:10 volumiobed volumio[1526]: verbose: ControllerMpd::sendMpdCommand status Apr 03 02:35:10 volumiobed volumio[1526]: info: sendMpdCommand status took 2 milliseconds Apr 03 02:35:10 volumiobed volumio[1526]: verbose: ControllerMpd::parseState Apr 03 02:35:10 volumiobed volumio[1526]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 02:35:10 volumiobed volumio[1526]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 03 02:35:10 volumiobed volumio[1526]: verbose: ControllerMpd::parseTrackInfo Apr 03 02:35:10 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:35:10 volumiobed volumio[1526]: info: CoreCommandRouter::servicePushState Apr 03 02:35:10 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:35:10 volumiobed volumio[1526]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5320862,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"198 Kbps","isStreaming":false,"title":"KBS ClassicFM","artist":"KBS 음악실","album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLyoiLCJDb25kaXRpb24iOnsiRGF0ZUxlc3NUaGFuIjp7IkFXUzpFcG9jaFRpbWUiOjE3NzUzNTAxMTN9fX1dfQ__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA&Signature=BNBodi9ThChyhQ1clBiHt4TssM2HQD4aqfnWe85~Yagptljam-LC6ym1OzHCnh~X3ZdQQ7cdD0zEBj47IcQoqeqgzO6SeY3zo37PRoDOethkOL3n8nOCWhjJHScBuX0RcGVuHHIT4yP-tnwLMrtaAx7x79DqGv5fJBRyzvIirSIHcqaJWanriT6z4n6U01VlZmApC-EgxuIebkX0s52IfnYUYhEWXgMX77Wntola5MQuPDvsGB62X47OxhSqKWyq3XNE21QYIBbPN2WSx-DSOTAIQBDakyDC5r32YwrwwCKTTHbPqg~ihIZ0p39dLSlmmmMSivKTNiBSyztaAyFnfA__","trackType":"","service":"carrot_radio","albumart":"https://padmin.static.kbs.co.kr/live/2021/5/28/1622175310040_252323.jpg"} Apr 03 02:35:10 volumiobed volumio[1526]: verbose: CURRENT POSITION 2 Apr 03 02:35:10 volumiobed volumio[1526]: info: CoreStateMachine::syncState stateService pause Apr 03 02:35:10 volumiobed volumio[1526]: info: CoreStateMachine::syncState currentStatus play Apr 03 02:35:10 volumiobed volumio[1526]: info: CoreStateMachine::pushState Apr 03 02:35:10 volumiobed volumio[1526]: info: CorePlayQueue::getTrack 2 Apr 03 02:35:10 volumiobed volumio[1526]: info: CoreCommandRouter::volumioPushState Apr 03 02:35:10 volumiobed volumio[1526]: info: [programRefresh] queue updated Apr 03 02:35:10 volumiobed volumio[1526]: info: [programRefresh] pushed: KBS 음악실 Apr 03 02:35:10 volumiobed volumio5-onboarding[1839]: time=2026-04-03T02:35:10.987Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.219.112:50882,192.168.219.112:46610 @ 0x1a48630" state=STATUS_PLAYING positionMs=5317229 volume=100 Apr 03 02:35:10 volumiobed volumio5-onboarding[1839]: time=2026-04-03T02:35:10.987Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.219.112:50882,192.168.219.112:46610 @ 0x1a48630" id=webcarrot/3 title="KBS ClassicFM" Apr 03 02:35:40 volumiobed volumio[1526]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 02:35:41 volumiobed volumio[1526]: Error: Unable to resolve or reject the same promise twice Apr 03 02:35:41 volumiobed volumio[1526]: at Promise.reject (/data/plugins/music_service/carrot_radio/node_modules/kew/kew.js:189:43) Apr 03 02:35:41 volumiobed volumio[1526]: at ClientRequest. (/data/plugins/music_service/carrot_radio/index.js:700:56) Apr 03 02:35:41 volumiobed volumio[1526]: at Object.onceWrapper (events.js:421:28) Apr 03 02:35:41 volumiobed volumio[1526]: at ClientRequest.emit (events.js:315:20) Apr 03 02:35:41 volumiobed volumio[1526]: at TLSSocket.emitRequestTimeout (_http_client.js:784:9) Apr 03 02:35:41 volumiobed volumio[1526]: at Object.onceWrapper (events.js:421:28) Apr 03 02:35:41 volumiobed volumio[1526]: at TLSSocket.emit (events.js:327:22) Apr 03 02:35:41 volumiobed volumio[1526]: at TLSSocket.Socket._onTimeout (net.js:483:8) Apr 03 02:35:41 volumiobed volumio[1526]: at listOnTimeout (internal/timers.js:554:17) Apr 03 02:35:41 volumiobed volumio[1526]: at processTimers (internal/timers.js:497:7) Apr 03 02:35:41 volumiobed volumio[1526]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 02:35:52 volumiobed sudo[26181]: volumio : unable to resolve host volumiobed Apr 03 02:35:52 volumiobed sudo[26181]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 03 02:35:52 volumiobed sudo[26181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-03 02:34 Apr 03 02:35:52 volumiobed sudo[26181]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"