-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sun 2025-02-16 00:04:52 CET. -- Feb 16 00:03:00 volumioelat volumio[791]: info: MyVolumio status changed Feb 16 00:03:00 volumioelat volumio[791]: info: Streaming services startup Feb 16 00:03:00 volumioelat volumio[791]: info: Starting Streaming Daemon Feb 16 00:03:00 volumioelat volumio[791]: info: Removing browser output: myVolumio user plan is not superstar Feb 16 00:03:00 volumioelat volumio[791]: info: Removing audio output: Feb 16 00:03:00 volumioelat volumio[791]: info: Stoppping Tunnel 1 Feb 16 00:03:00 volumioelat sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 16 00:03:00 volumioelat sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 00:03:00 volumioelat sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Feb 16 00:03:00 volumioelat sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 00:03:00 volumioelat sudo[1329]: pam_unix(sudo:session): session closed for user root Feb 16 00:03:00 volumioelat volumio[791]: error: Cannot start Volumio Streaming Daemon Feb 16 00:03:00 volumioelat volumio[791]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 16 00:03:00 volumioelat volumio[791]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 16 00:03:00 volumioelat sudo[1332]: pam_unix(sudo:session): session closed for user root Feb 16 00:03:00 volumioelat volumio[791]: info: Remote SSH Stopped Feb 16 00:03:00 volumioelat volumio[791]: info: Setting Geolocation for MyVolumio to eu7 Feb 16 00:03:00 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 00:03:01 volumioelat volumio[791]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 16 00:03:01 volumioelat volumio[791]: info: Updating MyVolumio device info Feb 16 00:03:01 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 00:03:02 volumioelat volumio[791]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 16 00:03:02 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:03:02 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:03:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 00:03:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 00:03:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 16 00:03:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 16 00:03:04 volumioelat volumio-remote-updater[506]: No test mode Feb 16 00:03:04 volumioelat volumio-remote-updater[506]: No alpha test mode Feb 16 00:03:04 volumioelat ntpd[767]: Soliciting pool server 151.22.209.90 Feb 16 00:03:04 volumioelat ntpd[767]: Soliciting pool server 193.204.114.105 Feb 16 00:03:04 volumioelat volumio[791]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 16 00:03:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 16 00:03:05 volumioelat volumio[791]: info: MYVOLUMIO: Adding device Feb 16 00:03:05 volumioelat volumio[791]: info: MYVOLUMIO: Evaluating Server Feb 16 00:03:05 volumioelat ntpd[767]: Soliciting pool server 185.19.184.35 Feb 16 00:03:05 volumioelat ntpd[767]: Soliciting pool server 37.247.53.178 Feb 16 00:03:06 volumioelat volumio[791]: info: Setting Geolocation for MyVolumio to eu4 Feb 16 00:03:06 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 00:03:06 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 00:03:06 volumioelat ntpd[767]: Soliciting pool server 93.94.88.51 Feb 16 00:03:06 volumioelat ntpd[767]: Soliciting pool server 85.199.214.99 Feb 16 00:03:06 volumioelat volumio[791]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 16 00:03:07 volumioelat volumio[791]: info: Updating MyVolumio device info Feb 16 00:03:07 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 00:03:07 volumioelat ntpd[767]: Soliciting pool server 5.249.144.95 Feb 16 00:03:07 volumioelat ntpd[767]: Soliciting pool server 93.94.88.50 Feb 16 00:03:07 volumioelat ntpd[767]: Soliciting pool server 188.213.165.209 Feb 16 00:03:07 volumioelat volumio[791]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 16 00:03:08 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 16 00:03:08 volumioelat volumio[791]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 16 00:03:08 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:03:08 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:03:08 volumioelat ntpd[767]: Soliciting pool server 162.159.200.123 Feb 16 00:03:09 volumioelat ntpd[767]: Soliciting pool server 2a00:6d41:10:1194::4 Feb 16 00:03:09 volumioelat ntpd[767]: Soliciting pool server 195.231.84.187 Feb 16 00:03:10 volumioelat ntpd[767]: Soliciting pool server 217.61.62.224 Feb 16 00:03:11 volumioelat ntpd[767]: Soliciting pool server 89.46.74.148 Feb 16 00:03:12 volumioelat ntpd[767]: Soliciting pool server 95.110.254.234 Feb 16 00:03:13 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:03:13 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:03:13 volumioelat ntpd[767]: receive: Unexpected origin timestamp 0xeb5b9bb0.7d995773 does not match aorg 0000000000.00000000 from server@89.46.74.148 xmt 0xeb5b9bb1.4a0cb9bb Feb 16 00:03:13 volumioelat ntpd[767]: receive: Unexpected origin timestamp 0xeb5b9bb0.7db7d7db does not match aorg 0000000000.00000000 from server@151.22.209.90 xmt 0xeb5b9bb1.4a7c3913 Feb 16 00:03:13 volumioelat ntpd[767]: receive: Unexpected origin timestamp 0xeb5b9bb0.7dab7b93 does not match aorg 0000000000.00000000 from server@5.249.144.95 xmt 0xeb5b9bb1.4a7be2d4 Feb 16 00:03:13 volumioelat ntpd[767]: receive: Unexpected origin timestamp 0xeb5b9bb0.7da66eea does not match aorg 0000000000.00000000 from server@93.94.88.50 xmt 0xeb5b9bb1.4b23349a Feb 16 00:03:13 volumioelat volumio[791]: info: Listing playlists Feb 16 00:03:13 volumioelat volumio[791]: info: Listing playlists Feb 16 00:03:13 volumioelat ntpd[767]: receive: Unexpected origin timestamp 0xeb5b9bb0.7daed1e1 does not match aorg 0000000000.00000000 from server@85.199.214.99 xmt 0xeb5b9bb1.4bf08605 Feb 16 00:03:13 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 00:03:13 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 00:03:13 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 16 00:03:13 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 16 00:03:13 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 16 00:03:13 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 16 00:03:13 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetBrowseSources Feb 16 00:03:13 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 00:03:16 volumioelat volumio[791]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 16 00:03:16 volumioelat volumio[791]: info: Completed starting MyVolumio Plugin Feb 16 00:03:16 volumioelat volumio[791]: [Metrics] CommandRouter: 67s 80.48ms Feb 16 00:03:16 volumioelat volumio[791]: info: CoreCommandRouter::volumiosetStartupVolume Feb 16 00:03:16 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 00:03:16 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 00:03:16 volumioelat volumio[791]: info: CoreCommandRouter::Close All Modals sent Feb 16 00:03:16 volumioelat volumio[791]: info: CoreCommandRouter::Close All Modals sent Feb 16 00:03:16 volumioelat volumio[791]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 16 00:03:16 volumioelat volumio[791]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 16 00:03:16 volumioelat volumio[791]: info: camilladsp stopping service pid 1105... Feb 16 00:03:17 volumioelat volumio[791]: info: camilladsp service terminated, instance 1 Feb 16 00:03:17 volumioelat volumio[791]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 16 00:03:17 volumioelat volumio[791]: info: camilladsp service started and running in background, instance 1 Feb 16 00:03:17 volumioelat volumio[791]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 16 00:03:17 volumioelat volumio[791]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 16 00:03:17 volumioelat volumio[791]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 16 00:03:17 volumioelat volumio[791]: error: FusionDsp - WebSocket error: [object Object] Feb 16 00:03:17 volumioelat volumio[791]: info: camilladsp spawned new process with pid 1377, instance 1, run: true Feb 16 00:03:17 volumioelat volumio[791]: info: camilladsp spawned new process with pid 1398, instance 1, run: true Feb 16 00:03:17 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 16 00:03:17 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 16 00:03:17 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 16 00:03:18 volumioelat volumio[791]: info: camilladsp spawned new process with pid 1405, instance 1, run: true Feb 16 00:03:23 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:03:23 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:03:23 volumioelat volumio[791]: info: BOOT COMPLETED Feb 16 00:03:32 volumioelat volumio[1009]: ...........................................................................................................................................................................................................++++ Feb 16 00:03:33 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:03:33 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:03:33 volumioelat volumio[791]: info: Listing playlists Feb 16 00:03:33 volumioelat volumio[791]: info: Listing playlists Feb 16 00:03:43 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:03:43 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:03:45 volumioelat volumio[1009]: .......................................................++++ Feb 16 00:03:45 volumioelat volumio[1009]: e is 65537 (0x010001) Feb 16 00:03:45 volumioelat volumio[1009]: writing RSA key Feb 16 00:03:53 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:03:53 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:03:53 volumioelat volumio[791]: info: Listing playlists Feb 16 00:03:53 volumioelat volumio[791]: info: Listing playlists Feb 16 00:03:58 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 16 00:03:58 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 16 00:03:58 volumioelat volumio[791]: info: Discovery: Getting this device information Feb 16 00:03:58 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:03:58 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:03:58 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 00:03:58 volumioelat volumio[791]: verbose: New Socket.io Connection to 192.168.1.88:3000 from 192.168.1.169 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 16 00:03:58 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:03:58 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:03:58 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 16 00:03:58 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 16 00:04:01 volumioelat sudo[1535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 00:04:01 volumioelat sudo[1535]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 00:04:01 volumioelat sudo[1535]: pam_unix(sudo:session): session closed for user root Feb 16 00:04:01 volumioelat sudo[1537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 00:04:01 volumioelat sudo[1537]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 00:04:01 volumioelat sudo[1537]: pam_unix(sudo:session): session closed for user root Feb 16 00:04:02 volumioelat volumio[791]: verbose: New Socket.io Connection to 192.168.1.88 from 192.168.1.169 UA: Mozilla/5.0 (Linux; Android 10; SM-N960F Build/QP1A.190711.020; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 16 00:04:02 volumioelat sudo[1543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 00:04:02 volumioelat sudo[1543]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 00:04:02 volumioelat sudo[1543]: pam_unix(sudo:session): session closed for user root Feb 16 00:04:02 volumioelat sudo[1545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 00:04:02 volumioelat sudo[1545]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 00:04:02 volumioelat sudo[1545]: pam_unix(sudo:session): session closed for user root Feb 16 00:04:02 volumioelat volumio[791]: verbose: New Socket.io Connection to 192.168.1.88 from 192.168.1.169 UA: Mozilla/5.0 (Linux; Android 10; SM-N960F Build/QP1A.190711.020; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetVisibleSources Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:02 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 16 00:04:02 volumioelat volumio[791]: info: Received Get System Info Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 16 00:04:02 volumioelat volumio[791]: info: Discovery: Getting this device information Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:02 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:02 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:02 volumioelat volumio[791]: info: Listing playlists Feb 16 00:04:02 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 16 00:04:03 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 16 00:04:03 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 16 00:04:03 volumioelat volumio[791]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 00:04:03 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:03 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 16 00:04:04 volumioelat volumio[791]: info: Received Get System Info Feb 16 00:04:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 16 00:04:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 16 00:04:04 volumioelat volumio[791]: info: Discovery: Getting this device information Feb 16 00:04:04 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:04 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 00:04:04 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 16 00:04:05 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 16 00:04:05 volumioelat volumio[791]: info: Received Get System Info Feb 16 00:04:05 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 16 00:04:05 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 16 00:04:05 volumioelat volumio[791]: info: Discovery: Getting this device information Feb 16 00:04:05 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:05 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:05 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPlay Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::play index undefined Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::startPlaybackTimer Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand stop Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand stop took 6 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand clear Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand clear took 2 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac" Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces system playlist update Feb 16 00:04:06 volumioelat volumio[791]: info: Ignoring MPD Status Update Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces system playlist update Feb 16 00:04:06 volumioelat volumio[791]: info: Ignoring MPD Status Update Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand add "USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac" took 10 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand play Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces system playlist update Feb 16 00:04:06 volumioelat volumio[791]: info: Ignoring MPD Status Update Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces system playlist update Feb 16 00:04:06 volumioelat volumio[791]: info: Ignoring MPD Status Update Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces system playlist update Feb 16 00:04:06 volumioelat volumio[791]: info: Ignoring MPD Status Update Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 31ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 29ms Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand play took 23 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 19ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 15ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 13ms Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces system playlist update Feb 16 00:04:06 volumioelat volumio[791]: info: Ignoring MPD Status Update Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces system playlist update Feb 16 00:04:06 volumioelat volumio[791]: info: Ignoring MPD Status Update Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces system playlist update Feb 16 00:04:06 volumioelat volumio[791]: info: Ignoring MPD Status Update Feb 16 00:04:06 volumioelat volumio[791]: error: Upnp client error: Error: This socket has been ended by the other party Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 21ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 18ms Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 18ms Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:06 volumioelat volumio[791]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 16 00:04:06 volumioelat volumio[791]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 16 00:04:06 volumioelat volumio[791]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand status took 43 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand status took 41 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand status took 36 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand status took 32 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:06 volumioelat volumio[791]: info: Feb 16 00:04:06 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand status took 46 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 38 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 36 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 34 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 32 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand status took 25 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand status took 21 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand status took 17 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseTrackInfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseTrackInfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseTrackInfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseTrackInfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:06 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService play Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus stop Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"637 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:06 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService play Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus play Feb 16 00:04:06 volumioelat volumio[791]: info: Received an update from plugin. extracting info from payload Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"play","position":0,"seek":457,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"637 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:06 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService play Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus play Feb 16 00:04:06 volumioelat volumio[791]: info: Received an update from plugin. extracting info from payload Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"play","position":0,"seek":457,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"637 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:06 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService play Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus play Feb 16 00:04:06 volumioelat volumio[791]: info: Received an update from plugin. extracting info from payload Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 223ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 251ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 248ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 245ms Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 164 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 155 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 155 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 154 milliseconds Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseTrackInfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseTrackInfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseTrackInfo Feb 16 00:04:06 volumioelat volumio[791]: verbose: ControllerMpd::parseTrackInfo Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1464,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"577 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:06 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService play Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus play Feb 16 00:04:06 volumioelat volumio[791]: info: Received an update from plugin. extracting info from payload Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1601,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:06 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService play Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus play Feb 16 00:04:06 volumioelat volumio[791]: info: Received an update from plugin. extracting info from payload Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1601,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:06 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService play Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus play Feb 16 00:04:06 volumioelat volumio[791]: info: Received an update from plugin. extracting info from payload Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1601,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:06 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService play Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus play Feb 16 00:04:06 volumioelat volumio[791]: info: Received an update from plugin. extracting info from payload Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 382ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 353ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 352ms Feb 16 00:04:06 volumioelat volumio[791]: info: ------------------------------ 352ms Feb 16 00:04:06 volumioelat volumio[791]: info: FusionDsp - {"Reload":{"result":"Ok"}} Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:06 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:06 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:06 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:07 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:07 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:07 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:07 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:07 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:08 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:08 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:08 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:08 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:08 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:09 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:09 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:09 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:09 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:09 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:10 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:10 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:10 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:10 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:10 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:11 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:11 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:11 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:11 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:11 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:12 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 16 00:04:12 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:12 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:13 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:13 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:13 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:13 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:13 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:13 volumioelat volumio[791]: info: Listing playlists Feb 16 00:04:13 volumioelat volumio[791]: info: Listing playlists Feb 16 00:04:13 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:13 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:14 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:14 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:14 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:15 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:15 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:15 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:15 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:15 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:16 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:16 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:16 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:16 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:16 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:17 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:17 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:17 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:17 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:17 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:18 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:18 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:18 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:18 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:18 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:19 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:19 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:19 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:19 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:19 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:20 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:20 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:20 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:20 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:20 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:20 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 16 00:04:20 volumioelat volumio[791]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 16 00:04:20 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 16 00:04:20 volumioelat volumio[791]: info: Received Get System Version Feb 16 00:04:20 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 00:04:20 volumioelat volumio[791]: info: Received Get System Info Feb 16 00:04:20 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 16 00:04:20 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 16 00:04:20 volumioelat volumio[791]: info: Discovery: Getting this device information Feb 16 00:04:20 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:20 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:20 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 00:04:21 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:21 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:21 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:21 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:21 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:22 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:22 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:22 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:22 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:22 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:23 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:23 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:23 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:23 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:23 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:23 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:23 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetQueue Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::getQueue Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getQueue Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::volumioPause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::pause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::stPlaybackTimer Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::servicePause Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::servicePause Feb 16 00:04:24 volumioelat volumio[791]: info: ControllerMpd::pause Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand pause Feb 16 00:04:24 volumioelat volumio[791]: info: sendMpdCommand pause took 3 milliseconds Feb 16 00:04:24 volumioelat volumio[791]: info: Feb 16 00:04:24 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:24 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:24 volumioelat volumio[791]: info: Feb 16 00:04:24 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:24 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:24 volumioelat volumio[791]: info: Feb 16 00:04:24 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:24 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:24 volumioelat volumio[791]: info: Feb 16 00:04:24 volumioelat volumio[791]: ---------------------------- MPD announces state update: player Feb 16 00:04:24 volumioelat volumio[791]: info: ControllerMpd::getState Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand status Feb 16 00:04:24 volumioelat volumio[791]: info: sendMpdCommand status took 17 milliseconds Feb 16 00:04:24 volumioelat volumio[791]: info: sendMpdCommand status took 13 milliseconds Feb 16 00:04:24 volumioelat volumio[791]: info: sendMpdCommand status took 10 milliseconds Feb 16 00:04:24 volumioelat volumio[791]: info: sendMpdCommand status took 6 milliseconds Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::parseState Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 00:04:24 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 16 00:04:24 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 16 00:04:24 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 12 milliseconds Feb 16 00:04:24 volumioelat volumio[791]: info: sendMpdCommand playlistinfo took 12 milliseconds Feb 16 00:04:24 volumioelat volumio[791]: verbose: ControllerMpd::parseTrackInfo Feb 16 00:04:24 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":162950,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1031 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:24 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService pause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus pause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::stPlaybackTimer Feb 16 00:04:24 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":162950,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1031 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:24 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService pause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus pause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::stPlaybackTimer Feb 16 00:04:24 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":162950,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1031 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:24 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService pause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus pause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::stPlaybackTimer Feb 16 00:04:24 volumioelat volumio[791]: info: ControllerMpd::pushState Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::servicePushState Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":162950,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1031 Kbps","isStreaming":false,"title":"Hells Bells","artist":"AC-DC","album":"Back In Black (Remastered)","uri":"USB/MUSIC/AC-DC/1980 - Back In Black [1997, EastWest, 62119-2, USA]/01. Hells Bells.flac","trackType":"flac"} Feb 16 00:04:24 volumioelat volumio[791]: verbose: CURRENT POSITION 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::syncState stateService pause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::syncState currentStatus pause Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::pushState Feb 16 00:04:24 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:24 volumioelat volumio[791]: info: CoreCommandRouter::volumioPushState Feb 16 00:04:24 volumioelat volumio[791]: info: CoreStateMachine::stPlaybackTimer Feb 16 00:04:24 volumioelat volumio[791]: info: ------------------------------ 138ms Feb 16 00:04:24 volumioelat volumio[791]: info: ------------------------------ 134ms Feb 16 00:04:24 volumioelat volumio[791]: info: ------------------------------ 132ms Feb 16 00:04:24 volumioelat volumio[791]: info: ------------------------------ 130ms Feb 16 00:04:24 volumioelat volumio[791]: info: camilladsp spawned new process with pid 1632, instance 1, run: true Feb 16 00:04:28 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 16 00:04:28 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 16 00:04:28 volumioelat volumio[791]: info: Discovery: Getting this device information Feb 16 00:04:28 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:28 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:28 volumioelat volumio[791]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 00:04:33 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:33 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:33 volumioelat volumio[791]: info: Listing playlists Feb 16 00:04:33 volumioelat volumio[791]: info: Listing playlists Feb 16 00:04:43 volumioelat volumio[791]: info: CoreCommandRouter::volumioGetState Feb 16 00:04:43 volumioelat volumio[791]: info: CorePlayQueue::getTrack 0 Feb 16 00:04:51 volumioelat volumio[791]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ Feb 16 00:04:51 volumioelat volumio[791]: info: PLUGIN onShutdown : networkfs Feb 16 00:04:51 volumioelat volumio[791]: info: PLUGIN onShutdown : audiophonicsonoff Feb 16 00:04:51 volumioelat volumio[791]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 00:04:51 volumioelat volumio[791]: TypeError: Cannot read property 'writeSync' of undefined Feb 16 00:04:51 volumioelat volumio[791]: at ControllerAudiophonicsOnOff.onVolumioShutdown (/data/plugins/system_hardware/audiophonicsonoff/index.js:48:25) Feb 16 00:04:51 volumioelat volumio[791]: at PluginManager.onVolumioShutdownPlugin (/volumio/app/pluginmanager.js:638:30) Feb 16 00:04:51 volumioelat volumio[791]: at HashMap. (/volumio/app/pluginmanager.js:621:31) Feb 16 00:04:51 volumioelat volumio[791]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 00:04:51 volumioelat volumio[791]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 00:04:51 volumioelat volumio[791]: at PluginManager.onVolumioShutdown (/volumio/app/pluginmanager.js:619:20) Feb 16 00:04:51 volumioelat volumio[791]: at CoreCommandRouter.shutdown (/volumio/app/index.js:1332:24) Feb 16 00:04:51 volumioelat volumio[791]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:859:33) Feb 16 00:04:51 volumioelat volumio[791]: at Socket.emit (events.js:315:20) Feb 16 00:04:51 volumioelat volumio[791]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Feb 16 00:04:51 volumioelat volumio[791]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Feb 16 00:04:51 volumioelat volumio[791]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 00:04:52 volumioelat sudo[1697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 00:03 Feb 16 00:04:52 volumioelat sudo[1697]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"