Dec 05 22:18:01 volumio-r dhcpcd[805]: eth0: rebinding lease of 192.168.0.26 Dec 05 22:18:01 volumio-r dhcpcd[805]: eth0: probing address 192.168.0.26/24 Dec 05 22:18:02 volumio-r volumio[1122]: info: Volumio Network Manager: Network status updated: 0 Dec 05 22:18:06 volumio-r dhcpcd[805]: eth0: leased 192.168.0.26 for 86400 seconds Dec 05 22:18:06 volumio-r avahi-daemon[683]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.26. Dec 05 22:18:06 volumio-r dhcpcd[805]: eth0: adding route to 192.168.0.0/24 Dec 05 22:18:06 volumio-r avahi-daemon[683]: New relevant interface eth0.IPv4 for mDNS. Dec 05 22:18:06 volumio-r avahi-daemon[683]: Registering new address record for 192.168.0.26 on eth0.IPv4. Dec 05 22:18:06 volumio-r dhcpcd[805]: eth0: adding default route via 192.168.0.1 Dec 05 22:18:06 volumio-r systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Dec 05 22:18:06 volumio-r systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Dec 05 22:18:06 volumio-r systemd[1]: welcome.service: Deactivated successfully. Dec 05 22:18:06 volumio-r systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 05 22:18:06 volumio-r systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 05 22:18:06 volumio-r systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 05 22:18:06 volumio-r welcome[2864]: Resolved ip:[1] 192.168.0.26 Dec 05 22:18:06 volumio-r systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 05 22:18:06 volumio-r systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Dec 05 22:18:07 volumio-r volumio[1122]: info: Discovery: adding 0ab643ee-9671-435e-87e9-c3dbaa2b6f40 Dec 05 22:18:07 volumio-r volumio[1122]: info: Discovery: Found device Volumio R Dec 05 22:18:07 volumio-r volumio[1122]: info: CoreCommandRouter::volumioGetState Dec 05 22:18:07 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 0 Dec 05 22:18:07 volumio-r volumio[1122]: info: Discovery: adding e1683bf5-5725-46bd-8370-5876cff8701b Dec 05 22:18:07 volumio-r volumio[1122]: info: Discovery: Found device Volumio Dec 05 22:18:07 volumio-r volumio[1122]: info: Discovery: Connecting to remote: 192.168.0.16 Dec 05 22:18:07 volumio-r volumio[1122]: info: Discovery: Connected to remote: 192.168.0.16 Dec 05 22:18:08 volumio-r ntpd[951]: IO: Listen normally on 4 eth0 192.168.0.26:123 Dec 05 22:18:08 volumio-r ntpd[951]: IO: new interface(s) found: waking up resolver Dec 05 22:18:12 volumio-r volumio[1122]: info: Volumio Network Manager: Network status updated: 1 Dec 05 22:18:47 volumio-r volumio[1122]: verbose: New Socket.io Connection to 192.168.0.26:3000 from 192.168.0.30 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Dec 05 22:18:47 volumio-r volumio[1122]: verbose: New Socket.io Connection to 192.168.0.26 from 192.168.0.30 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 22:18:47 volumio-r volumio[1122]: info: Discovery: Getting this device information Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::volumioGetState Dec 05 22:18:47 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 0 Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::volumioGetVisibleSources Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::volumioGetState Dec 05 22:18:47 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 0 Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 05 22:18:47 volumio-r volumio[1122]: info: Received Get System Info Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 22:18:47 volumio-r volumio[1122]: info: Discovery: Getting this device information Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::volumioGetState Dec 05 22:18:47 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 0 Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::volumioGetState Dec 05 22:18:47 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 0 Dec 05 22:18:47 volumio-r volumio[1122]: info: Listing playlists Dec 05 22:18:47 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreCommandRouter::volumioNext Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::next Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::stop Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::stPlaybackTimer Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::updateTrackBlock Dec 05 22:18:48 volumio-r volumio[1122]: info: CorePlayQueue::getTrackBlock Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:48 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 0 Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::serviceStop Dec 05 22:18:48 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 0 Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreCommandRouter::serviceStop Dec 05 22:18:48 volumio-r volumio[1122]: info: ControllerMpd::stop Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand stop Dec 05 22:18:48 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:18:48 volumio-r volumio[1122]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 05 22:18:48 volumio-r volumio[1122]: info: sendMpdCommand stop took 191 milliseconds Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::play index undefined Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 22:18:48 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::startPlaybackTimer Dec 05 22:18:48 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::clearAddPlayTracks USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/02 - Paradis inanimé.wv Dec 05 22:18:48 volumio-r 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 Dec 05 22:18:48 volumio-r sudo[3034]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:18:48 volumio-r sudo[3034]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand stop Dec 05 22:18:48 volumio-r volumio[1122]: info: CoreStateMachine::updateTrackBlock Dec 05 22:18:48 volumio-r volumio[1122]: info: CorePlayQueue::getTrackBlock Dec 05 22:18:48 volumio-r volumio[1122]: info: Dec 05 22:18:48 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:18:48 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:18:48 volumio-r volumio[1122]: info: sendMpdCommand stop took 4 milliseconds Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand clear Dec 05 22:18:48 volumio-r volumio[1122]: info: Dec 05 22:18:48 volumio-r volumio[1122]: ---------------------------- MPD announces system playlist update Dec 05 22:18:48 volumio-r volumio[1122]: info: Ignoring MPD Status Update Dec 05 22:18:48 volumio-r volumio[1122]: info: sendMpdCommand status took 7 milliseconds Dec 05 22:18:48 volumio-r volumio[1122]: info: sendMpdCommand clear took 7 milliseconds Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand add "USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/02 - Paradis inanimé.wv" Dec 05 22:18:48 volumio-r volumio[1122]: error: updateQueue error: null Dec 05 22:18:48 volumio-r volumio[1122]: info: ------------------------------ 8ms Dec 05 22:18:48 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:18:48 volumio-r volumio[1122]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 05 22:18:48 volumio-r volumio[1122]: info: ------------------------------ 19ms Dec 05 22:18:48 volumio-r volumio[1122]: info: Dec 05 22:18:48 volumio-r volumio[1122]: ---------------------------- MPD announces system playlist update Dec 05 22:18:48 volumio-r volumio[1122]: info: Ignoring MPD Status Update Dec 05 22:18:48 volumio-r volumio[1122]: info: sendMpdCommand add "USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/02 - Paradis inanimé.wv" took 20 milliseconds Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand play Dec 05 22:18:48 volumio-r volumio[1122]: info: ------------------------------ 5ms Dec 05 22:18:48 volumio-r systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 05 22:18:48 volumio-r systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 05 22:18:48 volumio-r systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 05 22:18:48 volumio-r systemd[1]: peppymeterbasic.service: Consumed 5.343s CPU time. Dec 05 22:18:48 volumio-r volumio[1122]: info: sendMpdCommand play took 76 milliseconds Dec 05 22:18:48 volumio-r sudo[3034]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:48 volumio-r volumio[1122]: info: peppymeterbasic Daemon Stop Dec 05 22:18:48 volumio-r volumio[1122]: info: Dec 05 22:18:48 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:18:48 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:18:48 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:18:49 volumio-r volumio[1122]: info: Dec 05 22:18:49 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:18:49 volumio-r volumio[1122]: info: sendMpdCommand status took 119 milliseconds Dec 05 22:18:49 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:18:49 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:18:49 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:18:49 volumio-r 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 Dec 05 22:18:49 volumio-r 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 Dec 05 22:18:49 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:18:49 volumio-r volumio[1122]: info: sendMpdCommand status took 8 milliseconds Dec 05 22:18:49 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 05 22:18:49 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:18:49 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:18:49 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:18:49 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:18:49 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:49 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":283,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9463 Kbps","isStreaming":false,"title":"02 - Paradis inanimé.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/02 - Paradis inanimé.wv","trackType":"wv"} Dec 05 22:18:49 volumio-r volumio[1122]: verbose: CURRENT POSITION 1 Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService play Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus stop Dec 05 22:18:49 volumio-r volumio[1122]: info: ------------------------------ 140ms Dec 05 22:18:49 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 05 22:18:49 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:18:49 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:18:49 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:49 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"play","position":0,"seek":349,"duration":283,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9460 Kbps","isStreaming":false,"title":"02 - Paradis inanimé.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/02 - Paradis inanimé.wv","trackType":"wv"} Dec 05 22:18:49 volumio-r volumio[1122]: verbose: CURRENT POSITION 1 Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService play Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus play Dec 05 22:18:49 volumio-r volumio[1122]: info: Received an update from plugin. extracting info from payload Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:49 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:49 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:49 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:49 volumio-r volumio[1122]: info: ------------------------------ 77ms Dec 05 22:18:49 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:49 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:49 volumio-r sudo[3046]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:49 volumio-r sudo[3046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:49 volumio-r sudo[3048]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:49 volumio-r sudo[3048]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:49 volumio-r systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 05 22:18:49 volumio-r sudo[3048]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:49 volumio-r sudo[3046]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:49 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:49 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreCommandRouter::volumioSeek Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreStateMachine::seek Dec 05 22:18:51 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:51 volumio-r volumio[1122]: info: TRACKBLOCK {"uri":"mnt/USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/02 - Paradis inanimé.wv","service":"mpd","name":"02 - Paradis inanimé.wv","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=945&web=//extralarge&path=%2FUSB%2FMus%2FWavPack%2FMyl%C3%A8ne%20Farmer%20-%20No.%2005%20on%20Tour%20(2009)&metadata=false","duration":283,"trackType":"wv","samplerate":"192 kHz","bitdepth":"32 bit","channels":2} Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreStateMachine::startPlaybackTimer Dec 05 22:18:51 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:51 volumio-r volumio[1122]: info: ControllerMpd::seek Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:51 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:51 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:51 volumio-r sudo[3061]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:51 volumio-r sudo[3061]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:51 volumio-r volumio[1122]: error: null Dec 05 22:18:51 volumio-r volumio[1122]: info: Dec 05 22:18:51 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:18:51 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:18:51 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:18:51 volumio-r volumio[1122]: info: sendMpdCommand status took 3 milliseconds Dec 05 22:18:51 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:18:51 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:18:51 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 05 22:18:51 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:18:51 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:18:51 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:51 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71000,"duration":283,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9497 Kbps","isStreaming":false,"title":"02 - Paradis inanimé.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/02 - Paradis inanimé.wv","trackType":"wv"} Dec 05 22:18:51 volumio-r volumio[1122]: verbose: CURRENT POSITION 1 Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService play Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus play Dec 05 22:18:51 volumio-r volumio[1122]: info: Received an update from plugin. extracting info from payload Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:51 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:51 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:51 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:51 volumio-r sudo[3061]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:51 volumio-r volumio[1122]: info: ------------------------------ 83ms Dec 05 22:18:51 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:51 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:51 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:51 volumio-r 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 Dec 05 22:18:51 volumio-r sudo[3066]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:51 volumio-r sudo[3066]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:51 volumio-r sudo[3068]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:51 volumio-r sudo[3068]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:51 volumio-r sudo[3066]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:51 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:51 volumio-r sudo[3068]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:51 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:52 volumio-r volumio[3053]: pygame 2.1.2 (SDL 2.26.5, Python 3.11.2) Dec 05 22:18:52 volumio-r volumio[3053]: Hello from the pygame community. https://www.pygame.org/contribute.html Dec 05 22:18:52 volumio-r volumio[3053]: Traceback (most recent call last): Dec 05 22:18:52 volumio-r volumio[3053]: File "/data/plugins/user_interface/peppymeterbasic/BasicPeppyMeter/peppymeter.py", line 289, in Dec 05 22:18:52 volumio-r volumio[3053]: pm.init_display() Dec 05 22:18:52 volumio-r volumio[3053]: File "/data/plugins/user_interface/peppymeterbasic/BasicPeppyMeter/peppymeter.py", line 145, in init_display Dec 05 22:18:52 volumio-r volumio[3053]: pygame.display.init() Dec 05 22:18:52 volumio-r volumio[3053]: pygame.error: No available displays Dec 05 22:18:55 volumio-r volumio[1122]: info: VolumeController::SetAlsaVolume105 Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:55 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:55 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:55 volumio-r sudo[3101]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:55 volumio-r sudo[3101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:55 volumio-r volumio[1122]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r sudo[3101]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:55 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:55 volumio-r volumio[1122]: info: VolumeController::SetAlsaVolume105 Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:55 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:55 volumio-r volumio[1122]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Dec 05 22:18:55 volumio-r sudo[3105]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:55 volumio-r volumio[1122]: info: VolumeController::SetAlsaVolume110 Dec 05 22:18:55 volumio-r sudo[3105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:55 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r volumio[1122]: info: VolumeController::SetAlsaVolume104 Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:55 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:55 volumio-r sudo[3105]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:55 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:55 volumio-r sudo[3110]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:55 volumio-r sudo[3110]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:55 volumio-r volumio[1122]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Dec 05 22:18:55 volumio-r volumio[1122]: info: VolumeController::SetAlsaVolume105 Dec 05 22:18:55 volumio-r sudo[3112]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:55 volumio-r sudo[3112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:55 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:18:55 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:55 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:55 volumio-r volumio[1122]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Dec 05 22:18:55 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:55 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:55 volumio-r sudo[3112]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:55 volumio-r sudo[3110]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:55 volumio-r volumio[1122]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Dec 05 22:18:55 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:55 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:55 volumio-r sudo[3117]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:55 volumio-r sudo[3117]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:55 volumio-r sudo[3117]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:55 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:18:59 volumio-r volumio[1122]: info: VolumeController::SetAlsaVolume65 Dec 05 22:18:59 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:18:59 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:18:59 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:18:59 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:18:59 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:18:59 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:18:59 volumio-r volumio[1122]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Dec 05 22:18:59 volumio-r sudo[3129]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:18:59 volumio-r sudo[3129]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:18:59 volumio-r sudo[3129]: pam_unix(sudo:session): session closed for user root Dec 05 22:18:59 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:00 volumio-r volumio[1122]: info: VolumeController::SetAlsaVolume3 Dec 05 22:19:00 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:00 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:19:00 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:00 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:00 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:19:00 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:19:00 volumio-r volumio[1122]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Dec 05 22:19:00 volumio-r sudo[3135]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:19:00 volumio-r sudo[3135]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:00 volumio-r sudo[3135]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:00 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:02 volumio-r volumio[1122]: info: VolumeController::SetAlsaVolume100 Dec 05 22:19:02 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:02 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:19:02 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:02 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Dec 05 22:19:02 volumio-r kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Dec 05 22:19:02 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:19:02 volumio-r volumio[1122]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Dec 05 22:19:02 volumio-r sudo[3158]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:19:02 volumio-r sudo[3158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:02 volumio-r sudo[3158]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:02 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::volumioNext Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::next Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::stop Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::stPlaybackTimer Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::updateTrackBlock Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrackBlock Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::serviceStop Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 1 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::serviceStop Dec 05 22:19:11 volumio-r volumio[1122]: info: ControllerMpd::stop Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand stop Dec 05 22:19:11 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:19:11 volumio-r 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 Dec 05 22:19:11 volumio-r sudo[3179]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:19:11 volumio-r sudo[3179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:11 volumio-r volumio[1122]: info: Dec 05 22:19:11 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand stop took 72 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::play index undefined Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::startPlaybackTimer Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::clearAddPlayTracks USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/03 - L'Âme-Stram-Gram.wv Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand stop Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::updateTrackBlock Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrackBlock Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand status took 20 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand stop took 8 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand clear Dec 05 22:19:11 volumio-r volumio[1122]: info: Dec 05 22:19:11 volumio-r volumio[1122]: ---------------------------- MPD announces system playlist update Dec 05 22:19:11 volumio-r volumio[1122]: info: Ignoring MPD Status Update Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand clear took 4 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand add "USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/03 - L'Âme-Stram-Gram.wv" Dec 05 22:19:11 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:11 volumio-r systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 05 22:19:11 volumio-r systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 05 22:19:11 volumio-r systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Paradis inanimé.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/02 - Paradis inanimé.wv","trackType":"wv"} Dec 05 22:19:11 volumio-r volumio[1122]: verbose: CURRENT POSITION 2 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService stop Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus stop Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:11 volumio-r systemd[1]: peppymeterbasic.service: Consumed 2.425s CPU time. Dec 05 22:19:11 volumio-r volumio[1122]: info: No code Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:11 volumio-r sudo[3179]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:11 volumio-r volumio[1122]: info: ------------------------------ 114ms Dec 05 22:19:11 volumio-r volumio[1122]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 05 22:19:11 volumio-r volumio[1122]: error: updateQueue error: null Dec 05 22:19:11 volumio-r volumio[1122]: info: Dec 05 22:19:11 volumio-r volumio[1122]: ---------------------------- MPD announces system playlist update Dec 05 22:19:11 volumio-r volumio[1122]: info: Ignoring MPD Status Update Dec 05 22:19:11 volumio-r volumio[1122]: info: ------------------------------ 100ms Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand add "USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/03 - L'Âme-Stram-Gram.wv" took 95 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand play Dec 05 22:19:11 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:19:11 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:19:11 volumio-r sudo[3185]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:19:11 volumio-r sudo[3185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:11 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:19:11 volumio-r sudo[3187]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:19:11 volumio-r sudo[3187]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:11 volumio-r sudo[3190]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:19:11 volumio-r volumio[1122]: info: peppymeterbasic Daemon Stop Dec 05 22:19:11 volumio-r volumio[1122]: info: Dec 05 22:19:11 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:19:11 volumio-r volumio[1122]: info: ------------------------------ 152ms Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand play took 150 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:19:11 volumio-r sudo[3190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:11 volumio-r sudo[3185]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:11 volumio-r volumio[1122]: info: peppymeterbasic Daemon Stop Dec 05 22:19:11 volumio-r 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 Dec 05 22:19:11 volumio-r 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 Dec 05 22:19:11 volumio-r volumio[1122]: info: Dec 05 22:19:11 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand status took 60 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand status took 7 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:19:11 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":327,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - L'Âme-Stram-Gram.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/03 - L'Âme-Stram-Gram.wv","trackType":"wv"} Dec 05 22:19:11 volumio-r volumio[1122]: verbose: CURRENT POSITION 2 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService play Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus stop Dec 05 22:19:11 volumio-r volumio[1122]: info: ------------------------------ 80ms Dec 05 22:19:11 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 05 22:19:11 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:19:11 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":327,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - L'Âme-Stram-Gram.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/03 - L'Âme-Stram-Gram.wv","trackType":"wv"} Dec 05 22:19:11 volumio-r volumio[1122]: verbose: CURRENT POSITION 2 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService play Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus play Dec 05 22:19:11 volumio-r volumio[1122]: info: Received an update from plugin. extracting info from payload Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:11 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:11 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:11 volumio-r sudo[3190]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:11 volumio-r sudo[3187]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:11 volumio-r volumio[1122]: info: ------------------------------ 155ms Dec 05 22:19:11 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:19:11 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:19:11 volumio-r volumio[1122]: info: peppymeterbasic Daemon Stop Dec 05 22:19:11 volumio-r sudo[3197]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:19:11 volumio-r volumio[1122]: info: peppymeterbasic Daemon Stop Dec 05 22:19:11 volumio-r sudo[3197]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:11 volumio-r sudo[3199]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:19:11 volumio-r sudo[3199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:12 volumio-r systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 05 22:19:12 volumio-r sudo[3197]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:12 volumio-r sudo[3199]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:12 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:12 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:13 volumio-r volumio[3204]: pygame 2.1.2 (SDL 2.26.5, Python 3.11.2) Dec 05 22:19:13 volumio-r volumio[3204]: Hello from the pygame community. https://www.pygame.org/contribute.html Dec 05 22:19:13 volumio-r volumio[3204]: Traceback (most recent call last): Dec 05 22:19:13 volumio-r volumio[3204]: File "/data/plugins/user_interface/peppymeterbasic/BasicPeppyMeter/peppymeter.py", line 289, in Dec 05 22:19:13 volumio-r volumio[3204]: pm.init_display() Dec 05 22:19:13 volumio-r volumio[3204]: File "/data/plugins/user_interface/peppymeterbasic/BasicPeppyMeter/peppymeter.py", line 145, in init_display Dec 05 22:19:13 volumio-r volumio[3204]: pygame.display.init() Dec 05 22:19:13 volumio-r volumio[3204]: pygame.error: No available displays Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreCommandRouter::volumioSeek Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreStateMachine::seek Dec 05 22:19:14 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:14 volumio-r volumio[1122]: info: TRACKBLOCK {"uri":"mnt/USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/03 - L'Âme-Stram-Gram.wv","service":"mpd","name":"03 - L'Âme-Stram-Gram.wv","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=945&web=//extralarge&path=%2FUSB%2FMus%2FWavPack%2FMyl%C3%A8ne%20Farmer%20-%20No.%2005%20on%20Tour%20(2009)&metadata=false","duration":327,"trackType":"wv","samplerate":"192 kHz","bitdepth":"32 bit","channels":2} Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreStateMachine::startPlaybackTimer Dec 05 22:19:14 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:14 volumio-r volumio[1122]: info: ControllerMpd::seek Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:14 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:14 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:19:14 volumio-r sudo[3235]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:19:14 volumio-r sudo[3235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:14 volumio-r volumio[1122]: error: null Dec 05 22:19:14 volumio-r volumio[1122]: info: Dec 05 22:19:14 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:19:14 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:19:14 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:19:14 volumio-r volumio[1122]: info: sendMpdCommand status took 2 milliseconds Dec 05 22:19:14 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:19:14 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:19:14 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 05 22:19:14 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:19:14 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:19:14 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:14 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45000,"duration":327,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9415 Kbps","isStreaming":false,"title":"03 - L'Âme-Stram-Gram.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/03 - L'Âme-Stram-Gram.wv","trackType":"wv"} Dec 05 22:19:14 volumio-r volumio[1122]: verbose: CURRENT POSITION 2 Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService play Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus play Dec 05 22:19:14 volumio-r volumio[1122]: info: Received an update from plugin. extracting info from payload Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:14 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:14 volumio-r sudo[3235]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:14 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:14 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:14 volumio-r volumio[1122]: info: ------------------------------ 71ms Dec 05 22:19:14 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:19:14 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:19:14 volumio-r 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 Dec 05 22:19:14 volumio-r sudo[3238]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:19:14 volumio-r sudo[3238]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:14 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:14 volumio-r sudo[3240]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:19:14 volumio-r sudo[3240]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:15 volumio-r sudo[3238]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:15 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:15 volumio-r sudo[3240]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:15 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::volumioNext Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::next Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::stop Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::stPlaybackTimer Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::updateTrackBlock Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrackBlock Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::serviceStop Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 2 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::serviceStop Dec 05 22:19:16 volumio-r volumio[1122]: info: ControllerMpd::stop Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand stop Dec 05 22:19:16 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:19:16 volumio-r 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 Dec 05 22:19:16 volumio-r volumio[1122]: info: Dec 05 22:19:16 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand stop took 50 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::play index undefined Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::startPlaybackTimer Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::clearAddPlayTracks USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/04 - Je m'ennuie.wv Dec 05 22:19:16 volumio-r sudo[3248]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand stop Dec 05 22:19:16 volumio-r sudo[3248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::updateTrackBlock Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrackBlock Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand status took 20 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand stop took 10 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand clear Dec 05 22:19:16 volumio-r volumio[1122]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 05 22:19:16 volumio-r volumio[1122]: info: Dec 05 22:19:16 volumio-r volumio[1122]: ---------------------------- MPD announces system playlist update Dec 05 22:19:16 volumio-r volumio[1122]: info: Ignoring MPD Status Update Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand clear took 7 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand add "USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/04 - Je m'ennuie.wv" Dec 05 22:19:16 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:16 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - L'Âme-Stram-Gram.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/03 - L'Âme-Stram-Gram.wv","trackType":"wv"} Dec 05 22:19:16 volumio-r volumio[1122]: verbose: CURRENT POSITION 3 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService stop Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus stop Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:16 volumio-r systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 05 22:19:16 volumio-r volumio[1122]: info: No code Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:16 volumio-r systemd[1]: peppymeterbasic.service: Killing process 3225 (python3) with signal SIGKILL. Dec 05 22:19:16 volumio-r systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 05 22:19:16 volumio-r systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 05 22:19:16 volumio-r systemd[1]: peppymeterbasic.service: Consumed 1.422s CPU time. Dec 05 22:19:16 volumio-r sudo[3248]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:16 volumio-r volumio[1122]: info: ------------------------------ 134ms Dec 05 22:19:16 volumio-r volumio[1122]: error: updateQueue error: null Dec 05 22:19:16 volumio-r volumio[1122]: info: Dec 05 22:19:16 volumio-r volumio[1122]: ---------------------------- MPD announces system playlist update Dec 05 22:19:16 volumio-r volumio[1122]: info: Ignoring MPD Status Update Dec 05 22:19:16 volumio-r volumio[1122]: info: ------------------------------ 104ms Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand add "USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/04 - Je m'ennuie.wv" took 99 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand play Dec 05 22:19:16 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:19:16 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:19:16 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:19:16 volumio-r sudo[3258]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:19:16 volumio-r sudo[3258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:16 volumio-r sudo[3254]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:19:16 volumio-r sudo[3254]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:16 volumio-r sudo[3256]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:19:16 volumio-r sudo[3256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:16 volumio-r 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 Dec 05 22:19:16 volumio-r 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 Dec 05 22:19:16 volumio-r sudo[3258]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:16 volumio-r volumio[1122]: info: peppymeterbasic Daemon Stop Dec 05 22:19:16 volumio-r volumio[1122]: info: Dec 05 22:19:16 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:19:16 volumio-r volumio[1122]: info: ------------------------------ 204ms Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand play took 202 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:19:16 volumio-r volumio[1122]: info: Dec 05 22:19:16 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:19:16 volumio-r volumio[1122]: info: ControllerMpd::getState Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand status took 9 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand status took 4 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::parseState Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:19:16 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:16 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"play","position":0,"seek":678,"duration":269,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9421 Kbps","isStreaming":false,"title":"04 - Je m'ennuie.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/04 - Je m'ennuie.wv","trackType":"wv"} Dec 05 22:19:16 volumio-r volumio[1122]: verbose: CURRENT POSITION 3 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService play Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus stop Dec 05 22:19:16 volumio-r volumio[1122]: info: ------------------------------ 26ms Dec 05 22:19:16 volumio-r volumio[1122]: info: peppymeterbasic Daemon Stop Dec 05 22:19:16 volumio-r volumio[1122]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 05 22:19:16 volumio-r volumio[1122]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:19:16 volumio-r volumio[1122]: info: ControllerMpd::pushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::servicePushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:16 volumio-r volumio[1122]: verbose: STATE SERVICE {"status":"play","position":0,"seek":678,"duration":269,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9421 Kbps","isStreaming":false,"title":"04 - Je m'ennuie.wv","artist":null,"album":null,"uri":"USB/Mus/WavPack/Mylène Farmer - No. 05 on Tour (2009)/04 - Je m'ennuie.wv","trackType":"wv"} Dec 05 22:19:16 volumio-r volumio[1122]: verbose: CURRENT POSITION 3 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::syncState stateService play Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::syncState currentStatus play Dec 05 22:19:16 volumio-r volumio[1122]: info: Received an update from plugin. extracting info from payload Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:16 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:16 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:17 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:17 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:17 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:17 volumio-r sudo[3254]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:17 volumio-r sudo[3256]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:17 volumio-r volumio[1122]: info: ------------------------------ 109ms Dec 05 22:19:17 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:19:17 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 05 22:19:17 volumio-r sudo[3266]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:19:17 volumio-r sudo[3266]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:17 volumio-r volumio[1122]: info: peppymeterbasic Daemon Stop Dec 05 22:19:17 volumio-r volumio[1122]: info: peppymeterbasic Daemon Stop Dec 05 22:19:17 volumio-r sudo[3268]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 05 22:19:17 volumio-r sudo[3268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:17 volumio-r systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 05 22:19:17 volumio-r sudo[3266]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:17 volumio-r sudo[3268]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:17 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:17 volumio-r volumio[1122]: info: peppymeterbasic Daemon Started Dec 05 22:19:19 volumio-r volumio[3273]: pygame 2.1.2 (SDL 2.26.5, Python 3.11.2) Dec 05 22:19:19 volumio-r volumio[3273]: Hello from the pygame community. https://www.pygame.org/contribute.html Dec 05 22:19:19 volumio-r volumio[3273]: Traceback (most recent call last): Dec 05 22:19:19 volumio-r volumio[3273]: File "/data/plugins/user_interface/peppymeterbasic/BasicPeppyMeter/peppymeter.py", line 289, in Dec 05 22:19:19 volumio-r volumio[3273]: pm.init_display() Dec 05 22:19:19 volumio-r volumio[3273]: File "/data/plugins/user_interface/peppymeterbasic/BasicPeppyMeter/peppymeter.py", line 145, in init_display Dec 05 22:19:19 volumio-r volumio[3273]: pygame.display.init() Dec 05 22:19:19 volumio-r volumio[3273]: pygame.error: No available displays Dec 05 22:19:20 volumio-r volumio[1122]: info: CoreCommandRouter::volumioGetQueue Dec 05 22:19:20 volumio-r volumio[1122]: info: CoreStateMachine::getQueue Dec 05 22:19:20 volumio-r volumio[1122]: info: CorePlayQueue::getQueue Dec 05 22:19:29 volumio-r volumio[1122]: info: Preload queue cleared Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreStateMachine::ClearQueue Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreStateMachine::stop Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreStateMachine::stPlaybackTimer Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreStateMachine::updateTrackBlock Dec 05 22:19:29 volumio-r volumio[1122]: info: CorePlayQueue::getTrackBlock Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreStateMachine::pushState Dec 05 22:19:29 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushState Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreStateMachine::serviceStop Dec 05 22:19:29 volumio-r volumio[1122]: info: CorePlayQueue::getTrack 3 Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreCommandRouter::serviceStop Dec 05 22:19:29 volumio-r volumio[1122]: info: ControllerMpd::stop Dec 05 22:19:29 volumio-r volumio[1122]: verbose: ControllerMpd::sendMpdCommand stop Dec 05 22:19:29 volumio-r volumio[1122]: info: CorePlayQueue::clearPlayQueue Dec 05 22:19:29 volumio-r volumio[1122]: info: CorePlayQueue::saveQueue Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreCommandRouter::volumioPushQueue Dec 05 22:19:29 volumio-r volumio[1122]: info: CoreStateMachine::addQueueItems Dec 05 22:19:29 volumio-r volumio[1122]: info: CorePlayQueue::addQueueItems Dec 05 22:19:29 volumio-r volumio[1122]: info: Preload queue cleared Dec 05 22:19:29 volumio-r volumio[1122]: info: Adding Item to queue: music-library/USB/Mus/WavPack/2004 - Liquid Chrystal Dec 05 22:19:29 volumio-r volumio[1122]: info: Exploding uri music-library/USB/Mus/WavPack/2004 - Liquid Chrystal in service mpd Dec 05 22:19:29 volumio-r 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 Dec 05 22:19:29 volumio-r volumio[1122]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 05 22:19:29 volumio-r volumio[1122]: info: Dec 05 22:19:29 volumio-r volumio[1122]: ---------------------------- MPD announces state update: player Dec 05 22:19:29 volumio-r volumio[1122]: info: ALBUMART /albumart?cacheid=945&web=Matthias%20Frey/Liquid%20Chrystal/extralarge&path=%2Fmnt%2FUSB%2FMus%2FWavPack%2F2004%20-%20Liquid%20Chrystal%2FMatthias%20Frey%20-%20Liquid%20Chrystal.wv&metadata=false Dec 05 22:19:29 volumio-r volumio[1122]: info: URI /mnt/USB/Mus/WavPack/2004 - Liquid Chrystal/Matthias Frey - Liquid Chrystal.wv Dec 05 22:19:29 volumio-r volumio[1122]: info: ALBUMART /albumart?cacheid=945&web=Matthias%20Frey/Liquid%20Chrystal/extralarge&path=%2Fmnt%2FUSB%2FMus%2FWavPack%2F2004%20-%20Liquid%20Chrystal%2FMatthias%20Frey%20-%20Liquid%20Chrystal.wv.cue&metadata=false Dec 05 22:19:29 volumio-r volumio[1122]: info: URI /mnt/USB/Mus/WavPack/2004 - Liquid Chrystal/Matthias Frey - Liquid Chrystal.wv.cue Dec 05 22:19:29 volumio-r volumio[1122]: info: ALBUMART /albumart?cacheid=945&web=Matthias%20Frey/Liquid%20Chrystal/extralarge&path=%2Fmnt%2FUSB%2FMus%2FWavPack%2F2004%20-%20Liquid%20Chrystal%2FMatthias%20Frey%20-%20Liquid%20Chrystal.wv.cue&metadata=false Dec 05 22:19:29 volumio-r volumio[1122]: info: URI /mnt/USB/Mus/WavPack/2004 - Liquid Chrystal/Matthias Frey - Liquid Chrystal.wv.cue Dec 05 22:19:29 volumio-r sudo[3319]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 05 22:19:29 volumio-r sudo[3319]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 22:19:29 volumio-r systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 05 22:19:29 volumio-r systemd[1]: peppymeterbasic.service: Killing process 3282 (python3) with signal SIGKILL. Dec 05 22:19:29 volumio-r systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 05 22:19:29 volumio-r volumio[1122]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 22:19:29 volumio-r systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 05 22:19:29 volumio-r systemd[1]: peppymeterbasic.service: Consumed 1.761s CPU time. Dec 05 22:19:29 volumio-r sudo[3319]: pam_unix(sudo:session): session closed for user root Dec 05 22:19:29 volumio-r volumio[1122]: Error: Unable to resolve or reject the same promise twice Dec 05 22:19:29 volumio-r volumio[1122]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Dec 05 22:19:29 volumio-r volumio[1122]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Dec 05 22:19:29 volumio-r volumio[1122]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Dec 05 22:19:29 volumio-r volumio[1122]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Dec 05 22:19:29 volumio-r volumio[1122]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Dec 05 22:19:29 volumio-r volumio[1122]: at Socket.emit (node:events:514:28) Dec 05 22:19:29 volumio-r volumio[1122]: at addChunk (node:internal/streams/readable:343:12) Dec 05 22:19:29 volumio-r volumio[1122]: at readableAddChunk (node:internal/streams/readable:312:11) Dec 05 22:19:29 volumio-r volumio[1122]: at Readable.push (node:internal/streams/readable:253:10) Dec 05 22:19:29 volumio-r volumio[1122]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Dec 05 22:19:29 volumio-r volumio[1122]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 22:19:31 volumio-r sudo[3337]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-05 22:18' Dec 05 22:19:31 volumio-r sudo[3337]: 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="ac7dd5922ede329d1459d48b226ddc71f5209a2c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="b5a4a000e056eaff366fbb6591bf2240b12246d0" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Nov 8 06:10:52 UTC 2025" VOLUMIO_VERSION="4.067" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="78c9815e90cf3bee23e5cdc5934a01e9"