-- Logs begin at Thu 2019-02-14 17:12:00 +07, end at Mon 2024-08-26 13:21:43 +07. -- Aug 26 13:20:07 music sudo[4128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 13:20:07 music sudo[4128]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 13:20:07 music sudo[4128]: pam_unix(sudo:session): session closed for user root Aug 26 13:20:07 music sudo[4131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 13:20:07 music sudo[4131]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 13:20:07 music sudo[4131]: pam_unix(sudo:session): session closed for user root Aug 26 13:20:07 music volumio[1043]: verbose: New Socket.io Connection to 192.169.1.150 from 192.169.1.218 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 13:20:08 music volumio[1043]: info: Received Get System Info Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:20:08 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:20:08 music volumio[1043]: info: Listing playlists Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 13:20:08 music volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:20:10 music sudo[4140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 13:20:10 music sudo[4140]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 13:20:10 music sudo[4140]: pam_unix(sudo:session): session closed for user root Aug 26 13:20:10 music sudo[4143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 13:20:10 music sudo[4143]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 13:20:10 music sudo[4143]: pam_unix(sudo:session): session closed for user root Aug 26 13:20:11 music volumio[1043]: verbose: New Socket.io Connection to 192.169.1.150 from 192.169.1.218 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 13:20:11 music volumio[1043]: info: Received Get System Info Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:20:11 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:20:11 music volumio[1043]: info: Listing playlists Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 13:20:11 music volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:20:12 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:20:12 music volumio[1043]: info: Received Get System Info Aug 26 13:20:12 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:20:12 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:20:12 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:20:12 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:20:12 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:20:12 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 13:20:13 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 26 13:20:15 music ntpd[810]: Soliciting pool server 2a0c:b847:ffff:79::e53c Aug 26 13:20:15 music volumio[1043]: info: CoreCommandRouter::volumioGetQueue Aug 26 13:20:15 music volumio[1043]: info: CoreStateMachine::getQueue Aug 26 13:20:15 music volumio[1043]: info: CorePlayQueue::getQueue Aug 26 13:20:17 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:20:17 music volumio[1043]: info: Received Get System Info Aug 26 13:20:17 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:20:17 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:20:17 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:20:17 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:20:17 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:20:20 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 26 13:20:23 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:20:23 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 13:20:23 music volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:20:29 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 13:20:29 music volumio[1043]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 26 13:20:29 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 26 13:20:29 music volumio[1043]: info: Received Get System Version Aug 26 13:20:29 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 13:20:29 music volumio[1043]: info: Received Get System Info Aug 26 13:20:29 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:20:29 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:20:29 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:20:29 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:20:29 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:20:31 music volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:20:38 music volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:20:38 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 26 13:20:38 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 26 13:20:38 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 26 13:20:38 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Aug 26 13:20:39 music volumio[1043]: info: Received Get System Version Aug 26 13:20:39 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 13:20:42 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:20:42 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 13:20:43 music volumio[1043]: info: CorePlayQueue::getTrack 2 Aug 26 13:20:43 music volumio[1043]: info: CorePlayQueue::getTrack 3 Aug 26 13:20:43 music volumio[1043]: info: Prefetching next song Aug 26 13:20:44 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-8qj-i5ozr.googlevideo.com/videoplayback?expire=1724674843&ei=ux7MZuzGLoyK2roP7P6OoAc&ip=113.160.5.174&id=o-AHAN-sZapBcE86ikfAAHeeQiNTY2YwXPtqjljj0Zf8Mz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=HN&mm=31%2C29&mn=sn-8qj-i5ozr%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=1&pl=23&gcr=vn&initcwndbps=1722500&siu=1&bui=AQmm2ezo9T_nsp1JBNGT8l63Mebh9WOB-LJGnGLaK8oy_kRluXwkVONr6j4g0XM-s4nDU-R01A&spc=Mv1m9nHv_G_7k62CFBqUR5XzSPQ8h-qf1FRPDe5Bqi1NgmnquEqmDz2VYS3H3AQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=yzkEMAeGVxPyp4-3I3jMsJEQ&rqh=1&gir=yes&clen=3843149&dur=238.681&lmt=1715045120742411&mt=1724652770&fvip=2&keepalive=yes&c=WEB&sefc=1&txp=4532434&n=SAkyGYOlCBSwFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgJ8yGcEuuOBauTslTFPodWW5eOkz6vSkAvJ_YVjfiCyoCIQD2ivCxZYDVpLwJjOcCoy4EPVcGOhVa_JkPYWeRrQxi5g%3D%3D&sig=AJfQdSswRgIhAOK17ar807jQwjoXZIWXm05NZGk9AVs5L7UB-QkDbKrmAiEAs6lzNgd4ek3SKOCy_LlVLt6PJWiOS3gp-9sNkkM6kmU%3D&cver=2.20230104.01.00&t.YouTube" Aug 26 13:20:44 music volumio[1043]: info: Aug 26 13:20:44 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:44 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:44 music volumio[1043]: info: sendMpdCommand addid "https://rr1---sn-8qj-i5ozr.googlevideo.com/videoplayback?expire=1724674843&ei=ux7MZuzGLoyK2roP7P6OoAc&ip=113.160.5.174&id=o-AHAN-sZapBcE86ikfAAHeeQiNTY2YwXPtqjljj0Zf8Mz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=HN&mm=31%2C29&mn=sn-8qj-i5ozr%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=1&pl=23&gcr=vn&initcwndbps=1722500&siu=1&bui=AQmm2ezo9T_nsp1JBNGT8l63Mebh9WOB-LJGnGLaK8oy_kRluXwkVONr6j4g0XM-s4nDU-R01A&spc=Mv1m9nHv_G_7k62CFBqUR5XzSPQ8h-qf1FRPDe5Bqi1NgmnquEqmDz2VYS3H3AQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=yzkEMAeGVxPyp4-3I3jMsJEQ&rqh=1&gir=yes&clen=3843149&dur=238.681&lmt=1715045120742411&mt=1724652770&fvip=2&keepalive=yes&c=WEB&sefc=1&txp=4532434&n=SAkyGYOlCBSwFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgJ8yGcEuuOBauTslTFPodWW5eOkz6vSkAvJ_YVjfiCyoCIQD2ivCxZYDVpLwJjOcCoy4EPVcGOhVa_JkPYWeRrQxi5g%3D%3D&sig=AJfQdSswRgIhAOK17ar807jQwjoXZIWXm05NZGk9AVs5L7UB-QkDbKrmAiEAs6lzNgd4ek3SKOCy_LlVLt6PJWiOS3gp-9sNkkM6kmU%3D&cver=2.20230104.01.00&t.YouTube" took 54 milliseconds Aug 26 13:20:44 music volumio[1043]: verbose: MPD COMMAND [object Object] Aug 26 13:20:44 music volumio[1043]: verbose: MPD COMMAND [object Object] Aug 26 13:20:44 music volumio[1043]: info: Aug 26 13:20:44 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:44 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:44 music volumio[1043]: info: Aug 26 13:20:44 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:44 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:44 music volumio[1043]: info: Aug 26 13:20:44 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:44 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:44 music volumio[1043]: info: Aug 26 13:20:44 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:44 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:44 music volumio[1043]: info: ------------------------------ 38ms Aug 26 13:20:44 music volumio[1043]: info: ------------------------------ 18ms Aug 26 13:20:44 music volumio[1043]: info: ------------------------------ 15ms Aug 26 13:20:44 music volumio[1043]: info: ------------------------------ 14ms Aug 26 13:20:44 music volumio[1043]: info: [youtube2-play] Prefetched and added track to MPD queue: 98º - I Do (Cherish You) Aug 26 13:20:44 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 26 13:20:44 music volumio[1043]: info: Aug 26 13:20:44 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:44 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:44 music volumio[1043]: info: Aug 26 13:20:44 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:44 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:44 music volumio[1043]: info: Aug 26 13:20:44 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:44 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:44 music volumio[1043]: info: ------------------------------ 22ms Aug 26 13:20:44 music volumio[1043]: info: sendMpdCommand consume 1 took 16 milliseconds Aug 26 13:20:44 music volumio[1043]: info: ------------------------------ 14ms Aug 26 13:20:44 music volumio[1043]: info: ------------------------------ 12ms Aug 26 13:20:44 music volumio[1043]: info: ------------------------------ 10ms Aug 26 13:20:47 music volumio[1043]: info: CoreStateMachine::startPlaybackTimer Aug 26 13:20:47 music volumio[1043]: info: CorePlayQueue::getTrack 3 Aug 26 13:20:48 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:48 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 13:20:48 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:48 music volumio[1043]: info: CorePlayQueue::getTrack 3 Aug 26 13:20:48 music volumio[1043]: info: ControllerMpd::getState Aug 26 13:20:48 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand status Aug 26 13:20:48 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:48 music volumio[1043]: info: sendMpdCommand status took 41 milliseconds Aug 26 13:20:48 music volumio[1043]: verbose: ControllerMpd::parseState Aug 26 13:20:48 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 13:20:48 music volumio[1043]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 26 13:20:48 music volumio[1043]: verbose: ControllerMpd::parseTrackInfo Aug 26 13:20:48 music volumio[1043]: info: ControllerMpd::pushState Aug 26 13:20:48 music volumio[1043]: info: CoreCommandRouter::servicePushState Aug 26 13:20:48 music volumio[1043]: info: CorePlayQueue::getTrack 3 Aug 26 13:20:48 music volumio[1043]: verbose: STATE SERVICE {"status":"play","position":0,"seek":216962,"duration":219,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Westlife - If I Let You Go (Official Video)","artist":"westlifeVEVO","album":"YouTube","uri":"https://rr1---sn-8qj-i5ozr.googlevideo.com/videoplayback?expire=1724674625&ei=4R3MZtjTC_q12roP46HP-A4&ip=113.160.5.174&id=o-ALbB55W7j29teht04-jgWhfrnK60NzAMCjkKUYom9Z4g&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=ur&mm=31%2C29&mn=sn-8qj-i5ozr%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=23&gcr=vn&initcwndbps=1731250&siu=1&bui=AQmm2exW6uXG4BY_q_JSaOksZ1cTZbRwBNQJDnyyltGfXlFXqvnCjVbwLA5TR78a09tV9G9BBA&spc=Mv1m9sUHQu-7xMznderm_7EA0GCyQbtUlMKgIFg60dujmmxsJLN78hOISYRaQo4&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=VS9VwBry6ri4l8xjNT8TEbsQ&rqh=1&gir=yes&clen=3614453&dur=218.661&lmt=1714511541421545&mt=1724652531&fvip=8&keepalive=yes&c=WEB&sefc=1&txp=4532434&n=0tnv4ngzQbC_Hg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgIzsvtQz5jcDqrr6YgCUbklD7YVqrJ0qwmav1LF9S8UQCIQDu9rTUqMuxPXpEm_-kQY87Vd-AK0W5AqSGCwC0Esdh0A%3D%3D&sig=AJfQdSswRQIhAJYg4AvrKAqyf415IxuG0oIUKzvdfl-koTHOL3V4AJHuAiBbcBd-wXfHFjoNGNPvPgGRv6KTNrVmuget0QO5Rzhf7Q%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 26 13:20:48 music volumio[1043]: verbose: CURRENT POSITION 3 Aug 26 13:20:48 music volumio[1043]: info: CoreStateMachine::syncState stateService play Aug 26 13:20:48 music volumio[1043]: info: CoreStateMachine::syncState currentStatus play Aug 26 13:20:48 music volumio[1043]: info: Received an update from plugin. extracting info from payload Aug 26 13:20:48 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:48 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 13:20:48 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:48 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:48 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:48 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:48 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:50 music volumio[1043]: info: Aug 26 13:20:50 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:50 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:50 music volumio[1043]: info: ControllerMpd::getState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand status Aug 26 13:20:50 music volumio[1043]: info: Aug 26 13:20:50 music volumio[1043]: ---------------------------- MPD announces state update: player Aug 26 13:20:50 music volumio[1043]: info: ControllerMpd::getState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand status Aug 26 13:20:50 music volumio[1043]: info: Aug 26 13:20:50 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:50 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:50 music volumio[1043]: info: Aug 26 13:20:50 music volumio[1043]: ---------------------------- MPD announces state update: player Aug 26 13:20:50 music volumio[1043]: info: ControllerMpd::getState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand status Aug 26 13:20:50 music volumio[1043]: info: Aug 26 13:20:50 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:50 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:50 music volumio[1043]: info: Aug 26 13:20:50 music volumio[1043]: ---------------------------- MPD announces state update: player Aug 26 13:20:50 music volumio[1043]: info: ControllerMpd::getState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand status Aug 26 13:20:50 music volumio[1043]: info: Aug 26 13:20:50 music volumio[1043]: ---------------------------- MPD announces system playlist update Aug 26 13:20:50 music volumio[1043]: info: Ignoring MPD Status Update Aug 26 13:20:50 music volumio[1043]: info: Aug 26 13:20:50 music volumio[1043]: ---------------------------- MPD announces state update: player Aug 26 13:20:50 music volumio[1043]: info: ControllerMpd::getState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand status Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand status took 29 milliseconds Aug 26 13:20:50 music volumio[1043]: info: ------------------------------ 33ms Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand status took 27 milliseconds Aug 26 13:20:50 music volumio[1043]: info: ------------------------------ 26ms Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand status took 24 milliseconds Aug 26 13:20:50 music volumio[1043]: info: ------------------------------ 22ms Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand status took 20 milliseconds Aug 26 13:20:50 music volumio[1043]: info: ------------------------------ 18ms Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand status took 16 milliseconds Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseState Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand playlistinfo took 11 milliseconds Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand playlistinfo took 11 milliseconds Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 26 13:20:50 music volumio[1043]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseTrackInfo Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseTrackInfo Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseTrackInfo Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseTrackInfo Aug 26 13:20:50 music volumio[1043]: verbose: ControllerMpd::parseTrackInfo Aug 26 13:20:50 music volumio[1043]: info: ControllerMpd::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::servicePushState Aug 26 13:20:50 music volumio[1043]: info: CorePlayQueue::getTrack 3 Aug 26 13:20:50 music volumio[1043]: verbose: STATE SERVICE {"status":"play","position":0,"seek":53,"duration":239,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"98º - I Do (Cherish You)","artist":"98DegreesVEVO","album":"YouTube","uri":"https://rr1---sn-8qj-i5ozr.googlevideo.com/videoplayback?expire=1724674843&ei=ux7MZuzGLoyK2roP7P6OoAc&ip=113.160.5.174&id=o-AHAN-sZapBcE86ikfAAHeeQiNTY2YwXPtqjljj0Zf8Mz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=HN&mm=31%2C29&mn=sn-8qj-i5ozr%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=1&pl=23&gcr=vn&initcwndbps=1722500&siu=1&bui=AQmm2ezo9T_nsp1JBNGT8l63Mebh9WOB-LJGnGLaK8oy_kRluXwkVONr6j4g0XM-s4nDU-R01A&spc=Mv1m9nHv_G_7k62CFBqUR5XzSPQ8h-qf1FRPDe5Bqi1NgmnquEqmDz2VYS3H3AQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=yzkEMAeGVxPyp4-3I3jMsJEQ&rqh=1&gir=yes&clen=3843149&dur=238.681&lmt=1715045120742411&mt=1724652770&fvip=2&keepalive=yes&c=WEB&sefc=1&txp=4532434&n=SAkyGYOlCBSwFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgJ8yGcEuuOBauTslTFPodWW5eOkz6vSkAvJ_YVjfiCyoCIQD2ivCxZYDVpLwJjOcCoy4EPVcGOhVa_JkPYWeRrQxi5g%3D%3D&sig=AJfQdSswRgIhAOK17ar807jQwjoXZIWXm05NZGk9AVs5L7UB-QkDbKrmAiEAs6lzNgd4ek3SKOCy_LlVLt6PJWiOS3gp-9sNkkM6kmU%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 26 13:20:50 music volumio[1043]: verbose: CURRENT POSITION 3 Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::syncState stateService play Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::syncState currentStatus play Aug 26 13:20:50 music volumio[1043]: info: Received an update from plugin. extracting info from payload Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:50 music volumio[1043]: info: ControllerMpd::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::servicePushState Aug 26 13:20:50 music volumio[1043]: info: CorePlayQueue::getTrack 3 Aug 26 13:20:50 music volumio[1043]: verbose: STATE SERVICE {"status":"play","position":0,"seek":53,"duration":239,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"98º - I Do (Cherish You)","artist":"98DegreesVEVO","album":"YouTube","uri":"https://rr1---sn-8qj-i5ozr.googlevideo.com/videoplayback?expire=1724674843&ei=ux7MZuzGLoyK2roP7P6OoAc&ip=113.160.5.174&id=o-AHAN-sZapBcE86ikfAAHeeQiNTY2YwXPtqjljj0Zf8Mz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=HN&mm=31%2C29&mn=sn-8qj-i5ozr%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=1&pl=23&gcr=vn&initcwndbps=1722500&siu=1&bui=AQmm2ezo9T_nsp1JBNGT8l63Mebh9WOB-LJGnGLaK8oy_kRluXwkVONr6j4g0XM-s4nDU-R01A&spc=Mv1m9nHv_G_7k62CFBqUR5XzSPQ8h-qf1FRPDe5Bqi1NgmnquEqmDz2VYS3H3AQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=yzkEMAeGVxPyp4-3I3jMsJEQ&rqh=1&gir=yes&clen=3843149&dur=238.681&lmt=1715045120742411&mt=1724652770&fvip=2&keepalive=yes&c=WEB&sefc=1&txp=4532434&n=SAkyGYOlCBSwFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgJ8yGcEuuOBauTslTFPodWW5eOkz6vSkAvJ_YVjfiCyoCIQD2ivCxZYDVpLwJjOcCoy4EPVcGOhVa_JkPYWeRrQxi5g%3D%3D&sig=AJfQdSswRgIhAOK17ar807jQwjoXZIWXm05NZGk9AVs5L7UB-QkDbKrmAiEAs6lzNgd4ek3SKOCy_LlVLt6PJWiOS3gp-9sNkkM6kmU%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 26 13:20:50 music volumio[1043]: verbose: CURRENT POSITION 3 Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::syncState stateService play Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::syncState currentStatus play Aug 26 13:20:50 music volumio[1043]: info: Received an update from plugin. extracting info from payload Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:50 music volumio[1043]: info: ControllerMpd::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::servicePushState Aug 26 13:20:50 music volumio[1043]: info: CorePlayQueue::getTrack 3 Aug 26 13:20:50 music volumio[1043]: verbose: STATE SERVICE {"status":"play","position":0,"seek":53,"duration":239,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"98º - I Do (Cherish You)","artist":"98DegreesVEVO","album":"YouTube","uri":"https://rr1---sn-8qj-i5ozr.googlevideo.com/videoplayback?expire=1724674843&ei=ux7MZuzGLoyK2roP7P6OoAc&ip=113.160.5.174&id=o-AHAN-sZapBcE86ikfAAHeeQiNTY2YwXPtqjljj0Zf8Mz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=HN&mm=31%2C29&mn=sn-8qj-i5ozr%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=1&pl=23&gcr=vn&initcwndbps=1722500&siu=1&bui=AQmm2ezo9T_nsp1JBNGT8l63Mebh9WOB-LJGnGLaK8oy_kRluXwkVONr6j4g0XM-s4nDU-R01A&spc=Mv1m9nHv_G_7k62CFBqUR5XzSPQ8h-qf1FRPDe5Bqi1NgmnquEqmDz2VYS3H3AQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=yzkEMAeGVxPyp4-3I3jMsJEQ&rqh=1&gir=yes&clen=3843149&dur=238.681&lmt=1715045120742411&mt=1724652770&fvip=2&keepalive=yes&c=WEB&sefc=1&txp=4532434&n=SAkyGYOlCBSwFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgJ8yGcEuuOBauTslTFPodWW5eOkz6vSkAvJ_YVjfiCyoCIQD2ivCxZYDVpLwJjOcCoy4EPVcGOhVa_JkPYWeRrQxi5g%3D%3D&sig=AJfQdSswRgIhAOK17ar807jQwjoXZIWXm05NZGk9AVs5L7UB-QkDbKrmAiEAs6lzNgd4ek3SKOCy_LlVLt6PJWiOS3gp-9sNkkM6kmU%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 26 13:20:50 music volumio[1043]: verbose: CURRENT POSITION 3 Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::syncState stateService play Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::syncState currentStatus play Aug 26 13:20:50 music volumio[1043]: info: Received an update from plugin. extracting info from payload Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:50 music volumio[1043]: info: ControllerMpd::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::servicePushState Aug 26 13:20:50 music volumio[1043]: info: CorePlayQueue::getTrack 3 Aug 26 13:20:50 music volumio[1043]: verbose: STATE SERVICE {"status":"play","position":0,"seek":53,"duration":239,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"98º - I Do (Cherish You)","artist":"98DegreesVEVO","album":"YouTube","uri":"https://rr1---sn-8qj-i5ozr.googlevideo.com/videoplayback?expire=1724674843&ei=ux7MZuzGLoyK2roP7P6OoAc&ip=113.160.5.174&id=o-AHAN-sZapBcE86ikfAAHeeQiNTY2YwXPtqjljj0Zf8Mz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=HN&mm=31%2C29&mn=sn-8qj-i5ozr%2Csn-8qj-i5ody&ms=au%2Crdu&mv=m&mvi=1&pl=23&gcr=vn&initcwndbps=1722500&siu=1&bui=AQmm2ezo9T_nsp1JBNGT8l63Mebh9WOB-LJGnGLaK8oy_kRluXwkVONr6j4g0XM-s4nDU-R01A&spc=Mv1m9nHv_G_7k62CFBqUR5XzSPQ8h-qf1FRPDe5Bqi1NgmnquEqmDz2VYS3H3AQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=yzkEMAeGVxPyp4-3I3jMsJEQ&rqh=1&gir=yes&clen=3843149&dur=238.681&lmt=1715045120742411&mt=1724652770&fvip=2&keepalive=yes&c=WEB&sefc=1&txp=4532434&n=SAkyGYOlCBSwFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AGtxev0wRQIgJ8yGcEuuOBauTslTFPodWW5eOkz6vSkAvJ_YVjfiCyoCIQD2ivCxZYDVpLwJjOcCoy4EPVcGOhVa_JkPYWeRrQxi5g%3D%3D&sig=AJfQdSswRgIhAOK17ar807jQwjoXZIWXm05NZGk9AVs5L7UB-QkDbKrmAiEAs6lzNgd4ek3SKOCy_LlVLt6PJWiOS3gp-9sNkkM6kmU%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Aug 26 13:20:50 music volumio[1043]: verbose: CURRENT POSITION 3 Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::syncState stateService play Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::syncState currentStatus play Aug 26 13:20:50 music volumio[1043]: info: Received an update from plugin. extracting info from payload Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:50 music volumio[1043]: info: CoreStateMachine::pushState Aug 26 13:20:50 music volumio[1043]: info: CoreCommandRouter::volumioPushState Aug 26 13:20:50 music volumio[1043]: info: ------------------------------ 254ms Aug 26 13:20:50 music volumio[1043]: info: ------------------------------ 250ms Aug 26 13:20:50 music volumio[1043]: info: ------------------------------ 246ms Aug 26 13:20:50 music volumio[1043]: info: ------------------------------ 245ms Aug 26 13:20:50 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:50 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:50 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:50 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:50 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:50 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:50 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:50 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:20:51 music volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:20:51 music volumio[1043]: info: [ytmusic] InnertubeLoader: creating Innertube instance... Aug 26 13:21:01 music volumio-remote-updater[602]: [2024-08-26 13:21:01] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Aug 26 13:21:05 music volumio[1043]: info: [ytmusic] InnertubeLoader: creating Auth instance... Aug 26 13:21:05 music volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:21:05 music volumio[1043]: info: [ytmusic] Auth success Aug 26 13:21:05 music volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:21:05 music volumio[1043]: info: [ytmusic] InnertubeLoader: Auth instance created (status: signed in) Aug 26 13:21:06 music volumio[1043]: Upnp client error: Error: This socket has been ended by the other party Aug 26 13:21:06 music volumio[1043]: Upnp client error: Error: This socket has been ended by the other party Aug 26 13:21:06 music volumio[1043]: Upnp client error: Error: This socket has been ended by the other party Aug 26 13:21:06 music volumio[1043]: Upnp client error: Error: This socket has been ended by the other party Aug 26 13:21:06 music volumio[1043]: Upnp client error: Error: This socket has been ended by the other party Aug 26 13:21:06 music volumio-remote-updater[602]: [2024-08-26 13:21:06] [connect] Successful connection Aug 26 13:21:06 music volumio-remote-updater[602]: [2024-08-26 13:21:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724653266 101 Aug 26 13:21:06 music volumio[1043]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Aug 26 13:21:06 music volumio[1043]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 26 13:21:06 music volumio[1043]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 26 13:21:07 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:21:07 music volumio[1043]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 26 13:21:07 music volumio[1043]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 26 13:21:07 music volumio[1043]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 26 13:21:07 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:21:07 music volumio[1043]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 26 13:21:10 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:21:10 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 13:21:20 music ntpd[810]: Soliciting pool server 2a0c:b847:ffff:79::e53c Aug 26 13:21:30 music sudo[4335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 13:21:30 music sudo[4335]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 13:21:30 music sudo[4335]: pam_unix(sudo:session): session closed for user root Aug 26 13:21:30 music sudo[4338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 13:21:30 music sudo[4338]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 13:21:30 music sudo[4338]: pam_unix(sudo:session): session closed for user root Aug 26 13:21:30 music volumio[1043]: verbose: New Socket.io Connection to 192.169.1.150 from 192.169.1.218 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 13:21:31 music volumio[1043]: info: Received Get System Info Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:21:31 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:21:31 music volumio[1043]: info: Listing playlists Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 13:21:31 music volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:21:32 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:21:32 music volumio[1043]: info: Received Get System Info Aug 26 13:21:32 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:21:32 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:21:32 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:21:32 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:21:32 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:21:32 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 13:21:33 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 26 13:21:34 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:21:34 music volumio[1043]: info: Received Get System Info Aug 26 13:21:34 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:21:34 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:21:34 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:21:34 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:21:34 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:21:36 music volumio[1043]: info: Received Get System Info Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:21:36 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:21:36 music volumio[1043]: info: Received Get System Info Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:21:36 music volumio[1043]: info: Discovery: Getting this device information Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::volumioGetState Aug 26 13:21:36 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:21:40 music volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 26 13:21:42 music volumio[1043]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ Aug 26 13:21:42 music volumio[1043]: info: PLUGIN onShutdown : networkfs Aug 26 13:21:42 music volumio[1043]: info: PLUGIN onShutdown : audiophonicsonoff Aug 26 13:21:42 music volumio[1043]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 13:21:42 music volumio[1043]: TypeError: Cannot read property 'writeSync' of undefined Aug 26 13:21:42 music volumio[1043]: at ControllerAudiophonicsOnOff.onVolumioShutdown (/data/plugins/system_controller/audiophonicsonoff/index.js:43:25) Aug 26 13:21:42 music volumio[1043]: at PluginManager.onVolumioShutdownPlugin (/volumio/app/pluginmanager.js:638:30) Aug 26 13:21:42 music volumio[1043]: at HashMap. (/volumio/app/pluginmanager.js:621:31) Aug 26 13:21:42 music volumio[1043]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Aug 26 13:21:42 music volumio[1043]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Aug 26 13:21:42 music volumio[1043]: at PluginManager.onVolumioShutdown (/volumio/app/pluginmanager.js:619:20) Aug 26 13:21:42 music volumio[1043]: at CoreCommandRouter.shutdown (/volumio/app/index.js:1319:24) Aug 26 13:21:42 music volumio[1043]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:859:33) Aug 26 13:21:42 music volumio[1043]: at Socket.emit (events.js:315:20) Aug 26 13:21:42 music volumio[1043]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 26 13:21:42 music volumio[1043]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 26 13:21:42 music volumio[1043]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 13:21:43 music sudo[4374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-26 13:20 Aug 26 13:21:43 music sudo[4374]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"