Oct 12 18:52:00 volumio4 sudo[11507]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:00 volumio4 sudo[11507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:00 volumio4 sudo[11507]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:01 volumio4 sudo[11509]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:01 volumio4 sudo[11509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:01 volumio4 sudo[11509]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:02 volumio4 sudo[11511]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:02 volumio4 sudo[11511]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:02 volumio4 sudo[11511]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:03 volumio4 sudo[11534]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:03 volumio4 sudo[11534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:03 volumio4 sudo[11534]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:04 volumio4 sudo[11536]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:04 volumio4 sudo[11536]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:04 volumio4 sudo[11536]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:05 volumio4 sudo[11538]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:05 volumio4 sudo[11538]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:05 volumio4 sudo[11538]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:06 volumio4 sudo[11540]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:06 volumio4 sudo[11540]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:06 volumio4 sudo[11540]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:07 volumio4 sudo[11542]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:07 volumio4 sudo[11542]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:07 volumio4 sudo[11542]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:08 volumio4 sudo[11564]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:08 volumio4 sudo[11564]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:08 volumio4 sudo[11564]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:09 volumio4 sudo[11566]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:09 volumio4 sudo[11566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:09 volumio4 sudo[11566]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:10 volumio4 sudo[11582]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:10 volumio4 sudo[11582]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:10 volumio4 sudo[11582]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:11 volumio4 sudo[11584]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:11 volumio4 sudo[11584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:11 volumio4 sudo[11584]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:12 volumio4 sudo[11597]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:12 volumio4 sudo[11597]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:12 volumio4 sudo[11597]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:13 volumio4 sudo[11627]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:13 volumio4 sudo[11627]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:13 volumio4 sudo[11627]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:14 volumio4 sudo[11629]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:14 volumio4 sudo[11629]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:14 volumio4 sudo[11629]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:15 volumio4 sudo[11632]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:15 volumio4 sudo[11632]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:15 volumio4 sudo[11632]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:16 volumio4 sudo[11634]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:16 volumio4 sudo[11634]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:16 volumio4 sudo[11634]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:17 volumio4 sudo[11636]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:17 volumio4 sudo[11636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:17 volumio4 sudo[11636]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:18 volumio4 sudo[11658]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:18 volumio4 sudo[11658]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:18 volumio4 sudo[11658]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:19 volumio4 sudo[11660]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:19 volumio4 sudo[11660]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:19 volumio4 sudo[11660]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:20 volumio4 sudo[11676]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:20 volumio4 sudo[11676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:20 volumio4 sudo[11676]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:21 volumio4 sudo[11678]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:21 volumio4 sudo[11678]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:21 volumio4 sudo[11678]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:22 volumio4 sudo[11680]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:22 volumio4 sudo[11680]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:22 volumio4 sudo[11680]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:23 volumio4 sudo[11702]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:23 volumio4 sudo[11702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:23 volumio4 sudo[11702]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:24 volumio4 sudo[11704]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:24 volumio4 sudo[11704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:24 volumio4 sudo[11704]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:25 volumio4 sudo[11706]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:25 volumio4 sudo[11706]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:25 volumio4 sudo[11706]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:26 volumio4 sudo[11708]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:26 volumio4 sudo[11708]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:26 volumio4 sudo[11708]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:27 volumio4 sudo[11710]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:27 volumio4 sudo[11710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:27 volumio4 sudo[11710]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:28 volumio4 sudo[11735]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:28 volumio4 sudo[11735]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:28 volumio4 sudo[11735]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:29 volumio4 sudo[11751]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:29 volumio4 sudo[11751]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:29 volumio4 sudo[11751]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:30 volumio4 sudo[11753]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:30 volumio4 sudo[11753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:30 volumio4 sudo[11753]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:31 volumio4 sudo[11755]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:31 volumio4 sudo[11755]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:31 volumio4 sudo[11755]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:32 volumio4 volumio[11229]: info: CoreCommandRouter::volumioGetState Oct 12 18:52:32 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 3 Oct 12 18:52:32 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 12 18:52:32 volumio4 volumio[11229]: info: CoreCommandRouter::volumioGetQueue Oct 12 18:52:32 volumio4 volumio[11229]: info: CoreStateMachine::getQueue Oct 12 18:52:32 volumio4 volumio[11229]: info: CorePlayQueue::getQueue Oct 12 18:52:32 volumio4 sudo[11779]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:32 volumio4 sudo[11779]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:32 volumio4 sudo[11779]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:33 volumio4 volumio[11229]: info: Executing endpoint glass_artistfanart Oct 12 18:52:33 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: glass , getArtistFanart Oct 12 18:52:33 volumio4 sudo[11808]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:33 volumio4 sudo[11808]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:33 volumio4 sudo[11808]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:34 volumio4 sudo[11811]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:34 volumio4 sudo[11811]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:34 volumio4 sudo[11811]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:35 volumio4 sudo[11813]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:35 volumio4 sudo[11813]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:35 volumio4 sudo[11813]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:36 volumio4 sudo[11815]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:36 volumio4 sudo[11815]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:36 volumio4 sudo[11815]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:37 volumio4 sudo[11817]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:37 volumio4 sudo[11817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:37 volumio4 sudo[11817]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:38 volumio4 sudo[11839]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:38 volumio4 sudo[11839]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:38 volumio4 sudo[11839]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:39 volumio4 sudo[11855]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:39 volumio4 sudo[11855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:39 volumio4 sudo[11855]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:40 volumio4 sudo[11857]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:40 volumio4 sudo[11857]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:40 volumio4 sudo[11857]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:41 volumio4 sudo[11859]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:41 volumio4 sudo[11859]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:41 volumio4 sudo[11859]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:42 volumio4 sudo[11861]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:42 volumio4 sudo[11861]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:42 volumio4 sudo[11861]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:43 volumio4 sudo[11884]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:43 volumio4 sudo[11884]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:43 volumio4 sudo[11884]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:44 volumio4 sudo[11887]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:44 volumio4 sudo[11887]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:44 volumio4 sudo[11887]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:45 volumio4 sudo[11889]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:45 volumio4 sudo[11889]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:45 volumio4 sudo[11889]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:46 volumio4 sudo[11891]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:46 volumio4 sudo[11891]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:46 volumio4 sudo[11891]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:47 volumio4 sudo[11893]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:47 volumio4 sudo[11893]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:47 volumio4 sudo[11893]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:49 volumio4 sudo[11915]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:49 volumio4 sudo[11915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:49 volumio4 sudo[11915]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:50 volumio4 sudo[11931]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:50 volumio4 sudo[11931]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:50 volumio4 sudo[11931]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:51 volumio4 sudo[11933]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:51 volumio4 sudo[11933]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:51 volumio4 sudo[11933]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:51 volumio4 volumio[11229]: info: CoreCommandRouter::volumioGetState Oct 12 18:52:51 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 3 Oct 12 18:52:51 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 12 18:52:51 volumio4 volumio[11229]: info: CoreCommandRouter::volumioGetQueue Oct 12 18:52:51 volumio4 volumio[11229]: info: CoreStateMachine::getQueue Oct 12 18:52:51 volumio4 volumio[11229]: info: CorePlayQueue::getQueue Oct 12 18:52:52 volumio4 sudo[11959]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:52 volumio4 sudo[11959]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:52 volumio4 volumio[11229]: info: Executing endpoint glass_artistfanart Oct 12 18:52:52 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: glass , getArtistFanart Oct 12 18:52:52 volumio4 sudo[11959]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:53 volumio4 sudo[11966]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:53 volumio4 sudo[11966]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:53 volumio4 sudo[11966]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:54 volumio4 sudo[11988]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:54 volumio4 sudo[11988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:54 volumio4 sudo[11988]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:55 volumio4 sudo[11991]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:55 volumio4 sudo[11991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:55 volumio4 sudo[11991]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:56 volumio4 sudo[11993]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:56 volumio4 sudo[11993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:56 volumio4 sudo[11993]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:57 volumio4 sudo[11995]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:57 volumio4 sudo[11995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:57 volumio4 sudo[11995]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:58 volumio4 sudo[11997]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:58 volumio4 sudo[11997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:58 volumio4 sudo[11997]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:59 volumio4 sudo[12022]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:52:59 volumio4 sudo[12022]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:52:59 volumio4 sudo[12022]: pam_unix(sudo:session): session closed for user root Oct 12 18:52:59 volumio4 volumio[11229]: info: CoreCommandRouter::volumioGetState Oct 12 18:52:59 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 3 Oct 12 18:52:59 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 12 18:52:59 volumio4 volumio[11229]: info: CoreCommandRouter::volumioGetQueue Oct 12 18:52:59 volumio4 volumio[11229]: info: CoreStateMachine::getQueue Oct 12 18:52:59 volumio4 volumio[11229]: info: CorePlayQueue::getQueue Oct 12 18:53:00 volumio4 sudo[12065]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:00 volumio4 sudo[12065]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:00 volumio4 sudo[12065]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:00 volumio4 volumio[11229]: info: Executing endpoint glass_artistfanart Oct 12 18:53:00 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: glass , getArtistFanart Oct 12 18:53:01 volumio4 sudo[12071]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:01 volumio4 sudo[12071]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:01 volumio4 sudo[12071]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:02 volumio4 sudo[12073]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:02 volumio4 sudo[12073]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:02 volumio4 sudo[12073]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:03 volumio4 sudo[12075]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:03 volumio4 sudo[12075]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:03 volumio4 sudo[12075]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:04 volumio4 sudo[12097]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:04 volumio4 sudo[12097]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:04 volumio4 sudo[12097]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:05 volumio4 sudo[12100]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:05 volumio4 sudo[12100]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:05 volumio4 sudo[12100]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:06 volumio4 sudo[12102]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:06 volumio4 sudo[12102]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:06 volumio4 sudo[12102]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:07 volumio4 sudo[12104]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:07 volumio4 sudo[12104]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:07 volumio4 sudo[12104]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:08 volumio4 sudo[12106]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:08 volumio4 sudo[12106]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:08 volumio4 sudo[12106]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:09 volumio4 sudo[12128]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:09 volumio4 sudo[12128]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:09 volumio4 sudo[12128]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:10 volumio4 sudo[12144]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:10 volumio4 sudo[12144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:10 volumio4 sudo[12144]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:11 volumio4 sudo[12146]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:11 volumio4 sudo[12146]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:11 volumio4 sudo[12146]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:12 volumio4 sudo[12148]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:12 volumio4 sudo[12148]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:12 volumio4 sudo[12148]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:13 volumio4 sudo[12150]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:13 volumio4 sudo[12150]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:13 volumio4 sudo[12150]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:14 volumio4 sudo[12176]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:14 volumio4 sudo[12176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:14 volumio4 sudo[12176]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:14 volumio4 volumio[11229]: info: CoreCommandRouter::volumioGetState Oct 12 18:53:14 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 3 Oct 12 18:53:15 volumio4 sudo[12179]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:15 volumio4 sudo[12179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:15 volumio4 sudo[12179]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:16 volumio4 volumio[11229]: info: CoreCommandRouter::volumioGetQueue Oct 12 18:53:16 volumio4 volumio[11229]: info: CoreStateMachine::getQueue Oct 12 18:53:16 volumio4 volumio[11229]: info: CorePlayQueue::getQueue Oct 12 18:53:16 volumio4 sudo[12181]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:16 volumio4 sudo[12181]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:16 volumio4 sudo[12181]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:17 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 18:53:17 volumio4 volumio[11229]: info: CURURI: music-library Oct 12 18:53:17 volumio4 volumio[11229]: info: Preload queue cleared Oct 12 18:53:17 volumio4 sudo[12183]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:17 volumio4 sudo[12183]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:17 volumio4 sudo[12183]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:18 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 18:53:18 volumio4 volumio[11229]: info: CURURI: music-library/NAS Oct 12 18:53:18 volumio4 volumio[11229]: info: Preload queue cleared Oct 12 18:53:18 volumio4 sudo[12185]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:18 volumio4 sudo[12185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:18 volumio4 sudo[12185]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:19 volumio4 sudo[12221]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:19 volumio4 sudo[12221]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:19 volumio4 sudo[12221]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:20 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 18:53:20 volumio4 volumio[11229]: info: CURURI: music-library/NAS/MyMusic2 Oct 12 18:53:20 volumio4 volumio[11229]: info: Preload queue cleared Oct 12 18:53:20 volumio4 sudo[12228]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:20 volumio4 sudo[12228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:20 volumio4 sudo[12228]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:21 volumio4 sudo[12233]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:21 volumio4 sudo[12233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:21 volumio4 sudo[12233]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:22 volumio4 sudo[12240]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:22 volumio4 sudo[12240]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:22 volumio4 sudo[12240]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:23 volumio4 sudo[12242]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:23 volumio4 sudo[12242]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:23 volumio4 sudo[12242]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:24 volumio4 sudo[12268]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:24 volumio4 sudo[12268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:24 volumio4 sudo[12268]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:25 volumio4 sudo[12270]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:25 volumio4 sudo[12270]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:25 volumio4 sudo[12270]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:26 volumio4 sudo[12272]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:26 volumio4 sudo[12272]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:26 volumio4 sudo[12272]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:27 volumio4 sudo[12281]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:27 volumio4 sudo[12281]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:27 volumio4 sudo[12281]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:28 volumio4 sudo[12283]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:28 volumio4 sudo[12283]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:28 volumio4 sudo[12283]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:29 volumio4 sudo[12323]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:29 volumio4 sudo[12323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:29 volumio4 sudo[12323]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:29 volumio4 volumio[11229]: info: Preload queue cleared Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::ClearQueue Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::stop Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::stPlaybackTimer Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::updateTrackBlock Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrackBlock Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 3 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::serviceStop Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 3 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::serviceStop Oct 12 18:53:29 volumio4 volumio[11229]: info: ControllerMpd::stop Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::clearPlayQueue Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::saveQueue Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushQueue Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::addQueueItems Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::addQueueItems Oct 12 18:53:29 volumio4 volumio[11229]: info: Preload queue cleared Oct 12 18:53:29 volumio4 volumio[11229]: info: Adding Item to queue: music-library/NAS/MyMusic2/Flac Anne Murray - Duets Friends & Legends (2008) [Country] Oct 12 18:53:29 volumio4 volumio[11229]: info: Exploding uri music-library/NAS/MyMusic2/Flac Anne Murray - Duets Friends & Legends (2008) [Country] in service mpd Oct 12 18:53:29 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Anne%20Murray%20-%20Duets%20Friends%20%26%20Legends%20(2008)%20%5BCountry%5D%2FAnne%20Murray%20-%20Duets%20Friends%20%26%20Legends.flac&metadata=false Oct 12 18:53:29 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Anne Murray - Duets Friends & Legends (2008) [Country]/Anne Murray - Duets Friends & Legends.flac Oct 12 18:53:29 volumio4 volumio[11229]: info: Oct 12 18:53:29 volumio4 volumio[11229]: ---------------------------- MPD announces state update: player Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand stop took 18 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: info: ControllerMpd::getState Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushQueue Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::saveQueue Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::updateTrackBlock Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrackBlock Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPlay Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::play index 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::stop Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::play index undefined Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::startPlaybackTimer Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::clearAddPlayTracks NAS/MyMusic2/Flac Anne Murray - Duets Friends & Legends (2008) [Country]/Anne Murray - Duets Friends & Legends.flac Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand status took 3 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand stop took 0 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::parseState Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 18:53:29 volumio4 volumio[11229]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 12 18:53:29 volumio4 volumio[11229]: info: Oct 12 18:53:29 volumio4 volumio[11229]: ---------------------------- MPD announces system playlist update Oct 12 18:53:29 volumio4 volumio[11229]: info: Ignoring MPD Status Update Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand clear took 1 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand add "NAS/MyMusic2/Flac Anne Murray - Duets Friends & Legends (2008) [Country]/Anne Murray - Duets Friends & Legends.flac" Oct 12 18:53:29 volumio4 volumio[11229]: info: ControllerMpd::pushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::servicePushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: 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":"She","artist":"Elvis Costello","album":"Notting Hill","uri":"NAS/MyCD/Notting Hill/04 She.flac","trackType":"flac"} Oct 12 18:53:29 volumio4 volumio[11229]: verbose: CURRENT POSITION 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::syncState stateService stop Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::syncState currentStatus stop Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:29 volumio4 volumio[11229]: info: No code Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:29 volumio4 volumio[11229]: info: ------------------------------ 10ms Oct 12 18:53:29 volumio4 volumio[11229]: error: updateQueue error: null Oct 12 18:53:29 volumio4 volumio[11229]: info: Oct 12 18:53:29 volumio4 volumio[11229]: ---------------------------- MPD announces system playlist update Oct 12 18:53:29 volumio4 volumio[11229]: info: Ignoring MPD Status Update Oct 12 18:53:29 volumio4 volumio[11229]: info: ------------------------------ 6ms Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand add "NAS/MyMusic2/Flac Anne Murray - Duets Friends & Legends (2008) [Country]/Anne Murray - Duets Friends & Legends.flac" took 5 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand play Oct 12 18:53:29 volumio4 volumio[11229]: info: ------------------------------ 3ms Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand play took 2 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: info: Oct 12 18:53:29 volumio4 volumio[11229]: ---------------------------- MPD announces state update: player Oct 12 18:53:29 volumio4 volumio[11229]: info: ControllerMpd::getState Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:53:29 volumio4 volumio[11229]: info: Oct 12 18:53:29 volumio4 volumio[11229]: ---------------------------- MPD announces state update: player Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand status took 14 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: info: ControllerMpd::getState Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::parseState Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand status took 0 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::parseState Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:53:29 volumio4 volumio[11229]: info: ControllerMpd::pushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::servicePushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"688 Kbps","isStreaming":false,"title":"Anne Murray - Duets Friends & Legends.flac","artist":null,"album":null,"uri":"NAS/MyMusic2/Flac Anne Murray - Duets Friends & Legends (2008) [Country]/Anne Murray - Duets Friends & Legends.flac","trackType":"flac"} Oct 12 18:53:29 volumio4 volumio[11229]: verbose: CURRENT POSITION 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::syncState stateService play Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::syncState currentStatus stop Oct 12 18:53:29 volumio4 volumio[11229]: info: ------------------------------ 16ms Oct 12 18:53:29 volumio4 volumio[11229]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 12 18:53:29 volumio4 volumio[11229]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:53:29 volumio4 volumio[11229]: info: ControllerMpd::pushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::servicePushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"688 Kbps","isStreaming":false,"title":"Anne Murray - Duets Friends & Legends.flac","artist":null,"album":null,"uri":"NAS/MyMusic2/Flac Anne Murray - Duets Friends & Legends (2008) [Country]/Anne Murray - Duets Friends & Legends.flac","trackType":"flac"} Oct 12 18:53:29 volumio4 volumio[11229]: verbose: CURRENT POSITION 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::syncState stateService play Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::syncState currentStatus play Oct 12 18:53:29 volumio4 volumio[11229]: info: Received an update from plugin. extracting info from payload Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:29 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:29 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:29 volumio4 volumio[11229]: info: ------------------------------ 5ms Oct 12 18:53:29 volumio4 volumio[11229]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 12 18:53:30 volumio4 sudo[12338]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:30 volumio4 sudo[12338]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:30 volumio4 sudo[12338]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:31 volumio4 sudo[12340]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:31 volumio4 sudo[12340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:31 volumio4 sudo[12340]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:32 volumio4 sudo[12342]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:32 volumio4 sudo[12342]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:32 volumio4 sudo[12342]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:33 volumio4 sudo[12346]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:33 volumio4 sudo[12346]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:33 volumio4 sudo[12346]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:34 volumio4 volumio[11229]: info: CoreCommandRouter::volumioGetState Oct 12 18:53:34 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:34 volumio4 sudo[12369]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:34 volumio4 sudo[12369]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:34 volumio4 sudo[12369]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:35 volumio4 sudo[12371]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:35 volumio4 sudo[12371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:35 volumio4 sudo[12371]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:36 volumio4 sudo[12374]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:36 volumio4 sudo[12374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:36 volumio4 sudo[12374]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:37 volumio4 sudo[12376]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:37 volumio4 sudo[12376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:37 volumio4 sudo[12376]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:38 volumio4 sudo[12378]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:38 volumio4 sudo[12378]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:38 volumio4 sudo[12378]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:39 volumio4 sudo[12414]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:39 volumio4 sudo[12414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:40 volumio4 sudo[12414]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:40 volumio4 sudo[12416]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:40 volumio4 sudo[12416]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:41 volumio4 sudo[12416]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:41 volumio4 sudo[12418]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:41 volumio4 sudo[12418]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:42 volumio4 sudo[12418]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:42 volumio4 sudo[12420]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:42 volumio4 sudo[12420]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:43 volumio4 sudo[12420]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:43 volumio4 volumio[11229]: info: Preload queue cleared Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::ClearQueue Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::stop Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::stPlaybackTimer Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::updateTrackBlock Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrackBlock Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::serviceStop Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::serviceStop Oct 12 18:53:43 volumio4 volumio[11229]: info: ControllerMpd::stop Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::clearPlayQueue Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::saveQueue Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushQueue Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::addQueueItems Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::addQueueItems Oct 12 18:53:43 volumio4 volumio[11229]: info: Preload queue cleared Oct 12 18:53:43 volumio4 volumio[11229]: info: Adding Item to queue: music-library/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009) Oct 12 18:53:43 volumio4 volumio[11229]: info: Exploding uri music-library/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009) in service mpd Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2001%20Diamonds%20And%20Rust.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 01 Diamonds And Rust.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2002%20One%20Day%20In%20Your%20Life.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 02 One Day In Your Life.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2003%20Long%2C%20Long%20Time.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 03 Long, Long Time.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2004%20Rainy%20Days%20And%20Monday.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 04 Rainy Days And Monday.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2005%20Fields%20of%20Gold.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 05 Fields of Gold.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2006%20Forever%20Young.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 06 Forever Young.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2007%20Sorry%20Seems%20To%20Be%20The%20Hardest%20Word.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 07 Sorry Seems To Be The Hardest Word.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2008%20I%20Just%20Fall%20In%20Love%20Again.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 08 I Just Fall In Love Again.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2009%20First%20of%20May.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 09 First of May.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2010%20Now%20And%20Forever.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 10 Now And Forever.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2011%20Too%20Beautiful%20To%20Last.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 11 Too Beautiful To Last.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=//medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Astor%20Fong%20-%20Forever%20Young%20Forever%20Love%20(2009)%2FAstor%20Fong%2012%20You%20Raise%20Me%20Up.flac&metadata=false Oct 12 18:53:43 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 12 You Raise Me Up.flac Oct 12 18:53:43 volumio4 volumio[11229]: info: Oct 12 18:53:43 volumio4 volumio[11229]: ---------------------------- MPD announces state update: player Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand stop took 25 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: info: ControllerMpd::getState Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushQueue Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::saveQueue Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::updateTrackBlock Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrackBlock Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPlay Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::play index 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::stop Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::play index undefined Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::startPlaybackTimer Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::clearAddPlayTracks NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 01 Diamonds And Rust.flac Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand status took 5 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand stop took 0 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::parseState Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 18:53:43 volumio4 volumio[11229]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 12 18:53:43 volumio4 volumio[11229]: info: Oct 12 18:53:43 volumio4 volumio[11229]: ---------------------------- MPD announces system playlist update Oct 12 18:53:43 volumio4 volumio[11229]: info: Ignoring MPD Status Update Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand clear took 2 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand add "NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 01 Diamonds And Rust.flac" Oct 12 18:53:43 volumio4 volumio[11229]: info: ControllerMpd::pushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::servicePushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: 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":"Anne Murray - Duets Friends & Legends.flac","artist":null,"album":null,"uri":"NAS/MyMusic2/Flac Anne Murray - Duets Friends & Legends (2008) [Country]/Anne Murray - Duets Friends & Legends.flac","trackType":"flac"} Oct 12 18:53:43 volumio4 volumio[11229]: verbose: CURRENT POSITION 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::syncState stateService stop Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::syncState currentStatus stop Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:43 volumio4 volumio[11229]: info: No code Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:43 volumio4 volumio[11229]: info: ------------------------------ 18ms Oct 12 18:53:43 volumio4 volumio[11229]: error: updateQueue error: null Oct 12 18:53:43 volumio4 volumio[11229]: info: Oct 12 18:53:43 volumio4 volumio[11229]: ---------------------------- MPD announces system playlist update Oct 12 18:53:43 volumio4 volumio[11229]: info: Ignoring MPD Status Update Oct 12 18:53:43 volumio4 volumio[11229]: info: ------------------------------ 11ms Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand add "NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 01 Diamonds And Rust.flac" took 10 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand play Oct 12 18:53:43 volumio4 volumio[11229]: info: ------------------------------ 5ms Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand play took 6 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: info: Executing endpoint glass_artistfanart Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: glass , getArtistFanart Oct 12 18:53:43 volumio4 volumio[11229]: info: Oct 12 18:53:43 volumio4 volumio[11229]: ---------------------------- MPD announces state update: player Oct 12 18:53:43 volumio4 volumio[11229]: info: ControllerMpd::getState Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:53:43 volumio4 volumio[11229]: info: Oct 12 18:53:43 volumio4 volumio[11229]: ---------------------------- MPD announces state update: player Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand status took 12 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: info: ControllerMpd::getState Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::parseState Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand status took 2 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::parseState Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:53:43 volumio4 volumio[11229]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:53:43 volumio4 volumio[11229]: info: ControllerMpd::pushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::servicePushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Astor Fong 01 Diamonds And Rust.flac","artist":null,"album":null,"uri":"NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 01 Diamonds And Rust.flac","trackType":"flac"} Oct 12 18:53:43 volumio4 volumio[11229]: verbose: CURRENT POSITION 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::syncState stateService play Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::syncState currentStatus stop Oct 12 18:53:43 volumio4 volumio[11229]: info: ControllerMpd::pushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::servicePushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"778 Kbps","isStreaming":false,"title":"Astor Fong 01 Diamonds And Rust.flac","artist":null,"album":null,"uri":"NAS/MyMusic2/Flac Astor Fong - Forever Young Forever Love (2009)/Astor Fong 01 Diamonds And Rust.flac","trackType":"flac"} Oct 12 18:53:43 volumio4 volumio[11229]: verbose: CURRENT POSITION 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::syncState stateService play Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::syncState currentStatus play Oct 12 18:53:43 volumio4 volumio[11229]: info: Received an update from plugin. extracting info from payload Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:43 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:43 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:43 volumio4 volumio[11229]: info: ------------------------------ 17ms Oct 12 18:53:43 volumio4 volumio[11229]: info: ------------------------------ 8ms Oct 12 18:53:43 volumio4 volumio[11229]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 12 18:53:43 volumio4 sudo[12439]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:43 volumio4 sudo[12439]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:44 volumio4 sudo[12439]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:45 volumio4 sudo[12467]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:45 volumio4 sudo[12467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:45 volumio4 sudo[12467]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:46 volumio4 sudo[12469]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:46 volumio4 sudo[12469]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:46 volumio4 sudo[12469]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:47 volumio4 sudo[12471]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:47 volumio4 sudo[12471]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:47 volumio4 sudo[12471]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:48 volumio4 sudo[12473]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:48 volumio4 sudo[12473]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:48 volumio4 sudo[12473]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:49 volumio4 sudo[12478]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:49 volumio4 sudo[12478]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:49 volumio4 sudo[12478]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:50 volumio4 sudo[12519]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:50 volumio4 sudo[12519]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:50 volumio4 sudo[12519]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:51 volumio4 sudo[12524]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:51 volumio4 sudo[12524]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:51 volumio4 sudo[12524]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:52 volumio4 sudo[12527]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:52 volumio4 sudo[12527]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:52 volumio4 sudo[12527]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:53 volumio4 sudo[12529]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:53 volumio4 sudo[12529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:53 volumio4 sudo[12529]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:54 volumio4 sudo[12534]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:54 volumio4 sudo[12534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:54 volumio4 sudo[12534]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:55 volumio4 sudo[12559]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:55 volumio4 sudo[12559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:55 volumio4 sudo[12559]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:56 volumio4 sudo[12561]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:56 volumio4 sudo[12561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:56 volumio4 sudo[12561]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:57 volumio4 sudo[12563]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:57 volumio4 sudo[12563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:57 volumio4 sudo[12563]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:58 volumio4 sudo[12565]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/ss -tnp state established Oct 12 18:53:58 volumio4 sudo[12565]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 18:53:58 volumio4 sudo[12565]: pam_unix(sudo:session): session closed for user root Oct 12 18:53:58 volumio4 volumio[11229]: info: Preload queue cleared Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreStateMachine::ClearQueue Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreStateMachine::stop Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreStateMachine::stPlaybackTimer Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreStateMachine::updateTrackBlock Oct 12 18:53:58 volumio4 volumio[11229]: info: CorePlayQueue::getTrackBlock Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreStateMachine::pushState Oct 12 18:53:58 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushState Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreStateMachine::serviceStop Oct 12 18:53:58 volumio4 volumio[11229]: info: CorePlayQueue::getTrack 0 Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreCommandRouter::serviceStop Oct 12 18:53:58 volumio4 volumio[11229]: info: ControllerMpd::stop Oct 12 18:53:58 volumio4 volumio[11229]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 18:53:58 volumio4 volumio[11229]: info: CorePlayQueue::clearPlayQueue Oct 12 18:53:58 volumio4 volumio[11229]: info: CorePlayQueue::saveQueue Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreCommandRouter::volumioPushQueue Oct 12 18:53:58 volumio4 volumio[11229]: info: CoreStateMachine::addQueueItems Oct 12 18:53:58 volumio4 volumio[11229]: info: CorePlayQueue::addQueueItems Oct 12 18:53:58 volumio4 volumio[11229]: info: Preload queue cleared Oct 12 18:53:58 volumio4 volumio[11229]: info: Adding Item to queue: music-library/NAS/MyMusic2/Flac Bread - Anthology of Bread (1985) Oct 12 18:53:58 volumio4 volumio[11229]: info: Exploding uri music-library/NAS/MyMusic2/Flac Bread - Anthology of Bread (1985) in service mpd Oct 12 18:53:58 volumio4 volumio[11229]: info: Oct 12 18:53:58 volumio4 volumio[11229]: ---------------------------- MPD announces state update: player Oct 12 18:53:58 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=Bread/Anthology%20of%20Bread/medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Bread%20-%20Anthology%20of%20Bread%20(1985)%2FBread%20-%20Anthology%20of%20Bread.cue&metadata=false Oct 12 18:53:58 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Bread - Anthology of Bread (1985)/Bread - Anthology of Bread.cue Oct 12 18:53:58 volumio4 volumio[11229]: info: ALBUMART /albumart?cacheid=717&web=Bread/Anthology%20of%20Bread/medium&path=%2Fmnt%2FNAS%2FMyMusic2%2FFlac%20Bread%20-%20Anthology%20of%20Bread%20(1985)%2FBread%20-%20Anthology%20of%20Bread.cue&metadata=false Oct 12 18:53:58 volumio4 volumio[11229]: info: URI /mnt/NAS/MyMusic2/Flac Bread - Anthology of Bread (1985)/Bread - Anthology of Bread.cue Oct 12 18:53:59 volumio4 volumio[11229]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 18:53:59 volumio4 volumio[11229]: Error: Unable to resolve or reject the same promise twice Oct 12 18:53:59 volumio4 volumio[11229]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 12 18:53:59 volumio4 volumio[11229]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 12 18:53:59 volumio4 volumio[11229]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 12 18:53:59 volumio4 volumio[11229]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 12 18:53:59 volumio4 volumio[11229]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 12 18:53:59 volumio4 volumio[11229]: at Socket.emit (node:events:514:28) Oct 12 18:53:59 volumio4 volumio[11229]: at addChunk (node:internal/streams/readable:343:12) Oct 12 18:53:59 volumio4 volumio[11229]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 12 18:53:59 volumio4 volumio[11229]: at Readable.push (node:internal/streams/readable:253:10) Oct 12 18:53:59 volumio4 volumio[11229]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 12 18:53:59 volumio4 volumio[11229]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 18:53:59 volumio4 sudo[12583]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 18:52' Oct 12 18:53:59 volumio4 sudo[12583]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"