-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sun 2024-04-14 15:53:07 BST. -- Apr 14 15:52:45 volumio ntpd[660]: receive: Unexpected origin timestamp 0xe8dd0333.23b54ad8 does not match aorg 0000000000.00000000 from server@185.53.45.4 xmt 0xe9c66c3d.51e7568e Apr 14 15:52:45 volumio ntpd[660]: receive: Unexpected origin timestamp 0xe8dd0333.23adc0de does not match aorg 0000000000.00000000 from server@148.253.179.18 xmt 0xe9c66c3d.51e5b2d1 Apr 14 15:52:45 volumio ntpd[660]: receive: Unexpected origin timestamp 0xe8dd0333.23b9b564 does not match aorg 0000000000.00000000 from server@85.199.214.101 xmt 0xe9c66c3d.5238525d Apr 14 15:52:45 volumio ntpd[660]: receive: Unexpected origin timestamp 0xe8dd0333.23bc829f does not match aorg 0000000000.00000000 from server@131.111.8.63 xmt 0xe9c66c3d.5292f7aa Apr 14 15:52:45 volumio ntpd[660]: receive: Unexpected origin timestamp 0xe8dd0333.23b8593f does not match aorg 0000000000.00000000 from server@195.171.43.10 xmt 0xe9c66c3d.52d7a209 Apr 14 15:52:45 volumio ntpd[660]: receive: Unexpected origin timestamp 0xe8dd0333.23b6c460 does not match aorg 0000000000.00000000 from server@80.82.244.120 xmt 0xe9c66c3d.53814f6b Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000105592 s, 0.0 kB/s Apr 14 15:52:45 volumio systemd[1]: Starting Daily apt download activities... Apr 14 15:52:45 volumio volumio[866]: info: camilladsp spawned new process with pid 5918, instance 1, run: true Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000116961 s, 0.0 kB/s Apr 14 15:52:45 volumio volumio[866]: info: camilladsp spawned new process with pid 5927, instance 1, run: true Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000112721 s, 0.0 kB/s Apr 14 15:52:45 volumio volumio[866]: info: camilladsp spawned new process with pid 5949, instance 1, run: true Apr 14 15:52:45 volumio volumio[866]: info: Initializing connection to go-librespot Websocket Apr 14 15:52:45 volumio volumio[866]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000107425 s, 0.0 kB/s Apr 14 15:52:45 volumio volumio[866]: info: camilladsp spawned new process with pid 5959, instance 1, run: true Apr 14 15:52:45 volumio volumio[866]: info: Discovery: A device disappeared from network Apr 14 15:52:45 volumio volumio[866]: info: Discovery: Device volumio disappeared from network Apr 14 15:52:45 volumio volumio[866]: info: Discovery: A device disappeared from network Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000103869 s, 0.0 kB/s Apr 14 15:52:45 volumio volumio[866]: info: camilladsp spawned new process with pid 5973, instance 1, run: true Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000128128 s, 0.0 kB/s Apr 14 15:52:45 volumio volumio[866]: info: camilladsp spawned new process with pid 5989, instance 1, run: true Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000231053 s, 0.0 kB/s Apr 14 15:52:45 volumio volumio[866]: info: camilladsp spawned new process with pid 6000, instance 1, run: true Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000496532 s, 0.0 kB/s Apr 14 15:52:45 volumio volumio[866]: info: camilladsp spawned new process with pid 6012, instance 1, run: true Apr 14 15:52:45 volumio volumio[866]: info: Discovery: adding d1108d53-3009-448c-af46-f20e51590889 Apr 14 15:52:45 volumio volumio[866]: info: Discovery: Found device Volumio Apr 14 15:52:45 volumio volumio[866]: info: CoreCommandRouter::volumioGetState Apr 14 15:52:45 volumio volumio[866]: info: CorePlayQueue::getTrack 0 Apr 14 15:52:45 volumio volumio[866]: info: Discovery: this is already registered, d1108d53-3009-448c-af46-f20e51590889 Apr 14 15:52:45 volumio volumio[866]: info: Discovery: Found device Volumio Apr 14 15:52:45 volumio volumio[866]: info: CoreCommandRouter::volumioGetState Apr 14 15:52:45 volumio volumio[866]: info: CorePlayQueue::getTrack 0 Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000105128 s, 0.0 kB/s Apr 14 15:52:45 volumio volumio[866]: info: camilladsp spawned new process with pid 6021, instance 1, run: true Apr 14 15:52:45 volumio volumio[866]: 0+0 records in Apr 14 15:52:45 volumio volumio[866]: 0+0 records out Apr 14 15:52:45 volumio volumio[866]: 0 bytes copied, 0.000121406 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6030, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000110776 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6039, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000104888 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6048, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000123591 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6057, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000101999 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6066, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000105425 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6075, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.00011385 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6084, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000105313 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6093, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000105221 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6102, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000121925 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6111, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000115314 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6120, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000113943 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6129, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000119758 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6138, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.00011785 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6147, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000114962 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6156, instance 1, run: true Apr 14 15:52:46 volumio volumio[866]: 0+0 records in Apr 14 15:52:46 volumio volumio[866]: 0+0 records out Apr 14 15:52:46 volumio volumio[866]: 0 bytes copied, 0.000177591 s, 0.0 kB/s Apr 14 15:52:46 volumio volumio[866]: info: camilladsp spawned new process with pid 6165, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000116073 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6174, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000123017 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6183, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000108498 s, 0.0 kB/s Apr 14 15:52:47 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 14 15:52:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9. Apr 14 15:52:47 volumio systemd[1]: Stopped go-librespot Daemon. Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6195, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000258904 s, 0.0 kB/s Apr 14 15:52:47 volumio systemd[1]: Started go-librespot Daemon. Apr 14 15:52:47 volumio go-librespot[6197]: Librespot-go daemon starting... Apr 14 15:52:47 volumio go-librespot[6197]: time="2024-04-14T15:52:47+01:00" level=info msg="generated new device id: a71de76a2d914bba7262cd318723eca78a5eb18a" Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6211, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000258905 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6231, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000115702 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6245, instance 1, run: true Apr 14 15:52:47 volumio go-librespot[6197]: time="2024-04-14T15:52:47+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Apr 14 15:52:47 volumio go-librespot[6197]: time="2024-04-14T15:52:47+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 14 15:52:47 volumio go-librespot[6197]: time="2024-04-14T15:52:47+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000133387 s, 0.0 kB/s Apr 14 15:52:47 volumio go-librespot[6197]: time="2024-04-14T15:52:47+01:00" level=debug msg="zeroconf server listening on port 42847" Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6262, instance 1, run: true Apr 14 15:52:47 volumio systemd[1]: apt-daily.service: Succeeded. Apr 14 15:52:47 volumio systemd[1]: Started Daily apt download activities. Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000144943 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6276, instance 1, run: true Apr 14 15:52:47 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000105814 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6287, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000250478 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6303, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000131628 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6319, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000119147 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6330, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000139887 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6339, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000114221 s, 0.0 kB/s Apr 14 15:52:47 volumio volumio[866]: info: camilladsp spawned new process with pid 6348, instance 1, run: true Apr 14 15:52:47 volumio volumio[866]: 0+0 records in Apr 14 15:52:47 volumio volumio[866]: 0+0 records out Apr 14 15:52:47 volumio volumio[866]: 0 bytes copied, 0.000113998 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6357, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000130684 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6366, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000117369 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6375, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000114092 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6384, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000134036 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6393, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000119221 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6402, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000116851 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6411, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.00025759 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6422, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000247794 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6437, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: info: Initializing connection to go-librespot Websocket Apr 14 15:52:48 volumio go-librespot[6197]: time="2024-04-14T15:52:48+01:00" level=debug msg="new websocket client" Apr 14 15:52:48 volumio volumio[866]: info: Connection to go-librespot Websocket established Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000109276 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6451, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000105369 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6472, instance 1, run: true Apr 14 15:52:48 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 14 15:52:48 volumio systemd[1]: Started Daily apt upgrade and clean activities. Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000105629 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6485, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000108758 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6494, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000102684 s, 0.0 kB/s Apr 14 15:52:48 volumio volumio[866]: info: camilladsp spawned new process with pid 6503, instance 1, run: true Apr 14 15:52:48 volumio volumio[866]: 0+0 records in Apr 14 15:52:48 volumio volumio[866]: 0+0 records out Apr 14 15:52:48 volumio volumio[866]: 0 bytes copied, 0.000105073 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6512, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000104462 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6521, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000105629 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6530, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000105443 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6539, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000106166 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6548, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000105017 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6557, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000104758 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6566, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000104925 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6575, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000107758 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6584, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000104202 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6593, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000123407 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6602, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000105795 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6612, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000105332 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6621, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000106776 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6630, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.000103628 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6639, instance 1, run: true Apr 14 15:52:49 volumio volumio[866]: 0+0 records in Apr 14 15:52:49 volumio volumio[866]: 0+0 records out Apr 14 15:52:49 volumio volumio[866]: 0 bytes copied, 0.00010574 s, 0.0 kB/s Apr 14 15:52:49 volumio volumio[866]: info: camilladsp spawned new process with pid 6648, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000118814 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6657, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000131129 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6666, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000106907 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6675, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000105184 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6684, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.00010811 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6693, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000103036 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6702, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000106462 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6711, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000106832 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6720, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000104776 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6729, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000103777 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6738, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.00010648 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6747, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000120165 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6756, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000105258 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6765, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000106851 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6774, instance 1, run: true Apr 14 15:52:50 volumio volumio[866]: 0+0 records in Apr 14 15:52:50 volumio volumio[866]: 0+0 records out Apr 14 15:52:50 volumio volumio[866]: 0 bytes copied, 0.000108573 s, 0.0 kB/s Apr 14 15:52:50 volumio volumio[866]: info: camilladsp spawned new process with pid 6783, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000106184 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6792, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000104814 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6801, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.00010398 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6810, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000119888 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6819, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000105665 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6828, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000122832 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6837, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000105851 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6846, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000115666 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6855, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000104128 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6864, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000106221 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6873, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: info: Getting Spotify volume Apr 14 15:52:51 volumio volumio[866]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000105369 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6882, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: info: CoreCommandRouter::volumioGetState Apr 14 15:52:51 volumio volumio[866]: info: CorePlayQueue::getTrack 0 Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000105981 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6891, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000104388 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6900, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000121221 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6909, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000104832 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6918, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000104202 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6927, instance 1, run: true Apr 14 15:52:51 volumio volumio[866]: 0+0 records in Apr 14 15:52:51 volumio volumio[866]: 0+0 records out Apr 14 15:52:51 volumio volumio[866]: 0 bytes copied, 0.000103685 s, 0.0 kB/s Apr 14 15:52:51 volumio volumio[866]: info: camilladsp spawned new process with pid 6936, instance 1, run: true Apr 14 15:52:52 volumio volumio[866]: 0+0 records in Apr 14 15:52:52 volumio volumio[866]: 0+0 records out Apr 14 15:52:52 volumio volumio[866]: 0 bytes copied, 0.000106128 s, 0.0 kB/s Apr 14 15:52:52 volumio volumio[866]: info: camilladsp spawned new process with pid 6945, instance 1, run: true Apr 14 15:52:52 volumio volumio[866]: 0+0 records in Apr 14 15:52:52 volumio volumio[866]: 0+0 records out Apr 14 15:52:52 volumio volumio[866]: 0 bytes copied, 0.000103147 s, 0.0 kB/s Apr 14 15:52:52 volumio volumio[866]: info: camilladsp spawned new process with pid 6954, instance 1, run: true Apr 14 15:52:52 volumio volumio[866]: 0+0 records in Apr 14 15:52:52 volumio volumio[866]: 0+0 records out Apr 14 15:52:52 volumio volumio[866]: 0 bytes copied, 0.000102499 s, 0.0 kB/s Apr 14 15:52:52 volumio volumio[866]: info: camilladsp spawned new process with pid 6963, instance 1, run: true Apr 14 15:52:52 volumio volumio[866]: 0+0 records in Apr 14 15:52:52 volumio volumio[866]: 0+0 records out Apr 14 15:52:52 volumio volumio[866]: 0 bytes copied, 0.00010548 s, 0.0 kB/s Apr 14 15:52:52 volumio volumio[866]: info: camilladsp spawned new process with pid 6972, instance 1, run: true Apr 14 15:52:52 volumio volumio[866]: 0+0 records in Apr 14 15:52:52 volumio volumio[866]: 0+0 records out Apr 14 15:52:52 volumio volumio[866]: 0 bytes copied, 0.000104332 s, 0.0 kB/s Apr 14 15:52:52 volumio volumio[866]: info: camilladsp spawned new process with pid 6981, instance 1, run: true Apr 14 15:52:52 volumio volumio[866]: 0+0 records in Apr 14 15:52:52 volumio volumio[866]: 0+0 records out Apr 14 15:52:52 volumio volumio[866]: 0 bytes copied, 0.000110425 s, 0.0 kB/s Apr 14 15:52:52 volumio volumio[866]: info: camilladsp spawned new process with pid 6990, instance 1, run: true Apr 14 15:52:52 volumio volumio[866]: 0+0 records in Apr 14 15:52:52 volumio volumio[866]: 0+0 records out Apr 14 15:52:52 volumio volumio[866]: 0 bytes copied, 0.000107184 s, 0.0 kB/s Apr 14 15:52:52 volumio volumio[866]: info: camilladsp spawned new process with pid 6999, instance 1, run: true Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 14 15:52:52 volumio volumio[866]: info: Adding plugin bluetooth to MyMusic Plugins Apr 14 15:52:52 volumio volumio[866]: info: Adding plugin multiroom to MyMusic Plugins Apr 14 15:52:52 volumio volumio[866]: info: Adding plugin metavolumio to MyMusic Plugins Apr 14 15:52:52 volumio volumio[866]: info: Adding plugin cd_controller to MyMusic Plugins Apr 14 15:52:52 volumio volumio[866]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 14 15:52:52 volumio volumio[866]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 14 15:52:52 volumio volumio[866]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 14 15:52:53 volumio volumio[866]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 14 15:52:53 volumio volumio[866]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 14 15:52:53 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:52:53 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:52:53 volumio volumio[866]: info: Starting MyVolumio Remote Streaming Endpoints Apr 14 15:52:53 volumio volumio[866]: info: MyVolumio login type: Token Apr 14 15:52:53 volumio volumio[866]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 14 15:52:53 volumio volumio[866]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 14 15:52:54 volumio volumio[866]: info: Starting Streaming Service Transparent Proxy Apr 14 15:52:54 volumio volumio[866]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 14 15:52:54 volumio volumio[866]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 14 15:52:54 volumio volumio[866]: info: Streaming services startup Apr 14 15:52:54 volumio volumio[866]: info: Starting Streaming Daemon Apr 14 15:52:54 volumio sudo[7013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 14 15:52:54 volumio sudo[7013]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 15:52:54 volumio sudo[7013]: pam_unix(sudo:session): session closed for user root Apr 14 15:52:54 volumio volumio[866]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 15:52:54 volumio volumio[866]: info: Retrieving Cloud Streaming UI Apr 14 15:52:54 volumio volumio[866]: error: Cannot start Volumio Streaming Daemon Apr 14 15:52:54 volumio volumio[866]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 14 15:52:54 volumio volumio[866]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 14 15:52:54 volumio volumio[866]: 0+0 records in Apr 14 15:52:54 volumio volumio[866]: 0+0 records out Apr 14 15:52:54 volumio volumio[866]: 0 bytes copied, 0.000116758 s, 0.0 kB/s Apr 14 15:52:54 volumio volumio[866]: info: camilladsp spawned new process with pid 7022, instance 1, run: true Apr 14 15:52:54 volumio volumio[866]: info: Getting Tidal Cloud Configuration Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 15:52:54 volumio volumio[866]: info: Getting Qobuz Cloud Configuration Apr 14 15:52:54 volumio volumio[866]: info: Asking plugin for UI Config Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 15:52:54 volumio volumio[866]: info: Getting Spotify Cloud Configuration Apr 14 15:52:54 volumio volumio[866]: info: Asking plugin for UI Config Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 15:52:54 volumio volumio[866]: info: Saving Spotify Acccount Apr 14 15:52:54 volumio volumio[866]: info: Got Tidal Cloud Configuration Apr 14 15:52:54 volumio volumio[866]: info: Got it Apr 14 15:52:54 volumio volumio[866]: info: Got it Apr 14 15:52:54 volumio volumio[866]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 15:52:54 volumio volumio[866]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 14 15:52:54 volumio volumio[866]: 0+0 records in Apr 14 15:52:54 volumio volumio[866]: 0+0 records out Apr 14 15:52:54 volumio volumio[866]: 0 bytes copied, 0.000150332 s, 0.0 kB/s Apr 14 15:52:54 volumio volumio[866]: info: camilladsp spawned new process with pid 7031, instance 1, run: true Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 15:52:54 volumio volumio[866]: 0+0 records in Apr 14 15:52:54 volumio volumio[866]: 0+0 records out Apr 14 15:52:54 volumio volumio[866]: 0 bytes copied, 0.00012185 s, 0.0 kB/s Apr 14 15:52:54 volumio volumio[866]: info: camilladsp spawned new process with pid 7040, instance 1, run: true Apr 14 15:52:54 volumio volumio[866]: 0+0 records in Apr 14 15:52:54 volumio volumio[866]: 0+0 records out Apr 14 15:52:54 volumio volumio[866]: 0 bytes copied, 0.000144165 s, 0.0 kB/s Apr 14 15:52:54 volumio volumio[866]: info: camilladsp spawned new process with pid 7049, instance 1, run: true Apr 14 15:52:54 volumio volumio[866]: error: MyVolumio Custom Token format not valid, refreshing it Apr 14 15:52:54 volumio volumio[866]: 0+0 records in Apr 14 15:52:54 volumio volumio[866]: 0+0 records out Apr 14 15:52:54 volumio volumio[866]: 0 bytes copied, 0.000119165 s, 0.0 kB/s Apr 14 15:52:54 volumio volumio[866]: info: camilladsp spawned new process with pid 7058, instance 1, run: true Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 15:52:54 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 14 15:52:54 volumio volumio[866]: 0+0 records in Apr 14 15:52:54 volumio volumio[866]: 0+0 records out Apr 14 15:52:54 volumio volumio[866]: 0 bytes copied, 0.000117554 s, 0.0 kB/s Apr 14 15:52:54 volumio volumio[866]: info: camilladsp spawned new process with pid 7073, instance 1, run: true Apr 14 15:52:54 volumio volumio[866]: 0+0 records in Apr 14 15:52:54 volumio volumio[866]: 0+0 records out Apr 14 15:52:54 volumio volumio[866]: 0 bytes copied, 0.000117573 s, 0.0 kB/s Apr 14 15:52:54 volumio volumio[866]: info: camilladsp spawned new process with pid 7082, instance 1, run: true Apr 14 15:52:54 volumio volumio[866]: 0+0 records in Apr 14 15:52:54 volumio volumio[866]: 0+0 records out Apr 14 15:52:54 volumio volumio[866]: 0 bytes copied, 0.000120832 s, 0.0 kB/s Apr 14 15:52:54 volumio volumio[866]: info: camilladsp spawned new process with pid 7091, instance 1, run: true Apr 14 15:52:54 volumio volumio[866]: STREAMING PROXY: Starting server on port 3245 Apr 14 15:52:54 volumio volumio[866]: Node JS runtime: 14 Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000107462 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7100, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000104036 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7109, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000106221 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7118, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000103943 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7127, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000104832 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7136, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000105388 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7145, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: info: MyVolumio login type: Token Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000104813 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7154, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000140628 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7163, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000102813 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7172, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000102813 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7181, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000119776 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7190, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.00010511 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7199, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000120703 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7208, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000119184 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7217, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000104128 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7226, instance 1, run: true Apr 14 15:52:55 volumio volumio[866]: 0+0 records in Apr 14 15:52:55 volumio volumio[866]: 0+0 records out Apr 14 15:52:55 volumio volumio[866]: 0 bytes copied, 0.000103425 s, 0.0 kB/s Apr 14 15:52:55 volumio volumio[866]: info: camilladsp spawned new process with pid 7235, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000106406 s, 0.0 kB/s Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7244, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000106776 s, 0.0 kB/s Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7253, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000103814 s, 0.0 kB/s Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7262, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000102907 s, 0.0 kB/s Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7271, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000103906 s, 0.0 kB/s Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7282, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: info: MyVolumio token set successfully Apr 14 15:52:56 volumio volumio[866]: info: MYVOLUMIO: Adding device Apr 14 15:52:56 volumio volumio[866]: info: MYVOLUMIO: Evaluating Server Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000105629 s, 0.0 kB/s Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7291, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000116351 s, 0.0 kB/s Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7300, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: info: MyVolumio status changed Apr 14 15:52:56 volumio volumio[866]: info: Streaming services startup Apr 14 15:52:56 volumio volumio[866]: info: Starting Streaming Daemon Apr 14 15:52:56 volumio volumio[866]: info: Removing browser output: myVolumio user plan is not superstar Apr 14 15:52:56 volumio volumio[866]: info: Removing audio output: Apr 14 15:52:56 volumio volumio[866]: info: Stoppping Tunnel 1 Apr 14 15:52:56 volumio sudo[7323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 14 15:52:56 volumio sudo[7323]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 15:52:56 volumio sudo[7326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 14 15:52:56 volumio sudo[7323]: pam_unix(sudo:session): session closed for user root Apr 14 15:52:56 volumio sudo[7326]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000109888 s, 0.0 kB/s Apr 14 15:52:56 volumio sudo[7326]: pam_unix(sudo:session): session closed for user root Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7330, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: info: Remote SSH Stopped Apr 14 15:52:56 volumio volumio[866]: error: Cannot start Volumio Streaming Daemon Apr 14 15:52:56 volumio volumio[866]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 14 15:52:56 volumio volumio[866]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000232664 s, 0.0 kB/s Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7339, instance 1, run: true Apr 14 15:52:56 volumio volumio[866]: 0+0 records in Apr 14 15:52:56 volumio volumio[866]: 0+0 records out Apr 14 15:52:56 volumio volumio[866]: 0 bytes copied, 0.000232293 s, 0.0 kB/s Apr 14 15:52:56 volumio volumio[866]: info: camilladsp spawned new process with pid 7348, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000232256 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7357, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000237071 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7366, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: info: Setting Geolocation for MyVolumio to eu3 Apr 14 15:52:57 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:52:57 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:52:57 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000121869 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7375, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000279479 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7384, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.00010561 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7393, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000107276 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7402, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000104665 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7411, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000104518 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7420, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000103906 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7429, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000103906 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7438, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000119166 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7447, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000103758 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7456, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000104591 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7465, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.000108462 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7474, instance 1, run: true Apr 14 15:52:57 volumio volumio[866]: 0+0 records in Apr 14 15:52:57 volumio volumio[866]: 0+0 records out Apr 14 15:52:57 volumio volumio[866]: 0 bytes copied, 0.00010748 s, 0.0 kB/s Apr 14 15:52:57 volumio volumio[866]: info: camilladsp spawned new process with pid 7483, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000105813 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7492, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000106369 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7501, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: info: Updating MyVolumio device info Apr 14 15:52:58 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:52:58 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:52:58 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000104591 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7510, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.00023185 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7519, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000230312 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7528, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000103869 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7537, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000120295 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7546, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000103647 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7555, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000104554 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7564, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000108906 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7573, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000108758 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7582, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000107258 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7591, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000104332 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7600, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000122851 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7609, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.000123628 s, 0.0 kB/s Apr 14 15:52:58 volumio volumio[866]: info: camilladsp spawned new process with pid 7618, instance 1, run: true Apr 14 15:52:58 volumio volumio[866]: 0+0 records in Apr 14 15:52:58 volumio volumio[866]: 0+0 records out Apr 14 15:52:58 volumio volumio[866]: 0 bytes copied, 0.00010461 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7627, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.00010611 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7636, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000105888 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7645, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000102851 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7654, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000107239 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7663, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000104814 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7672, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000103166 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7681, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000117239 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7690, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.00010411 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7699, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000103851 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7708, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000105943 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7717, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000104109 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7726, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.00010398 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7735, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000107517 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7744, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000103461 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7753, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000106258 s, 0.0 kB/s Apr 14 15:52:59 volumio volumio[866]: info: camilladsp spawned new process with pid 7762, instance 1, run: true Apr 14 15:52:59 volumio volumio[866]: 0+0 records in Apr 14 15:52:59 volumio volumio[866]: 0+0 records out Apr 14 15:52:59 volumio volumio[866]: 0 bytes copied, 0.000105017 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7771, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000104758 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7780, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000105776 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7789, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000104036 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7798, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000104739 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7807, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000119535 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7816, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000105444 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7825, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000104258 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7834, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000105333 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7843, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000105759 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7852, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000105073 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7861, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000105332 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7870, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000106832 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7879, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000104832 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7888, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000105147 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7897, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000103665 s, 0.0 kB/s Apr 14 15:53:00 volumio volumio[866]: info: camilladsp spawned new process with pid 7908, instance 1, run: true Apr 14 15:53:00 volumio volumio[866]: 0+0 records in Apr 14 15:53:00 volumio volumio[866]: 0+0 records out Apr 14 15:53:00 volumio volumio[866]: 0 bytes copied, 0.000105832 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 7919, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.00010398 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 7928, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.000102795 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 7937, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.000119055 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 7946, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.000103018 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 7955, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.000106128 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 7964, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.000105295 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 7973, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.000106795 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 7982, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.000118572 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 7991, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.000104091 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 8000, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 14 15:53:01 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.00010348 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 8010, instance 1, run: true Apr 14 15:53:01 volumio volumio[866]: info: MYVOLUMIO: Adding device Apr 14 15:53:01 volumio volumio[866]: info: MYVOLUMIO: Evaluating Server Apr 14 15:53:01 volumio volumio[866]: 0+0 records in Apr 14 15:53:01 volumio volumio[866]: 0+0 records out Apr 14 15:53:01 volumio volumio[866]: 0 bytes copied, 0.000114369 s, 0.0 kB/s Apr 14 15:53:01 volumio volumio[866]: info: camilladsp spawned new process with pid 8019, instance 1, run: true Apr 14 15:53:02 volumio volumio[866]: 0+0 records in Apr 14 15:53:02 volumio volumio[866]: 0+0 records out Apr 14 15:53:02 volumio volumio[866]: 0 bytes copied, 0.000106795 s, 0.0 kB/s Apr 14 15:53:02 volumio volumio[866]: info: camilladsp spawned new process with pid 8045, instance 1, run: true Apr 14 15:53:02 volumio volumio[866]: 0+0 records in Apr 14 15:53:02 volumio volumio[866]: 0+0 records out Apr 14 15:53:02 volumio volumio[866]: 0 bytes copied, 0.000124443 s, 0.0 kB/s Apr 14 15:53:02 volumio volumio[866]: info: camilladsp spawned new process with pid 8056, instance 1, run: true Apr 14 15:53:02 volumio volumio[866]: info: Setting Geolocation for MyVolumio to eu3 Apr 14 15:53:02 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:53:02 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:53:02 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:53:02 volumio volumio[866]: 0+0 records in Apr 14 15:53:02 volumio volumio[866]: 0+0 records out Apr 14 15:53:02 volumio volumio[866]: 0 bytes copied, 0.000271201 s, 0.0 kB/s Apr 14 15:53:02 volumio volumio[866]: info: camilladsp spawned new process with pid 8066, instance 1, run: true Apr 14 15:53:02 volumio volumio[866]: 0+0 records in Apr 14 15:53:02 volumio volumio[866]: 0+0 records out Apr 14 15:53:02 volumio volumio[866]: 0 bytes copied, 0.000309849 s, 0.0 kB/s Apr 14 15:53:02 volumio volumio[866]: info: camilladsp spawned new process with pid 8076, instance 1, run: true Apr 14 15:53:02 volumio volumio[866]: 0+0 records in Apr 14 15:53:02 volumio volumio[866]: 0+0 records out Apr 14 15:53:02 volumio volumio[866]: 0 bytes copied, 0.000105591 s, 0.0 kB/s Apr 14 15:53:02 volumio volumio[866]: info: camilladsp spawned new process with pid 8085, instance 1, run: true Apr 14 15:53:02 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 15:53:02 volumio volumio[866]: 0+0 records in Apr 14 15:53:02 volumio volumio[866]: 0+0 records out Apr 14 15:53:02 volumio volumio[866]: 0 bytes copied, 0.000107091 s, 0.0 kB/s Apr 14 15:53:02 volumio volumio[866]: info: camilladsp spawned new process with pid 8094, instance 1, run: true Apr 14 15:53:02 volumio volumio[866]: 0+0 records in Apr 14 15:53:02 volumio volumio[866]: 0+0 records out Apr 14 15:53:02 volumio volumio[866]: 0 bytes copied, 0.00012061 s, 0.0 kB/s Apr 14 15:53:02 volumio volumio[866]: info: camilladsp spawned new process with pid 8103, instance 1, run: true Apr 14 15:53:02 volumio volumio[866]: 0+0 records in Apr 14 15:53:02 volumio volumio[866]: 0+0 records out Apr 14 15:53:02 volumio volumio[866]: 0 bytes copied, 0.000105555 s, 0.0 kB/s Apr 14 15:53:02 volumio volumio[866]: info: camilladsp spawned new process with pid 8112, instance 1, run: true Apr 14 15:53:02 volumio volumio[866]: 0+0 records in Apr 14 15:53:02 volumio volumio[866]: 0+0 records out Apr 14 15:53:02 volumio volumio[866]: 0 bytes copied, 0.000105147 s, 0.0 kB/s Apr 14 15:53:02 volumio volumio[866]: info: camilladsp spawned new process with pid 8121, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.000103536 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8130, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.000132831 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8148, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.000245183 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8159, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.00024396 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8169, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: info: Error browsing device NAS029525 for shares : Error: Command failed: echo volumio | smbclient -L NAS029525.local. Apr 14 15:53:03 volumio volumio[866]: Unable to initialize messaging context Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.000102906 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8178, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: info: Updating MyVolumio device info Apr 14 15:53:03 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:53:03 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:53:03 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.000118202 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8187, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.000114258 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8196, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.00010448 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8205, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.000103018 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8214, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.000105406 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8223, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.000105222 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8232, instance 1, run: true Apr 14 15:53:03 volumio volumio[866]: 0+0 records in Apr 14 15:53:03 volumio volumio[866]: 0+0 records out Apr 14 15:53:03 volumio volumio[866]: 0 bytes copied, 0.00010387 s, 0.0 kB/s Apr 14 15:53:03 volumio volumio[866]: info: camilladsp spawned new process with pid 8241, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000105128 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8250, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.00010398 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8259, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000108684 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8268, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000105165 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8277, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000102906 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8286, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000104221 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8295, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000109832 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8304, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000104258 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8313, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000104147 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8322, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.00010411 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8331, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000102684 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8340, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000104573 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8349, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000104721 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8358, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000106055 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8367, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000105517 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8376, instance 1, run: true Apr 14 15:53:04 volumio volumio[866]: 0+0 records in Apr 14 15:53:04 volumio volumio[866]: 0+0 records out Apr 14 15:53:04 volumio volumio[866]: 0 bytes copied, 0.000116498 s, 0.0 kB/s Apr 14 15:53:04 volumio volumio[866]: info: camilladsp spawned new process with pid 8385, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000110314 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8394, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000107739 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8403, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000118795 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8412, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000119073 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8421, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000114795 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8430, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000105999 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8443, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.00010724 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8456, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000105869 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8465, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000103592 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8474, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000102944 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8483, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000104721 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8492, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.00010674 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8501, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000121962 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8510, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000104555 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8519, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000106869 s, 0.0 kB/s Apr 14 15:53:05 volumio volumio[866]: info: camilladsp spawned new process with pid 8528, instance 1, run: true Apr 14 15:53:05 volumio volumio[866]: 0+0 records in Apr 14 15:53:05 volumio volumio[866]: 0+0 records out Apr 14 15:53:05 volumio volumio[866]: 0 bytes copied, 0.000121536 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8537, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000106629 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8546, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.00010311 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8555, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000104239 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8564, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.00010411 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8573, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000104924 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8582, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000104462 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8591, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000119906 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8600, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.00010548 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8609, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000107388 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8618, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000105573 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8627, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000104036 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8636, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000106944 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8645, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000105202 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8654, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000102795 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8663, instance 1, run: true Apr 14 15:53:06 volumio volumio[866]: 0+0 records in Apr 14 15:53:06 volumio volumio[866]: 0+0 records out Apr 14 15:53:06 volumio volumio[866]: 0 bytes copied, 0.000103184 s, 0.0 kB/s Apr 14 15:53:06 volumio volumio[866]: info: camilladsp spawned new process with pid 8672, instance 1, run: true Apr 14 15:53:07 volumio volumio[866]: 0+0 records in Apr 14 15:53:07 volumio volumio[866]: 0+0 records out Apr 14 15:53:07 volumio volumio[866]: 0 bytes copied, 0.000109017 s, 0.0 kB/s Apr 14 15:53:07 volumio volumio[866]: info: camilladsp spawned new process with pid 8681, instance 1, run: true Apr 14 15:53:07 volumio volumio[866]: 0+0 records in Apr 14 15:53:07 volumio volumio[866]: 0+0 records out Apr 14 15:53:07 volumio volumio[866]: 0 bytes copied, 0.000119555 s, 0.0 kB/s Apr 14 15:53:07 volumio volumio[866]: info: camilladsp spawned new process with pid 8690, instance 1, run: true Apr 14 15:53:07 volumio volumio[866]: 0+0 records in Apr 14 15:53:07 volumio volumio[866]: 0+0 records out Apr 14 15:53:07 volumio volumio[866]: 0 bytes copied, 0.000104702 s, 0.0 kB/s Apr 14 15:53:07 volumio volumio[866]: info: camilladsp spawned new process with pid 8699, instance 1, run: true Apr 14 15:53:07 volumio volumio[866]: 0+0 records in Apr 14 15:53:07 volumio volumio[866]: 0+0 records out Apr 14 15:53:07 volumio volumio[866]: 0 bytes copied, 0.000120184 s, 0.0 kB/s Apr 14 15:53:07 volumio volumio[866]: info: camilladsp spawned new process with pid 8708, instance 1, run: true Apr 14 15:53:07 volumio volumio[866]: 0+0 records in Apr 14 15:53:07 volumio volumio[866]: 0+0 records out Apr 14 15:53:07 volumio volumio[866]: 0 bytes copied, 0.000175313 s, 0.0 kB/s Apr 14 15:53:07 volumio volumio[866]: info: camilladsp spawned new process with pid 8717, instance 1, run: true Apr 14 15:53:07 volumio volumio[866]: 0+0 records in Apr 14 15:53:07 volumio volumio[866]: 0+0 records out Apr 14 15:53:07 volumio volumio[866]: 0 bytes copied, 0.000105295 s, 0.0 kB/s Apr 14 15:53:07 volumio volumio[866]: info: camilladsp spawned new process with pid 8726, instance 1, run: true Apr 14 15:53:07 volumio volumio[866]: 0+0 records in Apr 14 15:53:07 volumio volumio[866]: 0+0 records out Apr 14 15:53:07 volumio volumio[866]: 0 bytes copied, 0.000105518 s, 0.0 kB/s Apr 14 15:53:07 volumio volumio[866]: info: camilladsp spawned new process with pid 8735, instance 1, run: true Apr 14 15:53:07 volumio volumio[866]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 15:53:07 volumio volumio[866]: Error: dns service error: unknown Apr 14 15:53:07 volumio volumio[866]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Apr 14 15:53:07 volumio volumio[866]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Apr 14 15:53:07 volumio volumio[866]: errorCode: -65537 Apr 14 15:53:07 volumio volumio[866]: } Apr 14 15:53:07 volumio volumio[866]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 15:53:07 volumio sudo[8751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-14 15:52 Apr 14 15:53:07 volumio sudo[8751]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"