-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Fri 2025-04-18 19:49:16 JST. -- Apr 18 19:48:00 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:00 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:00 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:01 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:01 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:01 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:02 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:02 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 18 19:48:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 18 19:48:02 smsl-n100 volumio[1180]: info: Discovery: Getting this device information Apr 18 19:48:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:02 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 18 19:48:02 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:02 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:03 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:03 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:03 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:04 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:04 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:04 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:05 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:05 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:05 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:06 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:06 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:06 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:08 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:08 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:08 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:09 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:09 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:09 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:10 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:10 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:10 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:11 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:11 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:11 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:11 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:11 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:11 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:12 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:12 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:12 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:14 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:14 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:14 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:15 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:15 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:15 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:16 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:16 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:16 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:18 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:18 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:18 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:19 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:19 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:19 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:20 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:20 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:20 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:20 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:20 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:20 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Preload queue cleared Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::ClearQueue Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::stop Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::stPlaybackTimer Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::updateTrackBlock Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrackBlock Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::pushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioPushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output update for this device Apr 18 19:48:21 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::serviceStop Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 17 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::serviceStop Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ControllerMpd::stop Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::clearPlayQueue Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::saveQueue Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioPushQueue Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::addQueueItems Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::addQueueItems Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Preload queue cleared Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/01_Jupiter Funk.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/01_Jupiter Funk.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioPushQueue Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::saveQueue Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::updateTrackBlock Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrackBlock Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioPlay Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::play index 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::addQueueItems Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::addQueueItems Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Preload queue cleared Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/02_Passengers.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/02_Passengers.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/03_Black Highway.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/03_Black Highway.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/04_Long way to house.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/04_Long way to house.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/05_Super nature.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/05_Super nature.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/06_Quliphoth.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/06_Quliphoth.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/07_MS Dub.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/07_MS Dub.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/08_How we hype.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/08_How we hype.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/09_Dawn.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/09_Dawn.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/01_Jupiter Funk.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/01_Jupiter Funk.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/02_Passengers.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/02_Passengers.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/03_Black Highway.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/03_Black Highway.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/04_Long way to house.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/04_Long way to house.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/05_Super nature.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/05_Super nature.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/06_Quliphoth.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/06_Quliphoth.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/07_MS Dub.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/07_MS Dub.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/08_How we hype.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/08_How we hype.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/09_Dawn.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/NAS/USB/SSD-PHPU3A/yoshiaki/09_Dawn.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/01_Jupiter Funk.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/01_Jupiter Funk.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/02_Passengers.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/02_Passengers.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/03_Black Highway.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/03_Black Highway.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/04_Long way to house.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/04_Long way to house.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/05_Super nature.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/05_Super nature.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/06_Quliphoth.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/06_Quliphoth.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/07_MS Dub.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/07_MS Dub.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/08_How we hype.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/08_How we hype.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/09_Dawn.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/09_Dawn.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/yoshiaki/01_Jupiter Funk.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/yoshiaki/01_Jupiter Funk.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/yoshiaki/02_Passengers.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/yoshiaki/02_Passengers.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/yoshiaki/03_Black Highway.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/yoshiaki/03_Black Highway.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/yoshiaki/04_Long way to house.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/yoshiaki/04_Long way to house.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/yoshiaki/05_Super nature.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/yoshiaki/05_Super nature.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/yoshiaki/06_Quliphoth.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/yoshiaki/06_Quliphoth.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/yoshiaki/07_MS Dub.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/yoshiaki/07_MS Dub.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/yoshiaki/08_How we hype.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/yoshiaki/08_How we hype.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Adding Item to queue: music-library/USB/SSD-PHPU3A/yoshiaki/09_Dawn.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Using cached record of: music-library/USB/SSD-PHPU3A/yoshiaki/09_Dawn.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::stop Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioPushQueue Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::saveQueue Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::play index undefined Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::updateTrackBlock Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrackBlock Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::startPlaybackTimer Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::clearAddPlayTracks NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/01_Jupiter Funk.m4a Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Apr 18 19:48:21 smsl-n100 volumio[1180]: ---------------------------- MPD announces state update: player Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand stop took 153 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ControllerMpd::getState Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand status Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand stop took 30 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand clear Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Apr 18 19:48:21 smsl-n100 volumio[1180]: ---------------------------- MPD announces system playlist update Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Ignoring MPD Status Update Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand status took 7 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand clear took 6 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::parseState Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand add "NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/01_Jupiter Funk.m4a" Apr 18 19:48:21 smsl-n100 volumio[1180]: error: updateQueue error: null Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Apr 18 19:48:21 smsl-n100 volumio[1180]: ---------------------------- MPD announces system playlist update Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Ignoring MPD Status Update Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ------------------------------ 13ms Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand add "NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/01_Jupiter Funk.m4a" took 9 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::parseTrackInfo Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand play Apr 18 19:48:21 smsl-n100 volumio[1180]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ------------------------------ 30ms Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ------------------------------ 15ms Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand play took 10 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Apr 18 19:48:21 smsl-n100 volumio[1180]: ---------------------------- MPD announces state update: player Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ControllerMpd::getState Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand status Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Apr 18 19:48:21 smsl-n100 volumio[1180]: ---------------------------- MPD announces state update: player Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ControllerMpd::getState Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand status Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand status took 9 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::parseState Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand status took 13 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::parseState Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::parseTrackInfo Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ControllerMpd::pushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::servicePushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"765 Kbps","isStreaming":false,"title":"Jupiter Funk","artist":"ORBITS","album":"Undiscovered Place","uri":"NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/01_Jupiter Funk.m4a","trackType":"m4a"} Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: CURRENT POSITION 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::syncState stateService play Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::syncState currentStatus stop Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ------------------------------ 46ms Apr 18 19:48:21 smsl-n100 volumio[1180]: info: sendMpdCommand playlistinfo took 25 milliseconds Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: ControllerMpd::parseTrackInfo Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ControllerMpd::pushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::servicePushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"765 Kbps","isStreaming":false,"title":"Jupiter Funk","artist":"ORBITS","album":"Undiscovered Place","uri":"NAS/USB/SSD-PHPU3A/.Trashes/501/yoshiaki/01_Jupiter Funk.m4a","trackType":"m4a"} Apr 18 19:48:21 smsl-n100 volumio[1180]: verbose: CURRENT POSITION 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::syncState stateService play Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::syncState currentStatus play Apr 18 19:48:21 smsl-n100 volumio[1180]: info: Received an update from plugin. extracting info from payload Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::pushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioPushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output update for this device Apr 18 19:48:21 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreStateMachine::pushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:21 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioPushState Apr 18 19:48:21 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output update for this device Apr 18 19:48:21 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output Apr 18 19:48:21 smsl-n100 volumio[1180]: info: ------------------------------ 133ms Apr 18 19:48:28 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 18 19:48:28 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:28 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:28 smsl-n100 volumio[1180]: info: CoreStateMachine::pushState Apr 18 19:48:28 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:28 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 19:48:28 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioPushState Apr 18 19:48:28 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output update for this device Apr 18 19:48:28 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output Apr 18 19:48:28 smsl-n100 volumio[1180]: error: Serial API: Failed to decode command: 100, message: undefined Apr 18 19:48:28 smsl-n100 volumio[1180]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 18 19:48:28 smsl-n100 volumio[1180]: error: Serial API: Failed to decode command: 100, message: undefined Apr 18 19:48:28 smsl-n100 volumio[1180]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 18 19:48:32 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 18 19:48:32 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 18 19:48:32 smsl-n100 volumio[1180]: info: Discovery: Getting this device information Apr 18 19:48:32 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:48:32 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:48:32 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 18 19:48:37 smsl-n100 volumio[1180]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 18 19:48:37 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 18 19:48:37 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 18 19:48:37 smsl-n100 sudo[15272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 18 19:48:37 smsl-n100 sudo[15272]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:48:37 smsl-n100 sudo[15272]: pam_unix(sudo:session): session closed for user root Apr 18 19:48:37 smsl-n100 sudo[15278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 18 19:48:37 smsl-n100 sudo[15278]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:48:37 smsl-n100 sudo[15278]: pam_unix(sudo:session): session closed for user root Apr 18 19:48:37 smsl-n100 sudo[15286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 18 19:48:37 smsl-n100 sudo[15286]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:48:37 smsl-n100 sudo[15286]: pam_unix(sudo:session): session closed for user root Apr 18 19:48:37 smsl-n100 sudo[15292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 18 19:48:37 smsl-n100 sudo[15292]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:48:37 smsl-n100 sudo[15292]: pam_unix(sudo:session): session closed for user root Apr 18 19:48:37 smsl-n100 sudo[15298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 19:48:37 smsl-n100 sudo[15298]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:48:37 smsl-n100 sudo[15298]: pam_unix(sudo:session): session closed for user root Apr 18 19:48:37 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 18 19:48:37 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 18 19:48:37 smsl-n100 sudo[15301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 19:48:37 smsl-n100 sudo[15301]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:48:37 smsl-n100 sudo[15301]: pam_unix(sudo:session): session closed for user root Apr 18 19:48:37 smsl-n100 sudo[15304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 18 19:48:37 smsl-n100 sudo[15304]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:48:42 smsl-n100 sudo[15304]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 18 19:49:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 18 19:49:02 smsl-n100 volumio[1180]: info: Discovery: Getting this device information Apr 18 19:49:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:49:02 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:49:02 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 18 19:49:03 smsl-n100 volumio[1180]: info: CALLMETHOD: system_controller network saveDnsSettings [object Object] Apr 18 19:49:03 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: network , saveDnsSettings Apr 18 19:49:03 smsl-n100 sudo[15383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /etc/resolv.conf.tail.tmpl /etc/resolv.conf.tail Apr 18 19:49:03 smsl-n100 sudo[15383]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:03 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 18 19:49:03 smsl-n100 volumio[1180]: info: Discovery: Restarting Advertising due to device name change Apr 18 19:49:03 smsl-n100 sudo[15383]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:03 smsl-n100 sudo[15386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 18 19:49:03 smsl-n100 sudo[15386]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:03 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 18 19:49:03 smsl-n100 volumio[1180]: info: Discovery: Restarting Advertising due to device name change Apr 18 19:49:03 smsl-n100 systemd[1]: Stopping Wireless Services... Apr 18 19:49:03 smsl-n100 wpa_supplicant[858]: wlan0: CTRL-EVENT-DISCONNECTED bssid=76:03:bd:a5:fc:2b reason=3 locally_generated=1 Apr 18 19:49:03 smsl-n100 sudo[15389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ip addr flush dev eth0 Apr 18 19:49:03 smsl-n100 dhcpcd[911]: wlan0: carrier lost Apr 18 19:49:03 smsl-n100 sudo[15389]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:03 smsl-n100 wpa_supplicant[858]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Apr 18 19:49:03 smsl-n100 volumio[1180]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 18 19:49:03 smsl-n100 wpa_supplicant[858]: wlan0: CTRL-EVENT-TERMINATING Apr 18 19:49:03 smsl-n100 avahi-daemon[567]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 18 19:49:03 smsl-n100 avahi-daemon[567]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.21. Apr 18 19:49:03 smsl-n100 sudo[15389]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:03 smsl-n100 dhcpcd[987]: eth0: pid 15392 deleted IP address 192.168.0.12/24 Apr 18 19:49:03 smsl-n100 systemd[1]: wireless.service: Succeeded. Apr 18 19:49:03 smsl-n100 dhcpcd[987]: eth0: deleting route to 192.168.0.0/24 Apr 18 19:49:03 smsl-n100 dhcpcd[987]: eth0: deleting default route via 192.168.0.1 Apr 18 19:49:03 smsl-n100 systemd[1]: Stopped Wireless Services. Apr 18 19:49:03 smsl-n100 avahi-daemon[567]: Withdrawing address record for 192.168.0.21 on wlan0. Apr 18 19:49:03 smsl-n100 volumio[1180]: info: Discovery: A device disappeared from network Apr 18 19:49:03 smsl-n100 avahi-daemon[567]: Withdrawing address record for 192.168.0.12 on eth0. Apr 18 19:49:03 smsl-n100 avahi-daemon[567]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.12. Apr 18 19:49:03 smsl-n100 avahi-daemon[567]: Interface eth0.IPv4 no longer relevant for mDNS. Apr 18 19:49:03 smsl-n100 systemd[1]: Starting Wireless Services... Apr 18 19:49:03 smsl-n100 volumio[1180]: info: Discovery: A device disappeared from network Apr 18 19:49:03 smsl-n100 volumio[1180]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 18 19:49:03 smsl-n100 sudo[15401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 down Apr 18 19:49:03 smsl-n100 sudo[15401]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:03 smsl-n100 volumio[1180]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 18 19:49:03 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Down Apr 18 19:49:03 smsl-n100 dhcpcd[911]: wlan0: deleting route to 192.168.0.0/24 Apr 18 19:49:03 smsl-n100 dhcpcd[911]: wlan0: deleting default route via 192.168.0.1 Apr 18 19:49:03 smsl-n100 sudo[15401]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:03 smsl-n100 sudo[15426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 up Apr 18 19:49:03 smsl-n100 dhcpcd[987]: eth0: rebinding lease of 192.168.0.12 Apr 18 19:49:03 smsl-n100 dhcpcd[987]: eth0: if_sendraw: Network is down Apr 18 19:49:03 smsl-n100 dhcpcd[987]: dhcp_readpacket: eth0: Network is down Apr 18 19:49:03 smsl-n100 sudo[15426]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:03 smsl-n100 dhcpcd[987]: eth0: carrier lost Apr 18 19:49:03 smsl-n100 dhcpcd[911]: dhcp_readpacket: eth0: Network is down Apr 18 19:49:03 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: PHY [stmmac-0:01] driver [Generic PHY] Apr 18 19:49:03 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: No Safety Features support found Apr 18 19:49:03 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: PTP not supported by HW Apr 18 19:49:03 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: configuring for phy/rgmii link mode Apr 18 19:49:03 smsl-n100 dhcpcd[911]: arp_read: eth0: Network is down Apr 18 19:49:03 smsl-n100 dhcpcd[911]: eth0: pid 15392 deleted IP address 192.168.0.12/24 Apr 18 19:49:03 smsl-n100 dhcpcd[911]: eth0: deleting route to 192.168.0.0/24 Apr 18 19:49:03 smsl-n100 dhcpcd[911]: eth0: deleting default route via 192.168.0.1 Apr 18 19:49:03 smsl-n100 sudo[15426]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:03 smsl-n100 dhcpcd[911]: eth0: rebinding lease of 192.168.0.12 Apr 18 19:49:03 smsl-n100 dhcpcd[911]: eth0: carrier lost Apr 18 19:49:03 smsl-n100 dhcpcd[987]: eth0: carrier acquired Apr 18 19:49:03 smsl-n100 dhcpcd[987]: eth0: IAID 18:d7:dd:48 Apr 18 19:49:03 smsl-n100 dhcpcd[911]: eth0: carrier acquired Apr 18 19:49:03 smsl-n100 dhcpcd[911]: eth0: IAID 18:d7:dd:48 Apr 18 19:49:04 smsl-n100 dhcpcd[911]: eth0: rebinding lease of 192.168.0.12 Apr 18 19:49:04 smsl-n100 dhcpcd[911]: eth0: soliciting an IPv6 router Apr 18 19:49:04 smsl-n100 ifplugd(eth0)[764]: Link beat lost. Apr 18 19:49:04 smsl-n100 dhcpcd[987]: eth0: rebinding lease of 192.168.0.12 Apr 18 19:49:04 smsl-n100 dhcpcd[911]: eth0: carrier lost Apr 18 19:49:04 smsl-n100 dhcpcd[987]: eth0: carrier lost Apr 18 19:49:04 smsl-n100 wireless.js[15410]: Cleaning previous... Apr 18 19:49:04 smsl-n100 sudo[15531]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 18 19:49:04 smsl-n100 sudo[15531]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:04 smsl-n100 sudo[15531]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:04 smsl-n100 sudo[15533]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 18 19:49:04 smsl-n100 sudo[15533]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:04 smsl-n100 sudo[15533]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:04 smsl-n100 wireless.js[15410]: Stopped aP Apr 18 19:49:05 smsl-n100 sudo[15540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 18 19:49:05 smsl-n100 sudo[15540]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:05 smsl-n100 sudo[15540]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:05 smsl-n100 sudo[15542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 18 19:49:05 smsl-n100 sudo[15542]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:05 smsl-n100 sudo[15542]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:05 smsl-n100 sudo[15549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 18 19:49:05 smsl-n100 sudo[15549]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:05 smsl-n100 sudo[15549]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:05 smsl-n100 sudo[15551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 18 19:49:05 smsl-n100 sudo[15551]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:05 smsl-n100 dhcpcd[911]: wlan0: carrier acquired Apr 18 19:49:05 smsl-n100 dhcpcd[911]: wlan0: IAID 2b:ee:c8:63 Apr 18 19:49:05 smsl-n100 dhcpcd[911]: wlan0: soliciting an IPv6 router Apr 18 19:49:06 smsl-n100 dhcpcd[911]: wlan0: rebinding lease of 192.168.0.21 Apr 18 19:49:06 smsl-n100 ntpd[1169]: Deleting interface #3 eth0, 192.168.0.12#123, interface stats: received=414, sent=416, dropped=0, active_time=5601 secs Apr 18 19:49:06 smsl-n100 ntpd[1169]: 160.16.113.133 local addr 192.168.0.12 -> Apr 18 19:49:06 smsl-n100 ntpd[1169]: 118.156.189.22 local addr 192.168.0.12 -> Apr 18 19:49:06 smsl-n100 ntpd[1169]: 133.130.121.141 local addr 192.168.0.12 -> Apr 18 19:49:06 smsl-n100 ntpd[1169]: 45.77.20.103 local addr 192.168.0.12 -> Apr 18 19:49:06 smsl-n100 ntpd[1169]: 139.162.81.45 local addr 192.168.0.12 -> Apr 18 19:49:06 smsl-n100 ntpd[1169]: 162.159.200.1 local addr 192.168.0.12 -> Apr 18 19:49:06 smsl-n100 ntpd[1169]: Deleting interface #4 wlan0, 192.168.0.21#123, interface stats: received=0, sent=0, dropped=0, active_time=5601 secs Apr 18 19:49:07 smsl-n100 volumio[1180]: info: Reporting MCU Network Status: 0 Apr 18 19:49:07 smsl-n100 volumio[1180]: info: Volumio Network Manager: Network status updated: 0 Apr 18 19:49:07 smsl-n100 volumio[1180]: info: CoreStateMachine::pushState Apr 18 19:49:07 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:49:07 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 19:49:07 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioPushState Apr 18 19:49:07 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output update for this device Apr 18 19:49:07 smsl-n100 volumio[1180]: info: MRS: Pushing multiroomSync output Apr 18 19:49:07 smsl-n100 volumio[1180]: error: Serial API: Failed to decode command: 100, message: undefined Apr 18 19:49:07 smsl-n100 volumio[1180]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 18 19:49:07 smsl-n100 volumio[1180]: error: Serial API: Failed to decode command: 100, message: undefined Apr 18 19:49:07 smsl-n100 volumio[1180]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 18 19:49:07 smsl-n100 volumio[1180]: error: Serial API: Failed to decode command: 0, message: undefined Apr 18 19:49:08 smsl-n100 volumio[1180]: info: Discovery: Started advertising with name: SMSL N100 Apr 18 19:49:08 smsl-n100 volumio[1180]: info: Discovery: Started advertising with name: SMSL N100 Apr 18 19:49:08 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Apr 18 19:49:08 smsl-n100 dhcpcd[911]: eth0: carrier acquired Apr 18 19:49:08 smsl-n100 dhcpcd[987]: eth0: carrier acquired Apr 18 19:49:08 smsl-n100 dhcpcd[911]: eth0: IAID 18:d7:dd:48 Apr 18 19:49:08 smsl-n100 dhcpcd[987]: eth0: IAID 18:d7:dd:48 Apr 18 19:49:08 smsl-n100 dhcpcd[911]: eth0: rebinding lease of 192.168.0.12 Apr 18 19:49:08 smsl-n100 dhcpcd[911]: eth0: probing address 192.168.0.12/24 Apr 18 19:49:08 smsl-n100 dhcpcd[987]: eth0: soliciting an IPv6 router Apr 18 19:49:09 smsl-n100 ifplugd(eth0)[764]: Link beat detected. Apr 18 19:49:09 smsl-n100 dhcpcd[911]: eth0: soliciting an IPv6 router Apr 18 19:49:09 smsl-n100 sudo[15551]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:09 smsl-n100 dhcpcd[987]: eth0: rebinding lease of 192.168.0.12 Apr 18 19:49:09 smsl-n100 dhcpcd[987]: eth0: probing address 192.168.0.12/24 Apr 18 19:49:09 smsl-n100 wireless.js[15410]: Start wireless flow Apr 18 19:49:09 smsl-n100 wireless.js[15410]: Stopped hotspot (if there).. Apr 18 19:49:09 smsl-n100 sudo[15578]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 18 19:49:09 smsl-n100 sudo[15578]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:09 smsl-n100 sudo[15578]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:09 smsl-n100 sudo[15580]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 18 19:49:09 smsl-n100 sudo[15580]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:09 smsl-n100 dhcpcd[911]: wlan0: carrier lost Apr 18 19:49:09 smsl-n100 sudo[15580]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:09 smsl-n100 wireless.js[15410]: DHCP IP Apr 18 19:49:09 smsl-n100 wireless.js[15410]: Start ap Apr 18 19:49:09 smsl-n100 wpa_supplicant[15585]: Successfully initialized wpa_supplicant Apr 18 19:49:09 smsl-n100 sudo[15589]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 18 19:49:09 smsl-n100 sudo[15589]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:09 smsl-n100 dhcpcd[15598]: sending commands to master dhcpcd process Apr 18 19:49:09 smsl-n100 sudo[15589]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:09 smsl-n100 dhcpcd[911]: wlan0: carrier acquired Apr 18 19:49:09 smsl-n100 dhcpcd[911]: wlan0: IAID 2b:ee:c8:63 Apr 18 19:49:09 smsl-n100 dhcpcd[911]: control command: /sbin/dhcpcd Apr 18 19:49:09 smsl-n100 dhcpcd[911]: wlan0: carrier lost Apr 18 19:49:10 smsl-n100 wireless.js[15410]: trying... Apr 18 19:49:10 smsl-n100 sudo[15611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 19:49:10 smsl-n100 sudo[15611]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:10 smsl-n100 sudo[15611]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:11 smsl-n100 wireless.js[15410]: trying... Apr 18 19:49:11 smsl-n100 sudo[15614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 19:49:11 smsl-n100 sudo[15614]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:11 smsl-n100 sudo[15614]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:12 smsl-n100 wireless.js[15410]: trying... Apr 18 19:49:12 smsl-n100 sudo[15617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 19:49:12 smsl-n100 sudo[15617]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:12 smsl-n100 sudo[15617]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:13 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 18 19:49:13 smsl-n100 volumio[1180]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 18 19:49:13 smsl-n100 volumio[1180]: info: Refreshing Cached IP Addresses Apr 18 19:49:13 smsl-n100 sudo[15620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 18 19:49:13 smsl-n100 sudo[15620]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:13 smsl-n100 wireless.js[15410]: trying... Apr 18 19:49:13 smsl-n100 sudo[15620]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:13 smsl-n100 sudo[15623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 19:49:13 smsl-n100 sudo[15623]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:13 smsl-n100 sudo[15625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 19:49:13 smsl-n100 sudo[15625]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:13 smsl-n100 sudo[15625]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:13 smsl-n100 volumio[1180]: error: Upnp client error: Error: This socket has been ended by the other party Apr 18 19:49:13 smsl-n100 sudo[15623]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:13 smsl-n100 sudo[15628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 19:49:13 smsl-n100 sudo[15628]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:13 smsl-n100 sudo[15628]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:14 smsl-n100 dhcpcd[911]: eth0: leased 192.168.0.12 for 86400 seconds Apr 18 19:49:14 smsl-n100 dhcpcd[911]: eth0: adding route to 192.168.0.0/24 Apr 18 19:49:14 smsl-n100 avahi-daemon[567]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.12. Apr 18 19:49:14 smsl-n100 dhcpcd[911]: eth0: adding default route via 192.168.0.1 Apr 18 19:49:14 smsl-n100 avahi-daemon[567]: New relevant interface eth0.IPv4 for mDNS. Apr 18 19:49:14 smsl-n100 avahi-daemon[567]: Registering new address record for 192.168.0.12 on eth0.IPv4. Apr 18 19:49:14 smsl-n100 volumio[1180]: verbose: New Socket.io Connection to 192.168.0.12:3000 from 192.168.0.2 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Apr 18 19:49:14 smsl-n100 ntpd[1169]: ntpd exiting on signal 15 (Terminated) Apr 18 19:49:14 smsl-n100 systemd[1]: Stopping Network Time Service... Apr 18 19:49:14 smsl-n100 systemd[1]: ntp.service: Succeeded. Apr 18 19:49:14 smsl-n100 volumio[1180]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 18 19:49:14 smsl-n100 systemd[1]: Stopped Network Time Service. Apr 18 19:49:14 smsl-n100 systemd[1]: Starting Network Time Service... Apr 18 19:49:14 smsl-n100 volumio[1180]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 18 19:49:14 smsl-n100 volumio[1180]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 18 19:49:14 smsl-n100 ntpd[15664]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 18 19:49:14 smsl-n100 ntpd[15664]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 18 19:49:14 smsl-n100 systemd[1]: Started Network Time Service. Apr 18 19:49:14 smsl-n100 ntpd[15671]: proto: precision = 1.166 usec (-20) Apr 18 19:49:14 smsl-n100 ntpd[15671]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 18 19:49:14 smsl-n100 ntpd[15671]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 18 19:49:14 smsl-n100 ntpd[15671]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 843 days ago Apr 18 19:49:14 smsl-n100 ntpd[15671]: Listen and drop on 0 v6wildcard [::]:123 Apr 18 19:49:14 smsl-n100 ntpd[15671]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 18 19:49:14 smsl-n100 ntpd[15671]: Listen normally on 2 lo 127.0.0.1:123 Apr 18 19:49:14 smsl-n100 ntpd[15671]: Listen normally on 3 eth0 192.168.0.12:123 Apr 18 19:49:14 smsl-n100 ntpd[15671]: Listening on routing socket on fd #20 for interface updates Apr 18 19:49:14 smsl-n100 ntpd[15671]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 18 19:49:14 smsl-n100 ntpd[15671]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 18 19:49:14 smsl-n100 dhcpcd[987]: eth0: leased 192.168.0.12 for 86400 seconds Apr 18 19:49:14 smsl-n100 dhcpcd[987]: eth0: adding route to 192.168.0.0/24 Apr 18 19:49:14 smsl-n100 dhcpcd[987]: eth0: adding default route via 192.168.0.1 Apr 18 19:49:14 smsl-n100 wireless.js[15410]: trying... Apr 18 19:49:14 smsl-n100 sudo[15700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 19:49:14 smsl-n100 sudo[15700]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:14 smsl-n100 sudo[15700]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:14 smsl-n100 ntpd[15671]: ntpd exiting on signal 15 (Terminated) Apr 18 19:49:14 smsl-n100 systemd[1]: Stopping Network Time Service... Apr 18 19:49:14 smsl-n100 systemd[1]: ntp.service: Succeeded. Apr 18 19:49:14 smsl-n100 systemd[1]: Stopped Network Time Service. Apr 18 19:49:14 smsl-n100 volumio[1180]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 18 19:49:14 smsl-n100 systemd[1]: Starting Network Time Service... Apr 18 19:49:15 smsl-n100 volumio[1180]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 18 19:49:15 smsl-n100 volumio[1180]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 18 19:49:15 smsl-n100 ntpd[15707]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 18 19:49:15 smsl-n100 ntpd[15707]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 18 19:49:15 smsl-n100 systemd[1]: Started Network Time Service. Apr 18 19:49:15 smsl-n100 ntpd[15713]: proto: precision = 1.166 usec (-20) Apr 18 19:49:15 smsl-n100 ntpd[15713]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 18 19:49:15 smsl-n100 ntpd[15713]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 18 19:49:15 smsl-n100 ntpd[15713]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 843 days ago Apr 18 19:49:15 smsl-n100 ntpd[15713]: Listen and drop on 0 v6wildcard [::]:123 Apr 18 19:49:15 smsl-n100 ntpd[15713]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 18 19:49:15 smsl-n100 ntpd[15713]: Listen normally on 2 lo 127.0.0.1:123 Apr 18 19:49:15 smsl-n100 ntpd[15713]: Listen normally on 3 eth0 192.168.0.12:123 Apr 18 19:49:15 smsl-n100 ntpd[15713]: Listening on routing socket on fd #20 for interface updates Apr 18 19:49:15 smsl-n100 ntpd[15713]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 18 19:49:15 smsl-n100 ntpd[15713]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 18 19:49:15 smsl-n100 volumio[1180]: info: Discovery: adding 2a96ea59-075c-4c4c-8bcd-0a4edfd023cf Apr 18 19:49:15 smsl-n100 volumio[1180]: info: Discovery: Found device SMSL N100 Apr 18 19:49:15 smsl-n100 volumio[1180]: info: CoreCommandRouter::volumioGetState Apr 18 19:49:15 smsl-n100 volumio[1180]: info: CorePlayQueue::getTrack 0 Apr 18 19:49:15 smsl-n100 volumio[1180]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 19:49:15 smsl-n100 volumio[1180]: Error: The value NaN is not a number Apr 18 19:49:15 smsl-n100 volumio[1180]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Apr 18 19:49:15 smsl-n100 volumio[1180]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Apr 18 19:49:15 smsl-n100 volumio[1180]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Apr 18 19:49:15 smsl-n100 volumio[1180]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Apr 18 19:49:15 smsl-n100 volumio[1180]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Apr 18 19:49:15 smsl-n100 volumio[1180]: at Browser.emit (events.js:400:28) Apr 18 19:49:15 smsl-n100 volumio[1180]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Apr 18 19:49:15 smsl-n100 volumio[1180]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Apr 18 19:49:15 smsl-n100 volumio[1180]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Apr 18 19:49:15 smsl-n100 volumio[1180]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Apr 18 19:49:15 smsl-n100 volumio[1180]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Apr 18 19:49:15 smsl-n100 volumio[1180]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Apr 18 19:49:15 smsl-n100 volumio[1180]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Apr 18 19:49:15 smsl-n100 volumio[1180]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 19:49:15 smsl-n100 wpa_supplicant[15602]: wlan0: Trying to associate with 76:03:bd:a5:fc:2b (SSID='yuremo8' freq=5500 MHz) Apr 18 19:49:15 smsl-n100 wpa_supplicant[15602]: wlan0: Associated with 76:03:bd:a5:fc:2b Apr 18 19:49:15 smsl-n100 wpa_supplicant[15602]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 18 19:49:15 smsl-n100 wpa_supplicant[15602]: wlan0: WPA: Key negotiation completed with 76:03:bd:a5:fc:2b [PTK=CCMP GTK=TKIP] Apr 18 19:49:15 smsl-n100 wpa_supplicant[15602]: wlan0: CTRL-EVENT-CONNECTED - Connection to 76:03:bd:a5:fc:2b completed [id=0 id_str=] Apr 18 19:49:15 smsl-n100 dhcpcd[911]: wlan0: carrier acquired Apr 18 19:49:15 smsl-n100 dhcpcd[911]: wlan0: IAID 2b:ee:c8:63 Apr 18 19:49:15 smsl-n100 wpa_supplicant[15602]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Apr 18 19:49:15 smsl-n100 wireless.js[15410]: trying... Apr 18 19:49:15 smsl-n100 sudo[15730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 19:49:15 smsl-n100 sudo[15730]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 19:49:15 smsl-n100 sudo[15730]: pam_unix(sudo:session): session closed for user root Apr 18 19:49:16 smsl-n100 dhcpcd[911]: wlan0: rebinding lease of 192.168.0.21 Apr 18 19:49:16 smsl-n100 dhcpcd[911]: wlan0: probing address 192.168.0.21/24 Apr 18 19:49:16 smsl-n100 ntpd[15713]: Soliciting pool server 129.250.35.251 Apr 18 19:49:16 smsl-n100 sudo[15733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-18 19:48 Apr 18 19:49:16 smsl-n100 sudo[15733]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"