-- Logs begin at Thu 2019-02-14 21:12:07 AEDT, end at Wed 2025-02-26 20:13:43 AEDT. -- Feb 26 20:12:15 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:12:15 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:12:15 volumio volumio[684]: info: Discovery: Getting this device information Feb 26 20:12:15 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:12:15 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:15 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:12:16 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 20:12:16 volumio volumio[684]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 26 20:12:16 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 26 20:12:16 volumio volumio[684]: info: Received Get System Version Feb 26 20:12:16 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:12:16 volumio volumio[684]: info: Received Get System Info Feb 26 20:12:16 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:12:16 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:12:16 volumio volumio[684]: info: Discovery: Getting this device information Feb 26 20:12:16 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:12:16 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:16 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:12:17 volumio volumio[684]: info: CoreCommandRouter::volumioPlay Feb 26 20:12:17 volumio volumio[684]: info: CoreStateMachine::play index undefined Feb 26 20:12:17 volumio volumio[684]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 20:12:17 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:17 volumio volumio[684]: info: CoreStateMachine::startPlaybackTimer Feb 26 20:12:17 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:17 volumio volumio[684]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Compared%20to%20What%22%2C%22artist%22%3A%22Roberta%20Flack%22%2C%22album%22%3A%22First%20Take%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FSO8yPChElW5T9OtosVEO5EufRXK5FZ2jBt2H5geHF84MGWR2pTmca99KXv8iugGJAJZD1cRKoCWY8kq2QQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22wDUk9Lsy_yQ%22%2C%22playlistId%22%3A%22OLAK5uy_loaMQUKi6Kqn0JhFsOF6vD6IRuwPSf1r0%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%228EAA0E53EFAD4163%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%22OLAK5uy_loaMQUKi6Kqn0JhFsOF6vD6IRuwPSf1r0%22%2C%22videoId%22%3A%223vjR2K6208Q%22%7D%7D%7D%7D Feb 26 20:12:18 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:18 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 20:12:18 volumio volumio[684]: info: sendMpdCommand stop took 7 milliseconds Feb 26 20:12:18 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clear Feb 26 20:12:18 volumio volumio[684]: info: Feb 26 20:12:18 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:18 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:18 volumio volumio[684]: info: sendMpdCommand clear took 13 milliseconds Feb 26 20:12:18 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582737&ei=8dq-Z-_bFMOK3LUP8KHc8Ac&ip=220.235.46.25&id=o-AHlBUdN5ZYaUL1Sl62kV3a-fAA0Ti5BnAs34XUmeHv5G&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561137%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntq7ynle&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3ztG7SuLhXfuo6gTJVC-R1IN4w4c92WIZqSFbStpHHPci35RXe0ePqYH1uKsforzFVxZRBPRAZ-&spc=RjZbSUzIPhLJ2pAU2aB38SdWEK_KgRhRCxZJcb7aqIx0Tf2NZg8NCSUo3dBdNkRf-bkBR-4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=lB7lgqnoCI9ZeEP-tyGT15QQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=1&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=vG4D7WHzrvGCBw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRAIgdO-YlxsyvKup4qlXl4HmU7r_fBxS0CdJ-dnjDVZDXGMCIGoaqb2U3to508z5kFyC4JGdFzMB8SDhYDqlRjH-cemL&sig=AJfQdSswRQIgHMXO-yMdfHml0I2z4gaJVEdgdejSkKtEOimUdGJnToYCIQC3Hy4qz5zAu1EPMlNf2Y0_iVt3ugTxiZszHM78kYsyvQ%3D%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube" Feb 26 20:12:18 volumio volumio[684]: info: Feb 26 20:12:18 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:18 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:18 volumio volumio[684]: info: Feb 26 20:12:18 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:18 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:18 volumio volumio[684]: error: updateQueue error: null Feb 26 20:12:18 volumio volumio[684]: info: Feb 26 20:12:18 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:18 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:18 volumio volumio[684]: info: ------------------------------ 44ms Feb 26 20:12:18 volumio volumio[684]: info: sendMpdCommand addid "https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582737&ei=8dq-Z-_bFMOK3LUP8KHc8Ac&ip=220.235.46.25&id=o-AHlBUdN5ZYaUL1Sl62kV3a-fAA0Ti5BnAs34XUmeHv5G&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561137%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntq7ynle&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3ztG7SuLhXfuo6gTJVC-R1IN4w4c92WIZqSFbStpHHPci35RXe0ePqYH1uKsforzFVxZRBPRAZ-&spc=RjZbSUzIPhLJ2pAU2aB38SdWEK_KgRhRCxZJcb7aqIx0Tf2NZg8NCSUo3dBdNkRf-bkBR-4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=lB7lgqnoCI9ZeEP-tyGT15QQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=1&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=vG4D7WHzrvGCBw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRAIgdO-YlxsyvKup4qlXl4HmU7r_fBxS0CdJ-dnjDVZDXGMCIGoaqb2U3to508z5kFyC4JGdFzMB8SDhYDqlRjH-cemL&sig=AJfQdSswRQIgHMXO-yMdfHml0I2z4gaJVEdgdejSkKtEOimUdGJnToYCIQC3Hy4qz5zAu1EPMlNf2Y0_iVt3ugTxiZszHM78kYsyvQ%3D%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube" took 39 milliseconds Feb 26 20:12:18 volumio volumio[684]: info: ------------------------------ 28ms Feb 26 20:12:18 volumio volumio[684]: verbose: MPD COMMAND [object Object] Feb 26 20:12:18 volumio volumio[684]: verbose: MPD COMMAND [object Object] Feb 26 20:12:18 volumio volumio[684]: error: Upnp client error: Error: This socket has been ended by the other party Feb 26 20:12:18 volumio volumio[684]: info: Feb 26 20:12:18 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:18 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:18 volumio volumio[684]: info: ------------------------------ 40ms Feb 26 20:12:18 volumio volumio[684]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 26 20:12:18 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand play Feb 26 20:12:18 volumio volumio[684]: info: Feb 26 20:12:18 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:18 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:18 volumio volumio[684]: info: Feb 26 20:12:18 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:18 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:18 volumio volumio[684]: info: ------------------------------ 44ms Feb 26 20:12:18 volumio volumio[684]: info: sendMpdCommand play took 35 milliseconds Feb 26 20:12:18 volumio volumio[684]: info: ------------------------------ 25ms Feb 26 20:12:18 volumio volumio[684]: info: Feb 26 20:12:18 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:18 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:18 volumio volumio[684]: info: Feb 26 20:12:18 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:18 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:18 volumio volumio[684]: info: ------------------------------ 86ms Feb 26 20:12:18 volumio volumio[684]: info: ------------------------------ 34ms Feb 26 20:12:18 volumio volumio[684]: info: ------------------------------ 26ms Feb 26 20:12:20 volumio mpd[1022]: exception: Failed to decode https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582737&ei=8dq-Z-_bFMOK3LUP8KHc8Ac&ip=220.235.46.25&id=o-AHlBUdN5ZYaUL1Sl62kV3a-fAA0Ti5BnAs34XUmeHv5G&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561137%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntq7ynle&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3ztG7SuLhXfuo6gTJVC-R1IN4w4c92WIZqSFbStpHHPci35RXe0ePqYH1uKsforzFVxZRBPRAZ-&spc=RjZbSUzIPhLJ2pAU2aB38SdWEK_KgRhRCxZJcb7aqIx0Tf2NZg8NCSUo3dBdNkRf-bkBR-4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=lB7lgqnoCI9ZeEP-tyGT15QQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=1&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=vG4D7WHzrvGCBw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRAIgdO-YlxsyvKup4qlXl4HmU7r_; got HTTP status 403 Feb 26 20:12:20 volumio mpd[1022]: player: played "https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582737&ei=8dq-Z-_bFMOK3LUP8KHc8Ac&ip=220.235.46.25&id=o-AHlBUdN5ZYaUL1Sl62kV3a-fAA0Ti5BnAs34XUmeHv5G&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561137%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntq7ynle&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3ztG7SuLhXfuo6gTJVC-R1IN4w4c92WIZqSFbStpHHPci35RXe0ePqYH1uKsforzFVxZRBPRAZ-&spc=RjZbSUzIPhLJ2pAU2aB38SdWEK_KgRhRCxZJcb7aqIx0Tf2NZg8NCSUo3dBdNkRf-bkBR-4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=lB7lgqnoCI9ZeEP-tyGT15QQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=1&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=vG4D7WHzrvGCBw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRAIgdO-YlxsyvKup4qlXl4HmU7r_fBxS0CdJ-dnjDVZDXGMCIGoaqb2U3to508z5kFyC4JGdFzMB8SDhYDqlRjH-cemL&sig=AJfQdSswRQIgHMXO-yMdfHml0I2z4gaJVEdgdejSkKtEOimUdGJnToYCIQC3Hy4qz5zAu1EPMlNf2Y0_iVt3ugTxiZszHM78kYsyvQ%3D%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube" Feb 26 20:12:20 volumio volumio[684]: info: Feb 26 20:12:20 volumio volumio[684]: ---------------------------- MPD announces state update: player Feb 26 20:12:20 volumio volumio[684]: info: ControllerMpd::getState Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:12:20 volumio volumio[684]: info: Feb 26 20:12:20 volumio volumio[684]: ---------------------------- MPD announces state update: player Feb 26 20:12:20 volumio volumio[684]: info: ControllerMpd::getState Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:12:20 volumio volumio[684]: info: Feb 26 20:12:20 volumio volumio[684]: ---------------------------- MPD announces state update: player Feb 26 20:12:20 volumio volumio[684]: info: ControllerMpd::getState Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 20:12:20 volumio volumio[684]: info: sendMpdCommand status took 52 milliseconds Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 20:12:20 volumio volumio[684]: info: sendMpdCommand status took 44 milliseconds Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 20:12:20 volumio volumio[684]: info: sendMpdCommand status took 46 milliseconds Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::parseState Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::parseState Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::parseState Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:12:20 volumio volumio[684]: info: sendMpdCommand clearerror took 70 milliseconds Feb 26 20:12:20 volumio volumio[684]: info: sendMpdCommand clearerror took 63 milliseconds Feb 26 20:12:20 volumio volumio[684]: info: sendMpdCommand clearerror took 55 milliseconds Feb 26 20:12:20 volumio volumio[684]: info: sendMpdCommand playlistinfo took 32 milliseconds Feb 26 20:12:20 volumio volumio[684]: info: sendMpdCommand playlistinfo took 26 milliseconds Feb 26 20:12:20 volumio volumio[684]: info: sendMpdCommand playlistinfo took 24 milliseconds Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:12:20 volumio volumio[684]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:12:20 volumio volumio[684]: info: ControllerMpd::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::servicePushState Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:20 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:20 volumio volumio[684]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Compared to What","artist":"Roberta Flack","album":"First Take","uri":"https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582737&ei=8dq-Z-_bFMOK3LUP8KHc8Ac&ip=220.235.46.25&id=o-AHlBUdN5ZYaUL1Sl62kV3a-fAA0Ti5BnAs34XUmeHv5G&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561137%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntq7ynle&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3ztG7SuLhXfuo6gTJVC-R1IN4w4c92WIZqSFbStpHHPci35RXe0ePqYH1uKsforzFVxZRBPRAZ-&spc=RjZbSUzIPhLJ2pAU2aB38SdWEK_KgRhRCxZJcb7aqIx0Tf2NZg8NCSUo3dBdNkRf-bkBR-4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=lB7lgqnoCI9ZeEP-tyGT15QQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=1&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=vG4D7WHzrvGCBw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRAIgdO-YlxsyvKup4qlXl4HmU7r_fBxS0CdJ-dnjDVZDXGMCIGoaqb2U3to508z5kFyC4JGdFzMB8SDhYDqlRjH-cemL&sig=AJfQdSswRQIgHMXO-yMdfHml0I2z4gaJVEdgdejSkKtEOimUdGJnToYCIQC3Hy4qz5zAu1EPMlNf2Y0_iVt3ugTxiZszHM78kYsyvQ%3D%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Feb 26 20:12:20 volumio volumio[684]: verbose: CURRENT POSITION 0 Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::syncState stateService stop Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:20 volumio volumio[684]: info: No code Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:20 volumio volumio[684]: info: ControllerMpd::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::servicePushState Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:20 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:20 volumio volumio[684]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Compared to What","artist":"Roberta Flack","album":"First Take","uri":"https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582737&ei=8dq-Z-_bFMOK3LUP8KHc8Ac&ip=220.235.46.25&id=o-AHlBUdN5ZYaUL1Sl62kV3a-fAA0Ti5BnAs34XUmeHv5G&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561137%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntq7ynle&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3ztG7SuLhXfuo6gTJVC-R1IN4w4c92WIZqSFbStpHHPci35RXe0ePqYH1uKsforzFVxZRBPRAZ-&spc=RjZbSUzIPhLJ2pAU2aB38SdWEK_KgRhRCxZJcb7aqIx0Tf2NZg8NCSUo3dBdNkRf-bkBR-4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=lB7lgqnoCI9ZeEP-tyGT15QQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=1&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=vG4D7WHzrvGCBw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRAIgdO-YlxsyvKup4qlXl4HmU7r_fBxS0CdJ-dnjDVZDXGMCIGoaqb2U3to508z5kFyC4JGdFzMB8SDhYDqlRjH-cemL&sig=AJfQdSswRQIgHMXO-yMdfHml0I2z4gaJVEdgdejSkKtEOimUdGJnToYCIQC3Hy4qz5zAu1EPMlNf2Y0_iVt3ugTxiZszHM78kYsyvQ%3D%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Feb 26 20:12:20 volumio volumio[684]: verbose: CURRENT POSITION 0 Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::syncState stateService stop Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:20 volumio volumio[684]: info: No code Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:20 volumio volumio[684]: info: ControllerMpd::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::servicePushState Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:20 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:20 volumio volumio[684]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Compared to What","artist":"Roberta Flack","album":"First Take","uri":"https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582737&ei=8dq-Z-_bFMOK3LUP8KHc8Ac&ip=220.235.46.25&id=o-AHlBUdN5ZYaUL1Sl62kV3a-fAA0Ti5BnAs34XUmeHv5G&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561137%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntq7ynle&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3ztG7SuLhXfuo6gTJVC-R1IN4w4c92WIZqSFbStpHHPci35RXe0ePqYH1uKsforzFVxZRBPRAZ-&spc=RjZbSUzIPhLJ2pAU2aB38SdWEK_KgRhRCxZJcb7aqIx0Tf2NZg8NCSUo3dBdNkRf-bkBR-4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=lB7lgqnoCI9ZeEP-tyGT15QQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=1&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=vG4D7WHzrvGCBw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRAIgdO-YlxsyvKup4qlXl4HmU7r_fBxS0CdJ-dnjDVZDXGMCIGoaqb2U3to508z5kFyC4JGdFzMB8SDhYDqlRjH-cemL&sig=AJfQdSswRQIgHMXO-yMdfHml0I2z4gaJVEdgdejSkKtEOimUdGJnToYCIQC3Hy4qz5zAu1EPMlNf2Y0_iVt3ugTxiZszHM78kYsyvQ%3D%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Feb 26 20:12:20 volumio volumio[684]: verbose: CURRENT POSITION 0 Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::syncState stateService stop Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:20 volumio volumio[684]: info: No code Feb 26 20:12:20 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:20 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:21 volumio volumio[684]: info: ------------------------------ 435ms Feb 26 20:12:21 volumio volumio[684]: info: ------------------------------ 435ms Feb 26 20:12:21 volumio volumio[684]: info: ------------------------------ 424ms Feb 26 20:12:21 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:21 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:21 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:22 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:22 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:22 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:22 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:22 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:22 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:22 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:22 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:22 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:22 volumio volumio[684]: Upnp client error: Error: This socket has been ended by the other party Feb 26 20:12:24 volumio volumio[684]: error: error Feb 26 20:12:24 volumio volumio[684]: error: error Feb 26 20:12:24 volumio volumio[684]: error: error Feb 26 20:12:24 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:25 volumio volumio[684]: error: error Feb 26 20:12:28 volumio volumio[684]: info: CoreCommandRouter::volumioPlay Feb 26 20:12:28 volumio volumio[684]: info: CoreStateMachine::play index undefined Feb 26 20:12:28 volumio volumio[684]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 20:12:28 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:28 volumio volumio[684]: info: CoreStateMachine::startPlaybackTimer Feb 26 20:12:28 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:28 volumio volumio[684]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Compared%20to%20What%22%2C%22artist%22%3A%22Roberta%20Flack%22%2C%22album%22%3A%22First%20Take%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FSO8yPChElW5T9OtosVEO5EufRXK5FZ2jBt2H5geHF84MGWR2pTmca99KXv8iugGJAJZD1cRKoCWY8kq2QQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22wDUk9Lsy_yQ%22%2C%22playlistId%22%3A%22OLAK5uy_loaMQUKi6Kqn0JhFsOF6vD6IRuwPSf1r0%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%228EAA0E53EFAD4163%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%22OLAK5uy_loaMQUKi6Kqn0JhFsOF6vD6IRuwPSf1r0%22%2C%22videoId%22%3A%223vjR2K6208Q%22%7D%7D%7D%7D Feb 26 20:12:29 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:29 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 20:12:29 volumio volumio[684]: info: sendMpdCommand stop took 6 milliseconds Feb 26 20:12:29 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clear Feb 26 20:12:29 volumio volumio[684]: info: Feb 26 20:12:29 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:29 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:29 volumio volumio[684]: info: sendMpdCommand clear took 12 milliseconds Feb 26 20:12:29 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582748&ei=_Nq-Z7q_E7_54t4PrZrjaA&ip=220.235.46.25&id=o-ABai0tC2QMjtdf3aQCck92M7L6br_u7jzdZT5wBFjf6O&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561148%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3yhDghIF1SxQs-SMwYPaBpQxeUi7dbPBI4nzmCj7uNJF2TDF1z8K9Jnxa5HCg2Czi0vP5gcCe8L&spc=RjZbSeroEHBhlI3YiaKCb8aKA0iGzV3iM6VvljDQplBXGITGOMpsVLHAM2F8hdTyxH35Ooc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_Fy1aPuK_vk0kl5ZL0aubG4Q&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=HoVv1cXBexRVpg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRgIhAJ4jE4bgi465x_Km8DqjlfQar_8zME4OJwfQFXx2CvLBAiEAk2zyyelxAIf8G9_pLfiyGA6QQWYPehSCpR8C6NiH0HQ%3D&sig=AJfQdSswRgIhANgp9MkNnysDrV6XoWNzmwMP9HOuoZrzOEFDaoe2XmEjAiEArKHWstQ8wCzfUJlj9V9QTJpyshtopuerLR9Gz-VLjtI%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube" Feb 26 20:12:29 volumio volumio[684]: info: Feb 26 20:12:29 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:29 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:29 volumio volumio[684]: info: Feb 26 20:12:29 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:29 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:29 volumio volumio[684]: error: updateQueue error: null Feb 26 20:12:29 volumio volumio[684]: info: Feb 26 20:12:29 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:29 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:29 volumio volumio[684]: info: ------------------------------ 62ms Feb 26 20:12:29 volumio volumio[684]: info: sendMpdCommand addid "https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582748&ei=_Nq-Z7q_E7_54t4PrZrjaA&ip=220.235.46.25&id=o-ABai0tC2QMjtdf3aQCck92M7L6br_u7jzdZT5wBFjf6O&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561148%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3yhDghIF1SxQs-SMwYPaBpQxeUi7dbPBI4nzmCj7uNJF2TDF1z8K9Jnxa5HCg2Czi0vP5gcCe8L&spc=RjZbSeroEHBhlI3YiaKCb8aKA0iGzV3iM6VvljDQplBXGITGOMpsVLHAM2F8hdTyxH35Ooc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_Fy1aPuK_vk0kl5ZL0aubG4Q&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=HoVv1cXBexRVpg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRgIhAJ4jE4bgi465x_Km8DqjlfQar_8zME4OJwfQFXx2CvLBAiEAk2zyyelxAIf8G9_pLfiyGA6QQWYPehSCpR8C6NiH0HQ%3D&sig=AJfQdSswRgIhANgp9MkNnysDrV6XoWNzmwMP9HOuoZrzOEFDaoe2XmEjAiEArKHWstQ8wCzfUJlj9V9QTJpyshtopuerLR9Gz-VLjtI%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube" took 55 milliseconds Feb 26 20:12:29 volumio volumio[684]: info: ------------------------------ 86ms Feb 26 20:12:29 volumio volumio[684]: info: ------------------------------ 82ms Feb 26 20:12:29 volumio volumio[684]: verbose: MPD COMMAND [object Object] Feb 26 20:12:29 volumio volumio[684]: info: Feb 26 20:12:29 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:29 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:29 volumio volumio[684]: info: Feb 26 20:12:29 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:29 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:29 volumio volumio[684]: info: Feb 26 20:12:29 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:29 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:29 volumio volumio[684]: info: ------------------------------ 116ms Feb 26 20:12:29 volumio volumio[684]: info: ------------------------------ 73ms Feb 26 20:12:29 volumio volumio[684]: info: ------------------------------ 43ms Feb 26 20:12:29 volumio volumio[684]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 26 20:12:29 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand play Feb 26 20:12:29 volumio volumio[684]: info: Feb 26 20:12:29 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:29 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:29 volumio volumio[684]: info: Feb 26 20:12:29 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:29 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:29 volumio volumio[684]: info: ------------------------------ 213ms Feb 26 20:12:29 volumio volumio[684]: info: sendMpdCommand play took 224 milliseconds Feb 26 20:12:29 volumio volumio[684]: info: ------------------------------ 210ms Feb 26 20:12:29 volumio volumio[684]: info: ------------------------------ 196ms Feb 26 20:12:31 volumio mpd[1022]: exception: Failed to decode https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582748&ei=_Nq-Z7q_E7_54t4PrZrjaA&ip=220.235.46.25&id=o-ABai0tC2QMjtdf3aQCck92M7L6br_u7jzdZT5wBFjf6O&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561148%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3yhDghIF1SxQs-SMwYPaBpQxeUi7dbPBI4nzmCj7uNJF2TDF1z8K9Jnxa5HCg2Czi0vP5gcCe8L&spc=RjZbSeroEHBhlI3YiaKCb8aKA0iGzV3iM6VvljDQplBXGITGOMpsVLHAM2F8hdTyxH35Ooc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_Fy1aPuK_vk0kl5ZL0aubG4Q&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=HoVv1cXBexRVpg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRgIhAJ4jE4bgi465x_Km8DqjlfQar; got HTTP status 403 Feb 26 20:12:31 volumio mpd[1022]: player: played "https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582748&ei=_Nq-Z7q_E7_54t4PrZrjaA&ip=220.235.46.25&id=o-ABai0tC2QMjtdf3aQCck92M7L6br_u7jzdZT5wBFjf6O&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561148%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3yhDghIF1SxQs-SMwYPaBpQxeUi7dbPBI4nzmCj7uNJF2TDF1z8K9Jnxa5HCg2Czi0vP5gcCe8L&spc=RjZbSeroEHBhlI3YiaKCb8aKA0iGzV3iM6VvljDQplBXGITGOMpsVLHAM2F8hdTyxH35Ooc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_Fy1aPuK_vk0kl5ZL0aubG4Q&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=HoVv1cXBexRVpg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRgIhAJ4jE4bgi465x_Km8DqjlfQar_8zME4OJwfQFXx2CvLBAiEAk2zyyelxAIf8G9_pLfiyGA6QQWYPehSCpR8C6NiH0HQ%3D&sig=AJfQdSswRgIhANgp9MkNnysDrV6XoWNzmwMP9HOuoZrzOEFDaoe2XmEjAiEArKHWstQ8wCzfUJlj9V9QTJpyshtopuerLR9Gz-VLjtI%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube" Feb 26 20:12:31 volumio volumio[684]: info: Feb 26 20:12:31 volumio volumio[684]: ---------------------------- MPD announces state update: player Feb 26 20:12:31 volumio volumio[684]: info: ControllerMpd::getState Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:12:31 volumio volumio[684]: info: Feb 26 20:12:31 volumio volumio[684]: ---------------------------- MPD announces state update: player Feb 26 20:12:31 volumio volumio[684]: info: ControllerMpd::getState Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:12:31 volumio volumio[684]: info: Feb 26 20:12:31 volumio volumio[684]: ---------------------------- MPD announces state update: player Feb 26 20:12:31 volumio volumio[684]: info: ControllerMpd::getState Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 20:12:31 volumio volumio[684]: info: sendMpdCommand status took 45 milliseconds Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 20:12:31 volumio volumio[684]: info: sendMpdCommand status took 48 milliseconds Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 20:12:31 volumio volumio[684]: info: sendMpdCommand status took 41 milliseconds Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::parseState Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::parseState Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::parseState Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:12:31 volumio volumio[684]: info: sendMpdCommand clearerror took 70 milliseconds Feb 26 20:12:31 volumio volumio[684]: info: sendMpdCommand clearerror took 63 milliseconds Feb 26 20:12:31 volumio volumio[684]: info: sendMpdCommand clearerror took 55 milliseconds Feb 26 20:12:31 volumio volumio[684]: info: sendMpdCommand playlistinfo took 29 milliseconds Feb 26 20:12:31 volumio volumio[684]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 26 20:12:31 volumio volumio[684]: info: sendMpdCommand playlistinfo took 25 milliseconds Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:12:31 volumio volumio[684]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:12:31 volumio volumio[684]: info: ControllerMpd::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::servicePushState Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:31 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:31 volumio volumio[684]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Compared to What","artist":"Roberta Flack","album":"First Take","uri":"https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582748&ei=_Nq-Z7q_E7_54t4PrZrjaA&ip=220.235.46.25&id=o-ABai0tC2QMjtdf3aQCck92M7L6br_u7jzdZT5wBFjf6O&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561148%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3yhDghIF1SxQs-SMwYPaBpQxeUi7dbPBI4nzmCj7uNJF2TDF1z8K9Jnxa5HCg2Czi0vP5gcCe8L&spc=RjZbSeroEHBhlI3YiaKCb8aKA0iGzV3iM6VvljDQplBXGITGOMpsVLHAM2F8hdTyxH35Ooc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_Fy1aPuK_vk0kl5ZL0aubG4Q&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=HoVv1cXBexRVpg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRgIhAJ4jE4bgi465x_Km8DqjlfQar_8zME4OJwfQFXx2CvLBAiEAk2zyyelxAIf8G9_pLfiyGA6QQWYPehSCpR8C6NiH0HQ%3D&sig=AJfQdSswRgIhANgp9MkNnysDrV6XoWNzmwMP9HOuoZrzOEFDaoe2XmEjAiEArKHWstQ8wCzfUJlj9V9QTJpyshtopuerLR9Gz-VLjtI%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Feb 26 20:12:31 volumio volumio[684]: verbose: CURRENT POSITION 0 Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::syncState stateService stop Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:31 volumio volumio[684]: info: No code Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:31 volumio volumio[684]: info: ControllerMpd::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::servicePushState Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:31 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:31 volumio volumio[684]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Compared to What","artist":"Roberta Flack","album":"First Take","uri":"https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582748&ei=_Nq-Z7q_E7_54t4PrZrjaA&ip=220.235.46.25&id=o-ABai0tC2QMjtdf3aQCck92M7L6br_u7jzdZT5wBFjf6O&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561148%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3yhDghIF1SxQs-SMwYPaBpQxeUi7dbPBI4nzmCj7uNJF2TDF1z8K9Jnxa5HCg2Czi0vP5gcCe8L&spc=RjZbSeroEHBhlI3YiaKCb8aKA0iGzV3iM6VvljDQplBXGITGOMpsVLHAM2F8hdTyxH35Ooc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_Fy1aPuK_vk0kl5ZL0aubG4Q&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=HoVv1cXBexRVpg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRgIhAJ4jE4bgi465x_Km8DqjlfQar_8zME4OJwfQFXx2CvLBAiEAk2zyyelxAIf8G9_pLfiyGA6QQWYPehSCpR8C6NiH0HQ%3D&sig=AJfQdSswRgIhANgp9MkNnysDrV6XoWNzmwMP9HOuoZrzOEFDaoe2XmEjAiEArKHWstQ8wCzfUJlj9V9QTJpyshtopuerLR9Gz-VLjtI%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Feb 26 20:12:31 volumio volumio[684]: verbose: CURRENT POSITION 0 Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::syncState stateService stop Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:31 volumio volumio[684]: info: No code Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:31 volumio volumio[684]: info: ControllerMpd::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::servicePushState Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:31 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:31 volumio volumio[684]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Compared to What","artist":"Roberta Flack","album":"First Take","uri":"https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582748&ei=_Nq-Z7q_E7_54t4PrZrjaA&ip=220.235.46.25&id=o-ABai0tC2QMjtdf3aQCck92M7L6br_u7jzdZT5wBFjf6O&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561148%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3yhDghIF1SxQs-SMwYPaBpQxeUi7dbPBI4nzmCj7uNJF2TDF1z8K9Jnxa5HCg2Czi0vP5gcCe8L&spc=RjZbSeroEHBhlI3YiaKCb8aKA0iGzV3iM6VvljDQplBXGITGOMpsVLHAM2F8hdTyxH35Ooc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=_Fy1aPuK_vk0kl5ZL0aubG4Q&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=HoVv1cXBexRVpg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRgIhAJ4jE4bgi465x_Km8DqjlfQar_8zME4OJwfQFXx2CvLBAiEAk2zyyelxAIf8G9_pLfiyGA6QQWYPehSCpR8C6NiH0HQ%3D&sig=AJfQdSswRgIhANgp9MkNnysDrV6XoWNzmwMP9HOuoZrzOEFDaoe2XmEjAiEArKHWstQ8wCzfUJlj9V9QTJpyshtopuerLR9Gz-VLjtI%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Feb 26 20:12:31 volumio volumio[684]: verbose: CURRENT POSITION 0 Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::syncState stateService stop Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:31 volumio volumio[684]: info: No code Feb 26 20:12:31 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:31 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:31 volumio volumio[684]: info: ------------------------------ 425ms Feb 26 20:12:31 volumio volumio[684]: info: ------------------------------ 419ms Feb 26 20:12:31 volumio volumio[684]: info: ------------------------------ 410ms Feb 26 20:12:32 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:32 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:32 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:38 volumio sudo[6416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:12:38 volumio sudo[6416]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:12:38 volumio sudo[6416]: pam_unix(sudo:session): session closed for user root Feb 26 20:12:38 volumio sudo[6418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:12:38 volumio sudo[6418]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:12:38 volumio sudo[6418]: pam_unix(sudo:session): session closed for user root Feb 26 20:12:38 volumio volumio[684]: verbose: New Socket.io Connection to 192.168.1.100 from 192.168.1.108 UA: Mozilla/5.0 (Linux; Android 14; SM-A356E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.121 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 26 20:12:39 volumio volumio[684]: info: CoreCommandRouter::volumioGetVisibleSources Feb 26 20:12:39 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:12:39 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 26 20:12:39 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:12:39 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 26 20:12:39 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 26 20:12:39 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 26 20:12:39 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 20:12:39 volumio sudo[6424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:12:39 volumio sudo[6424]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:12:39 volumio sudo[6424]: pam_unix(sudo:session): session closed for user root Feb 26 20:12:39 volumio sudo[6426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:12:39 volumio sudo[6426]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:12:39 volumio sudo[6426]: pam_unix(sudo:session): session closed for user root Feb 26 20:12:39 volumio volumio[684]: verbose: New Socket.io Connection to 192.168.1.100 from 192.168.1.108 UA: Mozilla/5.0 (Linux; Android 14; SM-A356E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.121 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 26 20:12:40 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:12:40 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 26 20:12:40 volumio volumio[684]: info: Listing playlists Feb 26 20:12:40 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 26 20:12:40 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 26 20:12:40 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 26 20:12:40 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 20:12:42 volumio volumio[684]: info: CoreCommandRouter::volumioPlay Feb 26 20:12:42 volumio volumio[684]: info: CoreStateMachine::play index undefined Feb 26 20:12:42 volumio volumio[684]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 20:12:42 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:42 volumio volumio[684]: info: CoreStateMachine::startPlaybackTimer Feb 26 20:12:42 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:42 volumio volumio[684]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Compared%20to%20What%22%2C%22artist%22%3A%22Roberta%20Flack%22%2C%22album%22%3A%22First%20Take%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FSO8yPChElW5T9OtosVEO5EufRXK5FZ2jBt2H5geHF84MGWR2pTmca99KXv8iugGJAJZD1cRKoCWY8kq2QQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22wDUk9Lsy_yQ%22%2C%22playlistId%22%3A%22OLAK5uy_loaMQUKi6Kqn0JhFsOF6vD6IRuwPSf1r0%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%228EAA0E53EFAD4163%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%22OLAK5uy_loaMQUKi6Kqn0JhFsOF6vD6IRuwPSf1r0%22%2C%22videoId%22%3A%223vjR2K6208Q%22%7D%7D%7D%7D Feb 26 20:12:43 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:43 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 20:12:43 volumio volumio[684]: info: sendMpdCommand stop took 12 milliseconds Feb 26 20:12:43 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clear Feb 26 20:12:43 volumio volumio[684]: info: Feb 26 20:12:43 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:43 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:43 volumio volumio[684]: info: sendMpdCommand clear took 12 milliseconds Feb 26 20:12:43 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582762&ei=Ctu-Z-7HJd-x2roPp_m7uAc&ip=220.235.46.25&id=o-AMfxbBH2S3uo_VPeR6E1edFA6iJZdXJU_8hOdP0Vm9pL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561162%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3w6G7lf3b2GOizV00RSgLP8J_xOSLO-FfZPsavep51OGgTO6z33bMV8vO48hWsu9nWFhsj3GD2R&spc=RjZbSU7tpdrjtBCNYZzbG6dWCWwZpJrDb68MjBnGVJNJn5e8JIWWXGElz9pMdcy4I2FvUiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Wgzrxt-ZyJgzHpr83i4gWTIQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=fDEMRkD34Ioixg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AFVRHeAwRQIgBJZZrm65BjNcgK-oV11RDrb4g6aNOWSC4rkj9ugh-cACIQDFKOUX7DN7rKnTC2GlknwY5etqKNvIgNsf8hGyQF8dhA%3D%3D&sig=AJfQdSswRgIhAP5WFgLDQxeWGggFH3AaRSXGnhUPdp3DGocno0UAagQIAiEAodP_hX03vjE2BCRAMwIPusWruI8pS0dcd2jx_SaY14s%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube" Feb 26 20:12:43 volumio volumio[684]: info: Feb 26 20:12:43 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:43 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:43 volumio volumio[684]: info: Feb 26 20:12:43 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:43 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:43 volumio volumio[684]: error: updateQueue error: null Feb 26 20:12:43 volumio volumio[684]: info: Feb 26 20:12:43 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:43 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:43 volumio volumio[684]: info: ------------------------------ 36ms Feb 26 20:12:43 volumio volumio[684]: info: sendMpdCommand addid "https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582762&ei=Ctu-Z-7HJd-x2roPp_m7uAc&ip=220.235.46.25&id=o-AMfxbBH2S3uo_VPeR6E1edFA6iJZdXJU_8hOdP0Vm9pL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561162%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3w6G7lf3b2GOizV00RSgLP8J_xOSLO-FfZPsavep51OGgTO6z33bMV8vO48hWsu9nWFhsj3GD2R&spc=RjZbSU7tpdrjtBCNYZzbG6dWCWwZpJrDb68MjBnGVJNJn5e8JIWWXGElz9pMdcy4I2FvUiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Wgzrxt-ZyJgzHpr83i4gWTIQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=fDEMRkD34Ioixg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AFVRHeAwRQIgBJZZrm65BjNcgK-oV11RDrb4g6aNOWSC4rkj9ugh-cACIQDFKOUX7DN7rKnTC2GlknwY5etqKNvIgNsf8hGyQF8dhA%3D%3D&sig=AJfQdSswRgIhAP5WFgLDQxeWGggFH3AaRSXGnhUPdp3DGocno0UAagQIAiEAodP_hX03vjE2BCRAMwIPusWruI8pS0dcd2jx_SaY14s%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube" took 27 milliseconds Feb 26 20:12:43 volumio volumio[684]: info: ------------------------------ 32ms Feb 26 20:12:43 volumio volumio[684]: verbose: MPD COMMAND [object Object] Feb 26 20:12:43 volumio volumio[684]: info: Feb 26 20:12:43 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:43 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:43 volumio volumio[684]: info: Feb 26 20:12:43 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:43 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:43 volumio volumio[684]: info: ------------------------------ 55ms Feb 26 20:12:43 volumio volumio[684]: info: ------------------------------ 49ms Feb 26 20:12:43 volumio volumio[684]: info: ------------------------------ 28ms Feb 26 20:12:43 volumio volumio[684]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 26 20:12:43 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand play Feb 26 20:12:43 volumio volumio[684]: info: Feb 26 20:12:43 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:43 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:43 volumio volumio[684]: info: Feb 26 20:12:43 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:43 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:44 volumio volumio[684]: info: ------------------------------ 67ms Feb 26 20:12:44 volumio volumio[684]: info: sendMpdCommand play took 76 milliseconds Feb 26 20:12:44 volumio volumio[684]: info: ------------------------------ 70ms Feb 26 20:12:44 volumio volumio[684]: info: ------------------------------ 51ms Feb 26 20:12:44 volumio volumio[684]: info: Feb 26 20:12:44 volumio volumio[684]: ---------------------------- MPD announces system playlist update Feb 26 20:12:44 volumio volumio[684]: info: Ignoring MPD Status Update Feb 26 20:12:44 volumio volumio[684]: info: ------------------------------ 49ms Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:12:45 volumio volumio[684]: info: Discovery: Getting this device information Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:12:45 volumio mpd[1022]: exception: Failed to decode https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582762&ei=Ctu-Z-7HJd-x2roPp_m7uAc&ip=220.235.46.25&id=o-AMfxbBH2S3uo_VPeR6E1edFA6iJZdXJU_8hOdP0Vm9pL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561162%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3w6G7lf3b2GOizV00RSgLP8J_xOSLO-FfZPsavep51OGgTO6z33bMV8vO48hWsu9nWFhsj3GD2R&spc=RjZbSU7tpdrjtBCNYZzbG6dWCWwZpJrDb68MjBnGVJNJn5e8JIWWXGElz9pMdcy4I2FvUiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Wgzrxt-ZyJgzHpr83i4gWTIQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=fDEMRkD34Ioixg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AFVRHeAwRQIgBJZZrm65BjNcgK-oV11RDrb4; got HTTP status 403 Feb 26 20:12:45 volumio mpd[1022]: player: played "https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582762&ei=Ctu-Z-7HJd-x2roPp_m7uAc&ip=220.235.46.25&id=o-AMfxbBH2S3uo_VPeR6E1edFA6iJZdXJU_8hOdP0Vm9pL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561162%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3w6G7lf3b2GOizV00RSgLP8J_xOSLO-FfZPsavep51OGgTO6z33bMV8vO48hWsu9nWFhsj3GD2R&spc=RjZbSU7tpdrjtBCNYZzbG6dWCWwZpJrDb68MjBnGVJNJn5e8JIWWXGElz9pMdcy4I2FvUiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Wgzrxt-ZyJgzHpr83i4gWTIQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=fDEMRkD34Ioixg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AFVRHeAwRQIgBJZZrm65BjNcgK-oV11RDrb4g6aNOWSC4rkj9ugh-cACIQDFKOUX7DN7rKnTC2GlknwY5etqKNvIgNsf8hGyQF8dhA%3D%3D&sig=AJfQdSswRgIhAP5WFgLDQxeWGggFH3AaRSXGnhUPdp3DGocno0UAagQIAiEAodP_hX03vjE2BCRAMwIPusWruI8pS0dcd2jx_SaY14s%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube" Feb 26 20:12:45 volumio volumio[684]: info: Feb 26 20:12:45 volumio volumio[684]: ---------------------------- MPD announces state update: player Feb 26 20:12:45 volumio volumio[684]: info: ControllerMpd::getState Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:12:45 volumio volumio[684]: info: Feb 26 20:12:45 volumio volumio[684]: ---------------------------- MPD announces state update: player Feb 26 20:12:45 volumio volumio[684]: info: ControllerMpd::getState Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:12:45 volumio volumio[684]: info: Feb 26 20:12:45 volumio volumio[684]: ---------------------------- MPD announces state update: player Feb 26 20:12:45 volumio volumio[684]: info: ControllerMpd::getState Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 20:12:45 volumio volumio[684]: info: sendMpdCommand status took 49 milliseconds Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 20:12:45 volumio volumio[684]: info: sendMpdCommand status took 40 milliseconds Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::parseState Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::parseState Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 20:12:45 volumio volumio[684]: info: sendMpdCommand status took 93 milliseconds Feb 26 20:12:45 volumio volumio[684]: info: sendMpdCommand clearerror took 70 milliseconds Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::parseState Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 20:12:45 volumio volumio[684]: info: sendMpdCommand clearerror took 90 milliseconds Feb 26 20:12:45 volumio volumio[684]: info: sendMpdCommand playlistinfo took 71 milliseconds Feb 26 20:12:45 volumio volumio[684]: info: sendMpdCommand playlistinfo took 70 milliseconds Feb 26 20:12:45 volumio volumio[684]: info: sendMpdCommand clearerror took 36 milliseconds Feb 26 20:12:45 volumio volumio[684]: info: sendMpdCommand playlistinfo took 27 milliseconds Feb 26 20:12:45 volumio volumio[684]: verbose: ControllerMpd::parseTrackInfo Feb 26 20:12:45 volumio volumio[684]: info: ControllerMpd::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::servicePushState Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:45 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:45 volumio volumio[684]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Compared to What","artist":"Roberta Flack","album":"First Take","uri":"https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582762&ei=Ctu-Z-7HJd-x2roPp_m7uAc&ip=220.235.46.25&id=o-AMfxbBH2S3uo_VPeR6E1edFA6iJZdXJU_8hOdP0Vm9pL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561162%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3w6G7lf3b2GOizV00RSgLP8J_xOSLO-FfZPsavep51OGgTO6z33bMV8vO48hWsu9nWFhsj3GD2R&spc=RjZbSU7tpdrjtBCNYZzbG6dWCWwZpJrDb68MjBnGVJNJn5e8JIWWXGElz9pMdcy4I2FvUiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Wgzrxt-ZyJgzHpr83i4gWTIQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=fDEMRkD34Ioixg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AFVRHeAwRQIgBJZZrm65BjNcgK-oV11RDrb4g6aNOWSC4rkj9ugh-cACIQDFKOUX7DN7rKnTC2GlknwY5etqKNvIgNsf8hGyQF8dhA%3D%3D&sig=AJfQdSswRgIhAP5WFgLDQxeWGggFH3AaRSXGnhUPdp3DGocno0UAagQIAiEAodP_hX03vjE2BCRAMwIPusWruI8pS0dcd2jx_SaY14s%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Feb 26 20:12:45 volumio volumio[684]: verbose: CURRENT POSITION 0 Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::syncState stateService stop Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:45 volumio volumio[684]: info: No code Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:45 volumio volumio[684]: info: ControllerMpd::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::servicePushState Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:45 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:45 volumio volumio[684]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Compared to What","artist":"Roberta Flack","album":"First Take","uri":"https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582762&ei=Ctu-Z-7HJd-x2roPp_m7uAc&ip=220.235.46.25&id=o-AMfxbBH2S3uo_VPeR6E1edFA6iJZdXJU_8hOdP0Vm9pL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561162%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3w6G7lf3b2GOizV00RSgLP8J_xOSLO-FfZPsavep51OGgTO6z33bMV8vO48hWsu9nWFhsj3GD2R&spc=RjZbSU7tpdrjtBCNYZzbG6dWCWwZpJrDb68MjBnGVJNJn5e8JIWWXGElz9pMdcy4I2FvUiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Wgzrxt-ZyJgzHpr83i4gWTIQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=fDEMRkD34Ioixg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AFVRHeAwRQIgBJZZrm65BjNcgK-oV11RDrb4g6aNOWSC4rkj9ugh-cACIQDFKOUX7DN7rKnTC2GlknwY5etqKNvIgNsf8hGyQF8dhA%3D%3D&sig=AJfQdSswRgIhAP5WFgLDQxeWGggFH3AaRSXGnhUPdp3DGocno0UAagQIAiEAodP_hX03vjE2BCRAMwIPusWruI8pS0dcd2jx_SaY14s%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Feb 26 20:12:45 volumio volumio[684]: verbose: CURRENT POSITION 0 Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::syncState stateService stop Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:45 volumio volumio[684]: info: No code Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:45 volumio volumio[684]: info: ControllerMpd::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::servicePushState Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:45 volumio volumio[684]: info: CorePlayQueue::getTrack 0 Feb 26 20:12:45 volumio volumio[684]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Compared to What","artist":"Roberta Flack","album":"First Take","uri":"https://rr2---sn-u2bpouxgoxu-jcgl.googlevideo.com/videoplayback?expire=1740582762&ei=Ctu-Z-7HJd-x2roPp_m7uAc&ip=220.235.46.25&id=o-AMfxbBH2S3uo_VPeR6E1edFA6iJZdXJU_8hOdP0Vm9pL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1740561162%2C&mh=lQ&mm=31%2C29&mn=sn-u2bpouxgoxu-jcgl%2Csn-ntqe6n76&ms=au%2Crdu&mv=m&mvi=2&pl=21&rms=au%2Cau&gcr=au&initcwndbps=3225000&bui=AUWDL3w6G7lf3b2GOizV00RSgLP8J_xOSLO-FfZPsavep51OGgTO6z33bMV8vO48hWsu9nWFhsj3GD2R&spc=RjZbSU7tpdrjtBCNYZzbG6dWCWwZpJrDb68MjBnGVJNJn5e8JIWWXGElz9pMdcy4I2FvUiA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Wgzrxt-ZyJgzHpr83i4gWTIQ&rqh=1&gir=yes&clen=5267942&dur=316.181&lmt=1714899952180766&mt=1740560691&fvip=4&keepalive=yes&fexp=51326932&c=WEB_REMIX&sefc=1&txp=1432434&n=fDEMRkD34Ioixg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AFVRHeAwRQIgBJZZrm65BjNcgK-oV11RDrb4g6aNOWSC4rkj9ugh-cACIQDFKOUX7DN7rKnTC2GlknwY5etqKNvIgNsf8hGyQF8dhA%3D%3D&sig=AJfQdSswRgIhAP5WFgLDQxeWGggFH3AaRSXGnhUPdp3DGocno0UAagQIAiEAodP_hX03vjE2BCRAMwIPusWruI8pS0dcd2jx_SaY14s%3D&pot=MnjfE9Lp-zU5PN8vcTsqxdKw-0nifsyyzEXJUB1ETvgtYvB19HbGHqM25nLN0r4jPEH_Z53tjFv8nbyOoTE-tTxmZXBw35jSZCVFo68G7HJxmbSyuQHx4_F6TnELHXeYxitRRhX-lnwy5dqj6JLdShwwQRov4Yo5Ffw%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Feb 26 20:12:45 volumio volumio[684]: verbose: CURRENT POSITION 0 Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::syncState stateService stop Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:45 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:45 volumio volumio[684]: info: No code Feb 26 20:12:45 volumio volumio[684]: info: CoreStateMachine::pushState Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioPushState Feb 26 20:12:46 volumio volumio[684]: info: ------------------------------ 475ms Feb 26 20:12:46 volumio volumio[684]: info: ------------------------------ 475ms Feb 26 20:12:46 volumio volumio[684]: info: ------------------------------ 466ms Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:12:46 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:12:46 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:12:57 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:12:57 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:12:57 volumio volumio[684]: info: Discovery: Getting this device information Feb 26 20:12:57 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:12:57 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:12:57 volumio volumio[684]: verbose: New Socket.io Connection to 192.168.1.100:3000 from 192.168.1.108 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 26 20:12:57 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:12:57 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 26 20:12:57 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 26 20:12:58 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:12:58 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:12:58 volumio volumio[684]: info: Discovery: Getting this device information Feb 26 20:12:58 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:12:58 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:13:05 volumio sudo[6496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:13:05 volumio sudo[6496]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:13:05 volumio sudo[6496]: pam_unix(sudo:session): session closed for user root Feb 26 20:13:05 volumio sudo[6498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:13:05 volumio sudo[6498]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:13:05 volumio sudo[6498]: pam_unix(sudo:session): session closed for user root Feb 26 20:13:05 volumio volumio[684]: verbose: New Socket.io Connection to 192.168.1.100 from 192.168.1.108 UA: Mozilla/5.0 (Linux; Android 14; SM-A356E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.121 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 26 20:13:05 volumio volumio[684]: info: CoreCommandRouter::volumioGetVisibleSources Feb 26 20:13:05 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:13:05 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 26 20:13:05 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:13:05 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 26 20:13:05 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 26 20:13:05 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 26 20:13:05 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 20:13:06 volumio sudo[6504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:13:06 volumio sudo[6504]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:13:06 volumio sudo[6504]: pam_unix(sudo:session): session closed for user root Feb 26 20:13:06 volumio sudo[6506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:13:06 volumio sudo[6506]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:13:06 volumio sudo[6506]: pam_unix(sudo:session): session closed for user root Feb 26 20:13:06 volumio volumio[684]: verbose: New Socket.io Connection to 192.168.1.100 from 192.168.1.108 UA: Mozilla/5.0 (Linux; Android 14; SM-A356E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.121 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 26 20:13:06 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:13:06 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 26 20:13:06 volumio volumio[684]: info: Listing playlists Feb 26 20:13:06 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 26 20:13:06 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 26 20:13:06 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 26 20:13:06 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 20:13:09 volumio volumio[684]: info: CoreCommandRouter::volumioGetVisibleSources Feb 26 20:13:09 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:13:09 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:13:09 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:13:09 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:13:11 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 26 20:13:11 volumio volumio[684]: info: CURURI: music-library Feb 26 20:13:11 volumio mpd[1022]: exception: No database Feb 26 20:13:11 volumio volumio[684]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database Feb 26 20:13:11 volumio volumio[684]: info: Preload queue cleared Feb 26 20:13:14 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: error: error Feb 26 20:13:15 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 26 20:13:15 volumio volumio[684]: info: CURURI: albums:// Feb 26 20:13:15 volumio mpd[1022]: exception: No database Feb 26 20:13:16 volumio volumio[684]: error: error Feb 26 20:13:16 volumio volumio[684]: error: error Feb 26 20:13:16 volumio volumio[684]: error: Failed to execute browseSource: Error: Cannot list albums Feb 26 20:13:16 volumio volumio[684]: error: error Feb 26 20:13:16 volumio volumio[684]: error: error Feb 26 20:13:23 volumio sudo[6582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:13:23 volumio sudo[6582]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:13:23 volumio sudo[6582]: pam_unix(sudo:session): session closed for user root Feb 26 20:13:23 volumio sudo[6584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:13:23 volumio sudo[6584]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:13:23 volumio sudo[6584]: pam_unix(sudo:session): session closed for user root Feb 26 20:13:23 volumio volumio[684]: verbose: New Socket.io Connection to 192.168.1.100 from 192.168.1.108 UA: Mozilla/5.0 (Linux; Android 14; SM-A356E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.121 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 26 20:13:23 volumio volumio[684]: info: CoreCommandRouter::volumioGetVisibleSources Feb 26 20:13:23 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:13:23 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 26 20:13:23 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:13:23 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 26 20:13:23 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 26 20:13:23 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 26 20:13:23 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 20:13:24 volumio sudo[6590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:13:24 volumio sudo[6590]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:13:24 volumio sudo[6590]: pam_unix(sudo:session): session closed for user root Feb 26 20:13:24 volumio sudo[6592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:13:24 volumio sudo[6592]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:13:24 volumio sudo[6592]: pam_unix(sudo:session): session closed for user root Feb 26 20:13:24 volumio volumio[684]: verbose: New Socket.io Connection to 192.168.1.100 from 192.168.1.108 UA: Mozilla/5.0 (Linux; Android 14; SM-A356E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.121 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 26 20:13:24 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:13:24 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 26 20:13:24 volumio volumio[684]: info: Listing playlists Feb 26 20:13:24 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 26 20:13:24 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 26 20:13:24 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 26 20:13:24 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 20:13:25 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 20:13:25 volumio volumio[684]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 26 20:13:25 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 26 20:13:25 volumio volumio[684]: info: Received Get System Version Feb 26 20:13:25 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:13:25 volumio volumio[684]: info: Received Get System Info Feb 26 20:13:25 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:13:25 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:13:25 volumio volumio[684]: info: Discovery: Getting this device information Feb 26 20:13:25 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:13:25 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:13:26 volumio volumio[684]: info: CoreCommandRouter::volumioGetVisibleSources Feb 26 20:13:26 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:13:26 volumio volumio[684]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:13:26 volumio volumio[684]: info: CoreStateMachine::getQueue Feb 26 20:13:26 volumio volumio[684]: info: CorePlayQueue::getQueue Feb 26 20:13:27 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 20:13:27 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 20:13:27 volumio volumio[684]: info: Discovery: Getting this device information Feb 26 20:13:27 volumio volumio[684]: info: CoreCommandRouter::volumioGetState Feb 26 20:13:27 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 20:13:29 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 26 20:13:29 volumio volumio[684]: info: Preload queue cleared Feb 26 20:13:30 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 26 20:13:31 volumio volumio[684]: info: Preload queue cleared Feb 26 20:13:33 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 26 20:13:33 volumio volumio[684]: info: Preload queue cleared Feb 26 20:13:38 volumio volumio[684]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 26 20:13:39 volumio volumio[684]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:13:39 volumio volumio[684]: TypeError: Cannot read property 'length' of undefined Feb 26 20:13:39 volumio volumio[684]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Feb 26 20:13:39 volumio volumio[684]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Feb 26 20:13:39 volumio volumio[684]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Feb 26 20:13:39 volumio volumio[684]: at Parser.emit (events.js:315:20) Feb 26 20:13:39 volumio volumio[684]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Feb 26 20:13:39 volumio volumio[684]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Feb 26 20:13:39 volumio volumio[684]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Feb 26 20:13:39 volumio volumio[684]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Feb 26 20:13:39 volumio volumio[684]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Feb 26 20:13:39 volumio volumio[684]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Feb 26 20:13:39 volumio volumio[684]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Feb 26 20:13:39 volumio volumio[684]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Feb 26 20:13:39 volumio volumio[684]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Feb 26 20:13:39 volumio volumio[684]: at IncomingMessage.emit (events.js:327:22) Feb 26 20:13:39 volumio volumio[684]: at endReadableNT (internal/streams/readable.js:1327:12) Feb 26 20:13:39 volumio volumio[684]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 26 20:13:39 volumio volumio[684]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:13:43 volumio sudo[6640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-26 20:12 Feb 26 20:13:43 volumio sudo[6640]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"