Sep 06 13:31:06 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:31:06 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 13:31:06 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 13:31:06 volumio volumio[1135]: info: Discovery: Getting this device information Sep 06 13:31:06 volumio volumio[1135]: info: CoreCommandRouter::volumioGetState Sep 06 13:31:06 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 13:31:06 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 06 13:31:06 volumio systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories... Sep 06 13:31:06 volumio dbus-daemon[722]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.42' (uid=0 pid=3014 comm="timedatectl show --property=NTPSynchronized --valu") Sep 06 13:31:06 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 06 13:31:06 volumio systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully. Sep 06 13:31:06 volumio systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories. Sep 06 13:31:06 volumio systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully. Sep 06 13:31:07 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:31:07 volumio dbus-daemon[722]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 06 13:31:07 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 06 13:31:07 volumio setdatetime-helper.sh[2996]: Time is already synchronized. Sep 06 13:31:07 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 06 13:31:07 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 06 13:31:07 volumio kernel: usb 1-1.1: device not accepting address 105, error -71 Sep 06 13:31:07 volumio kernel: usb 1-1.1: new high-speed USB device number 106 using xhci_hcd Sep 06 13:31:23 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:31:23 volumio volumio[1135]: info: Preload queue cleared Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::ClearQueue Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::stop Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::updateTrackBlock Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrackBlock Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::stPlaybackTimer Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::serviceStop Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::serviceStop Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 06 13:31:23 volumio volumio[1135]: info: ControllerMpd::stop Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand stop Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::clearPlayQueue Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::saveQueue Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::volumioPushQueue Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::addQueueItems Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::addQueueItems Sep 06 13:31:23 volumio volumio[1135]: info: Preload queue cleared Sep 06 13:31:23 volumio volumio[1135]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bach%20Air%20on%20the%20G%20String%22%2C%22artist%22%3A%22%E9%AB%99%E6%9C%A8%E5%87%9C%E3%80%85%E5%AD%90%20%20%E3%83%B4%E3%82%A1%E3%82%A4%E3%82%AA%E3%83%AA%E3%83%B3%E3%83%81%E3%83%A3%E3%83%B3%E3%83%8D%E3%83%AB%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FmpnLM322vJU%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNAFEJQDSFryq4qpAwkIARUAAIhCGAE%3D%26rs%3DAOn4CLD5wbTvqxE9wuXK3dQnGkGYx93OrA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22mpnLM322vJU%22%2C%22playlistId%22%3A%22RDmpnLM322vJU%22%2C%22params%22%3A%22OAHAAQGqAxXjg5Djg4Pjg4_jgIDjgqLjg6rjgqK6AwsI47mW5rSutbfkAboDCwixn-aGkdWFirYBugMKCLqA3aW_k97_GroDCgjhk7aIs6HJ-li6Aw8SDVJENUc3VmMwekZuT026AwoI7p_UtOujupZVugMKCJG_kc3HrpvlV7oDCgjIwO6bmdr5sSS6AwsI0OPm9b708-XIAboDCwj2o7bWu_zA_NQBugMLCN77iPbXuv7ozwG6AwsI08DQlOn1tfW4AboDCgior8iik4Dozxu6AwoI4_TJs7znudYkugMLCOqu_67czJjL3AG6AwoIzt-6mfSQifBxugMKCMSVtZS3q4n8CroDCgifoZXS0ty9_G66AwsIr7PBh_TeztuwAbgFAQ%253D%253D%22%7D%7D%7D Sep 06 13:31:23 volumio volumio[1135]: info: Exploding uri youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bach%20Air%20on%20the%20G%20String%22%2C%22artist%22%3A%22%E9%AB%99%E6%9C%A8%E5%87%9C%E3%80%85%E5%AD%90%20%20%E3%83%B4%E3%82%A1%E3%82%A4%E3%82%AA%E3%83%AA%E3%83%B3%E3%83%81%E3%83%A3%E3%83%B3%E3%83%8D%E3%83%AB%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FmpnLM322vJU%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNAFEJQDSFryq4qpAwkIARUAAIhCGAE%3D%26rs%3DAOn4CLD5wbTvqxE9wuXK3dQnGkGYx93OrA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22mpnLM322vJU%22%2C%22playlistId%22%3A%22RDmpnLM322vJU%22%2C%22params%22%3A%22OAHAAQGqAxXjg5Djg4Pjg4_jgIDjgqLjg6rjgqK6AwsI47mW5rSutbfkAboDCwixn-aGkdWFirYBugMKCLqA3aW_k97_GroDCgjhk7aIs6HJ-li6Aw8SDVJENUc3VmMwekZuT026AwoI7p_UtOujupZVugMKCJG_kc3HrpvlV7oDCgjIwO6bmdr5sSS6AwsI0OPm9b708-XIAboDCwj2o7bWu_zA_NQBugMLCN77iPbXuv7ozwG6AwsI08DQlOn1tfW4AboDCgior8iik4Dozxu6AwoI4_TJs7znudYkugMLCOqu_67czJjL3AG6AwoIzt-6mfSQifBxugMKCMSVtZS3q4n8CroDCgifoZXS0ty9_G66AwsIr7PBh_TeztuwAbgFAQ%253D%253D%22%7D%7D%7D in service youtube2 Sep 06 13:31:23 volumio volumio[1135]: info: [youtube2-browse] explodeUri: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bach%20Air%20on%20the%20G%20String%22%2C%22artist%22%3A%22%E9%AB%99%E6%9C%A8%E5%87%9C%E3%80%85%E5%AD%90%20%20%E3%83%B4%E3%82%A1%E3%82%A4%E3%82%AA%E3%83%AA%E3%83%B3%E3%83%81%E3%83%A3%E3%83%B3%E3%83%8D%E3%83%AB%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FmpnLM322vJU%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNAFEJQDSFryq4qpAwkIARUAAIhCGAE%3D%26rs%3DAOn4CLD5wbTvqxE9wuXK3dQnGkGYx93OrA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22mpnLM322vJU%22%2C%22playlistId%22%3A%22RDmpnLM322vJU%22%2C%22params%22%3A%22OAHAAQGqAxXjg5Djg4Pjg4_jgIDjgqLjg6rjgqK6AwsI47mW5rSutbfkAboDCwixn-aGkdWFirYBugMKCLqA3aW_k97_GroDCgjhk7aIs6HJ-li6Aw8SDVJENUc3VmMwekZuT026AwoI7p_UtOujupZVugMKCJG_kc3HrpvlV7oDCgjIwO6bmdr5sSS6AwsI0OPm9b708-XIAboDCwj2o7bWu_zA_NQBugMLCN77iPbXuv7ozwG6AwsI08DQlOn1tfW4AboDCgior8iik4Dozxu6AwoI4_TJs7znudYkugMLCOqu_67czJjL3AG6AwoIzt-6mfSQifBxugMKCMSVtZS3q4n8CroDCgifoZXS0ty9_G66AwsIr7PBh_TeztuwAbgFAQ%253D%253D%22%7D%7D%7D Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::volumioPushQueue Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::saveQueue Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::updateTrackBlock Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrackBlock Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::volumioPlay Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::play index 0 Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::stop Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::play index undefined Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::startPlaybackTimer Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22mpnLM322vJU%22%2C%22playlistId%22%3A%22RDmpnLM322vJU%22%2C%22params%22%3A%22OAHAAQGqAxXjg5Djg4Pjg4_jgIDjgqLjg6rjgqK6AwsI47mW5rSutbfkAboDCwixn-aGkdWFirYBugMKCLqA3aW_k97_GroDCgjhk7aIs6HJ-li6Aw8SDVJENUc3VmMwekZuT026AwoI7p_UtOujupZVugMKCJG_kc3HrpvlV7oDCgjIwO6bmdr5sSS6AwsI0OPm9b708-XIAboDCwj2o7bWu_zA_NQBugMLCN77iPbXuv7ozwG6AwsI08DQlOn1tfW4AboDCgior8iik4Dozxu6AwoI4_TJs7znudYkugMLCOqu_67czJjL3AG6AwoIzt-6mfSQifBxugMKCMSVtZS3q4n8CroDCgifoZXS0ty9_G66AwsIr7PBh_TeztuwAbgFAQ%253D%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Bach%20Air%20on%20the%20G%20String%22%2C%22artist%22%3A%22%E9%AB%99%E6%9C%A8%E5%87%9C%E3%80%85%E5%AD%90%20%20%E3%83%B4%E3%82%A1%E3%82%A4%E3%82%AA%E3%83%AA%E3%83%B3%E3%83%81%E3%83%A3%E3%83%B3%E3%83%8D%E3%83%AB%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FmpnLM322vJU%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNAFEJQDSFryq4qpAwkIARUAAIhCGAE%3D%26rs%3DAOn4CLD5wbTvqxE9wuXK3dQnGkGYx93OrA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22mpnLM322vJU%22%2C%22playlistId%22%3A%22RDmpnLM322vJU%22%2C%22params%22%3A%22OAHAAQGqAxXjg5Djg4Pjg4_jgIDjgqLjg6rjgqK6AwsI47mW5rSutbfkAboDCwixn-aGkdWFirYBugMKCLqA3aW_k97_GroDCgjhk7aIs6HJ-li6Aw8SDVJENUc3VmMwekZuT026AwoI7p_UtOujupZVugMKCJG_kc3HrpvlV7oDCgjIwO6bmdr5sSS6AwsI0OPm9b708-XIAboDCwj2o7bWu_zA_NQBugMLCN77iPbXuv7ozwG6AwsI08DQlOn1tfW4AboDCgior8iik4Dozxu6AwoI4_TJs7znudYkugMLCOqu_67czJjL3AG6AwoIzt-6mfSQifBxugMKCMSVtZS3q4n8CroDCgifoZXS0ty9_G66AwsIr7PBh_TeztuwAbgFAQ%253D%253D%22%7D%7D%7D Sep 06 13:31:23 volumio volumio[1135]: info: Sep 06 13:31:23 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:23 volumio volumio[1135]: info: sendMpdCommand stop took 25 milliseconds Sep 06 13:31:23 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:23 volumio volumio[1135]: info: Sep 06 13:31:23 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:23 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:23 volumio volumio[1135]: info: Sep 06 13:31:23 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:23 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:23 volumio volumio[1135]: info: sendMpdCommand status took 2 milliseconds Sep 06 13:31:23 volumio volumio[1135]: info: sendMpdCommand status took 2 milliseconds Sep 06 13:31:23 volumio volumio[1135]: info: sendMpdCommand status took 1 milliseconds Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:23 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 13:31:23 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 13:31:23 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:23 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:23 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Sep 06 13:31:23 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Sep 06 13:31:23 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:23 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:23 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:23 volumio volumio[1135]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Sep 06 13:31:23 volumio volumio[1135]: info: ------------------------------ 24ms Sep 06 13:31:23 volumio volumio[1135]: info: ------------------------------ 24ms Sep 06 13:31:23 volumio volumio[1135]: info: ------------------------------ 23ms Sep 06 13:31:23 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:31:23 volumio kernel: usb 1-1.1: device not accepting address 106, error -71 Sep 06 13:31:23 volumio kernel: usb 1-1-port1: unable to enumerate USB device Sep 06 13:31:23 volumio volumio[1135]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(mpnLM322vJU): No valid URL to decipher - retry with 'WEB_EMBEDDED' client. Sep 06 13:31:23 volumio kernel: usb 1-1.1: new high-speed USB device number 107 using xhci_hcd Sep 06 13:31:24 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand stop Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand stop took 2 milliseconds Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand clear Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 06 13:31:24 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand clear took 1 milliseconds Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube" Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 06 13:31:24 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 06 13:31:24 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 06 13:31:24 volumio volumio[1135]: error: updateQueue error: null Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 06 13:31:24 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 4ms Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand addid "https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube" took 3 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 3ms Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 2ms Sep 06 13:31:24 volumio volumio[1135]: verbose: MPD COMMAND [object Object] Sep 06 13:31:24 volumio volumio[1135]: verbose: MPD COMMAND [object Object] Sep 06 13:31:24 volumio volumio[1135]: verbose: MPD COMMAND [object Object] Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 06 13:31:24 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 06 13:31:24 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 06 13:31:24 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 5ms Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 4ms Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 3ms Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand play Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 06 13:31:24 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces system playlist update Sep 06 13:31:24 volumio volumio[1135]: info: Ignoring MPD Status Update Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 5ms Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand play took 4 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 3ms Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 2ms Sep 06 13:31:24 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand status took 2 milliseconds Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand status took 4 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand status took 3 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand status took 2 milliseconds Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:24 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:24 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バッハ Ｇ線上のアリア","artist":"髙木凜々子 ヴァイオリンチャンネル","album":"YouTube","uri":"https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 06 13:31:24 volumio volumio[1135]: verbose: CURRENT POSITION 0 Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus stop Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 8ms Sep 06 13:31:24 volumio volumio[1135]: info: Sep 06 13:31:24 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand status took 4 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand status took 1 milliseconds Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:24 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:24 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バッハ Ｇ線上のアリア","artist":"髙木凜々子 ヴァイオリンチャンネル","album":"YouTube","uri":"https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 06 13:31:24 volumio volumio[1135]: verbose: CURRENT POSITION 0 Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus play Sep 06 13:31:24 volumio volumio[1135]: info: Received an update from plugin. extracting info from payload Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:24 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:24 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バッハ Ｇ線上のアリア","artist":"髙木凜々子 ヴァイオリンチャンネル","album":"YouTube","uri":"https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 06 13:31:24 volumio volumio[1135]: verbose: CURRENT POSITION 0 Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus play Sep 06 13:31:24 volumio volumio[1135]: info: Received an update from plugin. extracting info from payload Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:24 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:24 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バッハ Ｇ線上のアリア","artist":"髙木凜々子 ヴァイオリンチャンネル","album":"YouTube","uri":"https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 06 13:31:24 volumio volumio[1135]: verbose: CURRENT POSITION 0 Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus play Sep 06 13:31:24 volumio volumio[1135]: info: Received an update from plugin. extracting info from payload Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 42ms Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 41ms Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 39ms Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 34 milliseconds Sep 06 13:31:24 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 33 milliseconds Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:24 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:24 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:24 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バッハ Ｇ線上のアリア","artist":"髙木凜々子 ヴァイオリンチャンネル","album":"YouTube","uri":"https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 06 13:31:24 volumio volumio[1135]: verbose: CURRENT POSITION 0 Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus play Sep 06 13:31:24 volumio volumio[1135]: info: Received an update from plugin. extracting info from payload Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:24 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:24 volumio volumio[1135]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バッハ Ｇ線上のアリア","artist":"髙木凜々子 ヴァイオリンチャンネル","album":"YouTube","uri":"https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 06 13:31:24 volumio volumio[1135]: verbose: CURRENT POSITION 0 Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState stateService play Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus play Sep 06 13:31:24 volumio volumio[1135]: info: Received an update from plugin. extracting info from payload Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:24 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 59ms Sep 06 13:31:24 volumio volumio[1135]: info: ------------------------------ 56ms Sep 06 13:31:24 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:31:24 volumio kernel: usb 1-1.1: new high-speed USB device number 108 using xhci_hcd Sep 06 13:31:25 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:31:25 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:31:25 volumio kernel: usb 1-1-port1: attempt power cycle Sep 06 13:31:26 volumio kernel: usb 1-1.1: new high-speed USB device number 109 using xhci_hcd Sep 06 13:31:41 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Sep 06 13:31:41 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:31:42 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 13:31:42 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 13:31:42 volumio volumio[1135]: info: Discovery: Getting this device information Sep 06 13:31:42 volumio volumio[1135]: info: CoreCommandRouter::volumioGetState Sep 06 13:31:42 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 13:31:42 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 13:31:42 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 13:31:42 volumio volumio[1135]: info: Discovery: Getting this device information Sep 06 13:31:42 volumio volumio[1135]: info: CoreCommandRouter::volumioGetState Sep 06 13:31:42 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 13:31:42 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:31:42 volumio kernel: usb 1-1.1: device not accepting address 109, error -71 Sep 06 13:31:42 volumio kernel: usb 1-1.1: new high-speed USB device number 110 using xhci_hcd Sep 06 13:31:58 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:31:58 volumio volumio[1135]: info: CoreCommandRouter::volumioPause Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::pause Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::stPlaybackTimer Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::servicePause Sep 06 13:31:58 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:58 volumio volumio[1135]: info: CoreCommandRouter::servicePause Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 06 13:31:58 volumio volumio[1135]: info: ControllerMpd::pause Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand pause Sep 06 13:31:58 volumio volumio[1135]: info: Sep 06 13:31:58 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:58 volumio volumio[1135]: info: sendMpdCommand pause took 15 milliseconds Sep 06 13:31:58 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:58 volumio volumio[1135]: info: Sep 06 13:31:58 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:58 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:58 volumio volumio[1135]: info: Sep 06 13:31:58 volumio volumio[1135]: ---------------------------- MPD announces state update: player Sep 06 13:31:58 volumio volumio[1135]: info: ControllerMpd::getState Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand status Sep 06 13:31:58 volumio volumio[1135]: info: sendMpdCommand status took 6 milliseconds Sep 06 13:31:58 volumio volumio[1135]: info: sendMpdCommand status took 5 milliseconds Sep 06 13:31:58 volumio volumio[1135]: info: sendMpdCommand status took 5 milliseconds Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::parseState Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 13:31:58 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 06 13:31:58 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 06 13:31:58 volumio volumio[1135]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:58 volumio volumio[1135]: verbose: ControllerMpd::parseTrackInfo Sep 06 13:31:58 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:58 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:58 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:58 volumio volumio[1135]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13863,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バッハ Ｇ線上のアリア","artist":"髙木凜々子 ヴァイオリンチャンネル","album":"YouTube","uri":"https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 06 13:31:58 volumio volumio[1135]: verbose: CURRENT POSITION 0 Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::syncState stateService pause Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus pause Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:58 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 13:31:58 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::stPlaybackTimer Sep 06 13:31:58 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:58 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:58 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:58 volumio volumio[1135]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13863,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バッハ Ｇ線上のアリア","artist":"髙木凜々子 ヴァイオリンチャンネル","album":"YouTube","uri":"https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 06 13:31:58 volumio volumio[1135]: verbose: CURRENT POSITION 0 Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::syncState stateService pause Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus pause Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:58 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::stPlaybackTimer Sep 06 13:31:58 volumio volumio[1135]: info: ControllerMpd::pushState Sep 06 13:31:58 volumio volumio[1135]: info: CoreCommandRouter::servicePushState Sep 06 13:31:58 volumio volumio[1135]: info: CorePlayQueue::getTrack 0 Sep 06 13:31:58 volumio volumio[1135]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13863,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"バッハ Ｇ線上のアリア","artist":"髙木凜々子 ヴァイオリンチャンネル","album":"YouTube","uri":"https://rr3---sn-oguesnd6.googlevideo.com/videoplayback?expire=1757154683&ei=G7m7aJGTKe6Y29gPpOWLUA&ip=106.73.130.32&id=o-AKvNKFBFy4G6aP6dUX9MHqaRFGrbI-wEMghnlh7p8JGd&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1757133083%2C&mh=tu&mm=31%2C29&mn=sn-oguesnd6%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=3&pl=18&rms=au%2Cau&initcwndbps=2412500&bui=AY1jyLM8o38uMNVdvcYd3bxc3WeoexMaYtTikTl3ar3CG43DLLvpDN8bI_DegeWCjl4aHXR8g2uajNTR&spc=l3OVKWlGNXMB8nHXzWMiSq389f7xZbCstc0nTBxRmxqxlsW9nTvYeA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_0DeRzD0t5Pjik0nNIl1OgkQ&rqh=1&gir=yes&clen=5248154&dur=295.961&lmt=1740151105689962&mt=1757132703&fvip=2&keepalive=yes&fexp=51552689%2C51565116%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5532534&n=0IJijauJL_btKA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhALMvxatbB4NbnWmw-3mM9ccyDxWyjp8yUMBPrtyCdnxLAiBd802fOEMEjlWK29zeoHzi9iJm7-va_U4uYpF2z2aFow%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgQos_b22ljDbWMaT3SCbIF6h6JNQEoE9Mf8UGNu6i1tMCIQCYFJK3EaUBPTybR_FNOuIXz0sTziDdNpXB-mCE5r1QEA%3D%3D&pot=Mnoe0lnxw4c-Px7src-X59QDEOmo7hbU6mwogmakGu3XGunMPZgsjqQOLPYXb6jEMq-CCWMGJuRF7Tq_Rua07otNnXbtaYT4v0PXQEirmnD5oTZaAHMHxComD-qrdVClcX8ej9ZiCBKVIs5WhQuAd3ls4XexRtEMCBKQqQ%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Sep 06 13:31:58 volumio volumio[1135]: verbose: CURRENT POSITION 0 Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::syncState stateService pause Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::syncState currentStatus pause Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::pushState Sep 06 13:31:58 volumio volumio[1135]: info: CoreCommandRouter::volumioPushState Sep 06 13:31:58 volumio volumio[1135]: info: CoreStateMachine::stPlaybackTimer Sep 06 13:31:58 volumio volumio[1135]: info: ------------------------------ 36ms Sep 06 13:31:58 volumio volumio[1135]: info: ------------------------------ 36ms Sep 06 13:31:58 volumio volumio[1135]: info: ------------------------------ 35ms Sep 06 13:31:58 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:31:58 volumio kernel: usb 1-1.1: device not accepting address 110, error -71 Sep 06 13:31:58 volumio kernel: usb 1-1-port1: unable to enumerate USB device Sep 06 13:31:59 volumio kernel: usb 1-1.1: new high-speed USB device number 111 using xhci_hcd Sep 06 13:31:59 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:32:00 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:32:00 volumio kernel: usb 1-1.1: new high-speed USB device number 112 using xhci_hcd Sep 06 13:32:00 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:32:01 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:32:01 volumio kernel: usb 1-1-port1: attempt power cycle Sep 06 13:32:01 volumio kernel: usb 1-1.1: new high-speed USB device number 113 using xhci_hcd Sep 06 13:32:04 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 13:32:04 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 13:32:04 volumio volumio[1135]: info: Discovery: Getting this device information Sep 06 13:32:04 volumio volumio[1135]: info: CoreCommandRouter::volumioGetState Sep 06 13:32:04 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 13:32:17 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 06 13:32:17 volumio volumio[1135]: info: CURURI: music-library Sep 06 13:32:17 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:32:17 volumio volumio[1135]: error: Failed LSINFO: null Sep 06 13:32:17 volumio volumio[1135]: info: Preload queue cleared Sep 06 13:32:17 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:32:17 volumio kernel: usb 1-1.1: device not accepting address 113, error -71 Sep 06 13:32:18 volumio kernel: usb 1-1.1: new high-speed USB device number 114 using xhci_hcd Sep 06 13:32:33 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:32:34 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:32:34 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 13:32:34 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 13:32:34 volumio volumio[1135]: info: Discovery: Getting this device information Sep 06 13:32:34 volumio volumio[1135]: info: CoreCommandRouter::volumioGetState Sep 06 13:32:34 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 13:32:34 volumio kernel: usb 1-1.1: device not accepting address 114, error -71 Sep 06 13:32:34 volumio kernel: usb 1-1-port1: unable to enumerate USB device Sep 06 13:32:34 volumio kernel: usb 1-1.1: new high-speed USB device number 115 using xhci_hcd Sep 06 13:32:34 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:32:35 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:32:35 volumio kernel: usb 1-1.1: new high-speed USB device number 116 using xhci_hcd Sep 06 13:32:35 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:32:36 volumio kernel: usb 1-1.1: device descriptor read/64, error -71 Sep 06 13:32:36 volumio kernel: usb 1-1-port1: attempt power cycle Sep 06 13:32:37 volumio kernel: usb 1-1.1: new high-speed USB device number 117 using xhci_hcd Sep 06 13:32:52 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:32:52 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Sep 06 13:32:52 volumio volumio[1135]: info: Preload queue cleared Sep 06 13:32:53 volumio kernel: usb 1-1.1: Device not responding to setup address. Sep 06 13:32:53 volumio kernel: usb 1-1.1: device not accepting address 117, error -71 Sep 06 13:32:53 volumio kernel: usb 1-1.1: new high-speed USB device number 118 using xhci_hcd Sep 06 13:32:57 volumio volumio[1135]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Sep 06 13:32:57 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 06 13:32:57 volumio dbus-daemon[722]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.44' (uid=0 pid=3168 comm="timedatectl show --property=NTPSynchronized --valu") Sep 06 13:32:57 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 06 13:32:57 volumio dbus-daemon[722]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 06 13:32:57 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 06 13:32:57 volumio setdatetime-helper.sh[3167]: Time is already synchronized. Sep 06 13:32:57 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 06 13:32:57 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 06 13:32:57 volumio volumio[1135]: info: READ Sep 06 13:32:57 volumio volumio[1135]: Use XMLElement.setAttribute instead Sep 06 13:32:57 volumio volumio[1135]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 13:32:57 volumio volumio[1135]: TypeError: children[i].attr(...).value is not a function Sep 06 13:32:57 volumio volumio[1135]: at /volumio/app/plugins/music_service/webradio/index.js:286:47 Sep 06 13:32:57 volumio volumio[1135]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Sep 06 13:32:57 volumio volumio[1135]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 13:32:58 volumio sudo[3185]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-06 13:31' Sep 06 13:32:58 volumio sudo[3185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri May 23 08:02:06 UTC 2025" VOLUMIO_VERSION="0.069" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="76fa67e30b28261e1dc7c3a89e610b9e"