-- Logs begin at Fri 2024-03-29 21:40:12 JST, end at Fri 2024-03-29 21:47:21 JST. -- Mar 29 21:46:31 volumio volumio[576]: info: CALLMETHOD: music_service squeezelite_mc configSaveServerCredentials [object Object] Mar 29 21:46:31 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: squeezelite_mc , configSaveServerCredentials Mar 29 21:46:40 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 21:46:40 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 21:46:44 volumio volumio[576]: info: CoreCommandRouter::volumioGetState Mar 29 21:46:44 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:47 volumio volumio[576]: info: CoreCommandRouter::volumioPlay Mar 29 21:46:47 volumio volumio[576]: info: CoreStateMachine::play index undefined Mar 29 21:46:47 volumio volumio[576]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 21:46:47 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:47 volumio volumio[576]: info: CoreStateMachine::startPlaybackTimer Mar 29 21:46:47 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:47 volumio volumio[576]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%E6%84%9B%E5%9B%BD%E3%81%AE%E8%8A%B1%22%2C%22artist%22%3A%22%E5%B3%B6%E5%80%89%E5%8D%83%E4%BB%A3%E5%AD%90%22%2C%22album%22%3A%22%EF%BC%88%E6%B1%BA%E5%AE%9A%E7%9B%A4%EF%BC%89%E3%83%88%E3%83%83%E3%83%97%E3%82%B9%E3%82%BF%E3%83%BC%E6%98%AD%E5%92%8C%E5%90%8D%E6%9B%B2%E5%A4%A7%E5%85%A8%E9%9B%86%20%E6%88%A6%E5%89%8D%E7%B7%A82%EF%BD%9E%E8%98%87%E5%B7%9E%E5%A4%9C%E6%9B%B2%E3%83%BB%E8%AA%B0%E3%81%8B%E6%95%85%E9%83%B7%E3%82%92%E6%83%B3%E3%82%8F%E3%81%96%E3%82%8B%EF%BD%9E%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FlPK_tgLAbPk8bvi09ZNUfRtt1IH75o0SkMeFBEQsa2RvkBXlu_MdIMU7iUaPtGowQhXAWpoPxs7drObl%3Dw701-h701-s-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22j5YamWNf5EY%22%2C%22playlistId%22%3A%22PL9CIXCTZGX1aA4sTzEVOXYG9HaMS8Vbs3%22%2C%22playlistSetVideoId%22%3A%2223F5ED9528E1FC57%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22PL9CIXCTZGX1aA4sTzEVOXYG9HaMS8Vbs3%22%2C%22videoId%22%3A%22igY5PK9Vjeg%22%7D%7D%7D%7D Mar 29 21:46:47 volumio volumio[576]: info: [ytmusic] InnertubeLoader: creating Innertube instance... Mar 29 21:46:48 volumio volumio[576]: info: [ytmusic] InnertubeLoader: creating Auth instance... Mar 29 21:46:48 volumio volumio[576]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 21:46:48 volumio volumio[576]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 21:46:48 volumio volumio[576]: info: [ytmusic] InnertubeLoader: Auth instance created (status: signed in) Mar 29 21:46:50 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:50 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 21:46:50 volumio volumio[576]: info: sendMpdCommand stop took 13 milliseconds Mar 29 21:46:50 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 21:46:50 volumio volumio[576]: info: Mar 29 21:46:50 volumio volumio[576]: ---------------------------- MPD announces system playlist update Mar 29 21:46:50 volumio volumio[576]: info: Ignoring MPD Status Update Mar 29 21:46:50 volumio volumio[576]: info: sendMpdCommand clear took 6 milliseconds Mar 29 21:46:50 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube" Mar 29 21:46:50 volumio volumio[576]: info: Mar 29 21:46:50 volumio volumio[576]: ---------------------------- MPD announces system playlist update Mar 29 21:46:50 volumio volumio[576]: info: Ignoring MPD Status Update Mar 29 21:46:50 volumio volumio[576]: info: Mar 29 21:46:50 volumio volumio[576]: ---------------------------- MPD announces system playlist update Mar 29 21:46:50 volumio volumio[576]: info: Ignoring MPD Status Update Mar 29 21:46:50 volumio volumio[576]: error: updateQueue error: null Mar 29 21:46:50 volumio volumio[576]: info: Mar 29 21:46:50 volumio volumio[576]: ---------------------------- MPD announces system playlist update Mar 29 21:46:50 volumio volumio[576]: info: Ignoring MPD Status Update Mar 29 21:46:50 volumio volumio[576]: info: ------------------------------ 26ms Mar 29 21:46:50 volumio volumio[576]: info: sendMpdCommand addid "https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube" took 21 milliseconds Mar 29 21:46:50 volumio volumio[576]: info: ------------------------------ 18ms Mar 29 21:46:50 volumio volumio[576]: info: ------------------------------ 15ms Mar 29 21:46:50 volumio volumio[576]: verbose: MPD COMMAND [object Object] Mar 29 21:46:50 volumio volumio[576]: verbose: MPD COMMAND [object Object] Mar 29 21:46:50 volumio volumio[576]: verbose: MPD COMMAND [object Object] Mar 29 21:46:50 volumio volumio[576]: info: Mar 29 21:46:50 volumio volumio[576]: ---------------------------- MPD announces system playlist update Mar 29 21:46:50 volumio volumio[576]: info: Ignoring MPD Status Update Mar 29 21:46:50 volumio volumio[576]: info: Mar 29 21:46:50 volumio volumio[576]: ---------------------------- MPD announces system playlist update Mar 29 21:46:50 volumio volumio[576]: info: Ignoring MPD Status Update Mar 29 21:46:50 volumio volumio[576]: error: Upnp client error: Error: This socket has been ended by the other party Mar 29 21:46:50 volumio volumio[576]: info: Mar 29 21:46:50 volumio volumio[576]: ---------------------------- MPD announces system playlist update Mar 29 21:46:50 volumio volumio[576]: info: Ignoring MPD Status Update Mar 29 21:46:50 volumio volumio[576]: info: ------------------------------ 31ms Mar 29 21:46:50 volumio volumio[576]: info: ------------------------------ 15ms Mar 29 21:46:50 volumio volumio[576]: info: ------------------------------ 13ms Mar 29 21:46:50 volumio volumio[576]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 21:46:50 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand play Mar 29 21:46:50 volumio volumio[576]: info: Mar 29 21:46:50 volumio volumio[576]: ---------------------------- MPD announces system playlist update Mar 29 21:46:50 volumio volumio[576]: info: Ignoring MPD Status Update Mar 29 21:46:50 volumio volumio[576]: info: Mar 29 21:46:50 volumio volumio[576]: ---------------------------- MPD announces system playlist update Mar 29 21:46:50 volumio volumio[576]: info: Ignoring MPD Status Update Mar 29 21:46:50 volumio volumio[576]: info: ------------------------------ 17ms Mar 29 21:46:50 volumio volumio[576]: info: sendMpdCommand play took 10 milliseconds Mar 29 21:46:50 volumio volumio[576]: info: ------------------------------ 49ms Mar 29 21:46:50 volumio volumio[576]: info: ------------------------------ 46ms Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:52 volumio volumio[576]: info: Mar 29 21:46:52 volumio volumio[576]: ---------------------------- MPD announces state update: player Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:52 volumio volumio[576]: info: Mar 29 21:46:52 volumio volumio[576]: ---------------------------- MPD announces state update: player Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:52 volumio volumio[576]: info: Mar 29 21:46:52 volumio volumio[576]: ---------------------------- MPD announces state update: player Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:52 volumio volumio[576]: info: Mar 29 21:46:52 volumio volumio[576]: ---------------------------- MPD announces state update: player Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand status took 24 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand status took 26 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand status took 22 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand status took 18 milliseconds Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:52 volumio volumio[576]: info: Mar 29 21:46:52 volumio volumio[576]: ---------------------------- MPD announces state update: player Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:52 volumio volumio[576]: info: Mar 29 21:46:52 volumio volumio[576]: ---------------------------- MPD announces state update: player Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand status took 46 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand status took 38 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand playlistinfo took 28 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand playlistinfo took 26 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand playlistinfo took 26 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand playlistinfo took 25 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand status took 18 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand status took 14 milliseconds Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::servicePushState Mar 29 21:46:52 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:52 volumio volumio[576]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愛国の花","artist":"島倉千代子","album":"（決定盤）トップスター昭和名曲大全集 戦前編2～蘇州夜曲・誰か故郷を想わざる～","uri":"https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Mar 29 21:46:52 volumio volumio[576]: verbose: CURRENT POSITION 0 Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState stateService play Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState currentStatus stop Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::servicePushState Mar 29 21:46:52 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:52 volumio volumio[576]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愛国の花","artist":"島倉千代子","album":"（決定盤）トップスター昭和名曲大全集 戦前編2～蘇州夜曲・誰か故郷を想わざる～","uri":"https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Mar 29 21:46:52 volumio volumio[576]: verbose: CURRENT POSITION 0 Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState stateService play Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState currentStatus play Mar 29 21:46:52 volumio volumio[576]: info: Received an update from plugin. extracting info from payload Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::servicePushState Mar 29 21:46:52 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:52 volumio volumio[576]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愛国の花","artist":"島倉千代子","album":"（決定盤）トップスター昭和名曲大全集 戦前編2～蘇州夜曲・誰か故郷を想わざる～","uri":"https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Mar 29 21:46:52 volumio volumio[576]: verbose: CURRENT POSITION 0 Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState stateService play Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState currentStatus play Mar 29 21:46:52 volumio volumio[576]: info: Received an update from plugin. extracting info from payload Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: ------------------------------ 189ms Mar 29 21:46:52 volumio volumio[576]: info: ------------------------------ 206ms Mar 29 21:46:52 volumio volumio[576]: info: ------------------------------ 203ms Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand playlistinfo took 149 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand playlistinfo took 148 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand playlistinfo took 138 milliseconds Mar 29 21:46:52 volumio volumio[576]: info: sendMpdCommand playlistinfo took 123 milliseconds Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:52 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::servicePushState Mar 29 21:46:52 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:52 volumio volumio[576]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9 Kbps","isStreaming":false,"title":"愛国の花","artist":"島倉千代子","album":"（決定盤）トップスター昭和名曲大全集 戦前編2～蘇州夜曲・誰か故郷を想わざる～","uri":"https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Mar 29 21:46:52 volumio volumio[576]: verbose: CURRENT POSITION 0 Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState stateService play Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState currentStatus play Mar 29 21:46:52 volumio volumio[576]: info: Received an update from plugin. extracting info from payload Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::servicePushState Mar 29 21:46:52 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:52 volumio volumio[576]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9 Kbps","isStreaming":false,"title":"愛国の花","artist":"島倉千代子","album":"（決定盤）トップスター昭和名曲大全集 戦前編2～蘇州夜曲・誰か故郷を想わざる～","uri":"https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Mar 29 21:46:52 volumio volumio[576]: verbose: CURRENT POSITION 0 Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState stateService play Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState currentStatus play Mar 29 21:46:52 volumio volumio[576]: info: Received an update from plugin. extracting info from payload Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: ControllerMpd::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::servicePushState Mar 29 21:46:52 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:52 volumio volumio[576]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9 Kbps","isStreaming":false,"title":"愛国の花","artist":"島倉千代子","album":"（決定盤）トップスター昭和名曲大全集 戦前編2～蘇州夜曲・誰か故郷を想わざる～","uri":"https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Mar 29 21:46:52 volumio volumio[576]: verbose: CURRENT POSITION 0 Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState stateService play Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::syncState currentStatus play Mar 29 21:46:52 volumio volumio[576]: info: Received an update from plugin. extracting info from payload Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:52 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:52 volumio volumio[576]: info: ------------------------------ 308ms Mar 29 21:46:52 volumio volumio[576]: info: ------------------------------ 279ms Mar 29 21:46:52 volumio volumio[576]: info: ------------------------------ 275ms Mar 29 21:46:56 volumio volumio[576]: info: CoreCommandRouter::volumioPause Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::pause Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::stPlaybackTimer Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::servicePause Mar 29 21:46:56 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:56 volumio volumio[576]: info: CoreCommandRouter::servicePause Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 21:46:56 volumio volumio[576]: info: ControllerMpd::pause Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand pause Mar 29 21:46:56 volumio volumio[576]: info: sendMpdCommand pause took 3 milliseconds Mar 29 21:46:56 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:56 volumio volumio[576]: info: Mar 29 21:46:56 volumio volumio[576]: ---------------------------- MPD announces state update: player Mar 29 21:46:56 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:56 volumio volumio[576]: info: Mar 29 21:46:56 volumio volumio[576]: ---------------------------- MPD announces state update: player Mar 29 21:46:56 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:56 volumio volumio[576]: info: Mar 29 21:46:56 volumio volumio[576]: ---------------------------- MPD announces state update: player Mar 29 21:46:56 volumio volumio[576]: info: ControllerMpd::getState Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand status Mar 29 21:46:56 volumio volumio[576]: info: sendMpdCommand status took 13 milliseconds Mar 29 21:46:56 volumio volumio[576]: info: sendMpdCommand status took 11 milliseconds Mar 29 21:46:56 volumio volumio[576]: info: sendMpdCommand status took 9 milliseconds Mar 29 21:46:56 volumio volumio[576]: info: sendMpdCommand status took 6 milliseconds Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::parseState Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 21:46:56 volumio volumio[576]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 29 21:46:56 volumio volumio[576]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 29 21:46:56 volumio volumio[576]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 29 21:46:56 volumio volumio[576]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:56 volumio volumio[576]: verbose: ControllerMpd::parseTrackInfo Mar 29 21:46:56 volumio volumio[576]: info: ControllerMpd::pushState Mar 29 21:46:56 volumio volumio[576]: info: CoreCommandRouter::servicePushState Mar 29 21:46:56 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:56 volumio volumio[576]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4776,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9 Kbps","isStreaming":false,"title":"愛国の花","artist":"島倉千代子","album":"（決定盤）トップスター昭和名曲大全集 戦前編2～蘇州夜曲・誰か故郷を想わざる～","uri":"https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Mar 29 21:46:56 volumio volumio[576]: verbose: CURRENT POSITION 0 Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::syncState stateService pause Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::syncState currentStatus pause Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:56 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 21:46:56 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::stPlaybackTimer Mar 29 21:46:56 volumio volumio[576]: info: ControllerMpd::pushState Mar 29 21:46:56 volumio volumio[576]: info: CoreCommandRouter::servicePushState Mar 29 21:46:56 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:56 volumio volumio[576]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4776,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9 Kbps","isStreaming":false,"title":"愛国の花","artist":"島倉千代子","album":"（決定盤）トップスター昭和名曲大全集 戦前編2～蘇州夜曲・誰か故郷を想わざる～","uri":"https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Mar 29 21:46:56 volumio volumio[576]: verbose: CURRENT POSITION 0 Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::syncState stateService pause Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::syncState currentStatus pause Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:56 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::stPlaybackTimer Mar 29 21:46:56 volumio volumio[576]: info: ControllerMpd::pushState Mar 29 21:46:56 volumio volumio[576]: info: CoreCommandRouter::servicePushState Mar 29 21:46:56 volumio volumio[576]: info: CorePlayQueue::getTrack 0 Mar 29 21:46:56 volumio volumio[576]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4776,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"9 Kbps","isStreaming":false,"title":"愛国の花","artist":"島倉千代子","album":"（決定盤）トップスター昭和名曲大全集 戦前編2～蘇州夜曲・誰か故郷を想わざる～","uri":"https://rr2---sn-3qqp-ioqsl.googlevideo.com/videoplayback?expire=1711738008&ei=OLgGZv3VMcuF1d8PldCziAQ&ip=106.163.89.229&id=o-AC6HPldG_UD0FVxduVb-EgumdSIFP03R5DHCsGeBCeyS&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=11&mm=31%2C26&mn=sn-3qqp-ioqsl%2Csn-3pm7kn7r&ms=au%2Conr&mv=m&mvi=2&pl=25&ctier=A&pfa=5&gcr=jp&initcwndbps=1285000&hightc=yes&siu=1&spc=UWF9f9lDYiQxilsPoHW8Mi8QGKxwfSaNONLYc0oXIbepvOhhgw&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=MqfbhAFAjCQh7HL2QLjgfOwQ&gir=yes&clen=8491656&dur=263.746&lmt=1615498724643439&mt=1711716052&fvip=1&keepalive=yes&fexp=51141542&c=WEB_REMIX&sefc=1&txp=1311222&n=2Wf5A2JAdrJaiw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgVQ6f4lgV2m2IgZsSvpLPQQm5c3h9AN5dA_gWc-_DWisCIQDHBWRoJd2lkheZxBvBfLAgnvSkdeAL_-VUFmFEaw5wUg%3D%3D&sig=AJfQdSswRQIhAIOCsJbbk-qp2reJUxqH-gwvutoEyJDaV_WVfdjXWxlRAiBIFuJs2hV5dZ4iaawkQ4Fbyx4NPsl-JMxa8d52OjfnWg%3D%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Mar 29 21:46:56 volumio volumio[576]: verbose: CURRENT POSITION 0 Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::syncState stateService pause Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::syncState currentStatus pause Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::pushState Mar 29 21:46:56 volumio volumio[576]: info: CoreCommandRouter::volumioPushState Mar 29 21:46:56 volumio volumio[576]: info: CoreStateMachine::stPlaybackTimer Mar 29 21:46:56 volumio volumio[576]: info: ------------------------------ 109ms Mar 29 21:46:56 volumio volumio[576]: info: ------------------------------ 107ms Mar 29 21:46:56 volumio volumio[576]: info: ------------------------------ 104ms Mar 29 21:47:08 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 29 21:47:08 volumio volumio[576]: info: Preload queue cleared Mar 29 21:47:11 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 29 21:47:11 volumio volumio[576]: info: Preload queue cleared Mar 29 21:47:13 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 29 21:47:13 volumio volumio[576]: info: Preload queue cleared Mar 29 21:47:20 volumio volumio[576]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 29 21:47:20 volumio volumio[576]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 21:47:20 volumio volumio[576]: TypeError: Cannot read property 'length' of undefined Mar 29 21:47:20 volumio volumio[576]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Mar 29 21:47:20 volumio volumio[576]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Mar 29 21:47:20 volumio volumio[576]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Mar 29 21:47:20 volumio volumio[576]: at Parser.emit (events.js:315:20) Mar 29 21:47:20 volumio volumio[576]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Mar 29 21:47:20 volumio volumio[576]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Mar 29 21:47:20 volumio volumio[576]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Mar 29 21:47:20 volumio volumio[576]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Mar 29 21:47:20 volumio volumio[576]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Mar 29 21:47:20 volumio volumio[576]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Mar 29 21:47:20 volumio volumio[576]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Mar 29 21:47:20 volumio volumio[576]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Mar 29 21:47:20 volumio volumio[576]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Mar 29 21:47:20 volumio volumio[576]: at IncomingMessage.emit (events.js:327:22) Mar 29 21:47:20 volumio volumio[576]: at endReadableNT (internal/streams/readable.js:1327:12) Mar 29 21:47:20 volumio volumio[576]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 29 21:47:20 volumio volumio[576]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 21:47:21 volumio sudo[1299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-29 21:46 Mar 29 21:47:21 volumio sudo[1299]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"