-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Wed 2024-07-17 19:57:23 CEST. -- Jul 17 19:56:49 volumio volumio[1112]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 19:56:49 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 19:56:49 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 19:56:49 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 19:56:50 volumio volumio[1112]: info: Received Get System Version Jul 17 19:56:50 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 19:56:50 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Jul 17 19:56:55 volumio volumio[1112]: info: CoreCommandRouter::volumioPause Jul 17 19:56:55 volumio volumio[1112]: info: CoreStateMachine::pause Jul 17 19:56:55 volumio volumio[1112]: info: CoreStateMachine::stPlaybackTimer Jul 17 19:56:55 volumio volumio[1112]: info: CoreStateMachine::servicePause Jul 17 19:56:55 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Jul 17 19:56:55 volumio volumio[1112]: info: CoreCommandRouter::servicePause Jul 17 19:56:55 volumio volumio[1112]: info: [1721239015484] ControllerQobuz::pause Jul 17 19:56:55 volumio volumio[1112]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 17 19:56:55 volumio volumio[1112]: info: ControllerMpd::pause Jul 17 19:56:55 volumio volumio[1112]: verbose: ControllerMpd::sendMpdCommand pause Jul 17 19:56:55 volumio volumio[1112]: info: sendMpdCommand pause took 2 milliseconds Jul 17 19:56:55 volumio volumio[1112]: info: Jul 17 19:56:55 volumio volumio[1112]: ---------------------------- MPD announces state update: player Jul 17 19:56:55 volumio volumio[1112]: info: ControllerMpd::getState Jul 17 19:56:55 volumio volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jul 17 19:56:55 volumio volumio[1112]: info: sendMpdCommand status took 1 milliseconds Jul 17 19:56:55 volumio volumio[1112]: verbose: ControllerMpd::parseState Jul 17 19:56:55 volumio volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 19:56:55 volumio volumio[1112]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 19:56:55 volumio volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jul 17 19:56:55 volumio volumio[1112]: info: ControllerMpd::pushState Jul 17 19:56:55 volumio volumio[1112]: info: CoreCommandRouter::servicePushState Jul 17 19:56:55 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Jul 17 19:56:55 volumio volumio[1112]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":165077,"duration":358,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"902 Kbps","isStreaming":false,"title":"44455274","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/44455274","trackType":"qobuz"} Jul 17 19:56:55 volumio volumio[1112]: verbose: CURRENT POSITION 0 Jul 17 19:56:55 volumio volumio[1112]: info: CoreStateMachine::syncState stateService pause Jul 17 19:56:55 volumio volumio[1112]: info: CoreStateMachine::syncState currentStatus pause Jul 17 19:56:55 volumio volumio[1112]: info: CoreStateMachine::pushState Jul 17 19:56:55 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 19:56:55 volumio volumio[1112]: info: CoreCommandRouter::volumioPushState Jul 17 19:56:55 volumio volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Jul 17 19:56:55 volumio volumio[1112]: info: MRS: Pushing multiroomSync output Jul 17 19:56:55 volumio volumio[1112]: info: CoreStateMachine::stPlaybackTimer Jul 17 19:56:55 volumio volumio[1112]: info: ------------------------------ 31ms Jul 17 19:56:55 volumio volumio[1112]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90 Jul 17 19:56:55 volumio volumio[1112]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 17 19:56:56 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 17 19:56:56 volumio volumio[1112]: info: camilladsp spawned new process with pid 4268, instance 1, run: true Jul 17 19:56:56 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 17 19:56:56 volumio volumio[1112]: info: CoreCommandRouter::volumioPlay Jul 17 19:56:56 volumio volumio[1112]: info: CoreStateMachine::play index undefined Jul 17 19:56:56 volumio volumio[1112]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 19:56:56 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Jul 17 19:56:56 volumio volumio[1112]: info: CoreStateMachine::startPlaybackTimer Jul 17 19:56:56 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Jul 17 19:56:56 volumio volumio[1112]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 19:56:56 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 19:56:56 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 17 19:56:56 volumio volumio[1112]: info: [1721239016920] ControllerQobuz::resume Jul 17 19:56:56 volumio volumio[1112]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 17 19:56:56 volumio volumio[1112]: info: ControllerMpd::resume Jul 17 19:56:56 volumio volumio[1112]: verbose: ControllerMpd::sendMpdCommand play Jul 17 19:56:56 volumio volumio[1112]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 17 19:56:56 volumio volumio[1112]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 17 19:56:56 volumio volumio[1112]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 17 19:56:56 volumio volumio[1112]: info: FusionDsp - Effects disabled Jul 17 19:56:56 volumio volumio[1112]: info: Jul 17 19:56:56 volumio volumio[1112]: ---------------------------- MPD announces state update: player Jul 17 19:56:56 volumio volumio[1112]: info: sendMpdCommand play took 29 milliseconds Jul 17 19:56:56 volumio volumio[1112]: info: ControllerMpd::getState Jul 17 19:56:56 volumio volumio[1112]: verbose: ControllerMpd::sendMpdCommand status Jul 17 19:56:56 volumio volumio[1112]: info: sendMpdCommand status took 2 milliseconds Jul 17 19:56:56 volumio volumio[1112]: verbose: ControllerMpd::parseState Jul 17 19:56:56 volumio volumio[1112]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 19:56:56 volumio volumio[1112]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 17 19:56:56 volumio volumio[1112]: verbose: ControllerMpd::parseTrackInfo Jul 17 19:56:56 volumio volumio[1112]: info: ControllerMpd::pushState Jul 17 19:56:56 volumio volumio[1112]: info: CoreCommandRouter::servicePushState Jul 17 19:56:56 volumio volumio[1112]: info: CorePlayQueue::getTrack 0 Jul 17 19:56:56 volumio volumio[1112]: verbose: STATE SERVICE {"status":"play","position":0,"seek":166313,"duration":358,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"815 Kbps","isStreaming":false,"title":"44455274","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/44455274","trackType":"qobuz"} Jul 17 19:56:56 volumio volumio[1112]: verbose: CURRENT POSITION 0 Jul 17 19:56:56 volumio volumio[1112]: info: CoreStateMachine::syncState stateService play Jul 17 19:56:56 volumio volumio[1112]: info: CoreStateMachine::syncState currentStatus pause Jul 17 19:56:56 volumio volumio[1112]: info: CoreStateMachine::pushState Jul 17 19:56:56 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 19:56:56 volumio volumio[1112]: info: CoreCommandRouter::volumioPushState Jul 17 19:56:56 volumio volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Jul 17 19:56:56 volumio volumio[1112]: info: MRS: Pushing multiroomSync output Jul 17 19:56:56 volumio volumio[1112]: info: ------------------------------ 31ms Jul 17 19:56:56 volumio volumio[1112]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 17 19:56:56 volumio volumio[1112]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90 Jul 17 19:56:59 volumio volumio[1112]: info: Listing playlists Jul 17 19:57:18 volumio volumio[1112]: verbose: New Socket.io Connection to 192.168.1.63 from 192.168.1.58 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 13 Jul 17 19:57:18 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 19:57:18 volumio volumio[1112]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 17 19:57:18 volumio volumio[1112]: info: CoreCommandRouter::volumioGetState Jul 17 19:57:18 volumio volumio[1112]: info: Listing playlists Jul 17 19:57:20 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 19:57:20 volumio volumio[1112]: info: Received Get System Info Jul 17 19:57:20 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 19:57:20 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 19:57:20 volumio volumio[1112]: info: Discovery: Getting this device information Jul 17 19:57:20 volumio volumio[1112]: info: CoreCommandRouter::volumioGetState Jul 17 19:57:20 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 19:57:21 volumio volumio[1112]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Jul 17 19:57:21 volumio volumio[1112]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Jul 17 19:57:21 volumio volumio[1112]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 19:57:21 volumio volumio[1112]: TypeError: Cannot read property 'then' of undefined Jul 17 19:57:21 volumio volumio[1112]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Jul 17 19:57:21 volumio volumio[1112]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2260:30) Jul 17 19:57:21 volumio volumio[1112]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1435:26) Jul 17 19:57:21 volumio volumio[1112]: at Socket.emit (events.js:315:20) Jul 17 19:57:21 volumio volumio[1112]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 17 19:57:21 volumio volumio[1112]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 17 19:57:21 volumio volumio[1112]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 19:57:23 volumio sudo[4330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-17 19:56 Jul 17 19:57:23 volumio sudo[4330]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"