-- Logs begin at Thu 2019-02-14 19:12:03 JST, end at Tue 2026-01-13 01:00:43 JST. -- Jan 13 00:59:01 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: obtained po_token (expires in 43200 seconds) Jan 13 00:59:01 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: re-create Innertube instance with po_token Jan 13 00:59:01 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: creating Innertube instance with po_token... Jan 13 00:59:08 volumiohd ntpd[636]: 157.7.213.62 local addr 192.168.3.100 -> Jan 13 00:59:08 volumiohd volumio[2419]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. Jan 13 00:59:08 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: going to refresh po_token in 43100 seconds Jan 13 00:59:26 volumiohd volumio[2419]: info: CALLMETHOD: music_service youtube2 configSaveI18n [object Object] Jan 13 00:59:26 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: youtube2 , configSaveI18n Jan 13 00:59:26 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 00:59:34 volumiohd volumio[2419]: info: CALLMETHOD: music_service youtube2 configSaveAccount [object Object] Jan 13 00:59:34 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: youtube2 , configSaveAccount Jan 13 00:59:34 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 00:59:34 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: creating Innertube instance... Jan 13 00:59:40 volumiohd volumio[2419]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. Jan 13 00:59:40 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: obtaining po_token by visitorData... Jan 13 00:59:42 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: obtained po_token (expires in 43200 seconds) Jan 13 00:59:42 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: re-create Innertube instance with po_token Jan 13 00:59:42 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: creating Innertube instance with po_token... Jan 13 00:59:49 volumiohd volumio[2419]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. Jan 13 00:59:49 volumiohd volumio[2419]: info: [youtube2] InnertubeLoader: going to refresh po_token in 43100 seconds Jan 13 00:59:50 volumiohd volumio[2419]: info: CoreCommandRouter::volumioGetState Jan 13 00:59:50 volumiohd volumio[2419]: info: CorePlayQueue::getTrack 0 Jan 13 00:59:50 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Jan 13 00:59:50 volumiohd volumio[2419]: info: [youtube2-browse] browseUri: youtube2 Jan 13 00:59:51 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:51 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:53 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Jan 13 00:59:53 volumiohd volumio[2419]: info: [youtube2-browse] browseUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 00:59:54 volumiohd volumio[2419]: info: Preload queue cleared Jan 13 01:00:03 volumiohd volumio[2419]: info: CoreCommandRouter::volumioGetState Jan 13 01:00:03 volumiohd volumio[2419]: info: CorePlayQueue::getTrack 0 Jan 13 01:00:06 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 01:00:07 volumiohd volumio[2419]: info: Getting Alsa Cards List without I2S DAC Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 13 01:00:07 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 01:00:20 volumiohd volumio[2419]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jan 13 01:00:20 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jan 13 01:00:20 volumiohd volumio[2419]: info: CoreCommandRouter::volumioGetState Jan 13 01:00:20 volumiohd volumio[2419]: info: CorePlayQueue::getTrack 0 Jan 13 01:00:20 volumiohd volumio[2419]: info: Restoring Previous Volume level: 46 false false Jan 13 01:00:20 volumiohd volumio[2419]: info: Volume configurations have been set Jan 13 01:00:20 volumiohd volumio[2419]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 13 01:00:20 volumiohd volumio[2419]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC2 HD Mixer: DAC Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Jan 13 01:00:20 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 13 01:00:20 volumiohd volumio[2419]: info: Disabling external Volume Control Jan 13 01:00:20 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 01:00:20 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 13 01:00:20 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 01:00:20 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 01:00:20 volumiohd volumio[2419]: info: Getting Alsa Cards List without I2S DAC Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 01:00:21 volumiohd volumio[2419]: info: VolumeController:: Volume=46 Mute =false Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreStateMachine::pushState Jan 13 01:00:21 volumiohd volumio[2419]: info: CorePlayQueue::getTrack 0 Jan 13 01:00:21 volumiohd volumio[2419]: info: CoreCommandRouter::volumioPushState Jan 13 01:00:25 volumiohd volumio[2419]: info: VolumeController::SetAlsaVolume46 Jan 13 01:00:25 volumiohd volumio[2419]: info: CoreStateMachine::pushState Jan 13 01:00:25 volumiohd volumio[2419]: info: CorePlayQueue::getTrack 0 Jan 13 01:00:25 volumiohd volumio[2419]: info: CoreCommandRouter::volumioPushState Jan 13 01:00:30 volumiohd volumio[2419]: info: CoreCommandRouter::volumioGetState Jan 13 01:00:30 volumiohd volumio[2419]: info: CorePlayQueue::getTrack 0 Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 01:00:32 volumiohd volumio[2419]: info: Retrieving Cloud Streaming UI Jan 13 01:00:32 volumiohd volumio[2419]: info: Getting Tidal Cloud Configuration Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 01:00:32 volumiohd volumio[2419]: info: Getting Qobuz Cloud Configuration Jan 13 01:00:32 volumiohd volumio[2419]: info: Asking plugin for UI Config Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 01:00:32 volumiohd volumio[2419]: info: Getting Spotify Cloud Configuration Jan 13 01:00:32 volumiohd volumio[2419]: info: Asking plugin for UI Config Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 01:00:32 volumiohd volumio[2419]: info: Saving Spotify Acccount Jan 13 01:00:32 volumiohd volumio[2419]: info: Got Tidal Cloud Configuration Jan 13 01:00:32 volumiohd volumio[2419]: info: Got it Jan 13 01:00:32 volumiohd volumio[2419]: info: Got it Jan 13 01:00:32 volumiohd volumio[2419]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 01:00:32 volumiohd volumio[2419]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 01:00:32 volumiohd volumio[2419]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 01:00:33 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 01:00:33 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 13 01:00:37 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 01:00:38 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jan 13 01:00:38 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jan 13 01:00:41 volumiohd volumio[2419]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 01:00:43 volumiohd volumio[2419]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 01:00:43 volumiohd volumio[2419]: Error: dns service error: unknown Jan 13 01:00:43 volumiohd volumio[2419]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Jan 13 01:00:43 volumiohd volumio[2419]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jan 13 01:00:43 volumiohd volumio[2419]: errorCode: -65537 Jan 13 01:00:43 volumiohd volumio[2419]: } Jan 13 01:00:43 volumiohd volumio[2419]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 01:00:43 volumiohd sudo[3000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-13 00:59 Jan 13 01:00:43 volumiohd sudo[3000]: 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="e5e6090399db628f1586eb4951e3592507f5fd38" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="50b5825b3acc4c58b5033699bcdbbd219d6a0836" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 19 Jan 2024 06:17:59 PM CET" VOLUMIO_VERSION="3.601" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="36b9da4b4411039910a860c6fa7331da"