-- Logs begin at Tue 2025-04-29 14:09:59 -03, end at Tue 2025-04-29 14:11:44 -03. --
Apr 29 14:10:00 volumio systemd-udevd[555]: Using default interface naming scheme 'v240'.
Apr 29 14:10:00 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Apr 29 14:10:00 volumio systemd-udevd[555]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Apr 29 14:10:00 volumio kernel: dw-apb-uart.8: ttyS4 at MMIO 0xa1332000 (irq = 4, base_baud = 115200) is a 16550A
Apr 29 14:10:00 volumio systemd[1]: Found device FPT310M4SSD128G boot.
Apr 29 14:10:00 volumio kernel: dw-apb-uart.9: ttyS5 at MMIO 0xa1330000 (irq = 5, base_baud = 115200) is a 16550A
Apr 29 14:10:00 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/6920-BAC4...
Apr 29 14:10:00 volumio systemd[1]: Started File System Check Daemon to report status.
Apr 29 14:10:00 volumio kernel: cryptd: max_cpu_qlen set to 1000
Apr 29 14:10:00 volumio kernel: dw-apb-uart.10: ttyS6 at MMIO 0xa132e000 (irq = 6, base_baud = 115200) is a 16550A
Apr 29 14:10:00 volumio kernel: SSE version of gcm_enc/dec engaged.
Apr 29 14:10:00 volumio systemd-fsck[590]: fsck.fat 4.1 (2017-01-24)
Apr 29 14:10:00 volumio systemd-fsck[590]: There are differences between boot sector and its backup.
Apr 29 14:10:00 volumio systemd-fsck[590]: This is mostly harmless. Differences: (offset:original/backup)
Apr 29 14:10:00 volumio systemd-fsck[590]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74
Apr 29 14:10:00 volumio systemd-fsck[590]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22
Apr 29 14:10:00 volumio systemd-fsck[590]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb
Apr 29 14:10:00 volumio systemd-fsck[590]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb
Apr 29 14:10:00 volumio systemd-fsck[590]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd
Apr 29 14:10:00 volumio systemd-fsck[590]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69
Apr 29 14:10:00 volumio systemd-fsck[590]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e
Apr 29 14:10:00 volumio systemd-fsck[590]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62
Apr 29 14:10:00 volumio systemd-fsck[590]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c
Apr 29 14:10:00 volumio systemd-fsck[590]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b
Apr 29 14:10:00 volumio systemd-fsck[590]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61
Apr 29 14:10:00 volumio systemd-fsck[590]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73
Apr 29 14:10:00 volumio systemd-fsck[590]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20
Apr 29 14:10:00 volumio systemd-fsck[590]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62
Apr 29 14:10:00 volumio systemd-fsck[590]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f
Apr 29 14:10:00 volumio systemd-fsck[590]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e
Apr 29 14:10:00 volumio systemd-fsck[590]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65
Apr 29 14:10:00 volumio systemd-fsck[590]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79
Apr 29 14:10:00 volumio systemd-fsck[590]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74
Apr 29 14:10:00 volumio systemd-fsck[590]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20
Apr 29 14:10:00 volumio systemd-fsck[590]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20
Apr 29 14:10:00 volumio systemd-fsck[590]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a
Apr 29 14:10:00 volumio systemd-fsck[590]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 282:2d/00, 283:15/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00
Apr 29 14:10:00 volumio kernel: dw-apb-uart.11: ttyS7 at MMIO 0xa132c000 (irq = 7, base_baud = 115200) is a 16550A
Apr 29 14:10:00 volumio systemd-fsck[590]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00
Apr 29 14:10:00 volumio systemd-fsck[590]: , 508:18/00, 509:37/00
Apr 29 14:10:00 volumio systemd-fsck[590]: Not automatically fixing this.
Apr 29 14:10:00 volumio systemd-fsck[590]: /dev/sda1: 18 files, 159614/344788 clusters
Apr 29 14:10:00 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Apr 29 14:10:00 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/6920-BAC4.
Apr 29 14:10:00 volumio systemd[1]: Mounting /boot...
Apr 29 14:10:00 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Apr 29 14:10:00 volumio systemd[1]: Mounted /boot.
Apr 29 14:10:00 volumio kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Apr 29 14:10:00 volumio kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
Apr 29 14:10:00 volumio systemd[1]: Reached target Local File Systems.
Apr 29 14:10:00 volumio systemd[1]: Starting Preprocess NFS configuration...
Apr 29 14:10:00 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Apr 29 14:10:00 volumio systemd[1]: Starting Create Volatile Files and Directories...
Apr 29 14:10:00 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Apr 29 14:10:00 volumio systemd-udevd[536]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:00 volumio systemd[1]: nfs-config.service: Succeeded.
Apr 29 14:10:00 volumio systemd[1]: Started Preprocess NFS configuration.
Apr 29 14:10:00 volumio systemd[1]: plymouth-read-write.service: Succeeded.
Apr 29 14:10:00 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Apr 29 14:10:00 volumio systemd[1]: Received SIGRTMIN+20 from PID 382 (plymouthd).
Apr 29 14:10:00 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Apr 29 14:10:00 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Apr 29 14:10:00 volumio systemd[1]: Reached target NFS client services.
Apr 29 14:10:00 volumio systemd[1]: Started Create Volatile Files and Directories.
Apr 29 14:10:00 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Apr 29 14:10:00 volumio systemd-udevd[553]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:00 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Apr 29 14:10:00 volumio systemd[1]: Starting RPC bind portmap service...
Apr 29 14:10:00 volumio systemd-udevd[549]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:00 volumio kernel: snd_hda_intel 0000:00:0e.0: DSP detected with PCI class/subclass/prog-if info 0x040100
Apr 29 14:10:00 volumio kernel: snd_hda_intel 0000:00:0e.0: bound 0000:00:02.0 (ops __SCT__tp_func_intel_frontbuffer_flush [i915])
Apr 29 14:10:00 volumio systemd-udevd[546]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:00 volumio systemd-udevd[542]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:00 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown.
Apr 29 14:10:00 volumio systemd[1]: Reached target System Initialization.
Apr 29 14:10:00 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Apr 29 14:10:00 volumio systemd[1]: Started Daily man-db regeneration.
Apr 29 14:10:00 volumio systemd[1]: Started Daily Cleanup of Temporary Directories.
Apr 29 14:10:00 volumio systemd[1]: Listening on triggerhappy.socket.
Apr 29 14:10:00 volumio systemd[1]: Started Daily apt download activities.
Apr 29 14:10:00 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Apr 29 14:10:00 volumio systemd[1]: Reached target Timers.
Apr 29 14:10:00 volumio systemd-udevd[544]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:00 volumio systemd[1]: Listening on D-Bus System Message Bus Socket.
Apr 29 14:10:00 volumio systemd[1]: Reached target Sockets.
Apr 29 14:10:00 volumio systemd[1]: Reached target Basic System.
Apr 29 14:10:00 volumio systemd-udevd[537]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:00 volumio systemd[1]: Started MPD Monitor Service.
Apr 29 14:10:00 volumio kernel: input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:0e.0/sound/card0/input13
Apr 29 14:10:00 volumio kernel: input: HDA Intel PCH HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:0e.0/sound/card0/input14
Apr 29 14:10:00 volumio kernel: input: HDA Intel PCH HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:0e.0/sound/card0/input15
Apr 29 14:10:00 volumio systemd[1]: Started volumio-remote-updater.service.
Apr 29 14:10:00 volumio mpd_monitor.sh[692]: MPD Monitor Service: Starting MPD Monitor Service
Apr 29 14:10:00 volumio systemd[1]: Started Volumio Iptables Module.
Apr 29 14:10:00 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 29 14:10:00 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Apr 29 14:10:00 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Apr 29 14:10:00 volumio systemd[1]: Started Volumio Log Rotation Service.
Apr 29 14:10:00 volumio systemd[1]: Starting Volumio Time Update Utility...
Apr 29 14:10:00 volumio systemd[1]: Starting Wireless Services...
Apr 29 14:10:00 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Apr 29 14:10:00 volumio systemd[1]: Starting triggerhappy global hotkey daemon...
Apr 29 14:10:00 volumio volumio-time-update[724]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 14:10:00 volumio thd[728]: Unable to parse trigger line:
Apr 29 14:10:00 volumio thd[728]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Apr 29 14:10:00 volumio thd[728]: Unable to parse trigger line:
Apr 29 14:10:00 volumio thd[728]: Found socket passed from systemd
Apr 29 14:10:01 volumio mpd_monitor.sh[692]: MPD error: Cannot assign requested address
Apr 29 14:10:01 volumio mpd_monitor.sh[692]: MPD Monitor Service: MPD Appears to be inactive, restarting
Apr 29 14:10:01 volumio mpd_monitor.sh[692]: mpd: no process found
Apr 29 14:10:01 volumio thd[728]: Device /dev/input/event3 not suitable.
Apr 29 14:10:01 volumio systemd-udevd[557]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:01 volumio systemd[1]: Starting DHCP Client Daemon...
Apr 29 14:10:01 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Apr 29 14:10:01 volumio systemd[1]: Started D-Bus System Message Bus.
Apr 29 14:10:01 volumio systemd[1]: Starting WPA supplicant...
Apr 29 14:10:01 volumio kernel: pstore: Using crash dump compression: deflate
Apr 29 14:10:01 volumio avahi-daemon[759]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113).
Apr 29 14:10:01 volumio avahi-daemon[759]: Successfully dropped root privileges.
Apr 29 14:10:01 volumio avahi-daemon[759]: avahi-daemon 0.7 starting up.
Apr 29 14:10:01 volumio kernel: pstore: Registered efi_pstore as persistent store backend
Apr 29 14:10:01 volumio systemd[1]: Starting Login Service...
Apr 29 14:10:01 volumio systemd[1]: Started RPC bind portmap service.
Apr 29 14:10:01 volumio systemd[1]: Started triggerhappy global hotkey daemon.
Apr 29 14:10:01 volumio volumio-remote-updater[704]: Error: No active session
Apr 29 14:10:01 volumio volumio-remote-updater[704]: [2025-04-29 14:10:01] [info] asio async_connect error: system:111 (Connection refused)
Apr 29 14:10:01 volumio volumio-remote-updater[704]: [2025-04-29 14:10:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 29 14:10:01 volumio volumio-remote-updater[704]: [2025-04-29 14:10:01] [error] handle_connect error: Underlying Transport Error
Apr 29 14:10:01 volumio avahi-daemon[759]: Successfully called chroot().
Apr 29 14:10:01 volumio avahi-daemon[759]: Successfully dropped remaining capabilities.
Apr 29 14:10:01 volumio avahi-daemon[759]: No service file found in /etc/avahi/services.
Apr 29 14:10:01 volumio volumio-time-update[724]: volumio-time-update-util: Date not found in response
Apr 29 14:10:01 volumio volumio-time-update[724]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 14:10:01 volumio kernel: rtw_8821ce 0000:03:00.0: enabling device (0000 -> 0003)
Apr 29 14:10:01 volumio avahi-daemon[759]: Network interface enumeration completed.
Apr 29 14:10:01 volumio avahi-daemon[759]: Server startup complete. Host name is volumio.local. Local service cookie is 3449415273.
Apr 29 14:10:01 volumio wpa_supplicant[766]: Successfully initialized wpa_supplicant
Apr 29 14:10:01 volumio kernel: rtw_8821ce 0000:03:00.0: Firmware version 24.11.0, H2C version 12
Apr 29 14:10:01 volumio systemd-logind[767]: New seat seat0.
Apr 29 14:10:01 volumio volumio[711]: Could not open config: /tmp/upmpdcli.conf
Apr 29 14:10:01 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Apr 29 14:10:01 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Apr 29 14:10:01 volumio kernel: 8021q: 802.1Q VLAN Support v1.8
Apr 29 14:10:01 volumio systemd-logind[767]: Watching system buttons on /dev/input/event0 (Lid Switch)
Apr 29 14:10:01 volumio systemd-logind[767]: Watching system buttons on /dev/input/event1 (Power Button)
Apr 29 14:10:01 volumio systemd-logind[767]: Watching system buttons on /dev/input/event5 ( USB Keyboard)
Apr 29 14:10:01 volumio systemd-logind[767]: Watching system buttons on /dev/input/event7 ( USB Keyboard System Control)
Apr 29 14:10:01 volumio systemd-udevd[558]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:01 volumio systemd-udevd[544]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:01 volumio systemd-logind[767]: Watching system buttons on /dev/input/event2 (AT Translated Set 2 keyboard)
Apr 29 14:10:01 volumio haveged[663]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K
Apr 29 14:10:01 volumio haveged[663]: haveged: cpu: (L4 VC); data: 24K (L4 V); inst: 32K (L4 V); idx: 24/40; sz: 31410/52825
Apr 29 14:10:01 volumio haveged[663]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.9984
Apr 29 14:10:01 volumio haveged[663]: haveged: fills: 0, generated: 0
Apr 29 14:10:01 volumio dhcpcd[732]: no interfaces have a carrier
Apr 29 14:10:01 volumio dhcpcd[732]: no interfaces have a carrier
Apr 29 14:10:01 volumio dhcpcd[732]: forked to background, child pid 799
Apr 29 14:10:01 volumio dhcpcd[732]: forked to background, child pid 799
Apr 29 14:10:01 volumio kernel: RTL8211E Gigabit Ethernet r8169-0-100:00: attached PHY driver (mii_bus:phy_addr=r8169-0-100:00, irq=MAC)
Apr 29 14:10:01 volumio kernel: Bluetooth: Core ver 2.22
Apr 29 14:10:01 volumio kernel: NET: Registered PF_BLUETOOTH protocol family
Apr 29 14:10:01 volumio kernel: Bluetooth: HCI device and connection manager initialized
Apr 29 14:10:01 volumio kernel: Bluetooth: HCI socket layer initialized
Apr 29 14:10:01 volumio kernel: Bluetooth: L2CAP socket layer initialized
Apr 29 14:10:01 volumio kernel: Bluetooth: SCO socket layer initialized
Apr 29 14:10:01 volumio systemd[1]: Found device RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller.
Apr 29 14:10:01 volumio systemd[1]: Started DHCP Client Daemon.
Apr 29 14:10:01 volumio kernel: usbcore: registered new interface driver btusb
Apr 29 14:10:01 volumio systemd[1]: iptables.service: Succeeded.
Apr 29 14:10:01 volumio kernel: Bluetooth: hci0: RTL: examining hci_ver=08 hci_rev=000c lmp_ver=08 lmp_subver=8821
Apr 29 14:10:01 volumio kernel: Bluetooth: hci0: RTL: rom_version status=0 version=1
Apr 29 14:10:01 volumio kernel: Bluetooth: hci0: RTL: loading rtl_bt/rtl8821c_fw.bin
Apr 29 14:10:01 volumio kernel: Bluetooth: hci0: RTL: loading rtl_bt/rtl8821c_config.bin
Apr 29 14:10:01 volumio kernel: Bluetooth: hci0: RTL: cfg_sz 10, total sz 34926
Apr 29 14:10:02 volumio systemd-udevd[546]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:02 volumio systemd-logind[767]: Watching system buttons on /dev/input/event9 (Intel HID events)
Apr 29 14:10:02 volumio systemd-udevd[537]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:02 volumio systemd-logind[767]: Watching system buttons on /dev/input/event10 (Intel HID 5 button array)
Apr 29 14:10:02 volumio dhcpcd[799]: eth0: waiting for carrier
Apr 29 14:10:02 volumio kernel: r8169 0000:01:00.0 eth0: Link is Down
Apr 29 14:10:02 volumio systemd-udevd[544]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Apr 29 14:10:02 volumio systemd[1]: Started Login Service.
Apr 29 14:10:02 volumio systemd-udevd[551]: Using default interface naming scheme 'v240'.
Apr 29 14:10:02 volumio systemd[1]: Started Manage Sound Card State (restore and store).
Apr 29 14:10:02 volumio systemd[1]: Starting Save/Restore Sound Card State...
Apr 29 14:10:02 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Apr 29 14:10:02 volumio systemd[1]: Started ifup for eth0.
Apr 29 14:10:02 volumio systemd[1]: Listening on mpd.socket.
Apr 29 14:10:02 volumio alsactl[826]: alsactl 1.1.8 daemon started
Apr 29 14:10:02 volumio systemd[1]: Reached target Remote File Systems (Pre).
Apr 29 14:10:02 volumio systemd[1]: Reached target Remote File Systems.
Apr 29 14:10:02 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Apr 29 14:10:02 volumio systemd[1]: Reached target RPC Port Mapper.
Apr 29 14:10:02 volumio kernel: Bluetooth: hci0: RTL: fw version 0x75b8f098
Apr 29 14:10:02 volumio systemd[1]: Starting Bluetooth service...
Apr 29 14:10:02 volumio systemd[1]: Starting Load/Save RF Kill Switch Status...
Apr 29 14:10:02 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Apr 29 14:10:02 volumio systemd-udevd[544]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:02 volumio systemd-udevd[549]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:02 volumio systemd[1]: Started WPA supplicant.
Apr 29 14:10:02 volumio systemd-udevd[546]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 29 14:10:02 volumio bluetoothd[838]: Bluetooth daemon 5.50
Apr 29 14:10:02 volumio bluetoothd[838]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Apr 29 14:10:02 volumio systemd[1]: Started Bluetooth service.
Apr 29 14:10:02 volumio systemd[1]: Reached target Bluetooth.
Apr 29 14:10:02 volumio bluetoothd[838]: Starting SDP server
Apr 29 14:10:02 volumio bluetoothd[838]: Excluding (cli) sap
Apr 29 14:10:02 volumio kernel: alsactl[829]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set
Apr 29 14:10:02 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Apr 29 14:10:02 volumio kernel: Bluetooth: BNEP filters: protocol multicast
Apr 29 14:10:02 volumio kernel: Bluetooth: BNEP socket layer initialized
Apr 29 14:10:02 volumio bluetoothd[838]: Bluetooth management interface 1.22 initialized
Apr 29 14:10:02 volumio dbus-daemon[765]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=838 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Apr 29 14:10:02 volumio kernel: Bluetooth: MGMT ver 1.22
Apr 29 14:10:02 volumio systemd[1]: Started Save/Restore Sound Card State.
Apr 29 14:10:02 volumio systemd[1]: Starting Hostname Service...
Apr 29 14:10:02 volumio systemd[1]: Reached target Sound Card.
Apr 29 14:10:02 volumio loadcpufreq[831]: Loading cpufreq kernel modules...done (acpi-cpufreq).
Apr 29 14:10:02 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Apr 29 14:10:02 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Apr 29 14:10:02 volumio dhcpcd[799]: wlan0: waiting for carrier
Apr 29 14:10:02 volumio dhcpcd[799]: eth0: carrier acquired
Apr 29 14:10:02 volumio systemd-udevd[551]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Apr 29 14:10:02 volumio dhcpcd[799]: DUID 00:04:51:45:30:80:bb:f3:11:ee:85:c7:d6:36:25:53:47:00
Apr 29 14:10:02 volumio dhcpcd[799]: eth0: IAID 01:19:36:8c
Apr 29 14:10:02 volumio dhcpcd[799]: eth0: adding address fe80::1409:1ff:fe19:368c
Apr 29 14:10:02 volumio wireless.js[725]: Cleaning previous...
Apr 29 14:10:02 volumio dhcpcd[799]: ipv6_addaddr1: Permission denied
Apr 29 14:10:02 volumio dhcpcd[799]: eth0: probing address 192.168.1.7/24
Apr 29 14:10:02 volumio dhcpcd[799]: eth0: carrier lost
Apr 29 14:10:02 volumio systemd[1]: Started Load/Save RF Kill Switch Status.
Apr 29 14:10:02 volumio cpufrequtils[884]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done.
Apr 29 14:10:02 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters.
Apr 29 14:10:03 volumio dhcpcd[799]: wlan0: carrier acquired
Apr 29 14:10:03 volumio dhcpcd[799]: wlan0: IAID 99:a1:19:db
Apr 29 14:10:03 volumio dhcpcd[799]: wlan0: adding address fe80::7e88:99ff:fea1:19db
Apr 29 14:10:03 volumio dhcpcd[799]: ipv6_addaddr1: Permission denied
Apr 29 14:10:03 volumio dhcpcd[799]: wlan0: probing address 192.168.1.8/24
Apr 29 14:10:03 volumio dbus-daemon[765]: [system] Successfully activated service 'org.freedesktop.hostname1'
Apr 29 14:10:03 volumio systemd[1]: Started Hostname Service.
Apr 29 14:10:03 volumio sh[830]: eth0=eth0
Apr 29 14:10:03 volumio systemd[1]: Found device RTL8821CE 802.11ac PCIe Wireless Network Adapter.
Apr 29 14:10:03 volumio systemd[1]: Started ifup for wlan0.
Apr 29 14:10:03 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown.
Apr 29 14:10:03 volumio systemd[1]: Starting Raise network interfaces...
Apr 29 14:10:03 volumio sudo[953]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Apr 29 14:10:03 volumio sudo[953]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:03 volumio sudo[953]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:03 volumio kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211
Apr 29 14:10:03 volumio sudo[983]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Apr 29 14:10:03 volumio sudo[983]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:03 volumio dhcpcd[799]: wlan0: carrier lost
Apr 29 14:10:03 volumio sudo[983]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:03 volumio wireless.js[725]: Stopped aP
Apr 29 14:10:03 volumio sudo[1015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 29 14:10:03 volumio sudo[1015]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:03 volumio sudo[1015]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:03 volumio dhcpcd[799]: wlan0: carrier acquired
Apr 29 14:10:03 volumio sudo[1037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Apr 29 14:10:03 volumio sudo[1037]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:03 volumio dhcpcd[799]: wlan0: IAID 99:a1:19:db
Apr 29 14:10:03 volumio dhcpcd[799]: wlan0: probing address 192.168.1.8/24
Apr 29 14:10:03 volumio sudo[1037]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:03 volumio ifup[962]: ifup: waiting for lock on /run/network/ifstate.wlan0
Apr 29 14:10:03 volumio dhcpcd[799]: wlan0: carrier lost
Apr 29 14:10:03 volumio sh[960]: wlan0=wlan0
Apr 29 14:10:03 volumio sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 29 14:10:03 volumio sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:03 volumio sudo[1071]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:03 volumio sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Apr 29 14:10:03 volumio sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:03 volumio systemd[1]: Started Raise network interfaces.
Apr 29 14:10:03 volumio systemd[1]: Reached target Network.
Apr 29 14:10:03 volumio systemd[1]: Starting Network Time Service...
Apr 29 14:10:03 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Apr 29 14:10:03 volumio systemd[1]: Starting Music Player Daemon...
Apr 29 14:10:03 volumio systemd[1]: Starting Permit User Sessions...
Apr 29 14:10:03 volumio systemd[1]: Reached target Network is Online.
Apr 29 14:10:03 volumio systemd[1]: Starting Samba NMB Daemon...
Apr 29 14:10:03 volumio systemd[1]: Starting LSB: Brings up/down network automatically...
Apr 29 14:10:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 29 14:10:03 volumio systemd[1]: Starting /etc/rc.local Compatibility...
Apr 29 14:10:03 volumio systemd[1]: Started Permit User Sessions.
Apr 29 14:10:03 volumio sudo[1105]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 29 14:10:03 volumio sudo[1105]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:03 volumio sudo[1105]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Apr 29 14:10:03 volumio sudo[1105]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:03 volumio systemd[1]: Started /etc/rc.local Compatibility.
Apr 29 14:10:04 volumio ntpd[1104]: ntpd 4.2.8p12@1.3728-o (1): Starting
Apr 29 14:10:04 volumio ntpd[1104]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Apr 29 14:10:04 volumio systemd[1]: Starting Hold until boot process finishes up...
Apr 29 14:10:04 volumio ntpd[1123]: proto: precision = 0.084 usec (-23)
Apr 29 14:10:04 volumio ntpd[1123]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Apr 29 14:10:04 volumio ntpd[1123]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Apr 29 14:10:04 volumio ntpd[1123]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 854 days ago
Apr 29 14:10:04 volumio systemd[1]: Starting Terminate Plymouth Boot Screen...
Apr 29 14:10:04 volumio systemd[1]: Started Network Time Service.
Apr 29 14:10:04 volumio ntpd[1123]: Listen and drop on 0 v6wildcard [::]:123
Apr 29 14:10:04 volumio ntpd[1123]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Apr 29 14:10:04 volumio ntpd[1123]: Listen normally on 2 lo 127.0.0.1:123
Apr 29 14:10:04 volumio ntpd[1123]: Listening on routing socket on fd #19 for interface updates
Apr 29 14:10:04 volumio ntpd[1123]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 29 14:10:04 volumio ntpd[1123]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 29 14:10:04 volumio systemd[1]: Received SIGRTMIN+21 from PID 382 (plymouthd).
Apr 29 14:10:04 volumio systemd[1]: Received SIGRTMIN+21 from PID 382 (plymouthd).
Apr 29 14:10:04 volumio ifplugd[1111]: Network Interface Plugging Daemon...error: unexpectedly disconnected from boot status daemon
Apr 29 14:10:04 volumio systemd[1]: plymouth-quit.service: Succeeded.
Apr 29 14:10:04 volumio systemd[1]: Started Terminate Plymouth Boot Screen.
Apr 29 14:10:04 volumio systemd[1]: plymouth-quit-wait.service: Succeeded.
Apr 29 14:10:04 volumio systemd[1]: Started Hold until boot process finishes up.
Apr 29 14:10:04 volumio ifplugd(eth0)[1138]: ifplugd 0.28 initializing.
Apr 29 14:10:04 volumio ifplugd(eth0)[1138]: Using interface eth0/16:09:01:19:36:8C with driver (version: 6.6.32-volumio)
Apr 29 14:10:04 volumio systemd[1]: Started Getty on tty1.
Apr 29 14:10:04 volumio ifplugd(eth0)[1138]: Using detection mode: SIOCETHTOOL
Apr 29 14:10:04 volumio systemd[1]: Reached target Login Prompts.
Apr 29 14:10:04 volumio ifplugd(eth0)[1138]: Initialization complete, link beat not detected.
Apr 29 14:10:04 volumio ifplugd[1111]: start eth0...done.
Apr 29 14:10:04 volumio systemd[1]: Started LSB: Brings up/down network automatically.
Apr 29 14:10:04 volumio nmbd[1119]: [2025/04/29 14:10:04.411157, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Apr 29 14:10:04 volumio nmbd[1119]: started asyncdns process 1139
Apr 29 14:10:04 volumio nmbd[1119]: [2025/04/29 14:10:04.412462, 0] ../lib/util/become_daemon.c:149(daemon_status)
Apr 29 14:10:04 volumio nmbd[1119]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Apr 29 14:10:04 volumio nmbd[1119]: [2025/04/29 14:10:04.412531, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Apr 29 14:10:04 volumio nmbd[1119]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Apr 29 14:10:04 volumio dhcpcd[799]: eth0: carrier acquired
Apr 29 14:10:04 volumio kernel: r8169 0000:01:00.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx
Apr 29 14:10:04 volumio dhcpcd[799]: eth0: IAID 01:19:36:8c
Apr 29 14:10:04 volumio dhcpcd[799]: eth0: probing address 192.168.1.7/24
Apr 29 14:10:05 volumio ntpd[1123]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Apr 29 14:10:05 volumio ifplugd(eth0)[1138]: Link beat detected.
Apr 29 14:10:05 volumio dhcpcd[799]: eth0: soliciting an IPv6 router
Apr 29 14:10:05 volumio ifplugd(eth0)[1138]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Apr 29 14:10:05 volumio mpd[1120]: Apr 29 14:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 29 14:10:05 volumio systemd[1]: Started Music Player Daemon.
Apr 29 14:10:05 volumio mpd_monitor.sh[692]: MPD Monitor Service: MPD restarted due to no mpc output.
Apr 29 14:10:05 volumio ifplugd(eth0)[1138]: client: ifup: interface eth0 already configured
Apr 29 14:10:05 volumio ifplugd(eth0)[1138]: Program executed successfully.
Apr 29 14:10:06 volumio ntpd[1123]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Apr 29 14:10:06 volumio volumio-remote-updater[704]: [2025-04-29 14:10:06] [info] asio async_connect error: system:111 (Connection refused)
Apr 29 14:10:06 volumio volumio-remote-updater[704]: [2025-04-29 14:10:06] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 29 14:10:06 volumio volumio-remote-updater[704]: [2025-04-29 14:10:06] [error] handle_connect error: Underlying Transport Error
Apr 29 14:10:06 volumio volumio-time-update[724]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 14:10:06 volumio volumio-time-update[724]: volumio-time-update-util: Date not found in response
Apr 29 14:10:06 volumio volumio-time-update[724]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 14:10:06 volumio sudo[1097]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:06 volumio wireless.js[725]: Start wireless flow
Apr 29 14:10:06 volumio wireless.js[725]: Stopped hotspot (if there)..
Apr 29 14:10:06 volumio sudo[1155]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Apr 29 14:10:06 volumio sudo[1155]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:06 volumio sudo[1155]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:06 volumio sudo[1157]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Apr 29 14:10:06 volumio sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:06 volumio sudo[1157]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:06 volumio wireless.js[725]: DHCP IP
Apr 29 14:10:06 volumio wireless.js[725]: Start ap
Apr 29 14:10:06 volumio wpa_supplicant[1159]: Successfully initialized wpa_supplicant
Apr 29 14:10:06 volumio sudo[1160]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Apr 29 14:10:06 volumio sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:06 volumio dhcpcd[1161]: sending commands to master dhcpcd process
Apr 29 14:10:06 volumio sudo[1160]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:06 volumio dhcpcd[799]: control command: /sbin/dhcpcd
Apr 29 14:10:07 volumio ntpd[1123]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Apr 29 14:10:07 volumio wireless.js[725]: trying...
Apr 29 14:10:07 volumio sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:07 volumio sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:07 volumio sudo[1164]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:07 volumio systemd[1]: systemd-rfkill.service: Succeeded.
Apr 29 14:10:08 volumio ntpd[1123]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Apr 29 14:10:08 volumio wireless.js[725]: trying...
Apr 29 14:10:08 volumio sudo[1167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:08 volumio sudo[1167]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:08 volumio sudo[1167]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:09 volumio dhcpcd[799]: eth0: using static address 192.168.1.7/24
Apr 29 14:10:09 volumio dhcpcd[799]: eth0: adding route to 192.168.1.0/24
Apr 29 14:10:09 volumio dhcpcd[799]: eth0: adding default route via 192.168.1.1
Apr 29 14:10:09 volumio avahi-daemon[759]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.7.
Apr 29 14:10:09 volumio avahi-daemon[759]: New relevant interface eth0.IPv4 for mDNS.
Apr 29 14:10:09 volumio avahi-daemon[759]: Registering new address record for 192.168.1.7 on eth0.IPv4.
Apr 29 14:10:09 volumio nmbd[1119]: [2025/04/29 14:10:09.415300, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 29 14:10:09 volumio systemd[1]: Started Samba NMB Daemon.
Apr 29 14:10:09 volumio nmbd[1119]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Apr 29 14:10:09 volumio nmbd[1119]: [2025/04/29 14:10:09.423676, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 29 14:10:09 volumio nmbd[1119]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.7 for name WORKGROUP<1d>.
Apr 29 14:10:09 volumio nmbd[1119]: This response was from IP 192.168.1.2, reporting an IP address of 192.168.1.2.
Apr 29 14:10:09 volumio systemd[1]: Starting Samba Winbind Daemon...
Apr 29 14:10:09 volumio winbindd[1186]: [2025/04/29 14:10:09.561034, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Apr 29 14:10:09 volumio winbindd[1186]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Apr 29 14:10:09 volumio winbindd[1186]: [2025/04/29 14:10:09.564133, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 29 14:10:09 volumio systemd[1]: Started Samba Winbind Daemon.
Apr 29 14:10:09 volumio winbindd[1186]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Apr 29 14:10:09 volumio systemd[1]: Starting Samba SMB Daemon...
Apr 29 14:10:09 volumio wireless.js[725]: trying...
Apr 29 14:10:09 volumio smbd[1191]: [2025/04/29 14:10:09.812696, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 29 14:10:09 volumio smbd[1191]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Apr 29 14:10:09 volumio systemd[1]: Started Samba SMB Daemon.
Apr 29 14:10:09 volumio sudo[1198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:09 volumio sudo[1198]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:09 volumio sudo[1198]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:10 volumio wpa_supplicant[1162]: wlan0: SME: Trying to authenticate with bc:99:11:d0:8c:35 (SSID='iCloud' freq=2462 MHz)
Apr 29 14:10:10 volumio kernel: wlan0: authenticate with bc:99:11:d0:8c:35
Apr 29 14:10:10 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Apr 29 14:10:10 volumio wireless.js[725]: trying...
Apr 29 14:10:10 volumio sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:10 volumio sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:10 volumio sudo[1203]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:10 volumio wpa_supplicant[1162]: wlan0: Trying to associate with bc:99:11:d0:8c:35 (SSID='iCloud' freq=2462 MHz)
Apr 29 14:10:10 volumio kernel: wlan0: send auth to bc:99:11:d0:8c:35 (try 1/3)
Apr 29 14:10:10 volumio kernel: wlan0: authenticated
Apr 29 14:10:10 volumio kernel: wlan0: associate with bc:99:11:d0:8c:35 (try 1/3)
Apr 29 14:10:10 volumio wpa_supplicant[1162]: wlan0: Associated with bc:99:11:d0:8c:35
Apr 29 14:10:10 volumio wpa_supplicant[1162]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 29 14:10:10 volumio kernel: wlan0: RX AssocResp from bc:99:11:d0:8c:35 (capab=0x31 status=0 aid=16)
Apr 29 14:10:10 volumio kernel: wlan0: associated
Apr 29 14:10:10 volumio wpa_supplicant[1162]: wlan0: WPA: Key negotiation completed with bc:99:11:d0:8c:35 [PTK=CCMP GTK=CCMP]
Apr 29 14:10:10 volumio wpa_supplicant[1162]: wlan0: CTRL-EVENT-CONNECTED - Connection to bc:99:11:d0:8c:35 completed [id=0 id_str=]
Apr 29 14:10:10 volumio dhcpcd[799]: wlan0: carrier acquired
Apr 29 14:10:10 volumio dhcpcd[799]: wlan0: IAID 99:a1:19:db
Apr 29 14:10:10 volumio dhcpcd[799]: wlan0: probing address 192.168.1.8/24
Apr 29 14:10:10 volumio dhcpcd[799]: wlan0: soliciting an IPv6 router
Apr 29 14:10:11 volumio volumio-time-update[724]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 14:10:11 volumio volumio-time-update[724]: volumio-time-update-util: Setting system time to: 2025-04-29 14:10:12
Apr 29 14:10:11 volumio sudo[1228]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-04-29 14:10:12
Apr 29 14:10:11 volumio sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:11 volumio dbus-daemon[765]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.8' (uid=0 pid=1229 comm="timedatectl set-time 2025-04-29 14:10:12 ")
Apr 29 14:10:11 volumio systemd[1]: Starting Time & Date Service...
Apr 29 14:10:11 volumio dbus-daemon[765]: [system] Successfully activated service 'org.freedesktop.timedate1'
Apr 29 14:10:11 volumio systemd[1]: Started Time & Date Service.
Apr 29 14:10:12 volumio systemd-timedated[1230]: Changed local time to Tue Apr 29 14:10:12 2025
Apr 29 14:10:12 volumio sudo[1228]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:12 volumio volumio-time-update[724]: volumio-time-update-util: System time updated successfully.
Apr 29 14:10:12 volumio systemd[1]: Started Volumio Time Update Utility.
Apr 29 14:10:12 volumio wireless.js[725]: trying...
Apr 29 14:10:12 volumio sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:12 volumio sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:12 volumio sudo[1232]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:12 volumio ntpd[1123]: Listen normally on 3 eth0 192.168.1.7:123
Apr 29 14:10:12 volumio ntpd[1123]: new interface(s) found: waking up resolver
Apr 29 14:10:13 volumio wireless.js[725]: trying...
Apr 29 14:10:13 volumio sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:13 volumio sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:13 volumio sudo[1235]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:14 volumio wireless.js[725]: trying...
Apr 29 14:10:14 volumio sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:14 volumio sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:14 volumio sudo[1238]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:14 volumio volumio-remote-updater[704]: [2025-04-29 14:10:14] [info] asio async_connect error: system:111 (Connection refused)
Apr 29 14:10:14 volumio volumio-remote-updater[704]: [2025-04-29 14:10:14] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 29 14:10:14 volumio volumio-remote-updater[704]: [2025-04-29 14:10:14] [error] handle_connect error: Underlying Transport Error
Apr 29 14:10:15 volumio wireless.js[725]: trying...
Apr 29 14:10:15 volumio sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:15 volumio sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:15 volumio sudo[1241]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:16 volumio wireless.js[725]: trying...
Apr 29 14:10:16 volumio sudo[1244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:16 volumio sudo[1244]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:16 volumio sudo[1244]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:16 volumio dhcpcd[799]: wlan0: using static address 192.168.1.8/24
Apr 29 14:10:16 volumio dhcpcd[799]: wlan0: adding route to 192.168.1.0/24
Apr 29 14:10:16 volumio dhcpcd[799]: wlan0: adding default route via 192.168.1.1
Apr 29 14:10:16 volumio avahi-daemon[759]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.8.
Apr 29 14:10:16 volumio avahi-daemon[759]: New relevant interface wlan0.IPv4 for mDNS.
Apr 29 14:10:16 volumio avahi-daemon[759]: Registering new address record for 192.168.1.8 on wlan0.IPv4.
Apr 29 14:10:17 volumio wireless.js[725]: trying...
Apr 29 14:10:17 volumio sudo[1264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 14:10:17 volumio sudo[1264]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:17 volumio sudo[1264]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:17 volumio wireless.js[725]: Connected to: ----iCloud
Apr 29 14:10:17 volumio wireless.js[725]: ----
Apr 29 14:10:17 volumio sudo[1267]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 29 14:10:17 volumio sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:17 volumio sudo[1267]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:17 volumio wireless.js[725]: ... joined AP, wlan0 IPv4 is 192.168.1.8, ipV6 is undefined
Apr 29 14:10:17 volumio wireless.js[725]: It's done! AP
Apr 29 14:10:17 volumio systemd[1]: Started Wireless Services.
Apr 29 14:10:17 volumio systemd[1]: Started Volumio Backend Module.
Apr 29 14:10:17 volumio systemd[1]: Started Intel SST and HDA soundcard init service.
Apr 29 14:10:17 volumio systemd[1]: Started Start Volumio Kiosk.
Apr 29 14:10:17 volumio systemd[1]: Started Volumio Cpu Tweaker.
Apr 29 14:10:17 volumio systemd[1]: Reached target Multi-User System.
Apr 29 14:10:17 volumio systemd[1]: Reached target Graphical Interface.
Apr 29 14:10:17 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Apr 29 14:10:17 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Apr 29 14:10:17 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Apr 29 14:10:17 volumio systemd[1]: Startup finished in 6.851s (firmware) + 2.739s (loader) + 9.043s (kernel) + 18.051s (userspace) = 36.685s.
Apr 29 14:10:17 volumio volumio-cpu-tweak[1280]: Setting RT Priority for mpd
Apr 29 14:10:17 volumio volumio-cpu-tweak[1280]: Not enough cores to set MPD affinity
Apr 29 14:10:17 volumio volumio-cpu-tweak[1280]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Apr 29 14:10:17 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded.
Apr 29 14:10:17 volumio startx[1279]: X.Org X Server 1.20.4
Apr 29 14:10:17 volumio startx[1279]: X Protocol Version 11, Revision 0
Apr 29 14:10:17 volumio startx[1279]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian
Apr 29 14:10:17 volumio startx[1279]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64
Apr 29 14:10:17 volumio startx[1279]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=7b43fb7d-889e-4b15-b604-8ac31edf660c bootpart=UUID=6920-BAC4 datapart=UUID=512f5d85-add0-4984-90db-92695e7ad21c hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no
Apr 29 14:10:17 volumio startx[1279]: Build Date: 18 December 2021 09:05:36AM
Apr 29 14:10:17 volumio startx[1279]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support)
Apr 29 14:10:17 volumio startx[1279]: Current version of pixman: 0.36.0
Apr 29 14:10:17 volumio startx[1279]: Before reporting problems, check http://wiki.x.org
Apr 29 14:10:17 volumio startx[1279]: to make sure that you have the latest version.
Apr 29 14:10:17 volumio startx[1279]: Markers: (--) probed, (**) from config file, (==) default setting,
Apr 29 14:10:17 volumio startx[1279]: (++) from command line, (!!) notice, (II) informational,
Apr 29 14:10:17 volumio startx[1279]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Apr 29 14:10:17 volumio startx[1279]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Apr 29 14:10:17 2025
Apr 29 14:10:17 volumio startx[1279]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Apr 29 14:10:17 volumio kernel: broken atomic modeset userspace detected, disabling atomic
Apr 29 14:10:17 volumio startx[1279]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc.
Apr 29 14:10:18 volumio systemd[1]: soundcard-init.service: Succeeded.
Apr 29 14:10:18 volumio ntpd[1123]: Listen normally on 4 wlan0 192.168.1.8:123
Apr 29 14:10:18 volumio ntpd[1123]: new interface(s) found: waking up resolver
Apr 29 14:10:18 volumio volumio[1272]: info: -------------------------------------------
Apr 29 14:10:18 volumio volumio[1272]: info: ----- Volumio3 ----
Apr 29 14:10:18 volumio volumio[1272]: info: -------------------------------------------
Apr 29 14:10:18 volumio volumio[1272]: info: ----- System startup ----
Apr 29 14:10:18 volumio volumio[1272]: info: -------------------------------------------
Apr 29 14:10:19 volumio volumio[1272]: info: MYVOLUMIO Environment detected
Apr 29 14:10:20 volumio volumio[1272]: info: Plugin folders cleanup
Apr 29 14:10:20 volumio volumio[1272]: info: Scanning into folder /volumio/app/plugins/
Apr 29 14:10:20 volumio volumio[1272]: info: Scanning category audio_interface
Apr 29 14:10:20 volumio volumio[1272]: info: Scanning category miscellanea
Apr 29 14:10:20 volumio volumio[1272]: info: Scanning category music_service
Apr 29 14:10:20 volumio volumio[1272]: info: Scanning category plugins.json
Apr 29 14:10:20 volumio volumio[1272]: info: Scanning category system_controller
Apr 29 14:10:20 volumio volumio[1272]: info: Scanning category user_interface
Apr 29 14:10:20 volumio volumio[1272]: info: Scanning into folder /data/plugins/
Apr 29 14:10:20 volumio volumio[1272]: info: Plugin folders cleanup completed
Apr 29 14:10:20 volumio volumio[1272]: info: -------------------------------------------
Apr 29 14:10:20 volumio volumio[1272]: info: ----- Core plugins startup ----
Apr 29 14:10:20 volumio volumio[1272]: info: -------------------------------------------
Apr 29 14:10:20 volumio volumio[1272]: info: Loading plugins from folder /volumio/app/plugins/
Apr 29 14:10:20 volumio volumio[1272]: info: Adding plugin upnp to MyMusic Plugins
Apr 29 14:10:20 volumio volumio[1272]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 29 14:10:20 volumio volumio[1272]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 29 14:10:20 volumio volumio[1272]: info: Loading plugins from folder /data/plugins/
Apr 29 14:10:20 volumio volumio[1272]: info: Loading plugin "system"...
Apr 29 14:10:20 volumio volumio[1272]: info: Loading plugin "appearance"...
Apr 29 14:10:21 volumio volumio[1272]: info: Loading plugin "network"...
Apr 29 14:10:21 volumio volumio[1272]: info: Refreshing Cached IP Addresses
Apr 29 14:10:21 volumio sudo[1481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 29 14:10:21 volumio sudo[1481]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:21 volumio sudo[1483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 29 14:10:21 volumio sudo[1481]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:21 volumio sudo[1483]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:21 volumio sudo[1483]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:21 volumio volumio[1272]: info: Loading plugin "services"...
Apr 29 14:10:21 volumio volumio[1272]: info: Loading plugin "alsa_controller"...
Apr 29 14:10:21 volumio sudo[1496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 29 14:10:21 volumio sudo[1496]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:21 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 14:10:21 volumio volumio[1272]: info: Loading plugin "wizard"...
Apr 29 14:10:21 volumio volumio[1272]: info: Loading plugin "networkfs"...
Apr 29 14:10:21 volumio volumio[1272]: info: Starting Udev Watcher for removable devices
Apr 29 14:10:21 volumio sudo[1518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=kamd,password=XrFyE1969,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/Music /mnt/NAS/NAS
Apr 29 14:10:21 volumio sudo[1520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=kamd,password=XrFyE1969,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/Music /mnt/NAS/Nas
Apr 29 14:10:21 volumio sudo[1518]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:21 volumio sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:21 volumio volumio[1272]: info: Ignoring mount for partition: boot
Apr 29 14:10:21 volumio volumio[1272]: info: Ignoring mount for partition: volumio
Apr 29 14:10:21 volumio volumio[1272]: info: Ignoring mount for partition: volumio_data
Apr 29 14:10:21 volumio volumio[1272]: error: Cannot associate FS Label, not mounting
Apr 29 14:10:21 volumio kernel: FS-Cache: Loaded
Apr 29 14:10:21 volumio kernel: Key type dns_resolver registered
Apr 29 14:10:21 volumio volumio[1272]: info: Ignoring mount for partition: FAF458FAF458BA99
Apr 29 14:10:21 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 29 14:10:21 volumio volumio[1272]: info: Loading plugin "volumio_command_line_client"...
Apr 29 14:10:21 volumio volumio[1272]: info: Loading plugin "upnp"...
Apr 29 14:10:21 volumio volumio[1272]: info: [1745946621827] Starting Upmpd Daemon
Apr 29 14:10:21 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 29 14:10:21 volumio volumio[1272]: info: Loading plugin "my_music"...
Apr 29 14:10:21 volumio volumio[1272]: info: Loading plugin "mpd"...
Apr 29 14:10:21 volumio kernel: Key type cifs.spnego registered
Apr 29 14:10:21 volumio kernel: Key type cifs.idmap registered
Apr 29 14:10:21 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Apr 29 14:10:21 volumio kernel: CIFS: Attempting to mount //192.168.1.10/Music
Apr 29 14:10:21 volumio kernel: CIFS: Attempting to mount //192.168.1.10/Music
Apr 29 14:10:21 volumio sudo[1520]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:21 volumio sudo[1518]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:22 volumio volumio[1272]: info: Loading plugin "upnp_browser"...
Apr 29 14:10:22 volumio volumio[1272]: info: Loading plugin "alarm-clock"...
Apr 29 14:10:22 volumio volumio[1272]: info: Loading plugin "airplay_emulation"...
Apr 29 14:10:22 volumio volumio[1272]: info: Starting Shairport Sync
Apr 29 14:10:22 volumio volumio[1272]: info: Loading plugin "last_100"...
Apr 29 14:10:22 volumio volumio[1272]: info: Loading plugin "webradio"...
Apr 29 14:10:23 volumio volumio[1272]: info: Loading plugin "i2s_dacs"...
Apr 29 14:10:23 volumio volumio[1272]: info: I2S DAC not set, start Auto-detection
Apr 29 14:10:23 volumio volumio[1272]: info: Loading plugin "volumiodiscovery"...
Apr 29 14:10:23 volumio volumio[1272]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 29 14:10:23 volumio volumio[1272]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 29 14:10:23 volumio volumio[1272]: *** WARNING *** For more information see
Apr 29 14:10:23 volumio volumio[1272]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 29 14:10:23 volumio node[1272]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 29 14:10:23 volumio volumio[1272]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 29 14:10:23 volumio volumio[1272]: *** WARNING *** For more information see
Apr 29 14:10:23 volumio node[1272]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 29 14:10:23 volumio node[1272]: *** WARNING *** For more information see
Apr 29 14:10:23 volumio node[1272]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 29 14:10:23 volumio node[1272]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 29 14:10:23 volumio node[1272]: *** WARNING *** For more information see
Apr 29 14:10:23 volumio volumio[1272]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 29 14:10:23 volumio volumio[1272]: info: Discovery: Started advertising with name: Volumio
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 29 14:10:23 volumio volumio[1272]: info: Loading plugin "outputs"...
Apr 29 14:10:23 volumio volumio[1272]: info: Loading plugin "albumart"...
Apr 29 14:10:23 volumio volumio[1272]: info: Plugin example_plugin is not enabled
Apr 29 14:10:23 volumio volumio[1272]: info: Loading plugin "inputs"...
Apr 29 14:10:23 volumio volumio[1272]: info: Loading plugin "updater_comm"...
Apr 29 14:10:23 volumio volumio[1272]: Forking 1 albumart workers
Apr 29 14:10:23 volumio volumio[1272]: info: Plugin mpdemulation is not enabled
Apr 29 14:10:23 volumio volumio[1272]: info: Loading plugin "rest_api"...
Apr 29 14:10:23 volumio volumio[1272]: info: Loading plugin "websocket"...
Apr 29 14:10:23 volumio volumio[1272]: info: Starting Socket.io Server version 2.3.0
Apr 29 14:10:23 volumio volumio[1272]: info: Loading i18n strings for locale ru
Apr 29 14:10:23 volumio volumio[1272]: Updating browse sources language
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::initPlayerControls
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: Express server listening on port 3000
Apr 29 14:10:23 volumio volumio[1272]: [Metrics] WebUI: 5s 331.46ms
Apr 29 14:10:23 volumio volumio[1272]: info: Setting Device type: x86
Apr 29 14:10:23 volumio volumio[1272]: info: CoreStateMachine::resetVolumioState
Apr 29 14:10:23 volumio volumio[1272]: info: CoreStateMachine::getcurrentVolume
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::volumioRetrievevolume
Apr 29 14:10:23 volumio volumio[1272]: Starting albumart workers
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 29 14:10:23 volumio volumio[1272]: info: Completed loading Core Plugins
Apr 29 14:10:23 volumio volumio[1272]: info: Preparing to generate the ALSA configuration file
Apr 29 14:10:23 volumio volumio[1272]: info: Volumio Network Manager: Network status updated: 3
Apr 29 14:10:23 volumio volumio[1272]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 29 14:10:23 volumio volumio[1272]: Unable to parse:
Apr 29 14:10:23 volumio volumio[1272]: Simple mixer control 'IEC958',0
Apr 29 14:10:23 volumio volumio[1272]: Capabilities: pswitch pswitch-joined
Apr 29 14:10:23 volumio volumio[1272]: Playback channels: Mono
Apr 29 14:10:23 volumio volumio[1272]: Mono: Playback [on]
Apr 29 14:10:23 volumio volumio[1272]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Apr 29 14:10:23 volumio volumio[1272]: info: Reloading queue from file
Apr 29 14:10:23 volumio volumio[1272]: Unable to parse:
Apr 29 14:10:23 volumio volumio[1272]: Simple mixer control 'IEC958',0
Apr 29 14:10:23 volumio volumio[1272]: Capabilities: pswitch pswitch-joined
Apr 29 14:10:23 volumio volumio[1272]: Playback channels: Mono
Apr 29 14:10:23 volumio volumio[1272]: Mono: Playback [on]
Apr 29 14:10:23 volumio volumio[1272]: info: VolumeController:: Volume=undefined Mute =false
Apr 29 14:10:23 volumio volumio[1272]: info: CoreStateMachine::pushState
Apr 29 14:10:23 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::volumioPushState
Apr 29 14:10:23 volumio volumio[1272]: info: CoreStateMachine::updateTrackBlock
Apr 29 14:10:23 volumio volumio[1272]: info: CorePlayQueue::getTrackBlock
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::volumioRetrievevolume
Apr 29 14:10:23 volumio volumio[1272]: info: Asound.conf file unchanged, so no further update is needed
Apr 29 14:10:23 volumio volumio[1272]: info: Output device has changed, restarting MPD
Apr 29 14:10:23 volumio sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 29 14:10:23 volumio sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:23 volumio sudo[1635]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:23 volumio volumio[1272]: info: Output device has changed, restarting Shairport Sync
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:23 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:23 volumio sudo[1638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 29 14:10:23 volumio sudo[1638]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:23 volumio systemd[1]: Stopping Music Player Daemon...
Apr 29 14:10:23 volumio volumio[1272]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 29 14:10:23 volumio volumio[1272]: info: ___________ START PLUGINS ___________
Apr 29 14:10:23 volumio systemd[1]: mpd.service: Succeeded.
Apr 29 14:10:23 volumio systemd[1]: Stopped Music Player Daemon.
Apr 29 14:10:23 volumio volumio[1272]: info: ControllerMpd::onStart: Initializing MPD
Apr 29 14:10:23 volumio volumio[1272]: info: Creating MPD Configuration file
Apr 29 14:10:23 volumio systemd[1]: Starting Music Player Daemon...
Apr 29 14:10:23 volumio sudo[1645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 29 14:10:24 volumio sudo[1645]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 14:10:24 volumio sudo[1645]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 29 14:10:24 volumio volumio[1272]: info: [1745946624019] CoreMusicLibrary::Adding element Медиа-серверы
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 14:10:24 volumio sudo[1643]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 29 14:10:24 volumio sudo[1643]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:24 volumio sudo[1643]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:24 volumio sudo[1653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 29 14:10:24 volumio sudo[1653]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:24 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 29 14:10:24 volumio systemd[1]: mpd.service: Succeeded.
Apr 29 14:10:24 volumio systemd[1]: Stopped Music Player Daemon.
Apr 29 14:10:24 volumio systemd[1]: Starting Music Player Daemon...
Apr 29 14:10:24 volumio volumio[1272]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:24 volumio sudo[1661]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 29 14:10:24 volumio sudo[1661]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:24 volumio sudo[1661]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:24 volumio volumio[1272]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 29 14:10:24 volumio volumio[1272]: info: [1745946624153] CoreMusicLibrary::Adding element Last_100
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 29 14:10:24 volumio volumio[1272]: info: [1745946624155] CoreMusicLibrary::Adding element Webradio
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 14:10:24 volumio volumio[1272]: info: Initializing BBC Radios
Apr 29 14:10:24 volumio volumio-remote-updater[704]: [2025-04-29 14:10:24] [connect] Successful connection
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: Volumio Calling Home
Apr 29 14:10:24 volumio volumio[1272]: info: CoreStateMachine::setRepeat null single undefined
Apr 29 14:10:24 volumio volumio[1272]: info: CoreStateMachine::pushState
Apr 29 14:10:24 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::volumioPushState
Apr 29 14:10:24 volumio volumio[1272]: info: CoreStateMachine::setRandom null
Apr 29 14:10:24 volumio volumio[1272]: info: CoreStateMachine::pushState
Apr 29 14:10:24 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::volumioPushState
Apr 29 14:10:24 volumio volumio-remote-updater[704]: [2025-04-29 14:10:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745946624 101
Apr 29 14:10:24 volumio volumio[1272]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1
Apr 29 14:10:24 volumio volumio[1272]: info: MPD Permissions set
Apr 29 14:10:24 volumio volumio[1272]: info: MPD Permissions set
Apr 29 14:10:24 volumio volumio[1272]: Unable to parse:
Apr 29 14:10:24 volumio volumio[1272]: Simple mixer control 'IEC958',0
Apr 29 14:10:24 volumio volumio[1272]: Capabilities: pswitch pswitch-joined
Apr 29 14:10:24 volumio volumio[1272]: Playback channels: Mono
Apr 29 14:10:24 volumio volumio[1272]: Mono: Playback [on]
Apr 29 14:10:24 volumio volumio[1272]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Apr 29 14:10:24 volumio volumio[1272]: error: error
Apr 29 14:10:24 volumio volumio[1272]: info: Volumio called home
Apr 29 14:10:24 volumio volumio[1272]: info: Discovery: adding a32c47ce-75b3-4fd5-ab43-61d7741a31ee
Apr 29 14:10:24 volumio volumio[1272]: info: Discovery: Found device Volumio
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:24 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:24 volumio volumio[1272]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Apr 29 14:10:24 volumio volumio[1272]: error: error
Apr 29 14:10:24 volumio volumio[1272]: error: error
Apr 29 14:10:24 volumio volumio[1272]: Unable to parse:
Apr 29 14:10:24 volumio volumio[1272]: Simple mixer control 'IEC958',0
Apr 29 14:10:24 volumio volumio[1272]: Capabilities: pswitch pswitch-joined
Apr 29 14:10:24 volumio volumio[1272]: Playback channels: Mono
Apr 29 14:10:24 volumio volumio[1272]: Mono: Playback [on]
Apr 29 14:10:24 volumio volumio[1272]: info: VolumeController:: Volume=undefined Mute =false
Apr 29 14:10:24 volumio volumio[1272]: info: CoreStateMachine::pushState
Apr 29 14:10:24 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::volumioPushState
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 29 14:10:24 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:24 volumio mpd[1668]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 29 14:10:24 volumio mpd[1668]: output: No 'audio_output' defined in config file
Apr 29 14:10:24 volumio mpd[1668]: couldn't open play stream: No such file or directory
Apr 29 14:10:24 volumio mpd[1668]: sndio_output: Error opening default sndio device
Apr 29 14:10:24 volumio mpd[1668]: output: Successfully detected a alsa audio device
Apr 29 14:10:24 volumio mpd[1668]: zeroconf: No global port, disabling zeroconf
Apr 29 14:10:24 volumio systemd[1]: Started Music Player Daemon.
Apr 29 14:10:24 volumio sudo[1638]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:24 volumio sudo[1653]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:25 volumio volumio[1272]: info: Discovery: this is already registered, a32c47ce-75b3-4fd5-ab43-61d7741a31ee
Apr 29 14:10:25 volumio volumio[1272]: info: Discovery: Found device Volumio
Apr 29 14:10:25 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:25 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: info: Completed starting Core Plugins
Apr 29 14:10:25 volumio volumio[1272]: info: -------------------------------------------
Apr 29 14:10:25 volumio volumio[1272]: info: ----- MyVolumio plugins startup ----
Apr 29 14:10:25 volumio volumio[1272]: info: -------------------------------------------
Apr 29 14:10:25 volumio volumio[1272]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: info: Starting Shairport Sync
Apr 29 14:10:25 volumio volumio[1272]: info: Starting Shairport Sync
Apr 29 14:10:25 volumio sudo[1703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 29 14:10:25 volumio sudo[1703]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:25 volumio volumio[1272]: info: Starting Shairport Sync
Apr 29 14:10:25 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 29 14:10:25 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 29 14:10:25 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 29 14:10:25 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 29 14:10:25 volumio sudo[1703]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:25 volumio sudo[1708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 29 14:10:25 volumio sudo[1708]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:25 volumio sudo[1706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 29 14:10:25 volumio sudo[1706]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:25 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 29 14:10:25 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 29 14:10:25 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 29 14:10:25 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 29 14:10:25 volumio sudo[1708]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:25 volumio sudo[1706]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:25 volumio volumio[1272]: error: MPD error: The expression evaluated to a falsy value:
Apr 29 14:10:25 volumio volumio[1272]: assert.ok(self.idling)
Apr 29 14:10:25 volumio volumio[1272]: error: The expression evaluated to a falsy value:
Apr 29 14:10:25 volumio volumio[1272]: assert.ok(self.idling)
Apr 29 14:10:25 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:25 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio mpd[1668]: mixer: Failed to read mixer for 'default detected output': no such mixer control: PCM
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: info: MPD running with PID1668
Apr 29 14:10:25 volumio volumio[1272]: ,establishing connection
Apr 29 14:10:25 volumio volumio[1272]: error: updateQueue error: null
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: info: Shairport-Sync Started
Apr 29 14:10:25 volumio volumio[1272]: Error adding Membership: Error: addMembership EINVAL
Apr 29 14:10:25 volumio volumio[1272]: info: Shairport-Sync Started
Apr 29 14:10:25 volumio volumio[1272]: info: Shairport-Sync Started
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: updateQueue error: null
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:25 volumio volumio[1272]: error: error
Apr 29 14:10:26 volumio volumio[1272]: error: error
Apr 29 14:10:26 volumio volumio[1272]: error: error
Apr 29 14:10:26 volumio volumio[1272]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Apr 29 14:10:27 volumio volumio[1272]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 29 14:10:28 volumio sudo[1496]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:28 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 29 14:10:28 volumio volumio[1272]: info: Received Get System Info
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 29 14:10:28 volumio volumio[1272]: info: Discovery: Getting this device information
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:28 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:28 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:28 volumio volumio[1272]: info: Listing playlists
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 29 14:10:28 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:28 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:29 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 29 14:10:29 volumio volumio[1272]: info: Received Get System Info
Apr 29 14:10:29 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 29 14:10:29 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 29 14:10:29 volumio volumio[1272]: info: Discovery: Getting this device information
Apr 29 14:10:29 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:29 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:29 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 29 14:10:30 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Apr 29 14:10:30 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Apr 29 14:10:30 volumio mpd[1668]: exception: No database
Apr 29 14:10:30 volumio mpd[1668]: exception: No database
Apr 29 14:10:30 volumio mpd[1668]: exception: No database
Apr 29 14:10:30 volumio volumio[1272]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database
Apr 29 14:10:30 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Apr 29 14:10:31 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 29 14:10:31 volumio volumio[1272]: info: Received Get System Info
Apr 29 14:10:31 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 29 14:10:31 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 29 14:10:31 volumio volumio[1272]: info: Discovery: Getting this device information
Apr 29 14:10:31 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:31 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:31 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 29 14:10:31 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Apr 29 14:10:31 volumio sudo[1737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 29 14:10:31 volumio sudo[1737]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:31 volumio sudo[1737]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:31 volumio sudo[1740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 29 14:10:31 volumio sudo[1740]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:31 volumio sudo[1740]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:31 volumio sudo[1743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 29 14:10:31 volumio sudo[1743]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:31 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 29 14:10:31 volumio sudo[1743]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:31 volumio volumio[1272]: info: Upmpdcli Daemon Started
Apr 29 14:10:31 volumio volumio[1745]: Generating RSA private key, 4096 bit long modulus (2 primes)
Apr 29 14:10:32 volumio volumio[1745]: .++++
Apr 29 14:10:33 volumio volumio[1745]: .......................................................................................................++++
Apr 29 14:10:33 volumio volumio[1745]: e is 65537 (0x010001)
Apr 29 14:10:33 volumio volumio[1745]: writing RSA key
Apr 29 14:10:33 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Apr 29 14:10:33 volumio volumio[1272]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 29 14:10:33 volumio volumio[1272]: info: Adding plugin multiroom to MyMusic Plugins
Apr 29 14:10:33 volumio volumio[1272]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 29 14:10:33 volumio volumio[1272]: info: Adding plugin cd_controller to MyMusic Plugins
Apr 29 14:10:33 volumio volumio[1272]: info: Adding plugin smart_inputs to MyMusic Plugins
Apr 29 14:10:33 volumio volumio[1272]: info: Adding plugin tidalconnect to MyMusic Plugins
Apr 29 14:10:33 volumio volumio[1272]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Apr 29 14:10:34 volumio volumio[1272]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Apr 29 14:10:34 volumio volumio[1272]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Apr 29 14:10:34 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:34 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:34 volumio volumio[1272]: info: Starting MyVolumio Remote Streaming Endpoints
Apr 29 14:10:34 volumio volumio[1272]: info: MyVolumio login type: Token
Apr 29 14:10:34 volumio volumio[1272]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Apr 29 14:10:34 volumio volumio[1272]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Apr 29 14:10:35 volumio volumio[1272]: info: Starting Streaming Service Transparent Proxy
Apr 29 14:10:35 volumio volumio[1272]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Apr 29 14:10:35 volumio volumio[1272]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Apr 29 14:10:35 volumio volumio[1272]: info: Streaming services startup
Apr 29 14:10:35 volumio volumio[1272]: info: Starting Streaming Daemon
Apr 29 14:10:35 volumio sudo[1847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 29 14:10:35 volumio sudo[1847]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:35 volumio sudo[1847]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:35 volumio volumio[1272]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Apr 29 14:10:35 volumio volumio[1272]: error: Cannot start Volumio Streaming Daemon
Apr 29 14:10:35 volumio volumio[1272]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 29 14:10:35 volumio volumio[1272]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 29 14:10:35 volumio volumio[1272]: error: MyVolumio Custom Token format not valid, refreshing it
Apr 29 14:10:36 volumio volumio[1272]: STREAMING PROXY: Starting server on port 3245
Apr 29 14:10:36 volumio volumio[1272]: Node JS runtime: 14
Apr 29 14:10:36 volumio volumio[1272]: info: MyVolumio login type: Token
Apr 29 14:10:36 volumio volumio[1272]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 29 14:10:37 volumio volumio[1272]: info: Retrieving Cloud Streaming UI
Apr 29 14:10:37 volumio volumio[1272]: info: Getting Tidal Cloud Configuration
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 29 14:10:37 volumio volumio[1272]: info: Getting Qobuz Cloud Configuration
Apr 29 14:10:37 volumio volumio[1272]: info: Asking plugin for UI Config
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 29 14:10:37 volumio volumio[1272]: info: Getting Spotify Cloud Configuration
Apr 29 14:10:37 volumio volumio[1272]: info: Asking plugin for UI Config
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 29 14:10:37 volumio volumio[1272]: info: Saving Spotify Acccount
Apr 29 14:10:37 volumio volumio[1272]: info: Got Tidal Cloud Configuration
Apr 29 14:10:37 volumio volumio[1272]: info: Got it
Apr 29 14:10:37 volumio volumio[1272]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 29 14:10:37 volumio volumio[1272]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 29 14:10:37 volumio volumio[1272]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 29 14:10:37 volumio volumio[1272]: info: MyVolumio token set successfully
Apr 29 14:10:37 volumio volumio[1272]: info: MYVOLUMIO: Adding device
Apr 29 14:10:37 volumio volumio[1272]: info: MYVOLUMIO: Evaluating Server
Apr 29 14:10:37 volumio volumio[1272]: info: MyVolumio status changed
Apr 29 14:10:37 volumio volumio[1272]: info: Streaming services startup
Apr 29 14:10:37 volumio volumio[1272]: info: Starting Streaming Daemon
Apr 29 14:10:37 volumio volumio[1272]: info: Removing browser output: myVolumio user plan is not superstar
Apr 29 14:10:37 volumio volumio[1272]: info: Removing audio output:
Apr 29 14:10:37 volumio volumio[1272]: info: Stoppping Tunnel 1
Apr 29 14:10:37 volumio sudo[2028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 29 14:10:37 volumio sudo[2028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:37 volumio sudo[2031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Apr 29 14:10:37 volumio sudo[2031]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:37 volumio sudo[2028]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:37 volumio sudo[2031]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:37 volumio volumio[1272]: error: Cannot start Volumio Streaming Daemon
Apr 29 14:10:37 volumio volumio[1272]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 29 14:10:37 volumio volumio[1272]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 29 14:10:37 volumio volumio[1272]: info: Remote SSH Stopped
Apr 29 14:10:38 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:10:38 volumio mpd[1668]: exception: No database
Apr 29 14:10:38 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 29 14:10:38 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 29 14:10:38 volumio volumio[1272]: info: Setting Geolocation for MyVolumio to eu10
Apr 29 14:10:38 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:38 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:38 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:38 volumio volumio[1272]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Apr 29 14:10:39 volumio volumio[1272]: info: Updating MyVolumio device info
Apr 29 14:10:39 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:39 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:39 volumio volumio[1272]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Apr 29 14:10:41 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:10:41 volumio mpd[1668]: exception: No database
Apr 29 14:10:42 volumio systemd[1]: systemd-timedated.service: Succeeded.
Apr 29 14:10:42 volumio volumio[1272]: info: MYVOLUMIO: Adding device
Apr 29 14:10:42 volumio volumio[1272]: info: MYVOLUMIO: Evaluating Server
Apr 29 14:10:44 volumio volumio[1272]: info: Setting Geolocation for MyVolumio to eu7
Apr 29 14:10:44 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:44 volumio volumio[1272]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Apr 29 14:10:45 volumio volumio[1272]: info: Updating MyVolumio device info
Apr 29 14:10:45 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:45 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:10:45 volumio mpd[1668]: exception: No database
Apr 29 14:10:46 volumio volumio[1272]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Apr 29 14:10:46 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 29 14:10:46 volumio volumio[1272]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Apr 29 14:10:46 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Apr 29 14:10:46 volumio volumio[1272]: info: Received Get System Version
Apr 29 14:10:46 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 14:10:46 volumio volumio[1272]: info: Received Get System Info
Apr 29 14:10:46 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 29 14:10:46 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 29 14:10:46 volumio volumio[1272]: info: Discovery: Getting this device information
Apr 29 14:10:46 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:46 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:46 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 29 14:10:47 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Apr 29 14:10:47 volumio sudo[2075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Nas
Apr 29 14:10:47 volumio sudo[2075]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 14:10:47 volumio systemd[1]: mnt-NAS-Nas.mount: Succeeded.
Apr 29 14:10:47 volumio sudo[2075]: pam_unix(sudo:session): session closed for user root
Apr 29 14:10:47 volumio volumio[1272]: info: Share Nas successfully unmounted
Apr 29 14:10:48 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 29 14:10:49 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 29 14:10:49 volumio volumio[1272]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Apr 29 14:10:49 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:10:49 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:10:49 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:10:49 volumio mpd[1668]: exception: No database
Apr 29 14:10:50 volumio volumio[1272]: info: [1745946650467] Database scan error: Error: Command failed: /usr/bin/mpc update
Apr 29 14:10:50 volumio volumio[1272]: MPD error: No database
Apr 29 14:10:50 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Apr 29 14:10:50 volumio volumio[1272]: verbose: ControllerMpd::sendMpdCommand rescan
Apr 29 14:10:53 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:10:53 volumio mpd[1668]: exception: No database
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 14:10:54 volumio volumio-remote-updater[704]: No test mode
Apr 29 14:10:54 volumio volumio-remote-updater[704]: No alpha test mode
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 29 14:10:54 volumio volumio[1272]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Slow down CD read speed
\n- Fix NAS Mounting
\n
\nNEW ADDITIONS
\n\n- Revert TIDAL Connect to working version
\n- Fix for USB DAC not recognized after OTA update
\n
\n","title":"Update v3.804","updateavailable":true}
Apr 29 14:10:54 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 29 14:10:55 volumio volumio[1272]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Apr 29 14:10:55 volumio volumio[1272]: info: Completed starting MyVolumio Plugin
Apr 29 14:10:55 volumio volumio[1272]: [Metrics] CommandRouter: 36s 645.99ms
Apr 29 14:10:55 volumio volumio[1272]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 29 14:10:55 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 14:10:55 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 14:10:55 volumio volumio[1272]: info: CoreCommandRouter::Close All Modals sent
Apr 29 14:10:55 volumio volumio[1272]: info: CoreCommandRouter::Close All Modals sent
Apr 29 14:10:56 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 29 14:10:56 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 29 14:10:56 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 29 14:10:57 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:10:57 volumio mpd[1668]: exception: No database
Apr 29 14:10:58 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Apr 29 14:10:58 volumio volumio[1272]: verbose: ControllerMpd::sendMpdCommand rescan
Apr 29 14:11:01 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:11:01 volumio mpd[1668]: exception: No database
Apr 29 14:11:02 volumio volumio[1272]: info: BOOT COMPLETED
Apr 29 14:11:05 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:11:05 volumio mpd[1668]: exception: No database
Apr 29 14:11:09 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:11:09 volumio mpd[1668]: exception: No database
Apr 29 14:11:10 volumio ntpd[1123]: Soliciting pool server 194.87.248.43
Apr 29 14:11:11 volumio ntpd[1123]: Soliciting pool server 51.250.35.68
Apr 29 14:11:12 volumio ntpd[1123]: Soliciting pool server 5.35.9.241
Apr 29 14:11:13 volumio ntpd[1123]: Soliciting pool server 89.109.251.21
Apr 29 14:11:13 volumio ntpd[1123]: Soliciting pool server 193.106.93.116
Apr 29 14:11:13 volumio ntpd[1123]: Soliciting pool server 109.195.84.246
Apr 29 14:11:13 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 29 14:11:13 volumio mpd[1668]: exception: No database
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio ntpd[1123]: Soliciting pool server 91.201.254.110
Apr 29 14:11:14 volumio ntpd[1123]: Soliciting pool server 162.159.200.123
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:14 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio ntpd[1123]: Soliciting pool server 89.108.115.94
Apr 29 14:11:15 volumio ntpd[1123]: Soliciting pool server 195.218.227.230
Apr 29 14:11:15 volumio ntpd[1123]: Soliciting pool server 217.69.139.133
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:15 volumio volumio[1272]: error: error
Apr 29 14:11:16 volumio ntpd[1123]: Soliciting pool server 213.108.170.26
Apr 29 14:11:16 volumio ntpd[1123]: Soliciting pool server 92.241.12.152
Apr 29 14:11:16 volumio ntpd[1123]: Soliciting pool server 92.255.126.3
Apr 29 14:11:17 volumio ntpd[1123]: Soliciting pool server 91.207.136.55
Apr 29 14:11:17 volumio ntpd[1123]: Soliciting pool server 2a02:6bf:f000:1:1::1
Apr 29 14:11:18 volumio ntpd[1123]: Soliciting pool server 185.247.185.18
Apr 29 14:11:18 volumio volumio[1272]: info: CoreCommandRouter::volumioGetState
Apr 29 14:11:18 volumio volumio[1272]: info: CorePlayQueue::getTrack 0
Apr 29 14:11:19 volumio ntpd[1123]: receive: Unexpected origin timestamp 0xebbb86b7.3ee90300 does not match aorg 0000000000.00000000 from server@89.108.115.94 xmt 0xebbb86b7.74808752
Apr 29 14:11:19 volumio ntpd[1123]: receive: Unexpected origin timestamp 0xebbb86b7.3eeaa481 does not match aorg 0000000000.00000000 from server@193.106.93.116 xmt 0xebbb86b7.7494ce2c
Apr 29 14:11:19 volumio ntpd[1123]: receive: Unexpected origin timestamp 0xebbb86b7.3ee80e57 does not match aorg 0000000000.00000000 from server@217.69.139.133 xmt 0xebbb86b7.7487ce39
Apr 29 14:11:19 volumio ntpd[1123]: receive: Unexpected origin timestamp 0xebbb86b7.3eeb624a does not match aorg 0000000000.00000000 from server@89.109.251.21 xmt 0xebbb86b7.74c9787f
Apr 29 14:11:19 volumio ntpd[1123]: receive: Unexpected origin timestamp 0xebbb86b7.3ee9e25c does not match aorg 0000000000.00000000 from server@91.201.254.110 xmt 0xebbb86b7.74f01798
Apr 29 14:11:19 volumio ntpd[1123]: receive: Unexpected origin timestamp 0xebbb86b7.3ee758f9 does not match aorg 0000000000.00000000 from server@92.241.12.152 xmt 0xebbb86b7.74f8ceb5
Apr 29 14:11:19 volumio ntpd[1123]: receive: Unexpected origin timestamp 0xebbb86b7.3ee102b2 does not match aorg 0000000000.00000000 from server@91.207.136.55 xmt 0xebbb86b7.778f0362
Apr 29 14:11:24 volumio volumio[1272]: info: CoreCommandRouter::volumioGetQueue
Apr 29 14:11:24 volumio volumio[1272]: info: CoreStateMachine::getQueue
Apr 29 14:11:24 volumio volumio[1272]: info: CorePlayQueue::getQueue
Apr 29 14:11:26 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 29 14:11:26 volumio volumio[1272]: info: CURURI: music-library
Apr 29 14:11:26 volumio mpd[1668]: exception: No database
Apr 29 14:11:26 volumio volumio[1272]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database
Apr 29 14:11:26 volumio volumio[1272]: info: Preload queue cleared
Apr 29 14:11:33 volumio volumio[1272]: info: Preload queue cleared
Apr 29 14:11:36 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 29 14:11:36 volumio volumio[1272]: info: CURURI: playlists
Apr 29 14:11:36 volumio volumio[1272]: info: Listing playlists
Apr 29 14:11:36 volumio volumio[1272]: info: Preload queue cleared
Apr 29 14:11:40 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 29 14:11:40 volumio volumio[1272]: info: Preload queue cleared
Apr 29 14:11:42 volumio volumio[1272]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 29 14:11:44 volumio volumio[1272]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 29 14:11:44 volumio volumio[1272]: TypeError: Cannot read property 'length' of undefined
Apr 29 14:11:44 volumio volumio[1272]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
Apr 29 14:11:44 volumio volumio[1272]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
Apr 29 14:11:44 volumio volumio[1272]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
Apr 29 14:11:44 volumio volumio[1272]: at Parser.emit (events.js:400:28)
Apr 29 14:11:44 volumio volumio[1272]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
Apr 29 14:11:44 volumio volumio[1272]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
Apr 29 14:11:44 volumio volumio[1272]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
Apr 29 14:11:44 volumio volumio[1272]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
Apr 29 14:11:44 volumio volumio[1272]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
Apr 29 14:11:44 volumio volumio[1272]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
Apr 29 14:11:44 volumio volumio[1272]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
Apr 29 14:11:44 volumio volumio[1272]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
Apr 29 14:11:44 volumio volumio[1272]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
Apr 29 14:11:44 volumio volumio[1272]: at IncomingMessage.emit (events.js:412:35)
Apr 29 14:11:44 volumio volumio[1272]: at endReadableNT (internal/streams/readable.js:1333:12)
Apr 29 14:11:44 volumio volumio[1272]: at processTicksAndRejections (internal/process/task_queues.js:82:21)
Apr 29 14:11:44 volumio volumio[1272]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 29 14:11:44 volumio sudo[2240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-29 14:10
Apr 29 14:11:44 volumio sudo[2240]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST"
VOLUMIO_VERSION="3.799"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"