-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Sat 2025-01-18 08:41:44 +07. -- Jan 18 08:40:00 tms909100wr volumio[10740]: pygame 1.9.4.post1 Jan 18 08:40:00 tms909100wr volumio[10740]: Hello from the pygame community. https://www.pygame.org/contribute.html Jan 18 08:40:05 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 08:40:05 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 08:40:05 tms909100wr volumio[849]: info: Discovery: Getting this device information Jan 18 08:40:05 tms909100wr volumio[849]: info: CoreCommandRouter::volumioGetState Jan 18 08:40:05 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 1 Jan 18 08:40:05 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 08:40:08 tms909100wr dbus-daemon[587]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Jan 18 08:40:08 tms909100wr volumio-time-update[584]: Failed to set time: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Jan 18 08:40:08 tms909100wr sudo[10647]: pam_unix(sudo:session): session closed for user root Jan 18 08:40:08 tms909100wr volumio-time-update[584]: volumio-time-update-util: Error setting time. Jan 18 08:40:08 tms909100wr volumio-time-update[584]: volumio-time-update-util: Retrying in 5 seconds... Jan 18 08:40:13 tms909100wr volumio-time-update[584]: volumio-time-update-util: Fetching time from Volumio... Jan 18 08:40:14 tms909100wr volumio-time-update[584]: volumio-time-update-util: Setting system time to: 2025-01-18 08:40:14 Jan 18 08:40:14 tms909100wr sudo[10833]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-01-18 08:40:14 Jan 18 08:40:14 tms909100wr sudo[10833]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:40:14 tms909100wr dbus-daemon[587]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.194' (uid=0 pid=10834 comm="timedatectl set-time 2025-01-18 08:40:14 ") Jan 18 08:40:14 tms909100wr systemd[1]: systemd-timedated.service: Failed to run 'start' task: No space left on device Jan 18 08:40:14 tms909100wr systemd[1]: systemd-timedated.service: Failed with result 'resources'. Jan 18 08:40:14 tms909100wr systemd[1]: Failed to start Time & Date Service. Jan 18 08:40:35 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 08:40:35 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 08:40:35 tms909100wr volumio[849]: info: Discovery: Getting this device information Jan 18 08:40:35 tms909100wr volumio[849]: info: CoreCommandRouter::volumioGetState Jan 18 08:40:35 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 1 Jan 18 08:40:35 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 08:40:39 tms909100wr dbus-daemon[587]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Jan 18 08:40:39 tms909100wr volumio-time-update[584]: Failed to set time: Connection timed out Jan 18 08:40:39 tms909100wr sudo[10833]: pam_unix(sudo:session): session closed for user root Jan 18 08:40:39 tms909100wr volumio-time-update[584]: volumio-time-update-util: Error setting time. Jan 18 08:40:39 tms909100wr volumio-time-update[584]: volumio-time-update-util: Retrying in 5 seconds... Jan 18 08:40:44 tms909100wr volumio-time-update[584]: volumio-time-update-util: Fetching time from Volumio... Jan 18 08:40:44 tms909100wr volumio-time-update[584]: volumio-time-update-util: Setting system time to: 2025-01-18 08:40:44 Jan 18 08:40:44 tms909100wr sudo[10995]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-01-18 08:40:44 Jan 18 08:40:44 tms909100wr sudo[10995]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:40:44 tms909100wr dbus-daemon[587]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.195' (uid=0 pid=10996 comm="timedatectl set-time 2025-01-18 08:40:44 ") Jan 18 08:40:44 tms909100wr systemd[1]: systemd-timedated.service: Failed to run 'start' task: No space left on device Jan 18 08:40:44 tms909100wr systemd[1]: systemd-timedated.service: Failed with result 'resources'. Jan 18 08:40:44 tms909100wr systemd[1]: Failed to start Time & Date Service. Jan 18 08:41:02 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 18 08:41:02 tms909100wr volumio[849]: info: CURURI: albums:// Jan 18 08:41:02 tms909100wr volumio[849]: info: listAlbums - loading Albums from cache Jan 18 08:41:02 tms909100wr volumio[849]: info: Preload queue cleared Jan 18 08:41:04 tms909100wr volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Anne%20Akiko%20Meyers/Air%3A%20The%20Bach%20Album/6efaa48f-efa8-46c4-b91c-32c94794fcdf.jpg' Jan 18 08:41:05 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 08:41:05 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 08:41:05 tms909100wr volumio[849]: info: Discovery: Getting this device information Jan 18 08:41:05 tms909100wr volumio[849]: info: CoreCommandRouter::volumioGetState Jan 18 08:41:05 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 1 Jan 18 08:41:05 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 08:41:06 tms909100wr volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Cassandra%20Wilson/Another%20Country/003b3d40-1aa9-4f06-9edd-73cddb48eaed.jpg' Jan 18 08:41:06 tms909100wr volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Renaud%20Garcia-Fons%20Trio/Arcoluz/0e978c88-0eeb-4dab-9b78-64583b86d795.jpg' Jan 18 08:41:09 tms909100wr volumio-time-update[584]: Failed to set time: Connection timed out Jan 18 08:41:09 tms909100wr dbus-daemon[587]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Jan 18 08:41:09 tms909100wr sudo[10995]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:09 tms909100wr volumio-time-update[584]: volumio-time-update-util: Error setting time. Jan 18 08:41:09 tms909100wr volumio-time-update[584]: volumio-time-update-util: Retrying in 5 seconds... Jan 18 08:41:14 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Jan 18 08:41:14 tms909100wr volumio[849]: info: Preload queue cleared Jan 18 08:41:14 tms909100wr volumio[849]: info: Preloading song: mnt/USB/128GB-USB/SYM - Ladd Chomsky march [symphony] - Unknow Artist.flac Jan 18 08:41:14 tms909100wr volumio[849]: info: Exploding uri mnt/USB/128GB-USB/SYM - Ladd Chomsky march [symphony] - Unknow Artist.flac in service mpd Jan 18 08:41:14 tms909100wr volumio[849]: info: ALBUMART /albumart?cacheid=178&web=Unknow%20Artist/16%20%2F%20Best%20Ultra%20Hi-end%20Audio%20Test/extralarge&path=%2Fmnt%2FUSB%2F128GB-USB%2FSYM%20-%20Ladd%20Chomsky%20march%20%5Bsymphony%5D%20-%20Unknow%20Artist.flac&metadata=false Jan 18 08:41:14 tms909100wr volumio[849]: info: URI /mnt/USB/128GB-USB/SYM - Ladd Chomsky march [symphony] - Unknow Artist.flac Jan 18 08:41:14 tms909100wr volumio-time-update[584]: volumio-time-update-util: Fetching time from Volumio... Jan 18 08:41:15 tms909100wr volumio-time-update[584]: volumio-time-update-util: Setting system time to: 2025-01-18 08:41:15 Jan 18 08:41:15 tms909100wr sudo[11117]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-01-18 08:41:15 Jan 18 08:41:15 tms909100wr sudo[11117]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:15 tms909100wr dbus-daemon[587]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.196' (uid=0 pid=11118 comm="timedatectl set-time 2025-01-18 08:41:15 ") Jan 18 08:41:15 tms909100wr systemd[1]: systemd-timedated.service: Failed to run 'start' task: No space left on device Jan 18 08:41:15 tms909100wr systemd[1]: systemd-timedated.service: Failed with result 'resources'. Jan 18 08:41:15 tms909100wr systemd[1]: Failed to start Time & Date Service. Jan 18 08:41:22 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 18 08:41:22 tms909100wr volumio[849]: info: CURURI: genres:// Jan 18 08:41:22 tms909100wr volumio[849]: info: Preload queue cleared Jan 18 08:41:28 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 18 08:41:28 tms909100wr volumio[849]: info: CURURI: genres://HiFi Jan 18 08:41:28 tms909100wr volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Harold%20Farberman/b5050951-c702-4e26-aeb1-2471cf00e8af.jpg' Jan 18 08:41:28 tms909100wr volumio[849]: info: Preload queue cleared Jan 18 08:41:28 tms909100wr volumio[849]: info: Preload queue cleared Jan 18 08:41:31 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 18 08:41:31 tms909100wr volumio[849]: info: CURURI: genres://Jazz Jan 18 08:41:31 tms909100wr volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Cassandra%20Wilson/Another%20Country/003b3d40-1aa9-4f06-9edd-73cddb48eaed.jpg' Jan 18 08:41:31 tms909100wr volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Renaud%20Garcia-Fons%20Trio/Arcoluz/0e978c88-0eeb-4dab-9b78-64583b86d795.jpg' Jan 18 08:41:31 tms909100wr volumio[849]: info: Preload queue cleared Jan 18 08:41:31 tms909100wr volumio[849]: info: Preload queue cleared Jan 18 08:41:31 tms909100wr volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Fourplay/Esprit%20De%20Four/f19c2ef8-38d6-4a2f-8e89-53ba265cc6c8.png' Jan 18 08:41:33 tms909100wr volumio[849]: Error in writing albumart JSON file: Error: ENOSPC: no space left on device, write Jan 18 08:41:35 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 08:41:35 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 08:41:35 tms909100wr volumio[849]: info: Discovery: Getting this device information Jan 18 08:41:35 tms909100wr volumio[849]: info: CoreCommandRouter::volumioGetState Jan 18 08:41:35 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 1 Jan 18 08:41:35 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 08:41:38 tms909100wr volumio[849]: info: Preload queue cleared Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::ClearQueue Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::stPlaybackTimer Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::updateTrackBlock Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrackBlock Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 1 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::serviceStop Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 1 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::serviceStop Jan 18 08:41:38 tms909100wr volumio[849]: info: ControllerMpd::stop Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::clearPlayQueue Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::saveQueue Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushQueue Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::addQueueItems Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::addQueueItems Jan 18 08:41:38 tms909100wr volumio[849]: info: Preload queue cleared Jan 18 08:41:38 tms909100wr volumio[849]: info: Adding Item to queue: genres://Jazz/Chantal%20Chamberland/Dripping%20Indigo Jan 18 08:41:38 tms909100wr volumio[849]: info: Exploding uri genres://Jazz/Chantal%20Chamberland/Dripping%20Indigo in service mpd Jan 18 08:41:38 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushQueue Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::saveQueue Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::updateTrackBlock Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrackBlock Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPlay Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::play index 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::play index undefined Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::startPlaybackTimer Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 08:41:38 tms909100wr volumio[849]: info: Jan 18 08:41:38 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:38 tms909100wr volumio[849]: info: sendMpdCommand stop took 27 milliseconds Jan 18 08:41:38 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:38 tms909100wr volumio[849]: info: sendMpdCommand stop took 3 milliseconds Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jan 18 08:41:38 tms909100wr volumio[849]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X' Jan 18 08:41:38 tms909100wr volumio[849]: info: Jan 18 08:41:38 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:38 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:38 tms909100wr volumio[849]: info: Jan 18 08:41:38 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:38 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:38 tms909100wr volumio[849]: info: Jan 18 08:41:38 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:38 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:38 tms909100wr sudo[11242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:38 tms909100wr sudo[11242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:38 tms909100wr volumio[849]: info: Jan 18 08:41:38 tms909100wr volumio[849]: ---------------------------- MPD announces system playlist update Jan 18 08:41:38 tms909100wr volumio[849]: info: Ignoring MPD Status Update Jan 18 08:41:38 tms909100wr volumio[849]: info: sendMpdCommand status took 8 milliseconds Jan 18 08:41:38 tms909100wr volumio[849]: info: sendMpdCommand clear took 7 milliseconds Jan 18 08:41:38 tms909100wr volumio[849]: info: sendMpdCommand status took 4 milliseconds Jan 18 08:41:38 tms909100wr volumio[849]: info: sendMpdCommand status took 5 milliseconds Jan 18 08:41:38 tms909100wr volumio[849]: info: sendMpdCommand status took 4 milliseconds Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav" Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:38 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:38 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 18 08:41:38 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: No code Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 18 08:41:38 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: No code Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 18 08:41:38 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: No code Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:38 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:38 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:38 tms909100wr volumio[849]: info: ------------------------------ 30ms Jan 18 08:41:38 tms909100wr systemd[1]: Stopping peppymeterbasic Daemon... Jan 18 08:41:38 tms909100wr systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Jan 18 08:41:38 tms909100wr volumio[849]: info: ------------------------------ 30ms Jan 18 08:41:38 tms909100wr volumio[849]: info: ------------------------------ 30ms Jan 18 08:41:38 tms909100wr volumio[849]: info: Jan 18 08:41:38 tms909100wr volumio[849]: ---------------------------- MPD announces system playlist update Jan 18 08:41:38 tms909100wr volumio[849]: info: Ignoring MPD Status Update Jan 18 08:41:38 tms909100wr volumio[849]: info: Jan 18 08:41:38 tms909100wr volumio[849]: ---------------------------- MPD announces system playlist update Jan 18 08:41:38 tms909100wr volumio[849]: info: Ignoring MPD Status Update Jan 18 08:41:38 tms909100wr systemd[1]: peppymeterbasic.service: Succeeded. Jan 18 08:41:38 tms909100wr systemd[1]: Stopped peppymeterbasic Daemon. Jan 18 08:41:38 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:38 tms909100wr sudo[11242]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:38 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:38 tms909100wr sudo[11245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:38 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:38 tms909100wr sudo[11245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:38 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:38 tms909100wr sudo[11245]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:38 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:38 tms909100wr sudo[11247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:38 tms909100wr sudo[11250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:38 tms909100wr sudo[11250]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:38 tms909100wr sudo[11247]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:38 tms909100wr sudo[11252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:38 tms909100wr sudo[11252]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:39 tms909100wr sudo[11247]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11250]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11252]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:39 tms909100wr sudo[11259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11259]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr sudo[11257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 18 08:41:39 tms909100wr sudo[11257]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr sudo[11262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11262]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr sudo[11266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11266]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: error: updateQueue error: null Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces system playlist update Jan 18 08:41:39 tms909100wr volumio[849]: info: Ignoring MPD Status Update Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 243ms Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand playlistinfo took 242 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand add "USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav" took 242 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 214ms Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 213ms Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseTrackInfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jan 18 08:41:39 tms909100wr volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 254ms Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces system playlist update Jan 18 08:41:39 tms909100wr volumio[849]: info: Ignoring MPD Status Update Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces system playlist update Jan 18 08:41:39 tms909100wr volumio[849]: info: Ignoring MPD Status Update Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces system playlist update Jan 18 08:41:39 tms909100wr volumio[849]: info: Ignoring MPD Status Update Jan 18 08:41:39 tms909100wr sudo[11270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11270]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 18ms Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand play took 16 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 15ms Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 13ms Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 13ms Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces system playlist update Jan 18 08:41:39 tms909100wr volumio[849]: info: Ignoring MPD Status Update Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Stop Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Stop Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Stop Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Stop Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Stop Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand status took 17 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand status took 14 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand status took 11 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 10ms Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:39 tms909100wr sudo[11257]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:39 tms909100wr sudo[11259]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:39 tms909100wr volumio[849]: info: Jan 18 08:41:39 tms909100wr volumio[849]: ---------------------------- MPD announces state update: player Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::getState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jan 18 08:41:39 tms909100wr sudo[11262]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11266]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand status took 25 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand status took 17 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand status took 9 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand status took 9 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand status took 8 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseTrackInfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseTrackInfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseTrackInfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseState Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bewitched, Bothered And Bewildered","artist":"Chantal Chamberland","album":"Dripping Indigo","uri":"USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav","trackType":"wav"} Jan 18 08:41:39 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService play Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bewitched, Bothered And Bewildered","artist":"Chantal Chamberland","album":"Dripping Indigo","uri":"USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav","trackType":"wav"} Jan 18 08:41:39 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService play Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus play Jan 18 08:41:39 tms909100wr volumio[849]: info: Received an update from plugin. extracting info from payload Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bewitched, Bothered And Bewildered","artist":"Chantal Chamberland","album":"Dripping Indigo","uri":"USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav","trackType":"wav"} Jan 18 08:41:39 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService play Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus play Jan 18 08:41:39 tms909100wr volumio[849]: info: Received an update from plugin. extracting info from payload Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 49ms Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 47ms Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 46ms Jan 18 08:41:39 tms909100wr sudo[11270]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Stop Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand playlistinfo took 415 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand playlistinfo took 414 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: info: sendMpdCommand playlistinfo took 413 milliseconds Jan 18 08:41:39 tms909100wr volumio[849]: verbose: ControllerMpd::parseTrackInfo Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bewitched, Bothered And Bewildered","artist":"Chantal Chamberland","album":"Dripping Indigo","uri":"USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav","trackType":"wav"} Jan 18 08:41:39 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService play Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus play Jan 18 08:41:39 tms909100wr volumio[849]: info: Received an update from plugin. extracting info from payload Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bewitched, Bothered And Bewildered","artist":"Chantal Chamberland","album":"Dripping Indigo","uri":"USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav","trackType":"wav"} Jan 18 08:41:39 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService play Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus play Jan 18 08:41:39 tms909100wr volumio[849]: info: Received an update from plugin. extracting info from payload Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bewitched, Bothered And Bewildered","artist":"Chantal Chamberland","album":"Dripping Indigo","uri":"USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav","trackType":"wav"} Jan 18 08:41:39 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService play Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus play Jan 18 08:41:39 tms909100wr volumio[849]: info: Received an update from plugin. extracting info from payload Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bewitched, Bothered And Bewildered","artist":"Chantal Chamberland","album":"Dripping Indigo","uri":"USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav","trackType":"wav"} Jan 18 08:41:39 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService play Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus play Jan 18 08:41:39 tms909100wr volumio[849]: info: Received an update from plugin. extracting info from payload Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: ControllerMpd::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::servicePushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bewitched, Bothered And Bewildered","artist":"Chantal Chamberland","album":"Dripping Indigo","uri":"USB/128GB-USB/02 Bewitched, Bothered And Bewildered.wav","trackType":"wav"} Jan 18 08:41:39 tms909100wr volumio[849]: verbose: CURRENT POSITION 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState stateService play Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::syncState currentStatus play Jan 18 08:41:39 tms909100wr volumio[849]: info: Received an update from plugin. extracting info from payload Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreStateMachine::pushState Jan 18 08:41:39 tms909100wr volumio[849]: info: CorePlayQueue::getTrack 0 Jan 18 08:41:39 tms909100wr volumio[849]: info: CoreCommandRouter::volumioPushState Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 468ms Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 460ms Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 453ms Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 451ms Jan 18 08:41:39 tms909100wr volumio[849]: info: ------------------------------ 450ms Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11278]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11280]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11284]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr systemd[1]: Started peppymeterbasic Daemon. Jan 18 08:41:39 tms909100wr sudo[11288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11288]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr sudo[11291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11291]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11278]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11294]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11294]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11280]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11301]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr sudo[11291]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11284]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11288]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11298]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11304]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr sudo[11301]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11306]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11304]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11310]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11306]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11313]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr sudo[11310]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr volumio[849]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 18 08:41:39 tms909100wr sudo[11313]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11316]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr sudo[11318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 18 08:41:39 tms909100wr sudo[11318]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Stop Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Stop Jan 18 08:41:39 tms909100wr volumio[849]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X' Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:39 tms909100wr volumio[849]: error: touch_display: Error waking up the screen: Error: Command failed: /usr/bin/xset -display : s reset dpms force on Jan 18 08:41:39 tms909100wr volumio[849]: /usr/bin/xset: unable to open display ":" Jan 18 08:41:39 tms909100wr sudo[11318]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr sudo[11316]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:39 tms909100wr volumio[849]: info: peppymeterbasic Daemon Started Jan 18 08:41:40 tms909100wr dbus-daemon[587]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Jan 18 08:41:40 tms909100wr volumio-time-update[584]: Failed to set time: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Jan 18 08:41:40 tms909100wr sudo[11117]: pam_unix(sudo:session): session closed for user root Jan 18 08:41:40 tms909100wr volumio-time-update[584]: volumio-time-update-util: Error setting time. Jan 18 08:41:40 tms909100wr volumio-time-update[584]: volumio-time-update-util: Retrying in 5 seconds... Jan 18 08:41:40 tms909100wr volumio[849]: Error in writing albumart JSON file: Error: ENOSPC: no space left on device, write Jan 18 08:41:40 tms909100wr volumio[849]: Error in writing albumart JSON file: Error: ENOSPC: no space left on device, write Jan 18 08:41:41 tms909100wr volumio[11285]: pygame 1.9.4.post1 Jan 18 08:41:41 tms909100wr volumio[11285]: Hello from the pygame community. https://www.pygame.org/contribute.html Jan 18 08:41:42 tms909100wr volumio[849]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 08:41:42 tms909100wr volumio[849]: [Error: ENOSPC: no space left on device, write] { Jan 18 08:41:42 tms909100wr volumio[849]: errno: -28, Jan 18 08:41:42 tms909100wr volumio[849]: code: 'ENOSPC', Jan 18 08:41:42 tms909100wr volumio[849]: syscall: 'write' Jan 18 08:41:42 tms909100wr volumio[849]: } Jan 18 08:41:42 tms909100wr volumio[849]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 08:41:44 tms909100wr sudo[11357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 08:40 Jan 18 08:41:44 tms909100wr sudo[11357]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"