-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sat 2025-03-01 08:51:30 CST. -- Mar 01 08:50:00 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:00 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:00 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:01 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:01 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:01 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:02 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:02 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:02 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:03 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:03 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:03 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:04 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:04 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:04 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:04 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:04 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:04 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:05 smsl-n100 ntpd[748]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 01 08:50:05 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:05 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:05 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:06 smsl-n100 ntpd[748]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 01 08:50:06 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:06 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:06 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:07 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:07 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:07 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:09 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:09 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:09 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:09 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:09 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:09 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:10 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:10 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:10 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:11 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:11 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:11 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:13 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:13 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:13 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:14 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:14 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:14 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:14 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:14 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:14 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:15 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:15 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:15 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:16 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:16 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:16 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:18 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:18 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:18 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:19 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:19 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:20 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:20 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:20 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:20 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:20 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:21 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:21 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:21 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:22 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:22 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:22 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:23 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:23 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:23 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:24 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:24 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:24 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:25 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:25 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:25 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:25 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:25 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:25 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:25 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:25 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:25 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:27 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:27 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:27 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:28 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:28 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:28 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:30 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:30 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:30 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:30 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:30 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:30 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:32 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:32 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:32 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:32 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:32 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:32 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:33 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:33 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:33 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:35 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:35 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:35 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:35 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:35 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:35 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:35 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:35 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:35 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:36 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:36 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:36 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:37 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:37 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:37 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:38 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:38 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:38 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:39 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:39 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:39 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:40 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:40 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:40 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:41 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:41 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:41 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:42 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:42 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:42 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:43 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:43 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:43 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:44 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:44 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:44 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:45 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:45 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:45 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:45 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:45 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:45 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:46 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:46 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:46 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:47 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:47 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:47 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:48 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:48 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:48 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:49 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:49 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:49 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:50 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:50 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:50 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:51 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:51 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:51 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:52 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:52 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:52 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:53 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:53 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:53 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:54 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:54 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:54 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:54 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:54 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:54 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:55 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:50:55 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:50:55 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:50:56 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:56 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:56 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:56 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:56 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:56 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:57 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:57 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:57 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:58 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:58 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:58 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:50:59 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:50:59 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:50:59 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:00 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:51:00 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:51:00 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:51:00 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:00 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:00 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:02 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:02 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:02 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:02 smsl-n100 ntpd[748]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 01 08:51:02 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:03 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:03 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:04 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:04 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:04 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:04 smsl-n100 ntpd[748]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 01 08:51:05 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:51:05 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:51:05 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:51:05 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:05 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:05 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:06 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:06 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:06 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:07 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:07 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:07 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:08 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:08 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:08 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:09 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:09 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:09 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:10 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:10 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:10 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:10 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:51:10 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:51:10 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:51:11 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:11 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:11 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:11 smsl-n100 ntpd[748]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 01 08:51:12 smsl-n100 kernel: usb 2-1.4: USB disconnect, device number 9 Mar 01 08:51:12 smsl-n100 ntpd[748]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 01 08:51:12 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:12 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:12 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:13 smsl-n100 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Mar 01 08:51:13 smsl-n100 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Mar 01 08:51:13 smsl-n100 volumio[960]: info: Partition removed: {"syspath":"/sys/devices/platform/ff5c0000.usb/usb2/2-1/2-1.4/2-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/39c21139-01 /dev/disk/by-id/usb-Fanxiang_F313_CCYYMMDDHHmmSS94-0:0-part1 /dev/disk/by-uuid/0C8B-40E4 /dev/disk/by-path/platform-ff5c0000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/ff5c0000.usb/usb2/2-1/2-1.4/2-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"0C8B-40E4","ID_FS_UUID_ENC":"0C8B-40E4","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"F313","ID_MODEL_ENC":"F313\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"2000","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"960","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"491519040","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"39c21139-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"39c21139","ID_PATH":"platform-ff5c0000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-ff5c0000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"1100","ID_SERIAL":"Fanxiang_F313_CCYYMMDDHHmmSS94-0:0","ID_SERIAL_SHORT":"CCYYMMDDHHmmSS94","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Fanxiang","ID_VENDOR_ENC":"Fanxiang","ID_VENDOR_ID":"090c","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2350","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"126998120"} Mar 01 08:51:13 smsl-n100 sudo[3134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Mar 01 08:51:13 smsl-n100 sudo[3134]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 08:51:13 smsl-n100 sudo[3134]: pam_unix(sudo:session): session closed for user root Mar 01 08:51:13 smsl-n100 systemd[1]: media-0C8B\x2d40E4.mount: Succeeded. Mar 01 08:51:13 smsl-n100 mount.exfat[1744]: failed to write super block Mar 01 08:51:13 smsl-n100 kernel: usb 2-1.4: new high-speed USB device number 10 using ehci-platform Mar 01 08:51:13 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:13 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:13 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:14 smsl-n100 kernel: usb 2-1.4: device not accepting address 10, error -71 Mar 01 08:51:14 smsl-n100 kernel: usb 2-1.4: new high-speed USB device number 11 using ehci-platform Mar 01 08:51:14 smsl-n100 kernel: usb 2-1.4: New USB device found, idVendor=090c, idProduct=2000, bcdDevice=11.00 Mar 01 08:51:14 smsl-n100 kernel: usb 2-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Mar 01 08:51:14 smsl-n100 kernel: usb 2-1.4: Product: USB Disk Mar 01 08:51:14 smsl-n100 kernel: usb 2-1.4: Manufacturer: Fanxiang Mar 01 08:51:14 smsl-n100 kernel: usb 2-1.4: SerialNumber: CCYYMMDDHHmmSS94 Mar 01 08:51:14 smsl-n100 kernel: usb-storage 2-1.4:1.0: USB Mass Storage device detected Mar 01 08:51:14 smsl-n100 kernel: scsi host0: usb-storage 2-1.4:1.0 Mar 01 08:51:15 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:15 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:15 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:15 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:51:15 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:51:15 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:51:16 smsl-n100 kernel: scsi 0:0:0:0: Direct-Access Fanxiang F313 1100 PQ: 0 ANSI: 6 Mar 01 08:51:16 smsl-n100 kernel: sd 0:0:0:0: [sda] 491520000 512-byte logical blocks: (252 GB/234 GiB) Mar 01 08:51:16 smsl-n100 kernel: sd 0:0:0:0: [sda] Write Protect is off Mar 01 08:51:16 smsl-n100 kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 Mar 01 08:51:16 smsl-n100 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Mar 01 08:51:16 smsl-n100 kernel: sda: sda1 Mar 01 08:51:16 smsl-n100 kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Mar 01 08:51:16 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:16 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:16 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:17 smsl-n100 kernel: usb 2-1.4: reset high-speed USB device number 11 using ehci-platform Mar 01 08:51:17 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:17 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:17 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:17 smsl-n100 volumio[960]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/0C8B-40E4 Mar 01 08:51:17 smsl-n100 kernel: usb 2-1.4: device descriptor read/64, error -71 Mar 01 08:51:18 smsl-n100 volumio[960]: info: Scanning removed location : "USB/0C8B-40E4" Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: update Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: update Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: update Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: update Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: MPD Database updated - AlbumList cache refreshed Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: database Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: update Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: MPD Database updated - AlbumList cache refreshed Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: database Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: update Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: MPD Database updated - AlbumList cache refreshed Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: database Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: update Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: MPD Database updated - AlbumList cache refreshed Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: database Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: Mar 01 08:51:18 smsl-n100 volumio[960]: ---------------------------- MPD announces state update: update Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: ControllerMpd::getState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::sendMpdCommand status Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 167 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 161 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 158 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 154 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 152 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 148 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 147 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 144 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 63 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 61 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 60 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 56 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 53 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 52 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 48 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 46 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: info: sendMpdCommand status took 44 milliseconds Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:18 smsl-n100 volumio[960]: info: Command Router : Notfying DB Updatefalse Mar 01 08:51:18 smsl-n100 volumio[960]: info: CoreCommandRouter::Close All Modals sent Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:18 smsl-n100 volumio[960]: info: Command Router : Notfying DB Updatefalse Mar 01 08:51:18 smsl-n100 volumio[960]: info: CoreCommandRouter::Close All Modals sent Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:18 smsl-n100 volumio[960]: info: Command Router : Notfying DB Updatefalse Mar 01 08:51:18 smsl-n100 volumio[960]: info: CoreCommandRouter::Close All Modals sent Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:18 smsl-n100 volumio[960]: info: Command Router : Notfying DB Updatefalse Mar 01 08:51:18 smsl-n100 volumio[960]: info: CoreCommandRouter::Close All Modals sent Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:18 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: info: Command Router : Notfying DB Updatefalse Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::Close All Modals sent Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: info: Command Router : Notfying DB Updatefalse Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::Close All Modals sent Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: info: Command Router : Notfying DB Updatefalse Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::Close All Modals sent Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 815ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 808ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 803ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 799ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 717ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 718ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 711ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 713ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 706ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 711ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: sendMpdCommand status took 713 milliseconds Mar 01 08:51:19 smsl-n100 volumio[960]: info: sendMpdCommand status took 696 milliseconds Mar 01 08:51:19 smsl-n100 volumio[960]: info: sendMpdCommand status took 694 milliseconds Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: info: Command Router : Notfying DB Updatefalse Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::Close All Modals sent Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: ControllerMpd::parseState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ControllerMpd::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::servicePushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: 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} Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: CURRENT POSITION 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState stateService stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::syncState currentStatus stop Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: No code Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreStateMachine::pushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioPushState Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 828ms Mar 01 08:51:19 smsl-n100 volumio[960]: info: ------------------------------ 829ms Mar 01 08:51:19 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:19 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:19 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:20 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:51:20 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:51:20 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:51:20 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:20 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:20 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:21 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Mar 01 08:51:21 smsl-n100 dhcpcd[956]: eth0: carrier acquired Mar 01 08:51:21 smsl-n100 dhcpcd[956]: eth0: IAID 1e:78:84:1c Mar 01 08:51:21 smsl-n100 dhcpcd[956]: eth0: soliciting a DHCP lease Mar 01 08:51:21 smsl-n100 ifplugd(eth0)[756]: Link beat detected. Mar 01 08:51:21 smsl-n100 ifplugd(eth0)[756]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Mar 01 08:51:21 smsl-n100 dhcpcd[956]: eth0: soliciting an IPv6 router Mar 01 08:51:21 smsl-n100 ifplugd(eth0)[756]: client: sending commands to master dhcpcd process Mar 01 08:51:21 smsl-n100 dhcpcd[3232]: sending commands to master dhcpcd process Mar 01 08:51:21 smsl-n100 dhcpcd[956]: control command: /sbin/dhcpcd eth0 Mar 01 08:51:21 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:22 smsl-n100 ifplugd(eth0)[756]: Program executed successfully. Mar 01 08:51:22 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:22 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:23 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:23 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:23 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:23 smsl-n100 dhcpcd[956]: eth0: offered 192.168.1.76 from 192.168.1.1 Mar 01 08:51:23 smsl-n100 dhcpcd[956]: eth0: probing address 192.168.1.76/24 Mar 01 08:51:24 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:24 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:24 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:25 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:25 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:25 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:25 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:51:25 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Date not found in response Mar 01 08:51:25 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Retrying in 5 seconds... Mar 01 08:51:26 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:26 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:26 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:26 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:26 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:26 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:27 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:28 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:28 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:28 smsl-n100 volumio[960]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 01 08:51:28 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:28 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:28 smsl-n100 dhcpcd[956]: eth0: leased 192.168.1.76 for 259200 seconds Mar 01 08:51:28 smsl-n100 dhcpcd[956]: eth0: adding route to 192.168.1.0/24 Mar 01 08:51:28 smsl-n100 avahi-daemon[566]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.76. Mar 01 08:51:28 smsl-n100 dhcpcd[956]: eth0: adding default route via 192.168.1.1 Mar 01 08:51:28 smsl-n100 avahi-daemon[566]: New relevant interface eth0.IPv4 for mDNS. Mar 01 08:51:29 smsl-n100 avahi-daemon[566]: Registering new address record for 192.168.1.76 on eth0.IPv4. Mar 01 08:51:29 smsl-n100 ntpd[748]: ntpd exiting on signal 15 (Terminated) Mar 01 08:51:29 smsl-n100 systemd[1]: Stopping Network Time Service... Mar 01 08:51:29 smsl-n100 systemd[1]: ntp.service: Succeeded. Mar 01 08:51:29 smsl-n100 systemd[1]: Stopped Network Time Service. Mar 01 08:51:29 smsl-n100 volumio[960]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 08:51:29 smsl-n100 systemd[1]: Starting Network Time Service... Mar 01 08:51:29 smsl-n100 volumio[960]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 01 08:51:29 smsl-n100 volumio[960]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 01 08:51:29 smsl-n100 ntpd[3314]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 01 08:51:29 smsl-n100 ntpd[3314]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 01 08:51:29 smsl-n100 systemd[1]: Started Network Time Service. Mar 01 08:51:29 smsl-n100 ntpd[3322]: proto: precision = 1.166 usec (-20) Mar 01 08:51:29 smsl-n100 ntpd[3322]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 01 08:51:29 smsl-n100 ntpd[3322]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 01 08:51:29 smsl-n100 ntpd[3322]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 795 days ago Mar 01 08:51:29 smsl-n100 ntpd[3322]: Listen and drop on 0 v6wildcard [::]:123 Mar 01 08:51:29 smsl-n100 ntpd[3322]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 01 08:51:29 smsl-n100 ntpd[3322]: Listen normally on 2 lo 127.0.0.1:123 Mar 01 08:51:29 smsl-n100 ntpd[3322]: Listen normally on 3 eth0 192.168.1.76:123 Mar 01 08:51:29 smsl-n100 ntpd[3322]: Listening on routing socket on fd #20 for interface updates Mar 01 08:51:29 smsl-n100 ntpd[3322]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 01 08:51:29 smsl-n100 ntpd[3322]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 01 08:51:29 smsl-n100 volumio[960]: info: Discovery: adding 57ffacb3-7ecd-425a-a0ec-2ae0d3eb3a7b Mar 01 08:51:29 smsl-n100 volumio[960]: info: Discovery: Found device SMSL N100 Mar 01 08:51:29 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState Mar 01 08:51:29 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0 Mar 01 08:51:29 smsl-n100 volumio[960]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 08:51:29 smsl-n100 volumio[960]: Error: The value NaN is not a number Mar 01 08:51:29 smsl-n100 volumio[960]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Mar 01 08:51:29 smsl-n100 volumio[960]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Mar 01 08:51:29 smsl-n100 volumio[960]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Mar 01 08:51:29 smsl-n100 volumio[960]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Mar 01 08:51:29 smsl-n100 volumio[960]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Mar 01 08:51:29 smsl-n100 volumio[960]: at Browser.emit (events.js:400:28) Mar 01 08:51:29 smsl-n100 volumio[960]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Mar 01 08:51:29 smsl-n100 volumio[960]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Mar 01 08:51:29 smsl-n100 volumio[960]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Mar 01 08:51:29 smsl-n100 volumio[960]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Mar 01 08:51:29 smsl-n100 volumio[960]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Mar 01 08:51:29 smsl-n100 volumio[960]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Mar 01 08:51:29 smsl-n100 volumio[960]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Mar 01 08:51:29 smsl-n100 volumio[960]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 08:51:30 smsl-n100 ntpd[3322]: Soliciting pool server 193.182.111.143 Mar 01 08:51:30 smsl-n100 volumio-time-update[553]: volumio-time-update-util: Fetching time from Volumio... Mar 01 08:51:30 smsl-n100 sudo[3337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-01 08:50 Mar 01 08:51:30 smsl-n100 sudo[3337]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8205c9d25502d90d2bb411bb156e1d5a8ef7404e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 20 Jan 2025 07:23:13 PM CET" VOLUMIO_VERSION="3.788" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="b3195a7f5841a4bc08e3e196c1a91b34"