-- Logs begin at Sat 2025-04-26 13:36:15 UTC, end at Sat 2025-04-26 19:17:30 UTC. --
Apr 26 19:16:02 volumio volumio[1212]: info: [1745694962105] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1
Apr 26 19:16:02 volumio volumio[1212]: info: [1745694962736] [RadioParadise] received new metadata: {"time":183,"artist":"Jackson Browne","title":"Doctor My Eyes","album":"Jackson Browne / Saturate Before Using","year":"1972","cover":"https://img.radioparadise.com/covers/l/B000AA7AX0.jpg","cover_med":"https://img.radioparadise.com/covers/m/B000AA7AX0.jpg","cover_small":"https://img.radioparadise.com/covers/s/B000AA7AX0.jpg"}
Apr 26 19:16:02 volumio volumio[1212]: info: CorePlayQueue::getTrack 0
Apr 26 19:16:02 volumio volumio[1212]: info: CoreCommandRouter::servicePushState
Apr 26 19:16:02 volumio volumio[1212]: info: CorePlayQueue::getTrack 0
Apr 26 19:16:02 volumio volumio[1212]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B000AA7AX0.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Doctor My Eyes","title":"Doctor My Eyes","artist":"Jackson Browne","album":"Jackson Browne / Saturate Before Using","streaming":true,"disableUiControls":true,"duration":188,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Apr 26 19:16:02 volumio volumio[1212]: verbose: CURRENT POSITION 0
Apr 26 19:16:02 volumio volumio[1212]: info: CoreStateMachine::syncState stateService play
Apr 26 19:16:02 volumio volumio[1212]: info: CoreStateMachine::syncState currentStatus play
Apr 26 19:16:02 volumio volumio[1212]: info: Received an update from plugin. extracting info from payload
Apr 26 19:16:02 volumio volumio[1212]: info: CoreStateMachine::pushState
Apr 26 19:16:02 volumio volumio[1212]: info: CorePlayQueue::getTrack 0
Apr 26 19:16:02 volumio volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 26 19:16:02 volumio volumio[1212]: info: CoreCommandRouter::volumioPushState
Apr 26 19:16:02 volumio volumio[1212]: info: CoreStateMachine::pushState
Apr 26 19:16:02 volumio volumio[1212]: info: CorePlayQueue::getTrack 0
Apr 26 19:16:02 volumio volumio[1212]: info: CoreCommandRouter::volumioPushState
Apr 26 19:16:02 volumio volumio[1212]: info: [1745694962749] [RadioParadise] setting new timer with duration of 188000 seconds.
Apr 26 19:16:02 volumio volumio[1212]: info: CorePlayQueue::getTrack 0
Apr 26 19:16:02 volumio volumio[1212]: info: CorePlayQueue::getTrack 1
Apr 26 19:16:03 volumio volumio[1212]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Type%20O%20Negative/October%20Rust/3a106680-26b7-4a9c-9923-d464e5f1df32.jpg'
Apr 26 19:16:03 volumio volumio[1212]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/U2/Songs%20of%20Experience%20(Deluxe%20Edition)/8e33cdd4-8434-4c2b-ac0a-9d68bcb8fd70.jpg'
Apr 26 19:16:03 volumio volumio[1212]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/U2/All%20That%20You%20Can%27t%20Leave%20Behind/1637cdcc-fec6-4896-a8f7-f42b2313e041.png'
Apr 26 19:16:03 volumio volumio[1212]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/U2/BOY/4457ba01-c10a-4efe-ba2f-cda52b242e26.png'
Apr 26 19:16:04 volumio volumio[1212]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/U2/October/abca1665-19c5-416d-ada1-879a373c4dc8.jpg'
Apr 26 19:17:05 volumio volumio[1212]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates.
Apr 26 19:17:05 volumio volumio[1212]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:106:19)
Apr 26 19:17:05 volumio volumio[1212]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:115:37)
Apr 26 19:17:05 volumio volumio[1212]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13
Apr 26 19:17:05 volumio volumio[1212]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Apr 26 19:17:05 volumio volumio[1212]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:149:13)
Apr 26 19:17:05 volumio volumio[1212]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:119:3)
Apr 26 19:17:05 volumio volumio[1212]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Apr 26 19:17:05 volumio volumio[1212]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15
Apr 26 19:17:05 volumio volumio[1212]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14)
Apr 26 19:17:05 volumio volumio[1212]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14)
Apr 26 19:17:05 volumio volumio[1212]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3)
Apr 26 19:17:05 volumio volumio[1212]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10)
Apr 26 19:17:05 volumio volumio[1212]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3)
Apr 26 19:17:05 volumio volumio[1212]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12)
Apr 26 19:17:05 volumio volumio[1212]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Apr 26 19:17:29 volumio volumio[1212]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 26 19:17:29 volumio volumio[1212]: Error: connect ETIMEDOUT 146.75.118.79:443
Apr 26 19:17:29 volumio volumio[1212]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Apr 26 19:17:29 volumio volumio[1212]: errno: -110,
Apr 26 19:17:29 volumio volumio[1212]: code: 'ETIMEDOUT',
Apr 26 19:17:29 volumio volumio[1212]: syscall: 'connect',
Apr 26 19:17:29 volumio volumio[1212]: address: '146.75.118.79',
Apr 26 19:17:29 volumio volumio[1212]: port: 443
Apr 26 19:17:29 volumio volumio[1212]: }
Apr 26 19:17:29 volumio volumio[1212]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 26 19:17:30 volumio sudo[22927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-26 19:16
Apr 26 19:17:30 volumio sudo[22927]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"