Aug 28 14:19:02 volumio volumio[13338]: info: CALLMETHOD: audio_interface fusiondsp usethispreset [object Object] Aug 28 14:19:02 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , usethispreset Aug 28 14:19:02 volumio volumio[13338]: info: FusionDsp - Value for usedpreset: Aug 28 14:19:02 volumio volumio[13338]: error: FusionDsp - Value reading JSON file: {"geq15":"3,4,3,3,5,4.5,2.5,0,1.5,1.5,3.5,4,4,2.5,3","state4preset":["None",false,false,50,0,0,0,"None",true,false,false,0,0,false],"x2geq15":"3,4,3,3,5,4.5,2.5,0,1.5,1.5,3.5,4,4,2.5,3"} Aug 28 14:19:02 volumio volumio[13338]: info: FusionDsp - geq15 3,4,3,3,5,4.5,2.5,0,1.5,1.5,3.5,4,4,2.5,3 Aug 28 14:19:02 volumio volumio[13338]: info: FusionDsp - value state4preset None,false,false,50,0,0,0,None,true,false,false,0,0,false Aug 28 14:19:02 volumio volumio[13338]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 28 14:19:03 volumio volumio[13338]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 14:19:03 volumio volumio[13338]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:19:17 volumio volumio[13338]: info: CALLMETHOD: audio_interface fusiondsp installtools Aug 28 14:19:17 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , installtools Aug 28 14:19:21 volumio volumio[13338]: --2026-08-28 14:19:17-- https://github.com/balbuze/volumio-plugins/raw/alsa_modular/plugins/audio_interface/FusionDsp/tools/tools.tar.xz Aug 28 14:19:21 volumio volumio[13338]: Resolving github.com (github.com)... 140.82.121.4 Aug 28 14:19:21 volumio volumio[13338]: Connecting to github.com (github.com)|140.82.121.4|:443... connected. Aug 28 14:19:21 volumio volumio[13338]: HTTP request sent, awaiting response... 302 Found Aug 28 14:19:21 volumio volumio[13338]: Location: https://raw.githubusercontent.com/balbuze/volumio-plugins/alsa_modular/plugins/audio_interface/FusionDsp/tools/tools.tar.xz [following] Aug 28 14:19:21 volumio volumio[13338]: --2026-08-28 14:19:17-- https://raw.githubusercontent.com/balbuze/volumio-plugins/alsa_modular/plugins/audio_interface/FusionDsp/tools/tools.tar.xz Aug 28 14:19:21 volumio volumio[13338]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.108.133, 185.199.111.133, 185.199.110.133, ... Aug 28 14:19:21 volumio volumio[13338]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.108.133|:443... connected. Aug 28 14:19:21 volumio volumio[13338]: HTTP request sent, awaiting response... 200 OK Aug 28 14:19:21 volumio volumio[13338]: Length: 23035700 (22M) [application/octet-stream] Aug 28 14:19:21 volumio volumio[13338]: Saving to: ‘/tmp/tools.tar.xz’ Aug 28 14:19:21 volumio volumio[13338]: 0K .......... .......... .......... .......... .......... 0% 2.49M 9s Aug 28 14:19:21 volumio volumio[13338]: 50K .......... .......... .......... .......... .......... 0% 11.9M 5s Aug 28 14:19:21 volumio volumio[13338]: 100K .......... .......... .......... .......... .......... 0% 4.26M 5s Aug 28 14:19:21 volumio volumio[13338]: 150K .......... .......... .......... .......... .......... 0% 7.73M 5s Aug 28 14:19:21 volumio volumio[13338]: 200K .......... .......... .......... .......... .......... 1% 7.84M 4s Aug 28 14:19:21 volumio volumio[13338]: 250K .......... .......... .......... .......... .......... 1% 7.88M 4s Aug 28 14:19:21 volumio volumio[13338]: 300K .......... .......... .......... .......... .......... 1% 7.66M 4s Aug 28 14:19:21 volumio volumio[13338]: 350K .......... .......... .......... .......... .......... 1% 11.8M 4s Aug 28 14:19:21 volumio volumio[13338]: 400K .......... .......... .......... .......... .......... 2% 11.5M 3s Aug 28 14:19:21 volumio volumio[13338]: 450K .......... .......... .......... .......... .......... 2% 7.56M 3s Aug 28 14:19:21 volumio volumio[13338]: 500K .......... .......... .......... .......... .......... 2% 7.49M 3s Aug 28 14:19:21 volumio volumio[13338]: 550K .......... .......... .......... .......... .......... 2% 11.0M 3s Aug 28 14:19:21 volumio volumio[13338]: 600K .......... .......... .......... .......... .......... 2% 7.61M 3s Aug 28 14:19:21 volumio volumio[13338]: 650K .......... .......... .......... .......... .......... 3% 7.97M 3s Aug 28 14:19:21 volumio volumio[13338]: 700K .......... .......... .......... .......... .......... 3% 11.3M 3s Aug 28 14:19:21 volumio volumio[13338]: 750K .......... .......... .......... .......... .......... 3% 11.5M 3s Aug 28 14:19:21 volumio volumio[13338]: 800K .......... .......... .......... .......... .......... 3% 8.01M 3s Aug 28 14:19:21 volumio volumio[13338]: 850K .......... .......... .......... .......... .......... 4% 7.60M 3s Aug 28 14:19:21 volumio volumio[13338]: 900K .......... .......... .......... .......... .......... 4% 9.25M 3s Aug 28 14:19:21 volumio volumio[13338]: 950K .......... .......... .......... .......... .......... 4% 8.21M 3s Aug 28 14:19:21 volumio volumio[13338]: 1000K .......... .......... .......... .......... .......... 4% 10.4M 3s Aug 28 14:19:21 volumio volumio[13338]: 1050K .......... .......... .......... .......... .......... 4% 7.96M 3s Aug 28 14:19:21 volumio volumio[13338]: 1100K .......... .......... .......... .......... .......... 5% 10.5M 3s Aug 28 14:19:21 volumio volumio[13338]: 1150K .......... .......... .......... .......... .......... 5% 7.46M 3s Aug 28 14:19:21 volumio volumio[13338]: 1200K .......... .......... .......... .......... .......... 5% 10.1M 3s Aug 28 14:19:21 volumio volumio[13338]: 1250K .......... .......... .......... .......... .......... 5% 7.60M 3s Aug 28 14:19:21 volumio volumio[13338]: 1300K .......... .......... .......... .......... .......... 6% 7.09M 3s Aug 28 14:19:21 volumio volumio[13338]: 1350K .......... .......... .......... .......... .......... 6% 9.39M 3s Aug 28 14:19:21 volumio volumio[13338]: 1400K .......... .......... .......... .......... .......... 6% 11.6M 3s Aug 28 14:19:21 volumio volumio[13338]: 1450K .......... .......... .......... .......... .......... 6% 7.38M 3s Aug 28 14:19:21 volumio volumio[13338]: 1500K .......... .......... .......... .......... .......... 6% 10.3M 3s Aug 28 14:19:21 volumio volumio[13338]: 1550K .......... .......... .......... .......... .......... 7% 9.26M 3s Aug 28 14:19:21 volumio volumio[13338]: 1600K .......... .......... .......... .......... .......... 7% 9.19M 3s Aug 28 14:19:21 volumio volumio[13338]: 1650K .......... .......... .......... .......... .......... 7% 5.70M 3s Aug 28 14:19:21 volumio volumio[13338]: 1700K .......... .......... .......... .......... .......... 7% 10.4M 3s Aug 28 14:19:21 volumio volumio[13338]: 1750K .......... .......... .......... .......... .......... 8% 8.38M 3s Aug 28 14:19:21 volumio volumio[13338]: 1800K .......... .......... .......... .......... .......... 8% 11.4M 3s Aug 28 14:19:21 volumio volumio[13338]: 1850K .......... .......... .......... .......... .......... 8% 8.33M 3s Aug 28 14:19:21 volumio volumio[13338]: 1900K .......... .......... .......... .......... .......... 8% 10.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 1950K .......... .......... .......... .......... .......... 8% 9.46M 2s Aug 28 14:19:21 volumio volumio[13338]: 2000K .......... .......... .......... .......... .......... 9% 8.50M 2s Aug 28 14:19:21 volumio volumio[13338]: 2050K .......... .......... .......... .......... .......... 9% 7.64M 2s Aug 28 14:19:21 volumio volumio[13338]: 2100K .......... .......... .......... .......... .......... 9% 6.43M 2s Aug 28 14:19:21 volumio volumio[13338]: 2150K .......... .......... .......... .......... .......... 9% 12.4M 2s Aug 28 14:19:21 volumio volumio[13338]: 2200K .......... .......... .......... .......... .......... 10% 7.90M 2s Aug 28 14:19:21 volumio volumio[13338]: 2250K .......... .......... .......... .......... .......... 10% 9.59M 2s Aug 28 14:19:21 volumio volumio[13338]: 2300K .......... .......... .......... .......... .......... 10% 10.0M 2s Aug 28 14:19:21 volumio volumio[13338]: 2350K .......... .......... .......... .......... .......... 10% 8.17M 2s Aug 28 14:19:21 volumio volumio[13338]: 2400K .......... .......... .......... .......... .......... 10% 11.7M 2s Aug 28 14:19:21 volumio volumio[13338]: 2450K .......... .......... .......... .......... .......... 11% 5.52M 2s Aug 28 14:19:21 volumio volumio[13338]: 2500K .......... .......... .......... .......... .......... 11% 11.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 2550K .......... .......... .......... .......... .......... 11% 11.1M 2s Aug 28 14:19:21 volumio volumio[13338]: 2600K .......... .......... .......... .......... .......... 11% 6.78M 2s Aug 28 14:19:21 volumio volumio[13338]: 2650K .......... .......... .......... .......... .......... 12% 11.8M 2s Aug 28 14:19:21 volumio volumio[13338]: 2700K .......... .......... .......... .......... .......... 12% 7.93M 2s Aug 28 14:19:21 volumio volumio[13338]: 2750K .......... .......... .......... .......... .......... 12% 10.0M 2s Aug 28 14:19:21 volumio volumio[13338]: 2800K .......... .......... .......... .......... .......... 12% 7.54M 2s Aug 28 14:19:21 volumio volumio[13338]: 2850K .......... .......... .......... .......... .......... 12% 6.80M 2s Aug 28 14:19:21 volumio volumio[13338]: 2900K .......... .......... .......... .......... .......... 13% 11.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 2950K .......... .......... .......... .......... .......... 13% 6.81M 2s Aug 28 14:19:21 volumio volumio[13338]: 3000K .......... .......... .......... .......... .......... 13% 12.1M 2s Aug 28 14:19:21 volumio volumio[13338]: 3050K .......... .......... .......... .......... .......... 13% 9.49M 2s Aug 28 14:19:21 volumio volumio[13338]: 3100K .......... .......... .......... .......... .......... 14% 10.3M 2s Aug 28 14:19:21 volumio volumio[13338]: 3150K .......... .......... .......... .......... .......... 14% 9.19M 2s Aug 28 14:19:21 volumio volumio[13338]: 3200K .......... .......... .......... .......... .......... 14% 8.35M 2s Aug 28 14:19:21 volumio volumio[13338]: 3250K .......... .......... .......... .......... .......... 14% 6.11M 2s Aug 28 14:19:21 volumio volumio[13338]: 3300K .......... .......... .......... .......... .......... 14% 11.2M 2s Aug 28 14:19:21 volumio volumio[13338]: 3350K .......... .......... .......... .......... .......... 15% 7.76M 2s Aug 28 14:19:21 volumio volumio[13338]: 3400K .......... .......... .......... .......... .......... 15% 7.68M 2s Aug 28 14:19:21 volumio volumio[13338]: 3450K .......... .......... .......... .......... .......... 15% 5.57M 2s Aug 28 14:19:21 volumio volumio[13338]: 3500K .......... .......... .......... .......... .......... 15% 8.82M 2s Aug 28 14:19:21 volumio volumio[13338]: 3550K .......... .......... .......... .......... .......... 16% 11.8M 2s Aug 28 14:19:21 volumio volumio[13338]: 3600K .......... .......... .......... .......... .......... 16% 17.3M 2s Aug 28 14:19:21 volumio volumio[13338]: 3650K .......... .......... .......... .......... .......... 16% 8.28M 2s Aug 28 14:19:21 volumio volumio[13338]: 3700K .......... .......... .......... .......... .......... 16% 8.61M 2s Aug 28 14:19:21 volumio volumio[13338]: 3750K .......... .......... .......... .......... .......... 16% 10.9M 2s Aug 28 14:19:21 volumio volumio[13338]: 3800K .......... .......... .......... .......... .......... 17% 7.65M 2s Aug 28 14:19:21 volumio volumio[13338]: 3850K .......... .......... .......... .......... .......... 17% 10.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 3900K .......... .......... .......... .......... .......... 17% 7.04M 2s Aug 28 14:19:21 volumio volumio[13338]: 3950K .......... .......... .......... .......... .......... 17% 11.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 4000K .......... .......... .......... .......... .......... 18% 8.41M 2s Aug 28 14:19:21 volumio volumio[13338]: 4050K .......... .......... .......... .......... .......... 18% 6.86M 2s Aug 28 14:19:21 volumio volumio[13338]: 4100K .......... .......... .......... .......... .......... 18% 8.41M 2s Aug 28 14:19:21 volumio volumio[13338]: 4150K .......... .......... .......... .......... .......... 18% 9.77M 2s Aug 28 14:19:21 volumio volumio[13338]: 4200K .......... .......... .......... .......... .......... 18% 11.4M 2s Aug 28 14:19:21 volumio volumio[13338]: 4250K .......... .......... .......... .......... .......... 19% 6.41M 2s Aug 28 14:19:21 volumio volumio[13338]: 4300K .......... .......... .......... .......... .......... 19% 11.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 4350K .......... .......... .......... .......... .......... 19% 7.94M 2s Aug 28 14:19:21 volumio volumio[13338]: 4400K .......... .......... .......... .......... .......... 19% 11.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 4450K .......... .......... .......... .......... .......... 20% 7.04M 2s Aug 28 14:19:21 volumio volumio[13338]: 4500K .......... .......... .......... .......... .......... 20% 7.60M 2s Aug 28 14:19:21 volumio volumio[13338]: 4550K .......... .......... .......... .......... .......... 20% 10.9M 2s Aug 28 14:19:21 volumio volumio[13338]: 4600K .......... .......... .......... .......... .......... 20% 6.99M 2s Aug 28 14:19:21 volumio volumio[13338]: 4650K .......... .......... .......... .......... .......... 20% 11.2M 2s Aug 28 14:19:21 volumio volumio[13338]: 4700K .......... .......... .......... .......... .......... 21% 11.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 4750K .......... .......... .......... .......... .......... 21% 7.95M 2s Aug 28 14:19:21 volumio volumio[13338]: 4800K .......... .......... .......... .......... .......... 21% 9.45M 2s Aug 28 14:19:21 volumio volumio[13338]: 4850K .......... .......... .......... .......... .......... 21% 6.55M 2s Aug 28 14:19:21 volumio volumio[13338]: 4900K .......... .......... .......... .......... .......... 22% 8.38M 2s Aug 28 14:19:21 volumio volumio[13338]: 4950K .......... .......... .......... .......... .......... 22% 9.67M 2s Aug 28 14:19:21 volumio volumio[13338]: 5000K .......... .......... .......... .......... .......... 22% 8.33M 2s Aug 28 14:19:21 volumio volumio[13338]: 5050K .......... .......... .......... .......... .......... 22% 10.4M 2s Aug 28 14:19:21 volumio volumio[13338]: 5100K .......... .......... .......... .......... .......... 22% 10.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 5150K .......... .......... .......... .......... .......... 23% 7.93M 2s Aug 28 14:19:21 volumio volumio[13338]: 5200K .......... .......... .......... .......... .......... 23% 7.75M 2s Aug 28 14:19:21 volumio volumio[13338]: 5250K .......... .......... .......... .......... .......... 23% 7.99M 2s Aug 28 14:19:21 volumio volumio[13338]: 5300K .......... .......... .......... .......... .......... 23% 7.00M 2s Aug 28 14:19:21 volumio volumio[13338]: 5350K .......... .......... .......... .......... .......... 24% 11.8M 2s Aug 28 14:19:21 volumio volumio[13338]: 5400K .......... .......... .......... .......... .......... 24% 9.72M 2s Aug 28 14:19:21 volumio volumio[13338]: 5450K .......... .......... .......... .......... .......... 24% 8.73M 2s Aug 28 14:19:21 volumio volumio[13338]: 5500K .......... .......... .......... .......... .......... 24% 9.21M 2s Aug 28 14:19:21 volumio volumio[13338]: 5550K .......... .......... .......... .......... .......... 24% 8.37M 2s Aug 28 14:19:21 volumio volumio[13338]: 5600K .......... .......... .......... .......... .......... 25% 10.3M 2s Aug 28 14:19:21 volumio volumio[13338]: 5650K .......... .......... .......... .......... .......... 25% 752K 2s Aug 28 14:19:21 volumio volumio[13338]: 5700K .......... .......... .......... .......... .......... 25% 35.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 5750K .......... .......... .......... .......... .......... 25% 4.91M 2s Aug 28 14:19:21 volumio volumio[13338]: 5800K .......... .......... .......... .......... .......... 26% 32.9M 2s Aug 28 14:19:21 volumio volumio[13338]: 5850K .......... .......... .......... .......... .......... 26% 11.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 5900K .......... .......... .......... .......... .......... 26% 17.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 5950K .......... .......... .......... .......... .......... 26% 14.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 6000K .......... .......... .......... .......... .......... 26% 35.1M 2s Aug 28 14:19:21 volumio volumio[13338]: 6050K .......... .......... .......... .......... .......... 27% 1020K 2s Aug 28 14:19:21 volumio volumio[13338]: 6100K .......... .......... .......... .......... .......... 27% 34.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 6150K .......... .......... .......... .......... .......... 27% 35.7M 2s Aug 28 14:19:21 volumio volumio[13338]: 6200K .......... .......... .......... .......... .......... 27% 35.7M 2s Aug 28 14:19:21 volumio volumio[13338]: 6250K .......... .......... .......... .......... .......... 28% 3.76M 2s Aug 28 14:19:21 volumio volumio[13338]: 6300K .......... .......... .......... .......... .......... 28% 35.1M 2s Aug 28 14:19:21 volumio volumio[13338]: 6350K .......... .......... .......... .......... .......... 28% 5.92M 2s Aug 28 14:19:21 volumio volumio[13338]: 6400K .......... .......... .......... .......... .......... 28% 35.3M 2s Aug 28 14:19:21 volumio volumio[13338]: 6450K .......... .......... .......... .......... .......... 28% 27.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 6500K .......... .......... .......... .......... .......... 29% 35.9M 2s Aug 28 14:19:21 volumio volumio[13338]: 6550K .......... .......... .......... .......... .......... 29% 35.8M 2s Aug 28 14:19:21 volumio volumio[13338]: 6600K .......... .......... .......... .......... .......... 29% 35.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 6650K .......... .......... .......... .......... .......... 29% 2.97M 2s Aug 28 14:19:21 volumio volumio[13338]: 6700K .......... .......... .......... .......... .......... 30% 35.4M 2s Aug 28 14:19:21 volumio volumio[13338]: 6750K .......... .......... .......... .......... .......... 30% 35.8M 2s Aug 28 14:19:21 volumio volumio[13338]: 6800K .......... .......... .......... .......... .......... 30% 3.88M 2s Aug 28 14:19:21 volumio volumio[13338]: 6850K .......... .......... .......... .......... .......... 30% 26.0M 2s Aug 28 14:19:21 volumio volumio[13338]: 6900K .......... .......... .......... .......... .......... 30% 4.18M 2s Aug 28 14:19:21 volumio volumio[13338]: 6950K .......... .......... .......... .......... .......... 31% 33.3M 2s Aug 28 14:19:21 volumio volumio[13338]: 7000K .......... .......... .......... .......... .......... 31% 34.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 7050K .......... .......... .......... .......... .......... 31% 33.9M 2s Aug 28 14:19:21 volumio volumio[13338]: 7100K .......... .......... .......... .......... .......... 31% 25.3M 2s Aug 28 14:19:21 volumio volumio[13338]: 7150K .......... .......... .......... .......... .......... 32% 33.3M 2s Aug 28 14:19:21 volumio volumio[13338]: 7200K .......... .......... .......... .......... .......... 32% 35.7M 2s Aug 28 14:19:21 volumio volumio[13338]: 7250K .......... .......... .......... .......... .......... 32% 27.3M 2s Aug 28 14:19:21 volumio volumio[13338]: 7300K .......... .......... .......... .......... .......... 32% 35.3M 2s Aug 28 14:19:21 volumio volumio[13338]: 7350K .......... .......... .......... .......... .......... 32% 35.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 7400K .......... .......... .......... .......... .......... 33% 35.2M 2s Aug 28 14:19:21 volumio volumio[13338]: 7450K .......... .......... .......... .......... .......... 33% 19.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 7500K .......... .......... .......... .......... .......... 33% 34.8M 2s Aug 28 14:19:21 volumio volumio[13338]: 7550K .......... .......... .......... .......... .......... 33% 35.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 7600K .......... .......... .......... .......... .......... 34% 35.0M 2s Aug 28 14:19:21 volumio volumio[13338]: 7650K .......... .......... .......... .......... .......... 34% 27.2M 2s Aug 28 14:19:21 volumio volumio[13338]: 7700K .......... .......... .......... .......... .......... 34% 35.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 7750K .......... .......... .......... .......... .......... 34% 35.0M 2s Aug 28 14:19:21 volumio volumio[13338]: 7800K .......... .......... .......... .......... .......... 34% 34.7M 2s Aug 28 14:19:21 volumio volumio[13338]: 7850K .......... .......... .......... .......... .......... 35% 7.62M 2s Aug 28 14:19:21 volumio volumio[13338]: 7900K .......... .......... .......... .......... .......... 35% 9.47M 2s Aug 28 14:19:21 volumio volumio[13338]: 7950K .......... .......... .......... .......... .......... 35% 12.7M 2s Aug 28 14:19:21 volumio volumio[13338]: 8000K .......... .......... .......... .......... .......... 35% 7.34M 2s Aug 28 14:19:21 volumio volumio[13338]: 8050K .......... .......... .......... .......... .......... 36% 7.17M 2s Aug 28 14:19:21 volumio volumio[13338]: 8100K .......... .......... .......... .......... .......... 36% 9.46M 2s Aug 28 14:19:21 volumio volumio[13338]: 8150K .......... .......... .......... .......... .......... 36% 8.19M 2s Aug 28 14:19:21 volumio volumio[13338]: 8200K .......... .......... .......... .......... .......... 36% 12.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 8250K .......... .......... .......... .......... .......... 36% 7.02M 2s Aug 28 14:19:21 volumio volumio[13338]: 8300K .......... .......... .......... .......... .......... 37% 12.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 8350K .......... .......... .......... .......... .......... 37% 7.44M 2s Aug 28 14:19:21 volumio volumio[13338]: 8400K .......... .......... .......... .......... .......... 37% 11.0M 2s Aug 28 14:19:21 volumio volumio[13338]: 8450K .......... .......... .......... .......... .......... 37% 6.61M 2s Aug 28 14:19:21 volumio volumio[13338]: 8500K .......... .......... .......... .......... .......... 38% 7.99M 2s Aug 28 14:19:21 volumio volumio[13338]: 8550K .......... .......... .......... .......... .......... 38% 12.1M 2s Aug 28 14:19:21 volumio volumio[13338]: 8600K .......... .......... .......... .......... .......... 38% 6.92M 2s Aug 28 14:19:21 volumio volumio[13338]: 8650K .......... .......... .......... .......... .......... 38% 10.5M 2s Aug 28 14:19:21 volumio volumio[13338]: 8700K .......... .......... .......... .......... .......... 38% 8.39M 2s Aug 28 14:19:21 volumio volumio[13338]: 8750K .......... .......... .......... .......... .......... 39% 10.1M 2s Aug 28 14:19:21 volumio volumio[13338]: 8800K .......... .......... .......... .......... .......... 39% 7.42M 2s Aug 28 14:19:21 volumio volumio[13338]: 8850K .......... .......... .......... .......... .......... 39% 7.61M 2s Aug 28 14:19:21 volumio volumio[13338]: 8900K .......... .......... .......... .......... .......... 39% 10.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 8950K .......... .......... .......... .......... .......... 40% 7.49M 2s Aug 28 14:19:21 volumio volumio[13338]: 9000K .......... .......... .......... .......... .......... 40% 10.6M 2s Aug 28 14:19:21 volumio volumio[13338]: 9050K .......... .......... .......... .......... .......... 40% 7.92M 2s Aug 28 14:19:21 volumio volumio[13338]: 9100K .......... .......... .......... .......... .......... 40% 12.2M 2s Aug 28 14:19:21 volumio volumio[13338]: 9150K .......... .......... .......... .......... .......... 40% 7.23M 2s Aug 28 14:19:21 volumio volumio[13338]: 9200K .......... .......... .......... .......... .......... 41% 9.08M 2s Aug 28 14:19:21 volumio volumio[13338]: 9250K .......... .......... .......... .......... .......... 41% 8.84M 2s Aug 28 14:19:21 volumio volumio[13338]: 9300K .......... .......... .......... .......... .......... 41% 6.95M 1s Aug 28 14:19:21 volumio volumio[13338]: 9350K .......... .......... .......... .......... .......... 41% 11.5M 1s Aug 28 14:19:21 volumio volumio[13338]: 9400K .......... .......... .......... .......... .......... 42% 8.19M 1s Aug 28 14:19:21 volumio volumio[13338]: 9450K .......... .......... .......... .......... .......... 42% 11.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 9500K .......... .......... .......... .......... .......... 42% 7.51M 1s Aug 28 14:19:21 volumio volumio[13338]: 9550K .......... .......... .......... .......... .......... 42% 12.2M 1s Aug 28 14:19:21 volumio volumio[13338]: 9600K .......... .......... .......... .......... .......... 42% 7.64M 1s Aug 28 14:19:21 volumio volumio[13338]: 9650K .......... .......... .......... .......... .......... 43% 7.41M 1s Aug 28 14:19:21 volumio volumio[13338]: 9700K .......... .......... .......... .......... .......... 43% 10.4M 1s Aug 28 14:19:21 volumio volumio[13338]: 9750K .......... .......... .......... .......... .......... 43% 7.97M 1s Aug 28 14:19:21 volumio volumio[13338]: 9800K .......... .......... .......... .......... .......... 43% 7.78M 1s Aug 28 14:19:21 volumio volumio[13338]: 9850K .......... .......... .......... .......... .......... 44% 9.81M 1s Aug 28 14:19:21 volumio volumio[13338]: 9900K .......... .......... .......... .......... .......... 44% 8.51M 1s Aug 28 14:19:21 volumio volumio[13338]: 9950K .......... .......... .......... .......... .......... 44% 12.0M 1s Aug 28 14:19:21 volumio volumio[13338]: 10000K .......... .......... .......... .......... .......... 44% 6.90M 1s Aug 28 14:19:21 volumio volumio[13338]: 10050K .......... .......... .......... .......... .......... 44% 8.42M 1s Aug 28 14:19:21 volumio volumio[13338]: 10100K .......... .......... .......... .......... .......... 45% 9.85M 1s Aug 28 14:19:21 volumio volumio[13338]: 10150K .......... .......... .......... .......... .......... 45% 8.08M 1s Aug 28 14:19:21 volumio volumio[13338]: 10200K .......... .......... .......... .......... .......... 45% 9.50M 1s Aug 28 14:19:21 volumio volumio[13338]: 10250K .......... .......... .......... .......... .......... 45% 7.60M 1s Aug 28 14:19:21 volumio volumio[13338]: 10300K .......... .......... .......... .......... .......... 46% 10.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 10350K .......... .......... .......... .......... .......... 46% 10.9M 1s Aug 28 14:19:21 volumio volumio[13338]: 10400K .......... .......... .......... .......... .......... 46% 7.75M 1s Aug 28 14:19:21 volumio volumio[13338]: 10450K .......... .......... .......... .......... .......... 46% 6.74M 1s Aug 28 14:19:21 volumio volumio[13338]: 10500K .......... .......... .......... .......... .......... 46% 7.06M 1s Aug 28 14:19:21 volumio volumio[13338]: 10550K .......... .......... .......... .......... .......... 47% 13.8M 1s Aug 28 14:19:21 volumio volumio[13338]: 10600K .......... .......... .......... .......... .......... 47% 7.45M 1s Aug 28 14:19:21 volumio volumio[13338]: 10650K .......... .......... .......... .......... .......... 47% 11.5M 1s Aug 28 14:19:21 volumio volumio[13338]: 10700K .......... .......... .......... .......... .......... 47% 9.79M 1s Aug 28 14:19:21 volumio volumio[13338]: 10750K .......... .......... .......... .......... .......... 48% 8.37M 1s Aug 28 14:19:21 volumio volumio[13338]: 10800K .......... .......... .......... .......... .......... 48% 11.2M 1s Aug 28 14:19:21 volumio volumio[13338]: 10850K .......... .......... .......... .......... .......... 48% 5.94M 1s Aug 28 14:19:21 volumio volumio[13338]: 10900K .......... .......... .......... .......... .......... 48% 10.2M 1s Aug 28 14:19:21 volumio volumio[13338]: 10950K .......... .......... .......... .......... .......... 48% 7.35M 1s Aug 28 14:19:21 volumio volumio[13338]: 11000K .......... .......... .......... .......... .......... 49% 12.2M 1s Aug 28 14:19:21 volumio volumio[13338]: 11050K .......... .......... .......... .......... .......... 49% 7.19M 1s Aug 28 14:19:21 volumio volumio[13338]: 11100K .......... .......... .......... .......... .......... 49% 12.0M 1s Aug 28 14:19:21 volumio volumio[13338]: 11150K .......... .......... .......... .......... .......... 49% 7.81M 1s Aug 28 14:19:21 volumio volumio[13338]: 11200K .......... .......... .......... .......... .......... 50% 12.2M 1s Aug 28 14:19:21 volumio volumio[13338]: 11250K .......... .......... .......... .......... .......... 50% 6.71M 1s Aug 28 14:19:21 volumio volumio[13338]: 11300K .......... .......... .......... .......... .......... 50% 7.42M 1s Aug 28 14:19:21 volumio volumio[13338]: 11350K .......... .......... .......... .......... .......... 50% 11.7M 1s Aug 28 14:19:21 volumio volumio[13338]: 11400K .......... .......... .......... .......... .......... 50% 7.91M 1s Aug 28 14:19:21 volumio volumio[13338]: 11450K .......... .......... .......... .......... .......... 51% 9.85M 1s Aug 28 14:19:21 volumio volumio[13338]: 11500K .......... .......... .......... .......... .......... 51% 9.45M 1s Aug 28 14:19:21 volumio volumio[13338]: 11550K .......... .......... .......... .......... .......... 51% 8.38M 1s Aug 28 14:19:21 volumio volumio[13338]: 11600K .......... .......... .......... .......... .......... 51% 10.9M 1s Aug 28 14:19:21 volumio volumio[13338]: 11650K .......... .......... .......... .......... .......... 52% 5.79M 1s Aug 28 14:19:21 volumio volumio[13338]: 11700K .......... .......... .......... .......... .......... 52% 9.86M 1s Aug 28 14:19:21 volumio volumio[13338]: 11750K .......... .......... .......... .......... .......... 52% 7.90M 1s Aug 28 14:19:21 volumio volumio[13338]: 11800K .......... .......... .......... .......... .......... 52% 13.5M 1s Aug 28 14:19:21 volumio volumio[13338]: 11850K .......... .......... .......... .......... .......... 52% 7.70M 1s Aug 28 14:19:21 volumio volumio[13338]: 11900K .......... .......... .......... .......... .......... 53% 8.49M 1s Aug 28 14:19:21 volumio volumio[13338]: 11950K .......... .......... .......... .......... .......... 53% 10.3M 1s Aug 28 14:19:21 volumio volumio[13338]: 12000K .......... .......... .......... .......... .......... 53% 7.49M 1s Aug 28 14:19:21 volumio volumio[13338]: 12050K .......... .......... .......... .......... .......... 53% 7.31M 1s Aug 28 14:19:21 volumio volumio[13338]: 12100K .......... .......... .......... .......... .......... 54% 7.58M 1s Aug 28 14:19:21 volumio volumio[13338]: 12150K .......... .......... .......... .......... .......... 54% 13.7M 1s Aug 28 14:19:21 volumio volumio[13338]: 12200K .......... .......... .......... .......... .......... 54% 9.32M 1s Aug 28 14:19:21 volumio volumio[13338]: 12250K .......... .......... .......... .......... .......... 54% 7.77M 1s Aug 28 14:19:21 volumio volumio[13338]: 12300K .......... .......... .......... .......... .......... 54% 11.6M 1s Aug 28 14:19:21 volumio volumio[13338]: 12350K .......... .......... .......... .......... .......... 55% 8.72M 1s Aug 28 14:19:21 volumio volumio[13338]: 12400K .......... .......... .......... .......... .......... 55% 7.89M 1s Aug 28 14:19:21 volumio volumio[13338]: 12450K .......... .......... .......... .......... .......... 55% 7.17M 1s Aug 28 14:19:21 volumio volumio[13338]: 12500K .......... .......... .......... .......... .......... 55% 6.46M 1s Aug 28 14:19:21 volumio volumio[13338]: 12550K .......... .......... .......... .......... .......... 56% 15.8M 1s Aug 28 14:19:21 volumio volumio[13338]: 12600K .......... .......... .......... .......... .......... 56% 9.42M 1s Aug 28 14:19:21 volumio volumio[13338]: 12650K .......... .......... .......... .......... .......... 56% 7.93M 1s Aug 28 14:19:21 volumio volumio[13338]: 12700K .......... .......... .......... .......... .......... 56% 10.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 12750K .......... .......... .......... .......... .......... 56% 8.14M 1s Aug 28 14:19:21 volumio volumio[13338]: 12800K .......... .......... .......... .......... .......... 57% 10.6M 1s Aug 28 14:19:21 volumio volumio[13338]: 12850K .......... .......... .......... .......... .......... 57% 5.92M 1s Aug 28 14:19:21 volumio volumio[13338]: 12900K .......... .......... .......... .......... .......... 57% 9.85M 1s Aug 28 14:19:21 volumio volumio[13338]: 12950K .......... .......... .......... .......... .......... 57% 10.4M 1s Aug 28 14:19:21 volumio volumio[13338]: 13000K .......... .......... .......... .......... .......... 58% 7.80M 1s Aug 28 14:19:21 volumio volumio[13338]: 13050K .......... .......... .......... .......... .......... 58% 10.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 13100K .......... .......... .......... .......... .......... 58% 7.73M 1s Aug 28 14:19:21 volumio volumio[13338]: 13150K .......... .......... .......... .......... .......... 58% 10.6M 1s Aug 28 14:19:21 volumio volumio[13338]: 13200K .......... .......... .......... .......... .......... 58% 10.7M 1s Aug 28 14:19:21 volumio volumio[13338]: 13250K .......... .......... .......... .......... .......... 59% 5.43M 1s Aug 28 14:19:21 volumio volumio[13338]: 13300K .......... .......... .......... .......... .......... 59% 12.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 13350K .......... .......... .......... .......... .......... 59% 8.46M 1s Aug 28 14:19:21 volumio volumio[13338]: 13400K .......... .......... .......... .......... .......... 59% 9.66M 1s Aug 28 14:19:21 volumio volumio[13338]: 13450K .......... .......... .......... .......... .......... 60% 9.71M 1s Aug 28 14:19:21 volumio volumio[13338]: 13500K .......... .......... .......... .......... .......... 60% 7.61M 1s Aug 28 14:19:21 volumio volumio[13338]: 13550K .......... .......... .......... .......... .......... 60% 11.0M 1s Aug 28 14:19:21 volumio volumio[13338]: 13600K .......... .......... .......... .......... .......... 60% 8.32M 1s Aug 28 14:19:21 volumio volumio[13338]: 13650K .......... .......... .......... .......... .......... 60% 7.11M 1s Aug 28 14:19:21 volumio volumio[13338]: 13700K .......... .......... .......... .......... .......... 61% 11.0M 1s Aug 28 14:19:21 volumio volumio[13338]: 13750K .......... .......... .......... .......... .......... 61% 6.87M 1s Aug 28 14:19:21 volumio volumio[13338]: 13800K .......... .......... .......... .......... .......... 61% 12.6M 1s Aug 28 14:19:21 volumio volumio[13338]: 13850K .......... .......... .......... .......... .......... 61% 7.65M 1s Aug 28 14:19:21 volumio volumio[13338]: 13900K .......... .......... .......... .......... .......... 62% 10.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 13950K .......... .......... .......... .......... .......... 62% 7.49M 1s Aug 28 14:19:21 volumio volumio[13338]: 14000K .......... .......... .......... .......... .......... 62% 12.2M 1s Aug 28 14:19:21 volumio volumio[13338]: 14050K .......... .......... .......... .......... .......... 62% 7.07M 1s Aug 28 14:19:21 volumio volumio[13338]: 14100K .......... .......... .......... .......... .......... 62% 8.05M 1s Aug 28 14:19:21 volumio volumio[13338]: 14150K .......... .......... .......... .......... .......... 63% 9.84M 1s Aug 28 14:19:21 volumio volumio[13338]: 14200K .......... .......... .......... .......... .......... 63% 7.10M 1s Aug 28 14:19:21 volumio volumio[13338]: 14250K .......... .......... .......... .......... .......... 63% 12.7M 1s Aug 28 14:19:21 volumio volumio[13338]: 14300K .......... .......... .......... .......... .......... 63% 8.28M 1s Aug 28 14:19:21 volumio volumio[13338]: 14350K .......... .......... .......... .......... .......... 64% 9.11M 1s Aug 28 14:19:21 volumio volumio[13338]: 14400K .......... .......... .......... .......... .......... 64% 10.2M 1s Aug 28 14:19:21 volumio volumio[13338]: 14450K .......... .......... .......... .......... .......... 64% 5.73M 1s Aug 28 14:19:21 volumio volumio[13338]: 14500K .......... .......... .......... .......... .......... 64% 12.6M 1s Aug 28 14:19:21 volumio volumio[13338]: 14550K .......... .......... .......... .......... .......... 64% 7.40M 1s Aug 28 14:19:21 volumio volumio[13338]: 14600K .......... .......... .......... .......... .......... 65% 12.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 14650K .......... .......... .......... .......... .......... 65% 6.74M 1s Aug 28 14:19:21 volumio volumio[13338]: 14700K .......... .......... .......... .......... .......... 65% 11.3M 1s Aug 28 14:19:21 volumio volumio[13338]: 14750K .......... .......... .......... .......... .......... 65% 8.81M 1s Aug 28 14:19:21 volumio volumio[13338]: 14800K .......... .......... .......... .......... .......... 66% 9.85M 1s Aug 28 14:19:21 volumio volumio[13338]: 14850K .......... .......... .......... .......... .......... 66% 7.10M 1s Aug 28 14:19:21 volumio volumio[13338]: 14900K .......... .......... .......... .......... .......... 66% 7.92M 1s Aug 28 14:19:21 volumio volumio[13338]: 14950K .......... .......... .......... .......... .......... 66% 11.9M 1s Aug 28 14:19:21 volumio volumio[13338]: 15000K .......... .......... .......... .......... .......... 66% 7.24M 1s Aug 28 14:19:21 volumio volumio[13338]: 15050K .......... .......... .......... .......... .......... 67% 8.82M 1s Aug 28 14:19:21 volumio volumio[13338]: 15100K .......... .......... .......... .......... .......... 67% 9.17M 1s Aug 28 14:19:21 volumio volumio[13338]: 15150K .......... .......... .......... .......... .......... 67% 11.3M 1s Aug 28 14:19:21 volumio volumio[13338]: 15200K .......... .......... .......... .......... .......... 67% 9.40M 1s Aug 28 14:19:21 volumio volumio[13338]: 15250K .......... .......... .......... .......... .......... 68% 6.07M 1s Aug 28 14:19:21 volumio volumio[13338]: 15300K .......... .......... .......... .......... .......... 68% 9.90M 1s Aug 28 14:19:21 volumio volumio[13338]: 15350K .......... .......... .......... .......... .......... 68% 8.30M 1s Aug 28 14:19:21 volumio volumio[13338]: 15400K .......... .......... .......... .......... .......... 68% 11.3M 1s Aug 28 14:19:21 volumio volumio[13338]: 15450K .......... .......... .......... .......... .......... 68% 6.88M 1s Aug 28 14:19:21 volumio volumio[13338]: 15500K .......... .......... .......... .......... .......... 69% 10.6M 1s Aug 28 14:19:21 volumio volumio[13338]: 15550K .......... .......... .......... .......... .......... 69% 10.8M 1s Aug 28 14:19:21 volumio volumio[13338]: 15600K .......... .......... .......... .......... .......... 69% 7.98M 1s Aug 28 14:19:21 volumio volumio[13338]: 15650K .......... .......... .......... .......... .......... 69% 7.42M 1s Aug 28 14:19:21 volumio volumio[13338]: 15700K .......... .......... .......... .......... .......... 70% 8.11M 1s Aug 28 14:19:21 volumio volumio[13338]: 15750K .......... .......... .......... .......... .......... 70% 10.5M 1s Aug 28 14:19:21 volumio volumio[13338]: 15800K .......... .......... .......... .......... .......... 70% 7.60M 1s Aug 28 14:19:21 volumio volumio[13338]: 15850K .......... .......... .......... .......... .......... 70% 9.64M 1s Aug 28 14:19:21 volumio volumio[13338]: 15900K .......... .......... .......... .......... .......... 70% 8.66M 1s Aug 28 14:19:21 volumio volumio[13338]: 15950K .......... .......... .......... .......... .......... 71% 11.9M 1s Aug 28 14:19:21 volumio volumio[13338]: 16000K .......... .......... .......... .......... .......... 71% 7.19M 1s Aug 28 14:19:21 volumio volumio[13338]: 16050K .......... .......... .......... .......... .......... 71% 6.97M 1s Aug 28 14:19:21 volumio volumio[13338]: 16100K .......... .......... .......... .......... .......... 71% 11.4M 1s Aug 28 14:19:21 volumio volumio[13338]: 16150K .......... .......... .......... .......... .......... 72% 7.92M 1s Aug 28 14:19:21 volumio volumio[13338]: 16200K .......... .......... .......... .......... .......... 72% 10.5M 1s Aug 28 14:19:21 volumio volumio[13338]: 16250K .......... .......... .......... .......... .......... 72% 8.44M 1s Aug 28 14:19:21 volumio volumio[13338]: 16300K .......... .......... .......... .......... .......... 72% 11.7M 1s Aug 28 14:19:21 volumio volumio[13338]: 16350K .......... .......... .......... .......... .......... 72% 6.77M 1s Aug 28 14:19:21 volumio volumio[13338]: 16400K .......... .......... .......... .......... .......... 73% 11.5M 1s Aug 28 14:19:21 volumio volumio[13338]: 16450K .......... .......... .......... .......... .......... 73% 7.17M 1s Aug 28 14:19:21 volumio volumio[13338]: 16500K .......... .......... .......... .......... .......... 73% 6.85M 1s Aug 28 14:19:21 volumio volumio[13338]: 16550K .......... .......... .......... .......... .......... 73% 12.7M 1s Aug 28 14:19:21 volumio volumio[13338]: 16600K .......... .......... .......... .......... .......... 74% 7.82M 1s Aug 28 14:19:21 volumio volumio[13338]: 16650K .......... .......... .......... .......... .......... 74% 8.57M 1s Aug 28 14:19:21 volumio volumio[13338]: 16700K .......... .......... .......... .......... .......... 74% 11.2M 1s Aug 28 14:19:21 volumio volumio[13338]: 16750K .......... .......... .......... .......... .......... 74% 7.75M 1s Aug 28 14:19:21 volumio volumio[13338]: 16800K .......... .......... .......... .......... .......... 74% 12.2M 1s Aug 28 14:19:21 volumio volumio[13338]: 16850K .......... .......... .......... .......... .......... 75% 5.71M 1s Aug 28 14:19:21 volumio volumio[13338]: 16900K .......... .......... .......... .......... .......... 75% 10.3M 1s Aug 28 14:19:21 volumio volumio[13338]: 16950K .......... .......... .......... .......... .......... 75% 11.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 17000K .......... .......... .......... .......... .......... 75% 7.42M 1s Aug 28 14:19:21 volumio volumio[13338]: 17050K .......... .......... .......... .......... .......... 76% 11.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 17100K .......... .......... .......... .......... .......... 76% 8.71M 1s Aug 28 14:19:21 volumio volumio[13338]: 17150K .......... .......... .......... .......... .......... 76% 9.87M 1s Aug 28 14:19:21 volumio volumio[13338]: 17200K .......... .......... .......... .......... .......... 76% 7.99M 1s Aug 28 14:19:21 volumio volumio[13338]: 17250K .......... .......... .......... .......... .......... 76% 6.65M 1s Aug 28 14:19:21 volumio volumio[13338]: 17300K .......... .......... .......... .......... .......... 77% 9.10M 1s Aug 28 14:19:21 volumio volumio[13338]: 17350K .......... .......... .......... .......... .......... 77% 10.9M 1s Aug 28 14:19:21 volumio volumio[13338]: 17400K .......... .......... .......... .......... .......... 77% 6.36M 1s Aug 28 14:19:21 volumio volumio[13338]: 17450K .......... .......... .......... .......... .......... 77% 13.7M 1s Aug 28 14:19:21 volumio volumio[13338]: 17500K .......... .......... .......... .......... .......... 78% 7.64M 1s Aug 28 14:19:21 volumio volumio[13338]: 17550K .......... .......... .......... .......... .......... 78% 13.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 17600K .......... .......... .......... .......... .......... 78% 7.47M 1s Aug 28 14:19:21 volumio volumio[13338]: 17650K .......... .......... .......... .......... .......... 78% 7.70M 1s Aug 28 14:19:21 volumio volumio[13338]: 17700K .......... .......... .......... .......... .......... 78% 7.21M 1s Aug 28 14:19:21 volumio volumio[13338]: 17750K .......... .......... .......... .......... .......... 79% 10.9M 1s Aug 28 14:19:21 volumio volumio[13338]: 17800K .......... .......... .......... .......... .......... 79% 7.91M 1s Aug 28 14:19:21 volumio volumio[13338]: 17850K .......... .......... .......... .......... .......... 79% 11.3M 1s Aug 28 14:19:21 volumio volumio[13338]: 17900K .......... .......... .......... .......... .......... 79% 7.46M 1s Aug 28 14:19:21 volumio volumio[13338]: 17950K .......... .......... .......... .......... .......... 80% 11.1M 1s Aug 28 14:19:21 volumio volumio[13338]: 18000K .......... .......... .......... .......... .......... 80% 9.26M 1s Aug 28 14:19:21 volumio volumio[13338]: 18050K .......... .......... .......... .......... .......... 80% 5.92M 0s Aug 28 14:19:21 volumio volumio[13338]: 18100K .......... .......... .......... .......... .......... 80% 12.8M 0s Aug 28 14:19:21 volumio volumio[13338]: 18150K .......... .......... .......... .......... .......... 80% 7.14M 0s Aug 28 14:19:21 volumio volumio[13338]: 18200K .......... .......... .......... .......... .......... 81% 10.6M 0s Aug 28 14:19:21 volumio volumio[13338]: 18250K .......... .......... .......... .......... .......... 81% 9.74M 0s Aug 28 14:19:21 volumio volumio[13338]: 18300K .......... .......... .......... .......... .......... 81% 8.39M 0s Aug 28 14:19:21 volumio volumio[13338]: 18350K .......... .......... .......... .......... .......... 81% 7.18M 0s Aug 28 14:19:21 volumio volumio[13338]: 18400K .......... .......... .......... .......... .......... 82% 12.3M 0s Aug 28 14:19:21 volumio volumio[13338]: 18450K .......... .......... .......... .......... .......... 82% 7.70M 0s Aug 28 14:19:21 volumio volumio[13338]: 18500K .......... .......... .......... .......... .......... 82% 7.51M 0s Aug 28 14:19:21 volumio volumio[13338]: 18550K .......... .......... .......... .......... .......... 82% 10.7M 0s Aug 28 14:19:21 volumio volumio[13338]: 18600K .......... .......... .......... .......... .......... 82% 7.41M 0s Aug 28 14:19:21 volumio volumio[13338]: 18650K .......... .......... .......... .......... .......... 83% 12.3M 0s Aug 28 14:19:21 volumio volumio[13338]: 18700K .......... .......... .......... .......... .......... 83% 7.64M 0s Aug 28 14:19:21 volumio volumio[13338]: 18750K .......... .......... .......... .......... .......... 83% 10.6M 0s Aug 28 14:19:21 volumio volumio[13338]: 18800K .......... .......... .......... .......... .......... 83% 7.50M 0s Aug 28 14:19:21 volumio volumio[13338]: 18850K .......... .......... .......... .......... .......... 84% 7.49M 0s Aug 28 14:19:21 volumio volumio[13338]: 18900K .......... .......... .......... .......... .......... 84% 11.5M 0s Aug 28 14:19:21 volumio volumio[13338]: 18950K .......... .......... .......... .......... .......... 84% 7.42M 0s Aug 28 14:19:21 volumio volumio[13338]: 19000K .......... .......... .......... .......... .......... 84% 11.2M 0s Aug 28 14:19:21 volumio volumio[13338]: 19050K .......... .......... .......... .......... .......... 84% 6.74M 0s Aug 28 14:19:21 volumio volumio[13338]: 19100K .......... .......... .......... .......... .......... 85% 11.6M 0s Aug 28 14:19:21 volumio volumio[13338]: 19150K .......... .......... .......... .......... .......... 85% 8.72M 0s Aug 28 14:19:21 volumio volumio[13338]: 19200K .......... .......... .......... .......... .......... 85% 10.5M 0s Aug 28 14:19:21 volumio volumio[13338]: 19250K .......... .......... .......... .......... .......... 85% 6.71M 0s Aug 28 14:19:21 volumio volumio[13338]: 19300K .......... .......... .......... .......... .......... 86% 7.71M 0s Aug 28 14:19:21 volumio volumio[13338]: 19350K .......... .......... .......... .......... .......... 86% 11.4M 0s Aug 28 14:19:21 volumio volumio[13338]: 19400K .......... .......... .......... .......... .......... 86% 7.23M 0s Aug 28 14:19:21 volumio volumio[13338]: 19450K .......... .......... .......... .......... .......... 86% 11.8M 0s Aug 28 14:19:21 volumio volumio[13338]: 19500K .......... .......... .......... .......... .......... 86% 7.09M 0s Aug 28 14:19:21 volumio volumio[13338]: 19550K .......... .......... .......... .......... .......... 87% 12.1M 0s Aug 28 14:19:21 volumio volumio[13338]: 19600K .......... .......... .......... .......... .......... 87% 7.70M 0s Aug 28 14:19:21 volumio volumio[13338]: 19650K .......... .......... .......... .......... .......... 87% 7.08M 0s Aug 28 14:19:21 volumio volumio[13338]: 19700K .......... .......... .......... .......... .......... 87% 8.57M 0s Aug 28 14:19:21 volumio volumio[13338]: 19750K .......... .......... .......... .......... .......... 88% 10.5M 0s Aug 28 14:19:21 volumio volumio[13338]: 19800K .......... .......... .......... .......... .......... 88% 10.4M 0s Aug 28 14:19:21 volumio volumio[13338]: 19850K .......... .......... .......... .......... .......... 88% 8.77M 0s Aug 28 14:19:21 volumio volumio[13338]: 19900K .......... .......... .......... .......... .......... 88% 8.89M 0s Aug 28 14:19:21 volumio volumio[13338]: 19950K .......... .......... .......... .......... .......... 88% 7.31M 0s Aug 28 14:19:21 volumio volumio[13338]: 20000K .......... .......... .......... .......... .......... 89% 9.01M 0s Aug 28 14:19:21 volumio volumio[13338]: 20050K .......... .......... .......... .......... .......... 89% 6.76M 0s Aug 28 14:19:21 volumio volumio[13338]: 20100K .......... .......... .......... .......... .......... 89% 7.04M 0s Aug 28 14:19:21 volumio volumio[13338]: 20150K .......... .......... .......... .......... .......... 89% 7.21M 0s Aug 28 14:19:21 volumio volumio[13338]: 20200K .......... .......... .......... .......... .......... 90% 7.20M 0s Aug 28 14:19:21 volumio volumio[13338]: 20250K .......... .......... .......... .......... .......... 90% 17.4M 0s Aug 28 14:19:21 volumio volumio[13338]: 20300K .......... .......... .......... .......... .......... 90% 15.3M 0s Aug 28 14:19:21 volumio volumio[13338]: 20350K .......... .......... .......... .......... .......... 90% 10.1M 0s Aug 28 14:19:21 volumio volumio[13338]: 20400K .......... .......... .......... .......... .......... 90% 9.39M 0s Aug 28 14:19:21 volumio volumio[13338]: 20450K .......... .......... .......... .......... .......... 91% 6.43M 0s Aug 28 14:19:21 volumio volumio[13338]: 20500K .......... .......... .......... .......... .......... 91% 11.7M 0s Aug 28 14:19:21 volumio volumio[13338]: 20550K .......... .......... .......... .......... .......... 91% 7.40M 0s Aug 28 14:19:21 volumio volumio[13338]: 20600K .......... .......... .......... .......... .......... 91% 11.1M 0s Aug 28 14:19:21 volumio volumio[13338]: 20650K .......... .......... .......... .......... .......... 92% 6.79M 0s Aug 28 14:19:21 volumio volumio[13338]: 20700K .......... .......... .......... .......... .......... 92% 12.5M 0s Aug 28 14:19:21 volumio volumio[13338]: 20750K .......... .......... .......... .......... .......... 92% 7.55M 0s Aug 28 14:19:21 volumio volumio[13338]: 20800K .......... .......... .......... .......... .......... 92% 12.0M 0s Aug 28 14:19:21 volumio volumio[13338]: 20850K .......... .......... .......... .......... .......... 92% 6.76M 0s Aug 28 14:19:21 volumio volumio[13338]: 20900K .......... .......... .......... .......... .......... 93% 8.06M 0s Aug 28 14:19:21 volumio volumio[13338]: 20950K .......... .......... .......... .......... .......... 93% 11.8M 0s Aug 28 14:19:21 volumio volumio[13338]: 21000K .......... .......... .......... .......... .......... 93% 7.41M 0s Aug 28 14:19:21 volumio volumio[13338]: 21050K .......... .......... .......... .......... .......... 93% 10.4M 0s Aug 28 14:19:21 volumio volumio[13338]: 21100K .......... .......... .......... .......... .......... 94% 7.82M 0s Aug 28 14:19:21 volumio volumio[13338]: 21150K .......... .......... .......... .......... .......... 94% 9.12M 0s Aug 28 14:19:21 volumio volumio[13338]: 21200K .......... .......... .......... .......... .......... 94% 10.1M 0s Aug 28 14:19:21 volumio volumio[13338]: 21250K .......... .......... .......... .......... .......... 94% 7.69M 0s Aug 28 14:19:21 volumio volumio[13338]: 21300K .......... .......... .......... .......... .......... 94% 7.02M 0s Aug 28 14:19:21 volumio volumio[13338]: 21350K .......... .......... .......... .......... .......... 95% 11.6M 0s Aug 28 14:19:21 volumio volumio[13338]: 21400K .......... .......... .......... .......... .......... 95% 7.62M 0s Aug 28 14:19:21 volumio volumio[13338]: 21450K .......... .......... .......... .......... .......... 95% 11.2M 0s Aug 28 14:19:21 volumio volumio[13338]: 21500K .......... .......... .......... .......... .......... 95% 7.70M 0s Aug 28 14:19:21 volumio volumio[13338]: 21550K .......... .......... .......... .......... .......... 96% 9.86M 0s Aug 28 14:19:21 volumio volumio[13338]: 21600K .......... .......... .......... .......... .......... 96% 10.3M 0s Aug 28 14:19:21 volumio volumio[13338]: 21650K .......... .......... .......... .......... .......... 96% 5.79M 0s Aug 28 14:19:21 volumio volumio[13338]: 21700K .......... .......... .......... .......... .......... 96% 10.4M 0s Aug 28 14:19:21 volumio volumio[13338]: 21750K .......... .......... .......... .......... .......... 96% 9.47M 0s Aug 28 14:19:21 volumio volumio[13338]: 21800K .......... .......... .......... .......... .......... 97% 8.35M 0s Aug 28 14:19:21 volumio volumio[13338]: 21850K .......... .......... .......... .......... .......... 97% 10.1M 0s Aug 28 14:19:21 volumio volumio[13338]: 21900K .......... .......... .......... .......... .......... 97% 8.80M 0s Aug 28 14:19:21 volumio volumio[13338]: 21950K .......... .......... .......... .......... .......... 97% 9.07M 0s Aug 28 14:19:21 volumio volumio[13338]: 22000K .......... .......... .......... .......... .......... 98% 9.10M 0s Aug 28 14:19:21 volumio volumio[13338]: 22050K .......... .......... .......... .......... .......... 98% 7.89M 0s Aug 28 14:19:21 volumio volumio[13338]: 22100K .......... .......... .......... .......... .......... 98% 7.58M 0s Aug 28 14:19:21 volumio volumio[13338]: 22150K .......... .......... .......... .......... .......... 98% 11.0M 0s Aug 28 14:19:21 volumio volumio[13338]: 22200K .......... .......... .......... .......... .......... 98% 7.28M 0s Aug 28 14:19:21 volumio volumio[13338]: 22250K .......... .......... .......... .......... .......... 99% 10.9M 0s Aug 28 14:19:21 volumio volumio[13338]: 22300K .......... .......... .......... .......... .......... 99% 7.62M 0s Aug 28 14:19:21 volumio volumio[13338]: 22350K .......... .......... .......... .......... .......... 99% 10.3M 0s Aug 28 14:19:21 volumio volumio[13338]: 22400K .......... .......... .......... .......... .......... 99% 10.0M 0s Aug 28 14:19:21 volumio volumio[13338]: 22450K .......... .......... .......... .......... ..... 100% 6.68M=2.5s Aug 28 14:19:21 volumio volumio[13338]: 2026-08-28 14:19:21 (8.66 MB/s) - ‘/tmp/tools.tar.xz’ saved [23035700/23035700] Aug 28 14:19:26 volumio volumio[13338]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 14:19:26 volumio volumio[13338]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:19:27 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: mpd , updateMpdDB Aug 28 14:19:27 volumio volumio[13338]: info: Update mpd DB Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand update Aug 28 14:19:27 volumio volumio[13338]: info: FusionDsp - Updapting dB for tools Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:27 volumio volumio[13338]: info: Aug 28 14:19:27 volumio volumio[13338]: ---------------------------- MPD announces state update: update Aug 28 14:19:27 volumio volumio[13338]: info: sendMpdCommand update took 2 milliseconds Aug 28 14:19:27 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:27 volumio volumio[13338]: info: Aug 28 14:19:27 volumio volumio[13338]: ---------------------------- MPD announces state update: update Aug 28 14:19:27 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:27 volumio volumio[13338]: info: Aug 28 14:19:27 volumio volumio[13338]: ---------------------------- MPD announces state update: update Aug 28 14:19:27 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:27 volumio volumio[13338]: info: Aug 28 14:19:27 volumio volumio[13338]: ---------------------------- MPD announces state update: update Aug 28 14:19:27 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:27 volumio volumio[13338]: info: sendMpdCommand status took 7 milliseconds Aug 28 14:19:27 volumio volumio[13338]: info: sendMpdCommand status took 5 milliseconds Aug 28 14:19:27 volumio volumio[13338]: info: sendMpdCommand status took 4 milliseconds Aug 28 14:19:27 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: info: Command Router : Notfying DB Updatetrue Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: info: Command Router : Notfying DB Updatetrue Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:19:28 volumio volumio[13338]: info: MPD Database updated - AlbumList cache refreshed Aug 28 14:19:28 volumio volumio[13338]: info: Aug 28 14:19:28 volumio volumio[13338]: ---------------------------- MPD announces state update: database Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: Aug 28 14:19:28 volumio volumio[13338]: ---------------------------- MPD announces state update: update Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 1643 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 1643 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 1642 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 1642 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 1641 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 35 milliseconds Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: info: Command Router : Notfying DB Updatetrue Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: info: Command Router : Notfying DB Updatetrue Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:28 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:28 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:28 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":112172,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1178 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:28 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:28 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:28 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:28 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:28 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:28 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:28 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:28 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:28 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:28.896+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=112172 volume=100 Aug 28 14:19:28 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:28.897+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:28 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:28.898+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=112172 volume=100 Aug 28 14:19:28 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:28.898+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:28 volumio volumio[13338]: info: ------------------------------ 1705ms Aug 28 14:19:28 volumio volumio[13338]: info: MPD Database updated - AlbumList cache refreshed Aug 28 14:19:28 volumio volumio[13338]: info: Aug 28 14:19:28 volumio volumio[13338]: ---------------------------- MPD announces state update: database Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: Aug 28 14:19:28 volumio volumio[13338]: ---------------------------- MPD announces state update: update Aug 28 14:19:28 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: MPD Database updated - AlbumList cache refreshed Aug 28 14:19:28 volumio volumio[13338]: info: Aug 28 14:19:28 volumio volumio[13338]: ---------------------------- MPD announces state update: database Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: Aug 28 14:19:28 volumio volumio[13338]: ---------------------------- MPD announces state update: update Aug 28 14:19:28 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: MPD Database updated - AlbumList cache refreshed Aug 28 14:19:28 volumio volumio[13338]: info: Aug 28 14:19:28 volumio volumio[13338]: ---------------------------- MPD announces state update: database Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: Aug 28 14:19:28 volumio volumio[13338]: ---------------------------- MPD announces state update: update Aug 28 14:19:28 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:28 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:28 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 87 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 85 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 84 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 84 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 69 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 57 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 27 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 27 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 27 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 26 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 25 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 26 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 25 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 24 milliseconds Aug 28 14:19:28 volumio volumio[13338]: info: sendMpdCommand status took 24 milliseconds Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: info: Command Router : Notfying DB Updatefalse Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: info: Command Router : Notfying DB Updatefalse Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: info: Command Router : Notfying DB Updatefalse Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: info: Command Router : Notfying DB Updatefalse Aug 28 14:19:28 volumio volumio[13338]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:28 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":112172,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1178 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":112172,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1178 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":112172,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1178 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.020+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=112172 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.021+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.021+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=112172 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.021+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.023+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=112172 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.023+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.024+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=112172 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.025+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.026+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=112172 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.026+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.028+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=112172 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.028+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 1849ms Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 1849ms Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 1848ms Aug 28 14:19:29 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 103 milliseconds Aug 28 14:19:29 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 102 milliseconds Aug 28 14:19:29 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 90 milliseconds Aug 28 14:19:29 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 89 milliseconds Aug 28 14:19:29 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 79 milliseconds Aug 28 14:19:29 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 78 milliseconds Aug 28 14:19:29 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 66 milliseconds Aug 28 14:19:29 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 66 milliseconds Aug 28 14:19:29 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:29 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:29 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:29 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:29 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:29 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:29 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:29 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113915,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1036 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113915,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1036 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113915,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1036 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113915,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1036 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113915,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1036 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113915,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1036 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113915,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1036 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113915,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1036 Kbps","isStreaming":false,"title":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:29 volumio volumio[13338]: verbose: CURRENT POSITION 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState stateService play Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus play Aug 28 14:19:29 volumio volumio[13338]: info: Received an update from plugin. extracting info from payload Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:29 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:29 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.091+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.091+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.093+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.093+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.095+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.095+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.097+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.097+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.099+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.099+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.101+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.101+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.102+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.102+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.104+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.104+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.106+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.106+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.107+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.108+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.109+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.109+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.111+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.111+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.112+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.113+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.114+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.114+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.116+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.116+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.117+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=113915 volume=100 Aug 28 14:19:29 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:29.118+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 327ms Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 328ms Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 268ms Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 267ms Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 267ms Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 267ms Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 265ms Aug 28 14:19:29 volumio volumio[13338]: info: ------------------------------ 266ms Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:29 volumio volumio[13338]: info: FusionDsp - Volumio is playing Aug 28 14:19:47 volumio volumio[13338]: info: CALLMETHOD: audio_interface fusiondsp playToolsFile [object Object] Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , playToolsFile Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::ClearQueue Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::stPlaybackTimer Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::updateTrackBlock Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrackBlock Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::serviceStop Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 2 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::serviceStop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::stop Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand stop Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::clearPlayQueue Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::saveQueue Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::addQueueItems Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::addQueueItems Aug 28 14:19:47 volumio volumio[13338]: info: Preload queue cleared Aug 28 14:19:47 volumio volumio[13338]: info: Adding Item to queue: INTERNAL/FusionDsp/tools/Datei auswählen Aug 28 14:19:47 volumio volumio[13338]: info: Exploding uri INTERNAL/FusionDsp/tools/Datei auswählen in service mpd Aug 28 14:19:47 volumio volumio[13338]: error: scanFolder - failure to stat '/mnt/INTERNAL/FusionDsp/tools/Datei auswählen' Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioClearQueue Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::ClearQueue Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::clearPlayQueue Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::saveQueue Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.369+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.369+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=090830d30ba211f59fadbdfc0d10368a" title="The One I Love" Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.371+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.371+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::saveQueue Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::updateTrackBlock Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrackBlock Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPlay Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::play index 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::play index undefined Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:47 volumio volumio[13338]: info: Aug 28 14:19:47 volumio volumio[13338]: ---------------------------- MPD announces state update: player Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand stop took 50 milliseconds Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:47 volumio volumio[13338]: info: Aug 28 14:19:47 volumio volumio[13338]: ---------------------------- MPD announces state update: player Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:47 volumio volumio[13338]: info: Aug 28 14:19:47 volumio volumio[13338]: ---------------------------- MPD announces state update: player Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:47 volumio volumio[13338]: info: Aug 28 14:19:47 volumio volumio[13338]: ---------------------------- MPD announces state update: player Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::getState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand status took 5 milliseconds Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand status took 5 milliseconds Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand status took 5 milliseconds Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand status took 4 milliseconds Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand status took 3 milliseconds Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseState Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 28 14:19:47 volumio volumio[13338]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:47 volumio volumio[13338]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: 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":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:47 volumio volumio[13338]: verbose: CURRENT POSITION 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::syncState stateService stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: No code Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: 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":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:47 volumio volumio[13338]: verbose: CURRENT POSITION 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::syncState stateService stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: No code Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: 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":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:47 volumio volumio[13338]: verbose: CURRENT POSITION 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::syncState stateService stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: No code Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: ControllerMpd::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::servicePushState Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: 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":"The One I Love","artist":"David Gray","album":"Greatest Hits","uri":"http://192.168.178.20:8096/Audio/090830d30ba211f59fadbdfc0d10368a/stream.flac?static=true&mediaSourceId=090830d30ba211f59fadbdfc0d10368a&tag=bc41b5b56a1eb0d0a068270f942e1d87&t.flac","trackType":"flac"} Aug 28 14:19:47 volumio volumio[13338]: verbose: CURRENT POSITION 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::syncState stateService stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio[13338]: info: No code Aug 28 14:19:47 volumio volumio[13338]: info: CoreStateMachine::pushState Aug 28 14:19:47 volumio volumio[13338]: info: CorePlayQueue::getTrack 0 Aug 28 14:19:47 volumio volumio[13338]: info: CoreCommandRouter::volumioPushState Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.439+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.439+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.440+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.441+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.442+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.442+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.444+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.444+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.446+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.447+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.448+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.448+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.449+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.450+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.450+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.450+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.452+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.453+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.453+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.453+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.454+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.455+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.455+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:19:47 volumio volumio5-onboarding[1635]: time=2026-08-28T14:19:47.456+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id= title= Aug 28 14:19:47 volumio volumio[13338]: info: ------------------------------ 90ms Aug 28 14:19:47 volumio volumio[13338]: info: ------------------------------ 89ms Aug 28 14:19:47 volumio volumio[13338]: info: ------------------------------ 90ms Aug 28 14:19:47 volumio volumio[13338]: info: ------------------------------ 89ms Aug 28 14:19:47 volumio volumio[13338]: info: Pushing Favourites {"favourite":false} Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Volumio is not playing Aug 28 14:19:47 volumio volumio[13338]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:19:47 volumio volumio[13338]: info: [jellyfin-play]: Reported 'stop' for song: The One I Love (at 132104 ms) Aug 28 14:19:48 volumio volumio[13338]: info: camilladsp respawn in 100 ms (attempt 1/10) Aug 28 14:20:10 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Aug 28 14:20:10 volumio volumio[13338]: info: [jellyfin-browse] browseUri: jellyfin Aug 28 14:20:10 volumio volumio[13338]: info: CoreCommandRouter::volumioGetQueue Aug 28 14:20:10 volumio volumio[13338]: info: CoreStateMachine::getQueue Aug 28 14:20:10 volumio volumio[13338]: info: CorePlayQueue::getQueue Aug 28 14:20:10 volumio volumio[13338]: info: Preload queue cleared Aug 28 14:20:12 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Aug 28 14:20:12 volumio volumio[13338]: info: [jellyfin-browse] browseUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9 Aug 28 14:20:12 volumio volumio[13338]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"startIndex":0,"limit":47,"sortBy":["SortName"],"sortOrder":["Ascending"]} Aug 28 14:20:12 volumio volumio[13338]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/UserViews?userId=6ae504d5eec5466b91368ceef326d15b Aug 28 14:20:12 volumio volumio[13338]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":11,"sortBy":["DateCreated","SortName"],"sortOrder":["Descending","Ascending"],"includeItemTypes":["MusicAlbum"]} Aug 28 14:20:12 volumio volumio[13338]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&limit=11&recursive=true&sortOrder=Descending&sortOrder=Ascending&parentId=8a05b0252259a1dbd62df97522638439&includeItemTypes=MusicAlbum&sortBy=DateCreated&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:20:12 volumio volumio[13338]: info: Preload queue cleared Aug 28 14:20:12 volumio volumio[13338]: info: Preload queue cleared Aug 28 14:20:16 volumio volumio[13338]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Aug 28 14:20:16 volumio volumio[13338]: info: [jellyfin-browse] browseUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47 Aug 28 14:20:16 volumio volumio[13338]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"fe466fa9bfa5c501c3b7edaf33bd5d47","startIndex":0,"sortBy":["SortName"],"sortOrder":["Ascending"],"fields":["MediaSources"],"includeItemTypes":["Audio"]} Aug 28 14:20:16 volumio volumio[13338]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&recursive=true&sortOrder=Ascending&parentId=fe466fa9bfa5c501c3b7edaf33bd5d47&fields=MediaSources&includeItemTypes=Audio&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:20:17 volumio volumio[13338]: info: Preload queue cleared Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa Aug 28 14:20:17 volumio volumio[13338]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e Aug 28 14:20:17 volumio volumio[13338]: info: Preload queue cleared Aug 28 14:20:18 volumio volumio[13338]: info: Preload queue cleared Aug 28 14:20:18 volumio volumio[13338]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::ClearQueue Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::stop Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:20:18 volumio volumio[13338]: info: CorePlayQueue::clearPlayQueue Aug 28 14:20:18 volumio volumio[13338]: info: CorePlayQueue::saveQueue Aug 28 14:20:18 volumio volumio[13338]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::addQueueItems Aug 28 14:20:18 volumio volumio[13338]: info: CorePlayQueue::addQueueItems Aug 28 14:20:18 volumio volumio[13338]: info: Preload queue cleared Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 Aug 28 14:20:18 volumio volumio[13338]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:20:18 volumio volumio[13338]: info: CorePlayQueue::saveQueue Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::updateTrackBlock Aug 28 14:20:18 volumio volumio[13338]: info: CorePlayQueue::getTrackBlock Aug 28 14:20:18 volumio volumio[13338]: info: CoreCommandRouter::volumioPlay Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::play index 1 Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::addQueueItems Aug 28 14:20:18 volumio volumio[13338]: info: CorePlayQueue::addQueueItems Aug 28 14:20:18 volumio volumio[13338]: info: Preload queue cleared Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa Aug 28 14:20:18 volumio volumio[13338]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e Aug 28 14:20:18 volumio volumio[13338]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e in service jellyfin Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::stop Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::play index undefined Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:20:18 volumio volumio[13338]: info: CorePlayQueue::getTrack 1 Aug 28 14:20:18 volumio volumio[13338]: info: CoreStateMachine::startPlaybackTimer Aug 28 14:20:18 volumio volumio[13338]: info: CorePlayQueue::getTrack 1 Aug 28 14:20:18 volumio volumio[13338]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=937d3486b5d4a8a421662555d22e1b10 Aug 28 14:20:18 volumio volumio[13338]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:20:18 volumio volumio[13338]: Error: No media streams found for song 02-Just A Friend Of Mine Aug 28 14:20:18 volumio volumio[13338]: at PlayController._PlayController_getStreamUrl (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:241:15) Aug 28 14:20:18 volumio volumio[13338]: at PlayController.clearAddPlayTrack (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:78:234) Aug 28 14:20:18 volumio volumio[13338]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 14:20:18 volumio volumio[13338]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:20:19 volumio sudo[14613]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 14:19' Aug 28 14:20:19 volumio sudo[14613]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"