Feb 09 01:55:12 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 323.
Feb 09 01:55:12 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 09 01:55:12 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 09 01:55:12 volumio upmpdcli[12874]: Could not open config: /tmp/upmpdcli.conf
Feb 09 01:55:12 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 09 01:55:12 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 09 01:55:21 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 09 01:55:21 volumio volumio[1178]: TypeError: Cannot set properties of undefined (setting 'name')
Feb 09 01:55:21 volumio volumio[1178]: at JpRadio.pushSongState (/data/plugins/music_service/jp_radio/dist/lib/radio.js:127:36)
Feb 09 01:55:21 volumio volumio[1178]: at processTicksAndRejections (node:internal/process/task_queues:95:5)
Feb 09 01:55:21 volumio volumio[1178]: at runNextTicks (node:internal/process/task_queues:64:3)
Feb 09 01:55:21 volumio volumio[1178]: at listOnTimeout (node:internal/timers:540:9)
Feb 09 01:55:21 volumio volumio[1178]: at process.processTimers (node:internal/timers:514:7)
Feb 09 01:55:27 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 324.
Feb 09 01:55:27 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 09 01:55:27 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 09 01:55:27 volumio upmpdcli[12893]: Could not open config: /tmp/upmpdcli.conf
Feb 09 01:55:27 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 09 01:55:27 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 09 01:55:42 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 325.
Feb 09 01:55:42 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 09 01:55:43 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 09 01:55:43 volumio upmpdcli[12923]: Could not open config: /tmp/upmpdcli.conf
Feb 09 01:55:43 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 09 01:55:43 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 09 01:55:58 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 326.
Feb 09 01:55:58 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 09 01:55:58 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 09 01:55:58 volumio upmpdcli[12941]: Could not open config: /tmp/upmpdcli.conf
Feb 09 01:55:58 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 09 01:55:58 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 09 01:56:01 volumio volumio[1178]: info: JP_Radio::JpRadio.startStream: res.on(close)
Feb 09 01:56:01 volumio volumio[1178]: info: JP_Radio::JpRadio.startStream: SIGTERM sent to ffmpeg group 8237
Feb 09 01:56:01 volumio volumio[1178]: info: JP_Radio::JpRadio.#setupRoutes.get=> req.url=/radiko/play/QRR
Feb 09 01:56:01 volumio volumio[1178]: info: JP_Radio::JpRadio.startStream: stationId=QRR, query=[]
Feb 09 01:56:01 volumio volumio[1178]: info: JP_Radio::Radiko.play: url=https://f-radiko.smartstream.ne.jp/QRR/_definst_/simul-stream.stream/playlist.m3u8
Feb 09 01:56:01 volumio volumio[1178]: info: JP_Radio::JpRadio.startStream: ffmpeg.pid=12957
Feb 09 01:56:01 volumio volumio[1178]: info: JP_Radio::JpRadio.startStream: Streaming started
Feb 09 01:56:04 volumio volumio[1178]: info:
Feb 09 01:56:04 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 09 01:56:04 volumio ir-mpd.sh[12956]: http://localhost:9000/radiko/play/QRR
Feb 09 01:56:04 volumio ir-mpd.sh[12956]: [playing] #2/6 0:00/0:00 (0%)
Feb 09 01:56:04 volumio ir-mpd.sh[12956]: volume: 86% repeat: on random: off single: off consume: off
Feb 09 01:56:04 volumio volumio[1178]: info: ControllerMpd::getState
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 01:56:04 volumio volumio[1178]: info:
Feb 09 01:56:04 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 09 01:56:04 volumio volumio[1178]: info: ControllerMpd::getState
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 01:56:04 volumio volumio[1178]: info:
Feb 09 01:56:04 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 09 01:56:04 volumio volumio[1178]: info: ControllerMpd::getState
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 09 01:56:04 volumio volumio[1178]: info: sendMpdCommand status took 7 milliseconds
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 01:56:04 volumio volumio[1178]: info: sendMpdCommand status took 8 milliseconds
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 01:56:04 volumio volumio[1178]: info: sendMpdCommand status took 8 milliseconds
Feb 09 01:56:04 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 09 01:56:04 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 09 01:56:04 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 09 01:56:04 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 09 01:56:04 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 09 01:56:04 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":null,"isStreaming":false,"title":"QRR","artist":null,"album":null,"uri":"http://localhost:9000/radiko/play/QRR","trackType":""}
Feb 09 01:56:04 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus stop
Feb 09 01:56:04 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 09 01:56:04 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 09 01:56:04 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 09 01:56:04 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":null,"isStreaming":false,"title":"QRR","artist":null,"album":null,"uri":"http://localhost:9000/radiko/play/QRR","trackType":""}
Feb 09 01:56:04 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 09 01:56:04 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 09 01:56:04 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 09 01:56:04 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 09 01:56:04 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 09 01:56:04 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 09 01:56:04 volumio volumio[1178]: info: ------------------------------ 46ms
Feb 09 01:56:04 volumio volumio[1178]: info: ------------------------------ 62ms
Feb 09 01:56:04 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 49 milliseconds
Feb 09 01:56:04 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 09 01:56:04 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 09 01:56:04 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 09 01:56:04 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 09 01:56:04 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":null,"isStreaming":false,"title":"QRR","artist":null,"album":null,"uri":"http://localhost:9000/radiko/play/QRR","trackType":""}
Feb 09 01:56:04 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 09 01:56:04 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 09 01:56:04 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 09 01:56:04 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 09 01:56:04 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 09 01:56:04 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 09 01:56:04 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 09 01:56:04 volumio volumio[1178]: info: ------------------------------ 95ms
Feb 09 01:56:04 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 09 01:56:04 volumio volumio[1178]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 09 01:56:04 volumio volumio[1178]: TypeError: Cannot set properties of undefined (setting 'name')
Feb 09 01:56:04 volumio volumio[1178]: at JpRadio.pushSongState (/data/plugins/music_service/jp_radio/dist/lib/radio.js:127:36)
Feb 09 01:56:04 volumio volumio[1178]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Feb 09 01:56:04 volumio volumio[1178]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 09 01:56:05 volumio sudo[12975]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-09 01:55'
Feb 09 01:56:05 volumio sudo[12975]: 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"