-- Logs begin at Thu 2025-05-08 21:17:55 +07, end at Thu 2025-05-08 21:19:06 +07. --
May 08 21:18:00 volumio kernel: snd_hda_intel 0000:00:01.1: Force to non-snoop mode
May 08 21:18:00 volumio kernel: snd_hda_intel 0000:00:09.2: enabling device (0004 -> 0006)
May 08 21:18:00 volumio kernel: snd_hda_intel 0000:00:01.1: bound 0000:00:01.0 (ops dc_fixpt_from_fraction.cold [amdgpu])
May 08 21:18:00 volumio kernel: input: HDA ATI HDMI HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.1/sound/card0/input16
May 08 21:18:00 volumio kernel: input: HDA ATI HDMI HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:01.1/sound/card0/input17
May 08 21:18:00 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: autoconfig for ALC255: line_outs=1 (0x14/0x0/0x0/0x0/0x0) type:speaker
May 08 21:18:00 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:    speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
May 08 21:18:00 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:    hp_outs=1 (0x21/0x0/0x0/0x0/0x0)
May 08 21:18:00 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:    mono: mono_out=0x0
May 08 21:18:00 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:    inputs:
May 08 21:18:00 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:      Mic=0x19
May 08 21:18:00 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:      Line=0x1b
May 08 21:18:00 volumio systemd-udevd[577]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio kernel: input: HD-Audio Generic Mic as /devices/pci0000:00/0000:00:09.2/sound/card1/input18
May 08 21:18:00 volumio kernel: input: HD-Audio Generic Line as /devices/pci0000:00/0000:00:09.2/sound/card1/input19
May 08 21:18:00 volumio kernel: input: HD-Audio Generic Front Headphone as /devices/pci0000:00/0000:00:09.2/sound/card1/input20
May 08 21:18:00 volumio systemd-udevd[602]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[581]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[580]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[611]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[613]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[598]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[608]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[584]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[583]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[607]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[599]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio kernel: kvm_amd: SVM disabled (by BIOS) in MSR_VM_CR on CPU 0
May 08 21:18:00 volumio systemd-udevd[601]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[612]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[593]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[613]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[598]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio systemd-udevd[599]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 08 21:18:00 volumio kernel: alsactl[726]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set
May 08 21:18:00 volumio systemd-udevd[579]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 99.
May 08 21:18:00 volumio systemd-udevd[614]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 1' failed with exit code 99.
May 08 21:18:00 volumio systemd[1]: Found device Mass_Storage boot.
May 08 21:18:00 volumio systemd[1]: Condition check resulted in RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller being skipped.
May 08 21:18:00 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
May 08 21:18:01 volumio systemd[1]: Starting Show Plymouth Boot Screen...
May 08 21:18:01 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
May 08 21:18:01 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/1409-87FE...
May 08 21:18:01 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
May 08 21:18:01 volumio systemd[1]: plymouth-start.service: Succeeded.
May 08 21:18:01 volumio systemd[1]: Started Show Plymouth Boot Screen.
May 08 21:18:01 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
May 08 21:18:01 volumio systemd[1]: Started File System Check Daemon to report status.
May 08 21:18:01 volumio systemd-fsck[740]: fsck.fat 4.1 (2017-01-24)
May 08 21:18:01 volumio systemd-fsck[740]: There are differences between boot sector and its backup.
May 08 21:18:01 volumio systemd-fsck[740]: This is mostly harmless. Differences: (offset:original/backup)
May 08 21:18:01 volumio systemd-fsck[740]:   3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74
May 08 21:18:01 volumio systemd-fsck[740]:   , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22
May 08 21:18:01 volumio systemd-fsck[740]:   , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb
May 08 21:18:01 volumio systemd-fsck[740]:   , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb
May 08 21:18:01 volumio systemd-fsck[740]:   , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd
May 08 21:18:01 volumio systemd-fsck[740]:   , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69
May 08 21:18:01 volumio systemd-fsck[740]:   , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e
May 08 21:18:01 volumio systemd-fsck[740]:   , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62
May 08 21:18:01 volumio systemd-fsck[740]:   , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c
May 08 21:18:01 volumio systemd-fsck[740]:   , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b
May 08 21:18:01 volumio systemd-fsck[740]:   , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61
May 08 21:18:01 volumio systemd-fsck[740]:   , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73
May 08 21:18:01 volumio systemd-fsck[740]:   , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20
May 08 21:18:01 volumio systemd-fsck[740]:   , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62
May 08 21:18:01 volumio systemd-fsck[740]:   , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f
May 08 21:18:01 volumio systemd-fsck[740]:   , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e
May 08 21:18:01 volumio systemd-fsck[740]:   , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65
May 08 21:18:01 volumio systemd-fsck[740]:   , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79
May 08 21:18:01 volumio systemd-fsck[740]:   , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74
May 08 21:18:01 volumio systemd-fsck[740]:   , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20
May 08 21:18:01 volumio systemd-fsck[740]:   , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20
May 08 21:18:01 volumio systemd-fsck[740]:   , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a
May 08 21:18:01 volumio systemd-fsck[740]:   , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 282:c6/00, 283:9b/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00
May 08 21:18:01 volumio systemd-fsck[740]:   , 508:18/00, 509:37/00
May 08 21:18:01 volumio systemd-fsck[740]:   Not automatically fixing this.
May 08 21:18:01 volumio systemd-fsck[740]: /dev/sdc1: 18 files, 159616/344788 clusters
May 08 21:18:01 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/1409-87FE.
May 08 21:18:01 volumio systemd[1]: Mounting /boot...
May 08 21:18:01 volumio kernel: FAT-fs (sdc1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
May 08 21:18:01 volumio systemd[1]: Mounted /boot.
May 08 21:18:01 volumio systemd[1]: Reached target Local File Systems.
May 08 21:18:01 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
May 08 21:18:01 volumio systemd[1]: Starting Preprocess NFS configuration...
May 08 21:18:01 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
May 08 21:18:01 volumio systemd[1]: Starting Raise network interfaces...
May 08 21:18:01 volumio systemd[1]: Starting Create Volatile Files and Directories...
May 08 21:18:01 volumio systemd[1]: Started ifup for eth0.
May 08 21:18:01 volumio systemd[1]: Received SIGRTMIN+20 from PID 379 (plymouthd).
May 08 21:18:01 volumio systemd[1]: plymouth-read-write.service: Succeeded.
May 08 21:18:01 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
May 08 21:18:01 volumio systemd[1]: nfs-config.service: Succeeded.
May 08 21:18:01 volumio systemd[1]: Started Preprocess NFS configuration.
May 08 21:18:01 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
May 08 21:18:01 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
May 08 21:18:01 volumio systemd[1]: Reached target NFS client services.
May 08 21:18:01 volumio systemd[1]: Started Create Volatile Files and Directories.
May 08 21:18:01 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
May 08 21:18:01 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
May 08 21:18:01 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown...
May 08 21:18:01 volumio systemd[1]: Starting RPC bind portmap service...
May 08 21:18:01 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown.
May 08 21:18:01 volumio systemd[1]: Reached target System Initialization.
May 08 21:18:01 volumio systemd[1]: Started Daily apt download activities.
May 08 21:18:01 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
May 08 21:18:01 volumio systemd[1]: Started Daily Cleanup of Temporary Directories.
May 08 21:18:01 volumio systemd[1]: Listening on triggerhappy.socket.
May 08 21:18:01 volumio systemd[1]: Started Daily man-db regeneration.
May 08 21:18:01 volumio systemd[1]: Started Daily apt upgrade and clean activities.
May 08 21:18:01 volumio systemd[1]: Reached target Timers.
May 08 21:18:01 volumio systemd[1]: Listening on D-Bus System Message Bus Socket.
May 08 21:18:01 volumio systemd[1]: Reached target Sockets.
May 08 21:18:01 volumio systemd[1]: Reached target Basic System.
May 08 21:18:01 volumio systemd[1]: Starting Login Service...
May 08 21:18:01 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
May 08 21:18:01 volumio systemd[1]: Starting Wireless Services...
May 08 21:18:01 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
May 08 21:18:01 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
May 08 21:18:01 volumio systemd[1]: Started volumio-remote-updater.service.
May 08 21:18:01 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
May 08 21:18:01 volumio systemd[1]: Started Manage Sound Card State (restore and store).
May 08 21:18:01 volumio systemd[1]: Started Volumio Log Rotation Service.
May 08 21:18:01 volumio systemd[1]: Starting triggerhappy global hotkey daemon...
May 08 21:18:01 volumio alsactl[778]: alsactl 1.1.8 daemon started
May 08 21:18:01 volumio systemd[1]: Starting Save/Restore Sound Card State...
May 08 21:18:01 volumio systemd[1]: Started Volumio Iptables Module.
May 08 21:18:01 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
May 08 21:18:01 volumio systemd[1]: Starting DHCP Client Daemon...
May 08 21:18:01 volumio systemd[1]: Started MPD Monitor Service.
May 08 21:18:01 volumio systemd[1]: Started D-Bus System Message Bus.
May 08 21:18:01 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
May 08 21:18:01 volumio systemd[1]: Starting WPA supplicant...
May 08 21:18:01 volumio systemd[1]: Starting Volumio Time Update Utility...
May 08 21:18:01 volumio kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
May 08 21:18:01 volumio kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
May 08 21:18:01 volumio volumio-time-update[792]: volumio-time-update-util: Fetching time from Volumio...
May 08 21:18:01 volumio alsactl[778]: No state is present for card HDMI
May 08 21:18:01 volumio alsactl[778]: Found hardware: "HDA-Intel" "ATI R6xx HDMI" "HDA:1002aa01,00aa0100,00100700" "0x103c" "0x8158"
May 08 21:18:01 volumio alsactl[778]: Hardware is initialized using a generic method
May 08 21:18:01 volumio alsactl[778]: No state is present for card HDMI
May 08 21:18:01 volumio alsactl[778]: No state is present for card Generic
May 08 21:18:01 volumio alsactl[778]: Found hardware: "HDA-Intel" "Realtek ALC255" "HDA:10ec0255,103c8158,00100002" "0x103c" "0x8158"
May 08 21:18:01 volumio alsactl[778]: Hardware is initialized using a generic method
May 08 21:18:01 volumio alsactl[778]: No state is present for card Generic
May 08 21:18:01 volumio ifup[749]: command failed: No such device (-19)
May 08 21:18:01 volumio mpd_monitor.sh[785]: MPD Monitor Service: Starting MPD Monitor Service
May 08 21:18:01 volumio alsactl[782]: No state is present for card HDMI
May 08 21:18:01 volumio alsactl[782]: Found hardware: "HDA-Intel" "ATI R6xx HDMI" "HDA:1002aa01,00aa0100,00100700" "0x103c" "0x8158"
May 08 21:18:01 volumio alsactl[782]: Hardware is initialized using a generic method
May 08 21:18:01 volumio sh[754]: command failed: No such device (-19)
May 08 21:18:01 volumio alsactl[782]: No state is present for card HDMI
May 08 21:18:01 volumio alsactl[782]: No state is present for card Generic
May 08 21:18:01 volumio alsactl[782]: Found hardware: "HDA-Intel" "Realtek ALC255" "HDA:10ec0255,103c8158,00100002" "0x103c" "0x8158"
May 08 21:18:01 volumio alsactl[782]: Hardware is initialized using a generic method
May 08 21:18:01 volumio alsactl[782]: No state is present for card Generic
May 08 21:18:01 volumio thd[781]: Unable to parse trigger line:
May 08 21:18:01 volumio thd[781]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
May 08 21:18:01 volumio thd[781]: Unable to parse trigger line:
May 08 21:18:01 volumio thd[781]: Unable to parse trigger line:
May 08 21:18:01 volumio thd[781]: Found socket passed from systemd
May 08 21:18:01 volumio thd[781]: Device /dev/input/event7 not suitable.
May 08 21:18:01 volumio thd[781]: Device /dev/input/event8 not suitable.
May 08 21:18:02 volumio systemd-logind[773]: New seat seat0.
May 08 21:18:02 volumio systemd-logind[773]: Watching system buttons on /dev/input/event1 (Power Button)
May 08 21:18:02 volumio systemd-logind[773]: Watching system buttons on /dev/input/event0 (Power Button)
May 08 21:18:02 volumio systemd-logind[773]: Watching system buttons on /dev/input/event3 (MOSART Semi. wireless dongle)
May 08 21:18:02 volumio systemd-logind[773]: Watching system buttons on /dev/input/event5 (MOSART Semi. wireless dongle Consumer Control)
May 08 21:18:02 volumio systemd-logind[773]: Watching system buttons on /dev/input/event6 (MOSART Semi. wireless dongle System Control)
May 08 21:18:02 volumio systemd-logind[773]: Watching system buttons on /dev/input/event9 (Usb KeyBoard Usb KeyBoard)
May 08 21:18:02 volumio systemd-logind[773]: Watching system buttons on /dev/input/event10 (Usb KeyBoard Usb KeyBoard Consumer Control)
May 08 21:18:02 volumio systemd-logind[773]: Watching system buttons on /dev/input/event11 (Usb KeyBoard Usb KeyBoard System Control)
May 08 21:18:02 volumio kernel: 8021q: 802.1Q VLAN Support v1.8
May 08 21:18:02 volumio mpd_monitor.sh[785]: MPD error: Cannot assign requested address
May 08 21:18:02 volumio mpd_monitor.sh[785]: MPD Monitor Service: MPD Appears to be inactive, restarting
May 08 21:18:02 volumio avahi-daemon[790]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113).
May 08 21:18:02 volumio avahi-daemon[790]: Successfully dropped root privileges.
May 08 21:18:02 volumio avahi-daemon[790]: avahi-daemon 0.7 starting up.
May 08 21:18:02 volumio sh[754]: sending commands to master dhcpcd process
May 08 21:18:02 volumio dhcpcd[839]: sending commands to master dhcpcd process
May 08 21:18:02 volumio haveged[767]: haveged: ver: 1.9.1; arch: x86; vend: ; build: (gcc 8.3.0 ITV); collect: 128K
May 08 21:18:02 volumio haveged[767]: haveged: cpu: (VC); data: 32K (V); inst: 96K (V); idx: 39/40; sz: 52825/52825
May 08 21:18:02 volumio haveged[767]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B):  last entropy estimate 8.00151
May 08 21:18:02 volumio haveged[767]: haveged: fills: 0, generated: 0
May 08 21:18:02 volumio ifup[749]: command failed: No such device (-19)
May 08 21:18:02 volumio mpd_monitor.sh[785]: mpd: no process found
May 08 21:18:03 volumio dhcpcd[784]: no interfaces have a carrier
May 08 21:18:03 volumio dhcpcd[784]: no interfaces have a carrier
May 08 21:18:03 volumio dhcpcd[784]: forked to background, child pid 890
May 08 21:18:03 volumio dhcpcd[784]: forked to background, child pid 890
May 08 21:18:03 volumio volumio-remote-updater[776]: Error: No active session
May 08 21:18:03 volumio kernel: Generic FE-GE Realtek PHY r8169-0-100:00: attached PHY driver (mii_bus:phy_addr=r8169-0-100:00, irq=MAC)
May 08 21:18:03 volumio volumio[777]: Could not open config: /tmp/upmpdcli.conf
May 08 21:18:03 volumio volumio-time-update[792]: volumio-time-update-util: Date not found in response
May 08 21:18:03 volumio volumio-time-update[792]: volumio-time-update-util: Retrying in 5 seconds...
May 08 21:18:03 volumio systemd[1]: Started Login Service.
May 08 21:18:03 volumio systemd[1]: Started triggerhappy global hotkey daemon.
May 08 21:18:03 volumio avahi-daemon[790]: Successfully called chroot().
May 08 21:18:03 volumio avahi-daemon[790]: Successfully dropped remaining capabilities.
May 08 21:18:03 volumio systemd[1]: Started RPC bind portmap service.
May 08 21:18:03 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
May 08 21:18:03 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
May 08 21:18:03 volumio wpa_supplicant[791]: Successfully initialized wpa_supplicant
May 08 21:18:03 volumio systemd[1]: Started Save/Restore Sound Card State.
May 08 21:18:03 volumio systemd[1]: Started DHCP Client Daemon.
May 08 21:18:03 volumio avahi-daemon[790]: No service file found in /etc/avahi/services.
May 08 21:18:03 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack.
May 08 21:18:03 volumio systemd[1]: Started WPA supplicant.
May 08 21:18:03 volumio sh[754]: eth0=eth0
May 08 21:18:03 volumio dhcpcd[890]: eth0: waiting for carrier
May 08 21:18:03 volumio volumio-remote-updater[776]: [2025-05-08 14:18:03] [info] asio async_connect error: system:111 (Connection refused)
May 08 21:18:03 volumio volumio-remote-updater[776]: [2025-05-08 14:18:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
May 08 21:18:03 volumio dhcpcd[890]: eth0: carrier acquired
May 08 21:18:03 volumio avahi-daemon[790]: Network interface enumeration completed.
May 08 21:18:03 volumio kernel: r8169 0000:01:00.0 eth0: Link is Down
May 08 21:18:03 volumio systemd[1]: Listening on mpd.socket.
May 08 21:18:03 volumio avahi-daemon[790]: Server startup complete. Host name is volumio.local. Local service cookie is 2801184536.
May 08 21:18:03 volumio dhcpcd[890]: DUID 00:04:35:18:a9:2c:e6:d2:8a:59:9d:c6:d4:28:6f:31:a0:e0
May 08 21:18:03 volumio dhcpcd[890]: eth0: IAID 0a:7d:fe:ac
May 08 21:18:03 volumio dhcpcd[890]: eth0: adding address fe80::a657:bcdf:1c04:f610
May 08 21:18:03 volumio dhcpcd[890]: ipv6_addaddr1: Permission denied
May 08 21:18:03 volumio dhcpcd[890]: control command: /sbin/dhcpcd eth0
May 08 21:18:03 volumio systemd[1]: Reached target Sound Card.
May 08 21:18:03 volumio systemd[1]: Reached target Remote File Systems (Pre).
May 08 21:18:03 volumio dhcpcd[890]: eth0: carrier lost
May 08 21:18:03 volumio systemd[1]: Reached target Remote File Systems.
May 08 21:18:03 volumio volumio-remote-updater[776]: [2025-05-08 14:18:03] [error] handle_connect error: Underlying Transport Error
May 08 21:18:03 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
May 08 21:18:03 volumio systemd[1]: Reached target RPC Port Mapper.
May 08 21:18:03 volumio systemd[1]: iptables.service: Succeeded.
May 08 21:18:03 volumio systemd[1]: Started Raise network interfaces.
May 08 21:18:03 volumio systemd[1]: Reached target Network.
May 08 21:18:03 volumio systemd[1]: Starting Network Time Service...
May 08 21:18:03 volumio systemd[1]: Starting Permit User Sessions...
May 08 21:18:03 volumio systemd[1]: Starting Music Player Daemon...
May 08 21:18:03 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
May 08 21:18:03 volumio systemd[1]: Reached target Network is Online.
May 08 21:18:03 volumio systemd[1]: Starting /etc/rc.local Compatibility...
May 08 21:18:03 volumio systemd[1]: Starting LSB: Brings up/down network automatically...
May 08 21:18:03 volumio systemd[1]: Starting Samba NMB Daemon...
May 08 21:18:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 08 21:18:03 volumio systemd[1]: Started /etc/rc.local Compatibility.
May 08 21:18:03 volumio systemd[1]: Started Permit User Sessions.
May 08 21:18:03 volumio systemd[1]: Starting Hold until boot process finishes up...
May 08 21:18:03 volumio systemd[1]: Starting Terminate Plymouth Boot Screen...
May 08 21:18:03 volumio systemd[1]: Received SIGRTMIN+21 from PID 379 (plymouthd).
May 08 21:18:03 volumio systemd[1]: plymouth-quit-wait.service: Succeeded.
May 08 21:18:03 volumio systemd[1]: Started Hold until boot process finishes up.
May 08 21:18:03 volumio systemd[1]: plymouth-quit.service: Succeeded.
May 08 21:18:03 volumio systemd[1]: Started Terminate Plymouth Boot Screen.
May 08 21:18:03 volumio systemd[1]: Received SIGRTMIN+21 from PID 379 (plymouthd).
May 08 21:18:03 volumio systemd[1]: Started Getty on tty1.
May 08 21:18:03 volumio systemd[1]: Reached target Login Prompts.
May 08 21:18:03 volumio ifplugd(eth0)[961]: ifplugd 0.28 initializing.
May 08 21:18:03 volumio ifplugd(eth0)[961]: Using interface eth0/7C:D3:0A:7D:FE:AC with driver  (version: 6.6.32-volumio)
May 08 21:18:03 volumio ifplugd(eth0)[961]: Using detection mode: SIOCETHTOOL
May 08 21:18:03 volumio ifplugd(eth0)[961]: Initialization complete, link beat not detected.
May 08 21:18:04 volumio ntpd[933]: ntpd 4.2.8p12@1.3728-o (1): Starting
May 08 21:18:04 volumio ntpd[933]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
May 08 21:18:04 volumio systemd[1]: Started Network Time Service.
May 08 21:18:04 volumio ntpd[966]: proto: precision = 0.246 usec (-22)
May 08 21:18:04 volumio ifplugd[938]: Network Interface Plugging Daemon...start eth0...done.
May 08 21:18:04 volumio systemd[1]: Started LSB: Brings up/down network automatically.
May 08 21:18:04 volumio ntpd[966]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
May 08 21:18:04 volumio ntpd[966]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
May 08 21:18:04 volumio ntpd[966]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 863 days ago
May 08 21:18:04 volumio ntpd[966]: Listen and drop on 0 v6wildcard [::]:123
May 08 21:18:04 volumio ntpd[966]: Listen and drop on 1 v4wildcard 0.0.0.0:123
May 08 21:18:04 volumio ntpd[966]: Listen normally on 2 lo 127.0.0.1:123
May 08 21:18:04 volumio ntpd[966]: Listening on routing socket on fd #19 for interface updates
May 08 21:18:04 volumio ntpd[966]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
May 08 21:18:04 volumio ntpd[966]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
May 08 21:18:04 volumio loadcpufreq[919]: Loading cpufreq kernel modules...done (powernow-k8).
May 08 21:18:04 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
May 08 21:18:04 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters...
May 08 21:18:04 volumio sudo[935]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 08 21:18:04 volumio sudo[935]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:04 volumio sudo[935]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 08 21:18:04 volumio sudo[935]: pam_unix(sudo:session): session closed for user root
May 08 21:18:04 volumio cpufrequtils[1001]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done.
May 08 21:18:04 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters.
May 08 21:18:05 volumio ntpd[966]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
May 08 21:18:05 volumio dhcpcd[890]: eth0: carrier acquired
May 08 21:18:05 volumio kernel: r8169 0000:01:00.0 eth0: Link is Up - 100Mbps/Full - flow control rx/tx
May 08 21:18:05 volumio dhcpcd[890]: eth0: IAID 0a:7d:fe:ac
May 08 21:18:05 volumio dhcpcd[890]: eth0: soliciting a DHCP lease
May 08 21:18:05 volumio dhcpcd[890]: eth0: offered 192.168.1.9 from 192.168.1.1
May 08 21:18:05 volumio dhcpcd[890]: eth0: probing address 192.168.1.9/24
May 08 21:18:05 volumio nmbd[943]: [2025/05/08 14:18:05.727543,  0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
May 08 21:18:05 volumio nmbd[943]:   started asyncdns process 1013
May 08 21:18:05 volumio nmbd[943]: [2025/05/08 14:18:05.728800,  0] ../lib/util/become_daemon.c:149(daemon_status)
May 08 21:18:05 volumio nmbd[943]:   daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
May 08 21:18:05 volumio nmbd[943]: [2025/05/08 14:18:05.728887,  0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
May 08 21:18:05 volumio nmbd[943]:   NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
May 08 21:18:05 volumio wireless.js[774]: WIRELESS: No wireless interface, exiting
May 08 21:18:05 volumio dhcpcd[890]: eth0: soliciting an IPv6 router
May 08 21:18:05 volumio iw[1018]: command failed: No such device (-19)
May 08 21:18:05 volumio iwconfig[1021]: Error for wireless request "Set Power Management" (8B2C) :
May 08 21:18:05 volumio iwconfig[1021]:     SET failed on device wlan0 ; No such device.
May 08 21:18:05 volumio systemd[1]: wireless.service: Succeeded.
May 08 21:18:05 volumio systemd[1]: Started Wireless Services.
May 08 21:18:05 volumio systemd[1]: Started Volumio Backend Module.
May 08 21:18:05 volumio systemd[1]: Started Start Volumio Kiosk.
May 08 21:18:05 volumio systemd[1]: Started Intel SST and HDA soundcard init service.
May 08 21:18:05 volumio systemd[1]: Started Volumio Cpu Tweaker.
May 08 21:18:05 volumio systemd[1]: Started First Start.
May 08 21:18:06 volumio ntpd[966]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
May 08 21:18:06 volumio firststart.sh[1034]: Volumio first start configuration script
May 08 21:18:06 volumio firststart.sh[1034]: Configuring unconfigured packages
May 08 21:18:06 volumio ifplugd(eth0)[961]: Link beat detected.
May 08 21:18:06 volumio volumio-cpu-tweak[1027]: Setting RT Priority for mpd
May 08 21:18:06 volumio volumio-cpu-tweak[1027]: Setting MPD Affinity
May 08 21:18:06 volumio ifplugd(eth0)[961]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
May 08 21:18:06 volumio volumio-cpu-tweak[1027]: pid 1006's current affinity mask: f
May 08 21:18:06 volumio volumio-cpu-tweak[1027]: pid 1006's new affinity mask: 3
May 08 21:18:06 volumio volumio-cpu-tweak[1027]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
May 08 21:18:06 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded.
May 08 21:18:06 volumio ifplugd(eth0)[961]: client: ifup: interface eth0 already configured
May 08 21:18:06 volumio startx[1025]: xauth:  file /root/.Xauthority does not exist
May 08 21:18:06 volumio ifplugd(eth0)[961]: Program executed successfully.
May 08 21:18:07 volumio ntpd[966]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
May 08 21:18:07 volumio firststart.sh[1034]: Creating /var/log/samba/cores folder
May 08 21:18:07 volumio firststart.sh[1034]: Removing default SSH host keys
May 08 21:18:07 volumio firststart.sh[1034]: removed '/etc/ssh/ssh_host_ecdsa_key'
May 08 21:18:07 volumio firststart.sh[1034]: removed '/etc/ssh/ssh_host_ecdsa_key.pub'
May 08 21:18:07 volumio firststart.sh[1034]: removed '/etc/ssh/ssh_host_ed25519_key'
May 08 21:18:07 volumio firststart.sh[1034]: removed '/etc/ssh/ssh_host_ed25519_key.pub'
May 08 21:18:07 volumio firststart.sh[1034]: removed '/etc/ssh/ssh_host_rsa_key'
May 08 21:18:07 volumio firststart.sh[1034]: removed '/etc/ssh/ssh_host_rsa_key.pub'
May 08 21:18:07 volumio firststart.sh[1034]: Generating SSH host keys
May 08 21:18:08 volumio ntpd[966]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
May 08 21:18:08 volumio startx[1025]: X.Org X Server 1.20.4
May 08 21:18:08 volumio startx[1025]: X Protocol Version 11, Revision 0
May 08 21:18:08 volumio startx[1025]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian
May 08 21:18:08 volumio startx[1025]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64
May 08 21:18:08 volumio startx[1025]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=eaa81698-748d-4665-b2a2-9d572f68d885 bootpart=UUID=1409-87FE datapart=UUID=fc60d0ac-b65e-4cc0-a959-f9f77b233d55 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
May 08 21:18:08 volumio startx[1025]: Build Date: 18 December 2021  09:05:36AM
May 08 21:18:08 volumio startx[1025]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support)
May 08 21:18:08 volumio startx[1025]: Current version of pixman: 0.36.0
May 08 21:18:08 volumio startx[1025]:         Before reporting problems, check http://wiki.x.org
May 08 21:18:08 volumio startx[1025]:         to make sure that you have the latest version.
May 08 21:18:08 volumio startx[1025]: Markers: (--) probed, (**) from config file, (==) default setting,
May 08 21:18:08 volumio startx[1025]:         (++) from command line, (!!) notice, (II) informational,
May 08 21:18:08 volumio startx[1025]:         (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
May 08 21:18:08 volumio startx[1025]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu May  8 14:18:08 2025
May 08 21:18:08 volumio systemd[1]: soundcard-init.service: Succeeded.
May 08 21:18:08 volumio startx[1025]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
May 08 21:18:08 volumio volumio-time-update[792]: volumio-time-update-util: Fetching time from Volumio...
May 08 21:18:08 volumio volumio-time-update[792]: volumio-time-update-util: Date not found in response
May 08 21:18:08 volumio volumio-time-update[792]: volumio-time-update-util: Retrying in 5 seconds...
May 08 21:18:08 volumio volumio-remote-updater[776]: [2025-05-08 14:18:08] [info] asio async_connect error: system:111 (Connection refused)
May 08 21:18:08 volumio volumio-remote-updater[776]: [2025-05-08 14:18:08] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
May 08 21:18:08 volumio volumio-remote-updater[776]: [2025-05-08 14:18:08] [error] handle_connect error: Underlying Transport Error
May 08 21:18:08 volumio startx[1025]: (II) AMDGPU(0): [KMS] Kernel modesetting enabled.
May 08 21:18:10 volumio dhcpcd[890]: eth0: leased 192.168.1.9 for 86400 seconds
May 08 21:18:10 volumio dhcpcd[890]: eth0: adding route to 192.168.1.0/24
May 08 21:18:10 volumio dhcpcd[890]: eth0: adding default route via 192.168.1.1
May 08 21:18:10 volumio avahi-daemon[790]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.9.
May 08 21:18:10 volumio avahi-daemon[790]: New relevant interface eth0.IPv4 for mDNS.
May 08 21:18:10 volumio avahi-daemon[790]: Registering new address record for 192.168.1.9 on eth0.IPv4.
May 08 21:18:10 volumio nmbd[943]: [2025/05/08 14:18:10.826430,  0] ../lib/util/become_daemon.c:138(daemon_ready)
May 08 21:18:10 volumio nmbd[943]:   daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
May 08 21:18:10 volumio systemd[1]: Started Samba NMB Daemon.
May 08 21:18:10 volumio systemd[1]: Starting Samba Winbind Daemon...
May 08 21:18:11 volumio mpd[1006]: May 08 14:18 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 08 21:18:11 volumio mpd[1006]: May 08 14:18 : exception: Database corrupted
May 08 21:18:11 volumio systemd[1]: Started Music Player Daemon.
May 08 21:18:11 volumio mpd_monitor.sh[785]: MPD Monitor Service: MPD restarted due to no mpc output.
May 08 21:18:11 volumio ntpd[966]: ntpd exiting on signal 15 (Terminated)
May 08 21:18:11 volumio systemd[1]: Stopping Network Time Service...
May 08 21:18:11 volumio systemd[1]: ntp.service: Succeeded.
May 08 21:18:11 volumio systemd[1]: Stopped Network Time Service.
May 08 21:18:11 volumio systemd[1]: Starting Network Time Service...
May 08 21:18:12 volumio ntpd[1222]: ntpd 4.2.8p12@1.3728-o (1): Starting
May 08 21:18:12 volumio ntpd[1222]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
May 08 21:18:12 volumio systemd[1]: Started Network Time Service.
May 08 21:18:12 volumio ntpd[1228]: proto: precision = 0.247 usec (-22)
May 08 21:18:12 volumio ntpd[1228]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
May 08 21:18:12 volumio ntpd[1228]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
May 08 21:18:12 volumio ntpd[1228]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 863 days ago
May 08 21:18:12 volumio ntpd[1228]: Listen and drop on 0 v6wildcard [::]:123
May 08 21:18:12 volumio ntpd[1228]: Listen and drop on 1 v4wildcard 0.0.0.0:123
May 08 21:18:12 volumio ntpd[1228]: Listen normally on 2 lo 127.0.0.1:123
May 08 21:18:12 volumio ntpd[1228]: Listen normally on 3 eth0 192.168.1.9:123
May 08 21:18:12 volumio ntpd[1228]: Listening on routing socket on fd #20 for interface updates
May 08 21:18:12 volumio ntpd[1228]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
May 08 21:18:12 volumio ntpd[1228]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
May 08 21:18:12 volumio winbindd[1203]: [2025/05/08 14:18:12.419464,  0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
May 08 21:18:12 volumio winbindd[1203]:   initialize_winbindd_cache: clearing cache and re-creating with version number 2
May 08 21:18:12 volumio firststart.sh[1034]: debconf: unable to initialize frontend: Dialog
May 08 21:18:12 volumio firststart.sh[1034]: debconf: (TERM is not set, so the dialog frontend is not usable.)
May 08 21:18:12 volumio firststart.sh[1034]: debconf: falling back to frontend: Readline
May 08 21:18:13 volumio ntpd[1228]: Soliciting pool server 103.70.115.65
May 08 21:18:13 volumio winbindd[1203]: [2025/05/08 14:18:13.251937,  0] ../lib/util/become_daemon.c:138(daemon_ready)
May 08 21:18:13 volumio systemd[1]: Started Samba Winbind Daemon.
May 08 21:18:13 volumio winbindd[1203]:   daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
May 08 21:18:13 volumio systemd[1]: Starting Samba SMB Daemon...
May 08 21:18:13 volumio firststart.sh[1034]: debconf: unable to initialize frontend: Readline
May 08 21:18:13 volumio firststart.sh[1034]: debconf: (This frontend requires a controlling tty.)
May 08 21:18:13 volumio firststart.sh[1034]: debconf: falling back to frontend: Teletype
May 08 21:18:13 volumio volumio-time-update[792]: volumio-time-update-util: Fetching time from Volumio...
May 08 21:18:14 volumio ntpd[1228]: Soliciting pool server 103.70.115.65
May 08 21:18:14 volumio volumio-time-update[792]: volumio-time-update-util: Setting system time to: 2025-05-08 14:18:13
May 08 21:18:14 volumio sudo[1262]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-05-08 14:18:13
May 08 21:18:14 volumio sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:14 volumio dbus-daemon[789]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.6' (uid=0 pid=1267 comm="timedatectl set-time 2025-05-08 14:18:13 ")
May 08 21:18:15 volumio ntpd[1228]: Soliciting pool server 103.70.115.65
May 08 21:18:15 volumio systemd[1]: Starting Time & Date Service...
May 08 21:18:16 volumio volumio-remote-updater[776]: [2025-05-08 14:18:16] [connect] Successful connection
May 08 21:18:16 volumio dbus-daemon[789]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 08 21:18:16 volumio systemd[1]: Started Time & Date Service.
May 08 21:18:16 volumio ntpd[1228]: Soliciting pool server 103.70.115.65
May 08 21:18:13 volumio systemd-timedated[1278]: Changed local time to Thu May  8 14:18:13 2025
May 08 21:18:13 volumio sudo[1262]: pam_unix(sudo:session): session closed for user root
May 08 21:18:13 volumio volumio-time-update[792]: volumio-time-update-util: System time updated successfully.
May 08 21:18:13 volumio systemd[1]: Started Volumio Time Update Utility.
May 08 21:18:14 volumio smbd[1244]: [2025/05/08 14:18:14.286969,  0] ../lib/util/become_daemon.c:138(daemon_ready)
May 08 21:18:14 volumio smbd[1244]:   daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
May 08 21:18:14 volumio systemd[1]: Started Samba SMB Daemon.
May 08 21:18:14 volumio systemd[1]: Reached target Multi-User System.
May 08 21:18:14 volumio systemd[1]: Reached target Graphical Interface.
May 08 21:18:14 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
May 08 21:18:14 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
May 08 21:18:14 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
May 08 21:18:14 volumio systemd[1]: Startup finished in 8.386s (firmware) + 6.383s (loader) + 1min 20.294s (kernel) + 26.440s (userspace) = 2min 1.505s.
May 08 21:18:14 volumio firststart.sh[1034]: Creating SSH2 RSA key; this may take some time ...
May 08 21:18:14 volumio firststart.sh[1034]: 2048 SHA256:go1CVEzINjKUPgT07T7M0kwoE2ru1V3fenYRuOz9bCY root@volumio (RSA)
May 08 21:18:14 volumio volumio[1024]: info: -------------------------------------------
May 08 21:18:14 volumio volumio[1024]: info: -----            Volumio3              ----
May 08 21:18:14 volumio volumio[1024]: info: -------------------------------------------
May 08 21:18:14 volumio volumio[1024]: info: -----          System startup          ----
May 08 21:18:14 volumio volumio[1024]: info: -------------------------------------------
May 08 21:18:14 volumio firststart.sh[1034]: Creating SSH2 DSA key; this may take some time ...
May 08 21:18:14 volumio firststart.sh[1034]: 1024 SHA256:6kJqIpPEsXXuefz/n18dds4krSxzHVaR40OztHG+HNc root@volumio (DSA)
May 08 21:18:15 volumio firststart.sh[1034]: Creating SSH2 ECDSA key; this may take some time ...
May 08 21:18:15 volumio firststart.sh[1034]: 256 SHA256:FbTMsTkZx/spNkVo8PAqJWRoGItyCiMbm5+7z6FMv5I root@volumio (ECDSA)
May 08 21:18:16 volumio volumio[1024]: info: File /data/configuration/plugins.json does not exist. Copying from Volumio
May 08 21:18:16 volumio volumio[1024]: info: MYVOLUMIO Environment detected
May 08 21:18:16 volumio systemd[1]: Reloading.
May 08 21:18:16 volumio volumio[1024]: info: Plugin folders cleanup
May 08 21:18:16 volumio volumio[1024]: info: Scanning into folder /volumio/app/plugins/
May 08 21:18:16 volumio volumio[1024]: info: Scanning category audio_interface
May 08 21:18:16 volumio volumio[1024]: info: Scanning category miscellanea
May 08 21:18:16 volumio volumio[1024]: info: Scanning category music_service
May 08 21:18:16 volumio volumio[1024]: info: Scanning category plugins.json
May 08 21:18:16 volumio volumio[1024]: info: Scanning category system_controller
May 08 21:18:16 volumio volumio[1024]: info: Scanning category user_interface
May 08 21:18:16 volumio volumio[1024]: info: Scanning into folder /data/plugins/
May 08 21:18:16 volumio volumio[1024]: info: Plugin folders cleanup completed
May 08 21:18:16 volumio volumio[1024]: info: -------------------------------------------
May 08 21:18:16 volumio volumio[1024]: info: -----      Core plugins startup        ----
May 08 21:18:16 volumio volumio[1024]: info: -------------------------------------------
May 08 21:18:16 volumio volumio[1024]: info: Loading plugins from folder /volumio/app/plugins/
May 08 21:18:16 volumio volumio[1024]: info: Adding plugin upnp to MyMusic Plugins
May 08 21:18:16 volumio volumio[1024]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 08 21:18:16 volumio volumio[1024]: info: Adding plugin upnp_browser to MyMusic Plugins
May 08 21:18:16 volumio volumio[1024]: info: Loading plugins from folder /data/plugins/
May 08 21:18:16 volumio volumio[1024]: info: Loading plugin "system"...
May 08 21:18:16 volumio volumio[1024]: info: No id defined. Creating one
May 08 21:18:16 volumio volumio[1024]: info: Loading plugin "appearance"...
May 08 21:18:16 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
May 08 21:18:16 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
May 08 21:18:16 volumio firststart.sh[1034]: rescue-ssh.target is a disabled or a static unit, not starting it.
May 08 21:18:16 volumio firststart.sh[1034]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5).
May 08 21:18:16 volumio firststart.sh[1034]: insserv: warning: current stop runlevel(s) (2 3 4 5) of script `ssh' overrides LSB defaults (empty).
May 08 21:18:17 volumio systemd[1]: Reloading.
May 08 21:18:17 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
May 08 21:18:17 volumio volumio[1024]: info: Loading plugin "network"...
May 08 21:18:17 volumio volumio[1024]: info: Refreshing Cached IP Addresses
May 08 21:18:17 volumio sudo[1485]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 08 21:18:17 volumio sudo[1485]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:17 volumio sudo[1487]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 08 21:18:17 volumio sudo[1487]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:17 volumio sudo[1485]: pam_unix(sudo:session): session closed for user root
May 08 21:18:17 volumio sudo[1487]: pam_unix(sudo:session): session closed for user root
May 08 21:18:17 volumio volumio[1024]: info: Loading plugin "services"...
May 08 21:18:17 volumio volumio[1024]: info: Loading plugin "alsa_controller"...
May 08 21:18:17 volumio sudo[1501]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 08 21:18:17 volumio sudo[1501]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:17 volumio sudo[1501]: pam_unix(sudo:session): session closed for user root
May 08 21:18:17 volumio volumio[1024]: warn: The ALSA output card is not set, defaulting to card [object Object]
May 08 21:18:17 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 08 21:18:17 volumio volumio[1024]: info: Found match in Cards Database: setting mixer  for card HDMI 0
May 08 21:18:17 volumio volumio[1024]: info: Setting mixer IEC958 for card HDMI 0
May 08 21:18:17 volumio volumio[1024]: info: CoreCommandRouter::volumioUpdateVolumeSettings
May 08 21:18:17 volumio volumio[1024]: info: CoreCommandRouter::volumioUpdateVolumeSettings
May 08 21:18:17 volumio volumio[1024]: info: CoreCommandRouter::volumioUpdateVolumeSettings
May 08 21:18:17 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 08 21:18:17 volumio volumio[1024]: info: Loading plugin "wizard"...
May 08 21:18:17 volumio volumio[1024]: info: Loading plugin "networkfs"...
May 08 21:18:17 volumio volumio[1024]: info: Starting Udev Watcher for removable devices
May 08 21:18:18 volumio volumio[1024]: info: Ignoring mount for partition: 48ED-89E0
May 08 21:18:18 volumio volumio[1024]: info: Ignoring mount for partition: Micro_10
May 08 21:18:18 volumio volumio[1024]: info: Ignoring mount for partition: Data
May 08 21:18:18 volumio volumio[1024]: info: Ignoring mount for partition: efi-boot
May 08 21:18:18 volumio volumio[1024]: info: Ignoring mount for partition: DaphileBoot
May 08 21:18:18 volumio volumio[1024]: info: Ignoring mount for partition: DaphileData
May 08 21:18:18 volumio volumio[1024]: info: Ignoring mount for partition: boot
May 08 21:18:18 volumio volumio[1024]: info: Ignoring mount for partition: volumio
May 08 21:18:18 volumio volumio[1024]: info: Ignoring mount for partition: volumio_data
May 08 21:18:18 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 08 21:18:18 volumio volumio[1024]: info: Loading plugin "volumio_command_line_client"...
May 08 21:18:18 volumio volumio[1024]: info: Loading plugin "upnp"...
May 08 21:18:18 volumio volumio[1024]: info: [1746713898386] Starting Upmpd Daemon
May 08 21:18:18 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 08 21:18:18 volumio volumio[1024]: info: Loading plugin "my_music"...
May 08 21:18:18 volumio volumio[1024]: info: Loading plugin "mpd"...
May 08 21:18:18 volumio volumio[1024]: info: Loading plugin "upnp_browser"...
May 08 21:18:19 volumio firststart.sh[1034]: Enabling SSH for first boot
May 08 21:18:19 volumio systemd[1]: Starting OpenBSD Secure Shell server...
May 08 21:18:19 volumio sshd[1553]: Server listening on 0.0.0.0 port 22.
May 08 21:18:19 volumio sshd[1553]: Server listening on :: port 22.
May 08 21:18:19 volumio systemd[1]: Started OpenBSD Secure Shell server.
May 08 21:18:19 volumio firststart.sh[1034]: Disabling firststart service
May 08 21:18:19 volumio firststart.sh[1034]: Removed /etc/systemd/system/multi-user.target.wants/firststart.service.
May 08 21:18:19 volumio systemd[1]: Reloading.
May 08 21:18:19 volumio volumio[1024]: info: Loading plugin "alarm-clock"...
May 08 21:18:19 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
May 08 21:18:19 volumio firststart.sh[1034]: Finalizing
May 08 21:18:19 volumio volumio[1024]: info: Loading plugin "airplay_emulation"...
May 08 21:18:19 volumio volumio[1024]: info: Starting Shairport Sync
May 08 21:18:19 volumio volumio[1024]: info: Loading plugin "last_100"...
May 08 21:18:19 volumio volumio[1024]: info: Loading plugin "webradio"...
May 08 21:18:20 volumio volumio[1024]: info: Loading plugin "i2s_dacs"...
May 08 21:18:20 volumio volumio[1024]: info: I2S DAC not set, start Auto-detection
May 08 21:18:20 volumio volumio[1024]: info: Loading plugin "volumiodiscovery"...
May 08 21:18:21 volumio volumio[1024]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 08 21:18:21 volumio volumio[1024]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 08 21:18:21 volumio volumio[1024]: *** WARNING *** For more information see 
May 08 21:18:21 volumio volumio[1024]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 08 21:18:21 volumio volumio[1024]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 08 21:18:21 volumio volumio[1024]: *** WARNING *** For more information see 
May 08 21:18:21 volumio node[1024]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 08 21:18:21 volumio node[1024]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 08 21:18:21 volumio node[1024]: *** WARNING *** For more information see 
May 08 21:18:21 volumio node[1024]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 08 21:18:21 volumio node[1024]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 08 21:18:21 volumio node[1024]: *** WARNING *** For more information see 
May 08 21:18:21 volumio volumio[1024]: info: Discovery: Started advertising with name: Volumio
May 08 21:18:21 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 08 21:18:21 volumio volumio[1024]: info: Loading plugin "outputs"...
May 08 21:18:21 volumio volumio[1024]: info: Loading plugin "albumart"...
May 08 21:18:21 volumio volumio[1024]: info: Plugin example_plugin is not enabled
May 08 21:18:21 volumio volumio[1024]: info: Loading plugin "inputs"...
May 08 21:18:21 volumio volumio[1024]: info: Loading plugin "updater_comm"...
May 08 21:18:21 volumio volumio[1024]: Forking 3 albumart workers
May 08 21:18:22 volumio volumio[1024]: info: Plugin mpdemulation is not enabled
May 08 21:18:22 volumio volumio[1024]: info: Loading plugin "rest_api"...
May 08 21:18:22 volumio volumio[1024]: info: Loading plugin "websocket"...
May 08 21:18:22 volumio volumio[1024]: info: Starting Socket.io Server version 2.3.0
May 08 21:18:22 volumio volumio[1024]: Starting albumart workers
May 08 21:18:22 volumio volumio[1024]: Starting albumart workers
May 08 21:18:22 volumio volumio[1024]: Starting albumart workers
May 08 21:18:22 volumio volumio[1024]: info: Loading i18n strings for locale en
May 08 21:18:22 volumio volumio[1024]: Updating browse sources language
May 08 21:18:22 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::initPlayerControls
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 08 21:18:23 volumio volumio[1024]: Express server listening on port 3000
May 08 21:18:23 volumio volumio[1024]:  [Metrics]  WebUI:  11s 498.47ms 
May 08 21:18:23 volumio volumio[1024]: info: Setting Device type: x86
May 08 21:18:23 volumio volumio[1024]: info: CoreStateMachine::resetVolumioState
May 08 21:18:23 volumio volumio[1024]: info: CoreStateMachine::getcurrentVolume
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrievevolume
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:23 volumio systemd[1]: firststart.service: Succeeded.
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
May 08 21:18:23 volumio volumio[1024]: info: CoreStateMachine::getcurrentVolume
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrievevolume
May 08 21:18:23 volumio volumio[1024]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
May 08 21:18:23 volumio volumio[1024]: info: Completed loading Core Plugins
May 08 21:18:23 volumio volumio[1024]: info: Preparing to generate the ALSA configuration file
May 08 21:18:23 volumio volumio[1024]: info: Cannot read play queue from file
May 08 21:18:23 volumio volumio[1024]: info: Volumio Network Manager: Network status updated: 1
May 08 21:18:23 volumio volumio[1024]: Unable to parse:
May 08 21:18:23 volumio volumio[1024]:  Simple mixer control 'IEC958',0
May 08 21:18:23 volumio volumio[1024]:   Capabilities: pswitch pswitch-joined
May 08 21:18:23 volumio volumio[1024]:   Playback channels: Mono
May 08 21:18:23 volumio volumio[1024]:   Mono: Playback [off]
May 08 21:18:23 volumio volumio[1024]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
May 08 21:18:23 volumio volumio[1024]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
May 08 21:18:23 volumio volumio[1024]: wlan0     Interface doesn't support scanning.
May 08 21:18:23 volumio volumio[1024]: info: Cannot use regular scanning, forcing with ap-force
May 08 21:18:23 volumio sudo[1627]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
May 08 21:18:23 volumio sudo[1627]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:23 volumio sudo[1627]: pam_unix(sudo:session): session closed for user root
May 08 21:18:23 volumio volumio[1024]: command failed: No such device (-19)
May 08 21:18:23 volumio volumio[1024]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
May 08 21:18:23 volumio volumio[1024]: command failed: No such device (-19)
May 08 21:18:23 volumio volumio[1024]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
May 08 21:18:23 volumio volumio[1024]: Unable to parse:
May 08 21:18:23 volumio volumio[1024]:  Simple mixer control 'IEC958',0
May 08 21:18:23 volumio volumio[1024]:   Capabilities: pswitch pswitch-joined
May 08 21:18:23 volumio volumio[1024]:   Playback channels: Mono
May 08 21:18:23 volumio volumio[1024]:   Mono: Playback [off]
May 08 21:18:23 volumio volumio[1024]: info: VolumeController:: Volume=undefined Mute =false
May 08 21:18:23 volumio volumio[1024]: info: CoreStateMachine::pushState
May 08 21:18:23 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState
May 08 21:18:23 volumio volumio[1024]: info: CoreStateMachine::updateTrackBlock
May 08 21:18:23 volumio volumio[1024]: info: CorePlayQueue::getTrackBlock
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrievevolume
May 08 21:18:23 volumio volumio[1024]: Unable to parse:
May 08 21:18:23 volumio volumio[1024]:  Simple mixer control 'IEC958',0
May 08 21:18:23 volumio volumio[1024]:   Capabilities: pswitch pswitch-joined
May 08 21:18:23 volumio volumio[1024]:   Playback channels: Mono
May 08 21:18:23 volumio volumio[1024]:   Mono: Playback [off]
May 08 21:18:23 volumio volumio[1024]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
May 08 21:18:23 volumio volumio[1024]: info: Asound.conf file written
May 08 21:18:23 volumio sudo[1639]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
May 08 21:18:23 volumio sudo[1639]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:23 volumio sudo[1639]: pam_unix(sudo:session): session closed for user root
May 08 21:18:23 volumio volumio[1024]: No state is present for card HDMI
May 08 21:18:23 volumio volumio[1024]: Found hardware: "HDA-Intel" "ATI R6xx HDMI" "HDA:1002aa01,00aa0100,00100700" "0x103c" "0x8158"
May 08 21:18:23 volumio volumio[1024]: Hardware is initialized using a generic method
May 08 21:18:23 volumio volumio[1024]: No state is present for card HDMI
May 08 21:18:23 volumio volumio[1024]: No state is present for card Generic
May 08 21:18:23 volumio volumio[1024]: Found hardware: "HDA-Intel" "Realtek ALC255" "HDA:10ec0255,103c8158,00100002" "0x103c" "0x8158"
May 08 21:18:23 volumio volumio[1024]: Hardware is initialized using a generic method
May 08 21:18:23 volumio volumio[1024]: No state is present for card Generic
May 08 21:18:23 volumio volumio[1024]: info: Output device has changed, restarting MPD
May 08 21:18:23 volumio sudo[1644]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 08 21:18:23 volumio sudo[1644]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:23 volumio volumio[1024]: info: Output device has changed, restarting Shairport Sync
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:23 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:23 volumio sudo[1647]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 08 21:18:23 volumio sudo[1647]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:23 volumio systemd[1]: Stopping Music Player Daemon...
May 08 21:18:24 volumio sudo[1644]: pam_unix(sudo:session): session closed for user root
May 08 21:18:24 volumio volumio[1024]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 08 21:18:24 volumio volumio[1024]: info: ___________ START PLUGINS ___________
May 08 21:18:24 volumio volumio[1024]: info: Setting Hotspot Unique name on first start: Volumio-A828E
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::Reload Ui
May 08 21:18:24 volumio volumio[1024]: info: ControllerMpd::onStart: Initializing MPD
May 08 21:18:24 volumio volumio[1024]: info: Creating MPD Configuration file
May 08 21:18:24 volumio sudo[1653]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 08 21:18:24 volumio sudo[1653]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 08 21:18:24 volumio volumio[1024]: info: [1746713904090] CoreMusicLibrary::Adding element Media Servers
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:18:24 volumio sudo[1653]: pam_unix(sudo:session): session closed for user root
May 08 21:18:24 volumio sudo[1655]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 08 21:18:24 volumio sudo[1655]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 08 21:18:24 volumio volumio[1024]: info: [1746713904177] CoreMusicLibrary::Adding element Last_100
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 08 21:18:24 volumio volumio[1024]: info: [1746713904179] CoreMusicLibrary::Adding element Webradio
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 08 21:18:24 volumio volumio[1024]: info: Initializing BBC Radios
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: Volumio Calling Home
May 08 21:18:24 volumio systemd[1]: mpd.service: Succeeded.
May 08 21:18:24 volumio systemd[1]: Stopped Music Player Daemon.
May 08 21:18:24 volumio systemd[1]: Starting Music Player Daemon...
May 08 21:18:24 volumio sudo[1675]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 08 21:18:24 volumio sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:24 volumio sudo[1675]: pam_unix(sudo:session): session closed for user root
May 08 21:18:24 volumio volumio[1024]: Unable to parse:
May 08 21:18:24 volumio volumio[1024]:  Simple mixer control 'IEC958',0
May 08 21:18:24 volumio volumio[1024]:   Capabilities: pswitch pswitch-joined
May 08 21:18:24 volumio volumio[1024]:   Playback channels: Mono
May 08 21:18:24 volumio volumio[1024]:   Mono: Playback [off]
May 08 21:18:24 volumio volumio[1024]: info: VolumeController:: Volume=undefined Mute =false
May 08 21:18:24 volumio volumio[1024]: info: CoreStateMachine::pushState
May 08 21:18:24 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState
May 08 21:18:24 volumio volumio[1024]: info: CoreStateMachine::updateTrackBlock
May 08 21:18:24 volumio volumio[1024]: info: CorePlayQueue::getTrackBlock
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrievevolume
May 08 21:18:24 volumio volumio[1024]: Unable to parse:
May 08 21:18:24 volumio volumio[1024]:  Simple mixer control 'IEC958',0
May 08 21:18:24 volumio volumio[1024]:   Capabilities: pswitch pswitch-joined
May 08 21:18:24 volumio volumio[1024]:   Playback channels: Mono
May 08 21:18:24 volumio volumio[1024]:   Mono: Playback [off]
May 08 21:18:24 volumio volumio[1024]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
May 08 21:18:24 volumio volumio[1024]: info: MPD Permissions set
May 08 21:18:24 volumio volumio[1024]: info: MPD Permissions set
May 08 21:18:24 volumio volumio[1024]: Unable to parse:
May 08 21:18:24 volumio volumio[1024]:  Simple mixer control 'IEC958',0
May 08 21:18:24 volumio volumio[1024]:   Capabilities: pswitch pswitch-joined
May 08 21:18:24 volumio volumio[1024]:   Playback channels: Mono
May 08 21:18:24 volumio volumio[1024]:   Mono: Playback [off]
May 08 21:18:24 volumio volumio[1024]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
May 08 21:18:24 volumio volumio[1024]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
May 08 21:18:24 volumio volumio[1024]: Unable to parse:
May 08 21:18:24 volumio volumio[1024]:  Simple mixer control 'IEC958',0
May 08 21:18:24 volumio volumio[1024]:   Capabilities: pswitch pswitch-joined
May 08 21:18:24 volumio volumio[1024]:   Playback channels: Mono
May 08 21:18:24 volumio volumio[1024]:   Mono: Playback [off]
May 08 21:18:24 volumio volumio[1024]: info: VolumeController:: Volume=undefined Mute =false
May 08 21:18:24 volumio volumio[1024]: info: CoreStateMachine::pushState
May 08 21:18:24 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:24 volumio volumio[1024]: info: Discovery: adding 99be08fc-36ea-4398-8347-fcea73fe2750
May 08 21:18:24 volumio volumio[1024]: info: Discovery: Found device Volumio
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState
May 08 21:18:24 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:24 volumio volumio[1024]: Unable to parse:
May 08 21:18:24 volumio volumio[1024]:  Simple mixer control 'IEC958',0
May 08 21:18:24 volumio volumio[1024]:   Capabilities: pswitch pswitch-joined
May 08 21:18:24 volumio volumio[1024]:   Playback channels: Mono
May 08 21:18:24 volumio volumio[1024]:   Mono: Playback [off]
May 08 21:18:24 volumio volumio[1024]: info: VolumeController:: Volume=undefined Mute =false
May 08 21:18:24 volumio volumio[1024]: info: CoreStateMachine::pushState
May 08 21:18:24 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState
May 08 21:18:24 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:24 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState
May 08 21:18:24 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:24 volumio volumio[1024]: info: Starting Shairport Sync
May 08 21:18:24 volumio volumio[1024]: info: Starting Shairport Sync
May 08 21:18:24 volumio volumio[1024]: info: Starting Shairport Sync
May 08 21:18:24 volumio sudo[1700]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 08 21:18:24 volumio sudo[1698]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 08 21:18:24 volumio sudo[1696]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 08 21:18:24 volumio sudo[1700]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:24 volumio sudo[1698]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:24 volumio sudo[1696]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:24 volumio volumio[1024]: info: Volumio called home
May 08 21:18:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 08 21:18:24 volumio systemd[1]: shairport-sync.service: Succeeded.
May 08 21:18:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 08 21:18:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 08 21:18:24 volumio sudo[1696]: pam_unix(sudo:session): session closed for user root
May 08 21:18:24 volumio sudo[1698]: pam_unix(sudo:session): session closed for user root
May 08 21:18:24 volumio sudo[1700]: pam_unix(sudo:session): session closed for user root
May 08 21:18:24 volumio volumio[1024]: info: Shairport-Sync Started
May 08 21:18:24 volumio volumio[1024]: Error adding Membership: Error: addMembership EINVAL
May 08 21:18:24 volumio volumio[1024]: info: Shairport-Sync Started
May 08 21:18:24 volumio volumio[1024]: info: Shairport-Sync Started
May 08 21:18:24 volumio mpd[1679]: May 08 14:18 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 08 21:18:24 volumio systemd[1]: Started Music Player Daemon.
May 08 21:18:24 volumio sudo[1655]: pam_unix(sudo:session): session closed for user root
May 08 21:18:24 volumio sudo[1647]: pam_unix(sudo:session): session closed for user root
May 08 21:18:25 volumio volumio[1024]: info: Completed starting Core Plugins
May 08 21:18:25 volumio volumio[1024]: info: -------------------------------------------
May 08 21:18:25 volumio volumio[1024]: info: -----    MyVolumio plugins startup     ----
May 08 21:18:25 volumio volumio[1024]: info: -------------------------------------------
May 08 21:18:25 volumio volumio[1024]: info: [MyVolumio PluginManager] Fetching plans data....
May 08 21:18:25 volumio volumio[1024]: error: MPD error: The expression evaluated to a falsy value:
May 08 21:18:25 volumio volumio[1024]:   assert.ok(self.idling)
May 08 21:18:25 volumio volumio[1024]: error: The expression evaluated to a falsy value:
May 08 21:18:25 volumio volumio[1024]:   assert.ok(self.idling)
May 08 21:18:25 volumio volumio[1024]: error: updateQueue error: null
May 08 21:18:25 volumio volumio[1024]: info: MPD running with PID1679
May 08 21:18:25 volumio volumio[1024]:  ,establishing connection
May 08 21:18:25 volumio sudo[1712]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf
May 08 21:18:25 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:25 volumio volumio[1024]: error: updateQueue error: null
May 08 21:18:25 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root
May 08 21:18:25 volumio volumio[1024]: info: Permissions for /etc/hostapd/hostapd.conf
May 08 21:18:25 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
May 08 21:18:25 volumio volumio[1024]: info: Discovery: Restarting Advertising due to device name change
May 08 21:18:25 volumio sudo[1715]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service
May 08 21:18:25 volumio sudo[1715]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:25 volumio systemd[1]: Starting Wireless Services...
May 08 21:18:25 volumio wireless.js[1717]: WIRELESS: No wireless interface, exiting
May 08 21:18:25 volumio iw[1728]: command failed: No such device (-19)
May 08 21:18:25 volumio iwconfig[1732]: Error for wireless request "Set Power Management" (8B2C) :
May 08 21:18:25 volumio iwconfig[1732]:     SET failed on device wlan0 ; No such device.
May 08 21:18:25 volumio systemd[1]: wireless.service: Succeeded.
May 08 21:18:25 volumio systemd[1]: Started Wireless Services.
May 08 21:18:25 volumio sudo[1715]: pam_unix(sudo:session): session closed for user root
May 08 21:18:26 volumio volumio[1024]: info: Discovery: A device disappeared from network
May 08 21:18:26 volumio volumio[1024]: info: Discovery: Device volumio disappeared from network
May 08 21:18:27 volumio volumio-remote-updater[776]: [2025-05-08 14:18:27] [connect] Successful connection
May 08 21:18:27 volumio volumio-remote-updater[776]: [2025-05-08 14:18:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1746713907 101
May 08 21:18:27 volumio volumio[1024]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2
May 08 21:18:28 volumio systemd[1]: systemd-fsckd.service: Succeeded.
May 08 21:18:28 volumio sudo[1753]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 08 21:18:28 volumio sudo[1753]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:28 volumio sudo[1753]: pam_unix(sudo:session): session closed for user root
May 08 21:18:28 volumio sudo[1755]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 08 21:18:28 volumio sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:28 volumio sudo[1758]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 08 21:18:28 volumio sudo[1758]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:28 volumio sudo[1755]: pam_unix(sudo:session): session closed for user root
May 08 21:18:28 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
May 08 21:18:28 volumio sudo[1758]: pam_unix(sudo:session): session closed for user root
May 08 21:18:28 volumio volumio[1024]: info: Upmpdcli Daemon Started
May 08 21:18:28 volumio volumio[1763]: Generating RSA private key, 4096 bit long modulus (2 primes)
May 08 21:18:28 volumio volumio[1763]: .......++++
May 08 21:18:30 volumio volumio[1024]: error: Failed LSINFO: Error:  [50@0] {lsinfo} No such directory
May 08 21:18:30 volumio volumio[1024]: info: Discovery: Started advertising with name: Volumio
May 08 21:18:30 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection
May 08 21:18:30 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo
May 08 21:18:30 volumio sudo[1781]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 08 21:18:30 volumio sudo[1781]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:30 volumio sudo[1781]: pam_unix(sudo:session): session closed for user root
May 08 21:18:30 volumio volumio[1024]: info: Discovery: adding 99be08fc-36ea-4398-8347-fcea73fe2750
May 08 21:18:30 volumio volumio[1024]: info: Discovery: Found device Volumio
May 08 21:18:30 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState
May 08 21:18:30 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:32 volumio volumio[1763]: .......................................................................................................................................................................................................................................++++
May 08 21:18:32 volumio volumio[1763]: e is 65537 (0x010001)
May 08 21:18:32 volumio volumio[1763]: writing RSA key
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 08 21:18:33 volumio volumio[1024]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 08 21:18:33 volumio volumio[1024]: info: Adding plugin bluetooth to MyMusic Plugins
May 08 21:18:33 volumio volumio[1024]: info: Adding plugin multiroom to MyMusic Plugins
May 08 21:18:33 volumio volumio[1024]: info: Adding plugin metavolumio to MyMusic Plugins
May 08 21:18:34 volumio volumio[1024]: info: Adding plugin cd_controller to MyMusic Plugins
May 08 21:18:34 volumio volumio[1024]: info: Adding plugin smart_inputs to MyMusic Plugins
May 08 21:18:34 volumio volumio[1024]: info: Adding plugin tidalconnect to MyMusic Plugins
May 08 21:18:34 volumio volumio[1024]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 08 21:18:37 volumio volumio[1024]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 08 21:18:37 volumio volumio[1024]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 08 21:18:37 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:37 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:37 volumio volumio[1024]: info: Starting MyVolumio Remote Streaming Endpoints
May 08 21:18:37 volumio volumio[1024]: info: MyVolumio not started
May 08 21:18:37 volumio volumio[1024]: info: Initializing device activation check
May 08 21:18:37 volumio volumio[1024]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 08 21:18:37 volumio volumio[1024]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 08 21:18:39 volumio volumio[1024]: info: Starting Streaming Service Transparent Proxy
May 08 21:18:39 volumio volumio[1024]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 08 21:18:39 volumio volumio[1024]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 08 21:18:39 volumio volumio[1024]: info: Streaming services startup
May 08 21:18:39 volumio volumio[1024]: info: Starting Streaming Daemon
May 08 21:18:39 volumio sudo[1873]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 08 21:18:39 volumio sudo[1873]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:39 volumio sudo[1873]: pam_unix(sudo:session): session closed for user root
May 08 21:18:39 volumio volumio[1024]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
May 08 21:18:39 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
May 08 21:18:39 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart
May 08 21:18:39 volumio volumio[1024]: info: Refreshing Cached IP Addresses
May 08 21:18:39 volumio sudo[1881]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
May 08 21:18:39 volumio sudo[1881]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:39 volumio sudo[1881]: pam_unix(sudo:session): session closed for user root
May 08 21:18:39 volumio sudo[1884]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 08 21:18:39 volumio sudo[1884]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:39 volumio sudo[1884]: pam_unix(sudo:session): session closed for user root
May 08 21:18:39 volumio sudo[1886]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 08 21:18:39 volumio sudo[1886]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:39 volumio volumio[1024]: error: Cannot start Volumio Streaming Daemon
May 08 21:18:39 volumio volumio[1024]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 08 21:18:39 volumio volumio[1024]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 08 21:18:39 volumio sudo[1886]: pam_unix(sudo:session): session closed for user root
May 08 21:18:39 volumio systemd[1]: upmpdcli.service: Succeeded.
May 08 21:18:39 volumio volumio[1024]: STREAMING PROXY: Starting server on port 3245
May 08 21:18:39 volumio volumio[1024]: Node JS runtime: 14
May 08 21:18:42 volumio dbus-daemon[789]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.15' (uid=0 pid=1791 comm="/usr/lib/chromium/chromium --show-component-extens")
May 08 21:18:42 volumio systemd[1]: Starting Bluetooth service...
May 08 21:18:43 volumio systemd[1]: systemd-timedated.service: Succeeded.
May 08 21:18:43 volumio bluetoothd[1906]: Bluetooth daemon 5.50
May 08 21:18:43 volumio kernel: Bluetooth: Core ver 2.22
May 08 21:18:43 volumio kernel: NET: Registered PF_BLUETOOTH protocol family
May 08 21:18:43 volumio kernel: Bluetooth: HCI device and connection manager initialized
May 08 21:18:43 volumio kernel: Bluetooth: HCI socket layer initialized
May 08 21:18:43 volumio kernel: Bluetooth: L2CAP socket layer initialized
May 08 21:18:43 volumio kernel: Bluetooth: SCO socket layer initialized
May 08 21:18:43 volumio bluetoothd[1906]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
May 08 21:18:43 volumio dbus-daemon[789]: [system] Successfully activated service 'org.bluez'
May 08 21:18:43 volumio systemd[1]: Started Bluetooth service.
May 08 21:18:43 volumio bluetoothd[1906]: Starting SDP server
May 08 21:18:43 volumio bluetoothd[1906]: Excluding (cli) sap
May 08 21:18:44 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
May 08 21:18:44 volumio kernel: Bluetooth: BNEP filters: protocol multicast
May 08 21:18:44 volumio kernel: Bluetooth: BNEP socket layer initialized
May 08 21:18:44 volumio dbus-daemon[789]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.16' (uid=0 pid=1906 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
May 08 21:18:44 volumio bluetoothd[1906]: Bluetooth management interface 1.22 initialized
May 08 21:18:44 volumio systemd[1]: Starting Hostname Service...
May 08 21:18:45 volumio dbus-daemon[789]: [system] Successfully activated service 'org.freedesktop.hostname1'
May 08 21:18:45 volumio systemd[1]: Started Hostname Service.
May 08 21:18:48 volumio volumio[1024]: 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
May 08 21:18:49 volumio sudo[2066]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 08 21:18:49 volumio sudo[2066]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:49 volumio sudo[2066]: pam_unix(sudo:session): session closed for user root
May 08 21:18:49 volumio sudo[2069]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 08 21:18:49 volumio sudo[2069]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:49 volumio sudo[2069]: pam_unix(sudo:session): session closed for user root
May 08 21:18:49 volumio volumio[1024]: verbose: New Socket.io Connection to 192.168.1.9 from 192.168.1.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::volumioGetVisibleSources
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
May 08 21:18:49 volumio volumio[1024]: info: Received Get System Info
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 08 21:18:49 volumio volumio[1024]: info: Discovery: Getting this device information
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState
May 08 21:18:49 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 08 21:18:49 volumio volumio-remote-updater[776]: No test mode
May 08 21:18:49 volumio volumio-remote-updater[776]: No alpha test mode
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:49 volumio volumio[1024]: info: Retrieving Cloud Streaming UI
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::volumioGetVisibleSources
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
May 08 21:18:49 volumio volumio[1024]: info: Received Get System Info
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 08 21:18:49 volumio volumio[1024]: info: Discovery: Getting this device information
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState
May 08 21:18:49 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 08 21:18:49 volumio sudo[2081]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 08 21:18:49 volumio sudo[2081]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:49 volumio sudo[2081]: pam_unix(sudo:session): session closed for user root
May 08 21:18:49 volumio sudo[2083]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 08 21:18:49 volumio sudo[2083]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:49 volumio volumio[1024]: info: Getting Tidal Cloud Configuration
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:49 volumio volumio[1024]: info: Getting Qobuz Cloud Configuration
May 08 21:18:49 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:49 volumio volumio[1024]: info: Getting Spotify Cloud Configuration
May 08 21:18:49 volumio sudo[2083]: pam_unix(sudo:session): session closed for user root
May 08 21:18:49 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:49 volumio volumio[1024]: info: Saving Spotify Acccount
May 08 21:18:49 volumio volumio[1024]: info: Got Tidal Cloud Configuration
May 08 21:18:49 volumio volumio[1024]: info: Got it
May 08 21:18:49 volumio volumio[1024]: info: Got it
May 08 21:18:49 volumio volumio[1024]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 08 21:18:49 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:49 volumio volumio[1024]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 08 21:18:49 volumio sudo[2089]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 08 21:18:49 volumio sudo[2089]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:49 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
May 08 21:18:49 volumio sudo[2089]: pam_unix(sudo:session): session closed for user root
May 08 21:18:49 volumio volumio[1024]: info: Upmpdcli Daemon Started
May 08 21:18:49 volumio volumio[2091]: writing RSA key
May 08 21:18:50 volumio volumio-remote-updater[776]: No test mode
May 08 21:18:50 volumio volumio-remote-updater[776]: No alpha test mode
May 08 21:18:50 volumio volumio[1024]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"NEW ADDITIONS
QOBUZ Connect Ready
 ","title":"Update v3.807","updateavailable":true}
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:50 volumio volumio[1024]: info: Retrieving Cloud Streaming UI
May 08 21:18:50 volumio volumio[1024]: info: Getting Tidal Cloud Configuration
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:50 volumio volumio[1024]: info: Getting Qobuz Cloud Configuration
May 08 21:18:50 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:50 volumio volumio[1024]: info: Getting Spotify Cloud Configuration
May 08 21:18:50 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:50 volumio volumio[1024]: info: Saving Spotify Acccount
May 08 21:18:50 volumio volumio[1024]: info: Got Tidal Cloud Configuration
May 08 21:18:50 volumio volumio[1024]: info: Got it
May 08 21:18:50 volumio volumio[1024]: info: Got it
May 08 21:18:50 volumio volumio[1024]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:50 volumio volumio[1024]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 08 21:18:50 volumio volumio[1024]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"NEW ADDITIONS
QOBUZ Connect Ready
 ","title":"Update v3.807","updateavailable":true}
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 08 21:18:50 volumio volumio[1024]: info: Loading i18n strings for locale vi
May 08 21:18:50 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 08 21:18:50 volumio volumio[1024]: info: Setting timezone to Asia/Saigon
May 08 21:18:50 volumio sudo[2123]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 08 21:18:50 volumio sudo[2123]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:50 volumio sudo[2123]: pam_unix(sudo:session): session closed for user root
May 08 21:18:50 volumio sudo[2126]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Saigon /etc/localtime
May 08 21:18:50 volumio sudo[2126]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:50 volumio sudo[2126]: pam_unix(sudo:session): session closed for user root
May 08 21:18:50 volumio sudo[2129]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 08 21:18:50 volumio sudo[2129]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:50 volumio sudo[2129]: pam_unix(sudo:session): session closed for user root
May 08 21:18:50 volumio sudo[2132]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Saigon
May 08 21:18:50 volumio sudo[2132]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:50 volumio dbus-daemon[789]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=2133 comm="/usr/bin/timedatectl set-timezone Asia/Saigon ")
May 08 21:18:50 volumio systemd[1]: Starting Time & Date Service...
May 08 21:18:51 volumio dbus-daemon[789]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 08 21:18:51 volumio systemd[1]: Started Time & Date Service.
May 08 21:18:51 volumio sudo[2132]: pam_unix(sudo:session): session closed for user root
May 08 21:18:51 volumio volumio[1024]: Updating browse sources language
May 08 21:18:51 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:18:51 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 08 21:18:51 volumio volumio[1024]: info: Loading i18n strings for locale en
May 08 21:18:51 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 08 21:18:51 volumio volumio[1024]: info: Setting timezone to UTC
May 08 21:18:51 volumio sudo[2136]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 08 21:18:51 volumio sudo[2136]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:51 volumio sudo[2136]: pam_unix(sudo:session): session closed for user root
May 08 21:18:51 volumio sudo[2139]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/UTC /etc/localtime
May 08 21:18:51 volumio sudo[2139]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:51 volumio sudo[2139]: pam_unix(sudo:session): session closed for user root
May 08 21:18:51 volumio sudo[2142]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 08 21:18:51 volumio sudo[2142]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:51 volumio sudo[2142]: pam_unix(sudo:session): session closed for user root
May 08 21:18:51 volumio sudo[2145]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC
May 08 21:18:51 volumio sudo[2145]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:51 volumio systemd-timedated[2134]: Failed to set time zone: Permission denied
May 08 21:18:51 volumio sudo[2145]: pam_unix(sudo:session): session closed for user root
May 08 21:18:51 volumio volumio[1024]: Failed to set time zone: Access denied
May 08 21:18:51 volumio volumio[1024]: info: Could not set timezone, retrying
May 08 21:18:51 volumio volumio[1024]: Updating browse sources language
May 08 21:18:51 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:18:51 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 08 21:18:51 volumio volumio[1024]: info: Fetching Streaming Services browse cache
May 08 21:18:51 volumio volumio[1024]: info: Fetching Streaming Services browse cache
May 08 21:18:52 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
May 08 21:18:52 volumio volumio[1024]: info: MyVolumio login type: Token
May 08 21:18:52 volumio sudo[2148]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC
May 08 21:18:52 volumio sudo[2148]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:52 volumio sudo[2148]: pam_unix(sudo:session): session closed for user root
May 08 21:18:52 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 08 21:18:52 volumio volumio[1024]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
May 08 21:18:52 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState
May 08 21:18:52 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:18:52 volumio volumio[1024]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
May 08 21:18:53 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 08 21:18:53 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 08 21:18:53 volumio volumio[1024]: info: Loading i18n strings for locale vi
May 08 21:18:53 volumio volumio[1024]: Updating browse sources language
May 08 21:18:53 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:18:53 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 08 21:18:53 volumio volumio[1024]: info: Setting timezone to Asia/Saigon
May 08 21:18:53 volumio sudo[2153]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 08 21:18:53 volumio sudo[2153]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:53 volumio sudo[2153]: pam_unix(sudo:session): session closed for user root
May 08 21:18:53 volumio sudo[2156]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Saigon /etc/localtime
May 08 21:18:53 volumio sudo[2156]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:53 volumio sudo[2156]: pam_unix(sudo:session): session closed for user root
May 08 21:18:53 volumio sudo[2159]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 08 21:18:53 volumio sudo[2159]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:53 volumio sudo[2159]: pam_unix(sudo:session): session closed for user root
May 08 21:18:53 volumio sudo[2162]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Saigon
May 08 21:18:53 volumio sudo[2162]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:53 volumio systemd-timedated[2134]: Failed to set time zone: Permission denied
May 08 21:18:53 volumio sudo[2162]: pam_unix(sudo:session): session closed for user root
May 08 21:18:53 volumio volumio[1024]: Failed to set time zone: Access denied
May 08 21:18:53 volumio volumio[1024]: info: Could not set timezone, retrying
May 08 21:18:53 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
May 08 21:18:53 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
May 08 21:18:53 volumio sudo[2165]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 08 21:18:53 volumio sudo[2165]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:53 volumio sudo[2165]: pam_unix(sudo:session): session closed for user root
May 08 21:18:53 volumio volumio[1024]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
May 08 21:18:53 volumio volumio[1024]: wlan0     Interface doesn't support scanning.
May 08 21:18:53 volumio volumio[1024]: info: Cannot use regular scanning, forcing with ap-force
May 08 21:18:53 volumio sudo[2170]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
May 08 21:18:53 volumio sudo[2170]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:54 volumio sudo[2170]: pam_unix(sudo:session): session closed for user root
May 08 21:18:54 volumio volumio[1024]: command failed: No such device (-19)
May 08 21:18:54 volumio volumio[1024]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
May 08 21:18:54 volumio volumio[1024]: command failed: No such device (-19)
May 08 21:18:54 volumio volumio[1024]: info: Fetching Streaming Services browse cache
May 08 21:18:54 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 08 21:18:54 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:54 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 08 21:18:54 volumio volumio-remote-updater[776]: No test mode
May 08 21:18:54 volumio volumio-remote-updater[776]: No alpha test mode
May 08 21:18:54 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
May 08 21:18:55 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 08 21:18:55 volumio sudo[2178]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Saigon
May 08 21:18:55 volumio sudo[2178]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:18:55 volumio sudo[2178]: pam_unix(sudo:session): session closed for user root
May 08 21:18:55 volumio volumio[1024]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"NEW ADDITIONS
QOBUZ Connect Ready
 ","title":"Update v3.807","updateavailable":true}
May 08 21:18:55 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 08 21:18:55 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 08 21:18:57 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:57 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:57 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
May 08 21:18:57 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 08 21:18:57 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
May 08 21:18:57 volumio volumio[1024]: info: CoreCommandRouter::volumioGetBrowseSources
May 08 21:18:57 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 08 21:18:59 volumio volumio[1024]: error: MyVolumio Plugin failed to authenticate in a timely fashion
May 08 21:18:59 volumio volumio[1024]: info: Completed starting MyVolumio Plugin
May 08 21:18:59 volumio volumio[1024]:  [Metrics]  CommandRouter:  44s 602.81ms 
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::volumiosetStartupVolume
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::Close All Modals sent
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::Close All Modals sent
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Retrieving Cloud Streaming UI
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Retrieving Cloud Streaming UI
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Retrieving Cloud Streaming UI
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Retrieving Cloud Streaming UI
May 08 21:18:59 volumio volumio[1024]: info: Getting Tidal Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Getting Qobuz Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Getting Spotify Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Saving Spotify Acccount
May 08 21:18:59 volumio volumio[1024]: info: Got Tidal Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Got it
May 08 21:18:59 volumio volumio[1024]: info: Got it
May 08 21:18:59 volumio volumio[1024]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 08 21:18:59 volumio volumio[1024]: info: Getting Tidal Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Getting Qobuz Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Getting Spotify Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Saving Spotify Acccount
May 08 21:18:59 volumio volumio[1024]: info: Got Tidal Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Got it
May 08 21:18:59 volumio volumio[1024]: info: Got it
May 08 21:18:59 volumio volumio[1024]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 08 21:18:59 volumio volumio[1024]: info: Getting Tidal Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Getting Qobuz Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Getting Spotify Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Saving Spotify Acccount
May 08 21:18:59 volumio volumio[1024]: info: Got Tidal Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Got it
May 08 21:18:59 volumio volumio[1024]: info: Got it
May 08 21:18:59 volumio volumio[1024]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 08 21:18:59 volumio volumio[1024]: info: Getting Tidal Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Getting Qobuz Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Getting Spotify Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: info: Saving Spotify Acccount
May 08 21:18:59 volumio volumio[1024]: info: Got Tidal Cloud Configuration
May 08 21:18:59 volumio volumio[1024]: info: Got it
May 08 21:18:59 volumio volumio[1024]: info: Got it
May 08 21:18:59 volumio volumio[1024]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 08 21:18:59 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:18:59 volumio volumio[1024]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 08 21:19:00 volumio volumio[1024]: info: Version has changed, forcing UI Reload
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::Reload Ui
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 08 21:19:00 volumio kernel: snd_hda_intel 0000:00:01.1: IRQ timing workaround is activated for card #0. Suggest a bigger bdl_pos_adj.
May 08 21:19:00 volumio sudo[2313]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 08 21:19:00 volumio sudo[2313]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:00 volumio sudo[2313]: pam_unix(sudo:session): session closed for user root
May 08 21:19:00 volumio sudo[2321]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 08 21:19:00 volumio sudo[2321]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:00 volumio sudo[2321]: pam_unix(sudo:session): session closed for user root
May 08 21:19:00 volumio volumio[1024]: verbose: New Socket.io Connection to 192.168.1.9 from 192.168.1.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::volumioGetVisibleSources
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
May 08 21:19:00 volumio volumio[1024]: info: Received Get System Info
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 08 21:19:00 volumio volumio[1024]: info: Discovery: Getting this device information
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState
May 08 21:19:00 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 08 21:19:00 volumio volumio-remote-updater[776]: No test mode
May 08 21:19:00 volumio volumio-remote-updater[776]: No alpha test mode
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:00 volumio volumio[1024]: info: Retrieving Cloud Streaming UI
May 08 21:19:00 volumio volumio[1024]: info: Getting Tidal Cloud Configuration
May 08 21:19:00 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:01 volumio volumio[1024]: info: Getting Qobuz Cloud Configuration
May 08 21:19:01 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:01 volumio volumio[1024]: info: Getting Spotify Cloud Configuration
May 08 21:19:01 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:01 volumio volumio[1024]: info: Saving Spotify Acccount
May 08 21:19:01 volumio volumio[1024]: info: Got Tidal Cloud Configuration
May 08 21:19:01 volumio volumio[1024]: info: Got it
May 08 21:19:01 volumio volumio[1024]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:01 volumio volumio[1024]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 08 21:19:01 volumio volumio[1024]: 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: 5
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::volumioGetVisibleSources
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
May 08 21:19:01 volumio volumio[1024]: info: Received Get System Info
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 08 21:19:01 volumio volumio[1024]: info: Discovery: Getting this device information
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState
May 08 21:19:01 volumio volumio[1024]: info: CorePlayQueue::getTrack 0
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 08 21:19:01 volumio volumio-remote-updater[776]: No test mode
May 08 21:19:01 volumio volumio-remote-updater[776]: No alpha test mode
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:01 volumio volumio[1024]: info: Retrieving Cloud Streaming UI
May 08 21:19:01 volumio volumio[1024]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"NEW ADDITIONS
QOBUZ Connect Ready
 ","title":"Update v3.807","updateavailable":true}
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 08 21:19:01 volumio volumio[1024]: info: Getting Tidal Cloud Configuration
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:01 volumio volumio[1024]: info: Getting Qobuz Cloud Configuration
May 08 21:19:01 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:01 volumio volumio[1024]: info: Getting Spotify Cloud Configuration
May 08 21:19:01 volumio volumio[1024]: info: Asking plugin for UI Config
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:01 volumio volumio[1024]: info: Saving Spotify Acccount
May 08 21:19:01 volumio volumio[1024]: info: Got Tidal Cloud Configuration
May 08 21:19:01 volumio volumio[1024]: info: Got it
May 08 21:19:01 volumio volumio[1024]: info: Got it
May 08 21:19:01 volumio volumio[1024]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin
May 08 21:19:01 volumio volumio[1024]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 08 21:19:01 volumio volumio[1024]: info: Loading i18n strings for locale vi
May 08 21:19:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 08 21:19:01 volumio volumio[1024]: info: Setting timezone to Asia/Saigon
May 08 21:19:02 volumio sudo[2435]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 08 21:19:02 volumio sudo[2435]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:02 volumio sudo[2435]: pam_unix(sudo:session): session closed for user root
May 08 21:19:02 volumio sudo[2438]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Saigon /etc/localtime
May 08 21:19:02 volumio sudo[2438]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:02 volumio sudo[2438]: pam_unix(sudo:session): session closed for user root
May 08 21:19:02 volumio sudo[2441]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 08 21:19:02 volumio sudo[2441]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:02 volumio sudo[2441]: pam_unix(sudo:session): session closed for user root
May 08 21:19:02 volumio sudo[2444]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Saigon
May 08 21:19:02 volumio sudo[2444]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:02 volumio sudo[2444]: pam_unix(sudo:session): session closed for user root
May 08 21:19:02 volumio volumio[1024]: Updating browse sources language
May 08 21:19:02 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:19:02 volumio volumio[1024]: info: Fetching Streaming Services browse cache
May 08 21:19:02 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 08 21:19:03 volumio volumio[1024]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"NEW ADDITIONS
QOBUZ Connect Ready
 ","title":"Update v3.807","updateavailable":true}
May 08 21:19:03 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 08 21:19:03 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 08 21:19:03 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 08 21:19:03 volumio volumio[1024]: info: Loading i18n strings for locale en
May 08 21:19:03 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 08 21:19:03 volumio volumio[1024]: info: Setting timezone to UTC
May 08 21:19:04 volumio sudo[2447]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 08 21:19:04 volumio sudo[2447]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:04 volumio sudo[2447]: pam_unix(sudo:session): session closed for user root
May 08 21:19:04 volumio sudo[2450]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/UTC /etc/localtime
May 08 21:19:04 volumio sudo[2450]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:04 volumio sudo[2450]: pam_unix(sudo:session): session closed for user root
May 08 21:19:04 volumio sudo[2453]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 08 21:19:04 volumio sudo[2453]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:04 volumio sudo[2453]: pam_unix(sudo:session): session closed for user root
May 08 21:19:04 volumio sudo[2456]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC
May 08 21:19:04 volumio sudo[2456]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:05 volumio systemd-timedated[2134]: Failed to set time zone: Permission denied
May 08 21:19:05 volumio sudo[2456]: pam_unix(sudo:session): session closed for user root
May 08 21:19:05 volumio volumio[1024]: Failed to set time zone: Access denied
May 08 21:19:05 volumio volumio[1024]: info: Could not set timezone, retrying
May 08 21:19:05 volumio volumio[1024]: info: Fetching Streaming Services browse cache
May 08 21:19:05 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 08 21:19:05 volumio volumio[1024]: info: Loading i18n strings for locale vi
May 08 21:19:05 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 08 21:19:05 volumio volumio[1024]: info: Setting timezone to Asia/Saigon
May 08 21:19:05 volumio sudo[2459]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 08 21:19:05 volumio sudo[2459]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:05 volumio sudo[2459]: pam_unix(sudo:session): session closed for user root
May 08 21:19:05 volumio sudo[2462]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Saigon /etc/localtime
May 08 21:19:05 volumio sudo[2462]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:05 volumio sudo[2462]: pam_unix(sudo:session): session closed for user root
May 08 21:19:05 volumio sudo[2465]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 08 21:19:05 volumio sudo[2465]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:05 volumio sudo[2465]: pam_unix(sudo:session): session closed for user root
May 08 21:19:05 volumio sudo[2468]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Saigon
May 08 21:19:05 volumio sudo[2468]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:05 volumio systemd-timedated[2134]: Failed to set time zone: Permission denied
May 08 21:19:05 volumio sudo[2468]: pam_unix(sudo:session): session closed for user root
May 08 21:19:05 volumio volumio[1024]: Failed to set time zone: Access denied
May 08 21:19:05 volumio volumio[1024]: info: Could not set timezone, retrying
May 08 21:19:05 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
May 08 21:19:05 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
May 08 21:19:05 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 08 21:19:05 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 08 21:19:05 volumio sudo[2471]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 08 21:19:05 volumio sudo[2471]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:05 volumio sudo[2471]: pam_unix(sudo:session): session closed for user root
May 08 21:19:05 volumio volumio[1024]: Updating browse sources language
May 08 21:19:05 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:19:05 volumio volumio[1024]: Updating browse sources language
May 08 21:19:05 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 08 21:19:05 volumio volumio[1024]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
May 08 21:19:05 volumio volumio[1024]: wlan0     Interface doesn't support scanning.
May 08 21:19:05 volumio volumio[1024]: info: Cannot use regular scanning, forcing with ap-force
May 08 21:19:05 volumio sudo[2476]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
May 08 21:19:05 volumio sudo[2476]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:05 volumio sudo[2476]: pam_unix(sudo:session): session closed for user root
May 08 21:19:05 volumio volumio[1024]: command failed: No such device (-19)
May 08 21:19:05 volumio volumio[1024]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
May 08 21:19:05 volumio volumio[1024]: command failed: No such device (-19)
May 08 21:19:05 volumio volumio[1024]: info: Fetching Streaming Services browse cache
May 08 21:19:06 volumio sudo[2481]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC
May 08 21:19:06 volumio sudo[2481]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 08 21:19:06 volumio systemd-timedated[2134]: Failed to set time zone: Permission denied
May 08 21:19:06 volumio sudo[2481]: pam_unix(sudo:session): session closed for user root
May 08 21:19:06 volumio volumio[1024]: Failed to set time zone: Access denied
May 08 21:19:06 volumio volumio[1024]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 08 21:19:06 volumio volumio[1024]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'UTC'
May 08 21:19:06 volumio volumio[1024]: Failed to set time zone: Access denied
May 08 21:19:06 volumio volumio[1024]:     at checkExecSyncError (child_process.js:790:11)
May 08 21:19:06 volumio volumio[1024]:     at execSync (child_process.js:863:15)
May 08 21:19:06 volumio volumio[1024]:     at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9)
May 08 21:19:06 volumio volumio[1024]:     at listOnTimeout (internal/timers.js:557:17)
May 08 21:19:06 volumio volumio[1024]:     at processTimers (internal/timers.js:500:7) {
May 08 21:19:06 volumio volumio[1024]:   status: 1,
May 08 21:19:06 volumio volumio[1024]:   signal: null,
May 08 21:19:06 volumio volumio[1024]:   output: [ null, '', 'Failed to set time zone: Access denied\n' ],
May 08 21:19:06 volumio volumio[1024]:   pid: 2480,
May 08 21:19:06 volumio volumio[1024]:   stdout: '',
May 08 21:19:06 volumio volumio[1024]:   stderr: 'Failed to set time zone: Access denied\n'
May 08 21:19:06 volumio volumio[1024]: }
May 08 21:19:06 volumio volumio[1024]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 08 21:19:06 volumio sudo[2492]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-08 21:18
May 08 21:19:06 volumio sudo[2492]: 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="9ab87de061b3649c303da550e73c92d340b0f989"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST"
VOLUMIO_VERSION="3.804"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"