-- Logs begin at Sun 2025-02-23 21:19:58 CST, end at Sun 2025-02-23 21:21:09 CST. -- Feb 23 21:20:00 volumio-m1s kernel: usb 1-2: 1:3 : unsupported format bits 0x100000000 Feb 23 21:20:00 volumio-m1s kernel: usbcore: registered new interface driver snd-usb-audio Feb 23 21:20:00 volumio-m1s systemd-udevd[559]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 21:20:00 volumio-m1s systemd-udevd[538]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 21:20:00 volumio-m1s systemd[1]: Found device /dev/disk/by-uuid/058F-31E9. Feb 23 21:20:00 volumio-m1s systemd-udevd[556]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 21:20:00 volumio-m1s systemd-udevd[557]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 21:20:00 volumio-m1s systemd-udevd[547]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 21:20:00 volumio-m1s kernel: iwlwifi 0000:01:00.0: Detected Intel(R) Dual Band Wireless AC 3165, REV=0x210 Feb 23 21:20:00 volumio-m1s kernel: thermal thermal_zone6: failed to read out thermal zone (-61) Feb 23 21:20:00 volumio-m1s kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Feb 23 21:20:00 volumio-m1s kernel: iwlwifi 0000:01:00.0: Allocated 0x00400000 bytes for firmware monitor. Feb 23 21:20:00 volumio-m1s kernel: iwlwifi 0000:01:00.0: base HW address: 5c:5f:67:79:05:45, OTP minor version: 0x0 Feb 23 21:20:00 volumio-m1s kernel: Bluetooth: Core ver 2.22 Feb 23 21:20:00 volumio-m1s kernel: NET: Registered PF_BLUETOOTH protocol family Feb 23 21:20:00 volumio-m1s kernel: Bluetooth: HCI device and connection manager initialized Feb 23 21:20:00 volumio-m1s kernel: Bluetooth: HCI socket layer initialized Feb 23 21:20:00 volumio-m1s kernel: Bluetooth: L2CAP socket layer initialized Feb 23 21:20:00 volumio-m1s kernel: Bluetooth: SCO socket layer initialized Feb 23 21:20:00 volumio-m1s kernel: usbcore: registered new interface driver btusb Feb 23 21:20:00 volumio-m1s kernel: ieee80211 phy0: Selected rate control algorithm 'iwl-mvm-rs' Feb 23 21:20:00 volumio-m1s kernel: Bluetooth: hci0: Legacy ROM 2.5 revision 1.0 build 3 week 17 2014 Feb 23 21:20:00 volumio-m1s kernel: Bluetooth: hci0: Intel device is already patched. patch num: 32 Feb 23 21:20:00 volumio-m1s systemd-udevd[561]: Using default interface naming scheme 'v240'. Feb 23 21:20:00 volumio-m1s systemd-udevd[561]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 23 21:20:00 volumio-m1s kernel: alsactl[746]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Feb 23 21:20:00 volumio-m1s systemd-udevd[550]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Feb 23 21:20:00 volumio-m1s systemd[1]: Started Helper to synchronize boot up for ifupdown. Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in Wireless 3165 being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Show Plymouth Boot Screen... Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 23 21:20:01 volumio-m1s systemd[1]: Starting File System Check on /dev/disk/by-uuid/058F-31E9... Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Load/Save RF Kill Switch Status... Feb 23 21:20:01 volumio-m1s systemd[1]: plymouth-start.service: Succeeded. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Show Plymouth Boot Screen. Feb 23 21:20:01 volumio-m1s systemd[1]: Started File System Check Daemon to report status. Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Load/Save RF Kill Switch Status. Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: fsck.fat 4.1 (2017-01-24) Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: There are differences between boot sector and its backup. Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: This is mostly harmless. Differences: (offset:original/backup) Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 282:2d/00, 283:15/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: , 508:18/00, 509:37/00 Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: Not automatically fixing this. Feb 23 21:20:01 volumio-m1s systemd-fsck[773]: /dev/mmcblk1p1: 18 files, 159614/344788 clusters Feb 23 21:20:01 volumio-m1s systemd[1]: Started File System Check on /dev/disk/by-uuid/058F-31E9. Feb 23 21:20:01 volumio-m1s systemd[1]: Mounting /boot... Feb 23 21:20:01 volumio-m1s kernel: FAT-fs (mmcblk1p1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Feb 23 21:20:01 volumio-m1s systemd[1]: Mounted /boot. Feb 23 21:20:01 volumio-m1s systemd[1]: Reached target Local File Systems. Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Create Volatile Files and Directories... Feb 23 21:20:01 volumio-m1s systemd[1]: Started ifup for wlan0. Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Raise network interfaces... Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Preprocess NFS configuration... Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Received SIGRTMIN+20 from PID 396 (plymouthd). Feb 23 21:20:01 volumio-m1s systemd[1]: plymouth-read-write.service: Succeeded. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Feb 23 21:20:01 volumio-m1s systemd[1]: nfs-config.service: Succeeded. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Preprocess NFS configuration. Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Reached target NFS client services. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Create Volatile Files and Directories. Feb 23 21:20:01 volumio-m1s kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Feb 23 21:20:01 volumio-m1s systemd[1]: Starting RPC bind portmap service... Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Update UTMP about System Boot/Shutdown... Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Update UTMP about System Boot/Shutdown. Feb 23 21:20:01 volumio-m1s systemd[1]: Reached target System Initialization. Feb 23 21:20:01 volumio-m1s systemd[1]: Listening on triggerhappy.socket. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Daily man-db regeneration. Feb 23 21:20:01 volumio-m1s systemd[1]: Listening on D-Bus System Message Bus Socket. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Daily apt download activities. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Daily Cleanup of Temporary Directories. Feb 23 21:20:01 volumio-m1s systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Feb 23 21:20:01 volumio-m1s systemd[1]: Reached target Sockets. Feb 23 21:20:01 volumio-m1s systemd[1]: Reached target Basic System. Feb 23 21:20:01 volumio-m1s kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Feb 23 21:20:01 volumio-m1s systemd[1]: Started volumio-remote-updater.service. Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Started UPnP Renderer front-end to MPD. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Manage Sound Card State (restore and store). Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Save/Restore Sound Card State... Feb 23 21:20:01 volumio-m1s alsactl[831]: alsactl 1.1.8 daemon started Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Bluetooth service... Feb 23 21:20:01 volumio-m1s systemd[1]: Started MPD Monitor Service. Feb 23 21:20:01 volumio-m1s systemd[1]: Started D-Bus System Message Bus. Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Starting DHCP Client Daemon... Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Wireless Services... Feb 23 21:20:01 volumio-m1s systemd[1]: Starting WPA supplicant... Feb 23 21:20:01 volumio-m1s systemd[1]: Started Volumio Log Rotation Service. Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Volumio Time Update Utility... Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Feb 23 21:20:01 volumio-m1s systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Feb 23 21:20:01 volumio-m1s systemd[1]: Started Volumio Iptables Module. Feb 23 21:20:01 volumio-m1s kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Feb 23 21:20:01 volumio-m1s kernel: iwlwifi 0000:01:00.0: FW already configured (0) - re-configuring Feb 23 21:20:01 volumio-m1s systemd[1]: Starting triggerhappy global hotkey daemon... Feb 23 21:20:01 volumio-m1s systemd[1]: Starting Login Service... Feb 23 21:20:01 volumio-m1s systemd[1]: Started Daily apt upgrade and clean activities. Feb 23 21:20:01 volumio-m1s systemd[1]: Reached target Timers. Feb 23 21:20:01 volumio-m1s systemd[1]: Started RPC bind portmap service. Feb 23 21:20:01 volumio-m1s systemd[1]: Reached target Remote File Systems (Pre). Feb 23 21:20:01 volumio-m1s systemd[1]: Reached target Remote File Systems. Feb 23 21:20:01 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Fetching time from Volumio... Feb 23 21:20:01 volumio-m1s systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Feb 23 21:20:01 volumio-m1s systemd[1]: Reached target RPC Port Mapper. Feb 23 21:20:01 volumio-m1s thd[844]: Unable to parse trigger line: Feb 23 21:20:01 volumio-m1s thd[844]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Feb 23 21:20:01 volumio-m1s thd[844]: Unable to parse trigger line: Feb 23 21:20:01 volumio-m1s thd[844]: Found socket passed from systemd Feb 23 21:20:01 volumio-m1s systemd-logind[845]: New seat seat0. Feb 23 21:20:01 volumio-m1s mpd_monitor.sh[834]: MPD error: Connection refused Feb 23 21:20:01 volumio-m1s systemd-logind[845]: Watching system buttons on /dev/input/event2 (Power Button) Feb 23 21:20:02 volumio-m1s systemd-logind[845]: Watching system buttons on /dev/input/event0 (Power Button) Feb 23 21:20:02 volumio-m1s systemd-logind[845]: Watching system buttons on /dev/input/event1 (Lid Switch) Feb 23 21:20:02 volumio-m1s kernel: 8021q: 802.1Q VLAN Support v1.8 Feb 23 21:20:02 volumio-m1s mpd_monitor.sh[834]: mpd: no process found Feb 23 21:20:02 volumio-m1s avahi-daemon[841]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Feb 23 21:20:02 volumio-m1s avahi-daemon[841]: Successfully dropped root privileges. Feb 23 21:20:02 volumio-m1s avahi-daemon[841]: avahi-daemon 0.7 starting up. Feb 23 21:20:02 volumio-m1s systemd-logind[845]: Watching system buttons on /dev/input/event8 (gpio-keys) Feb 23 21:20:02 volumio-m1s bluetoothd[833]: Bluetooth daemon 5.50 Feb 23 21:20:02 volumio-m1s volumio-remote-updater[829]: Error: No active session Feb 23 21:20:02 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:02] [info] asio async_connect error: system:111 (Connection refused) Feb 23 21:20:02 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 23 21:20:02 volumio-m1s bluetoothd[833]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Feb 23 21:20:02 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:02] [error] handle_connect error: Underlying Transport Error Feb 23 21:20:02 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Date not found in response Feb 23 21:20:02 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 21:20:02 volumio-m1s haveged[815]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K Feb 23 21:20:02 volumio-m1s haveged[815]: haveged: cpu: (L4 VC); data: 24K (L4 V); inst: 32K (L4 V); idx: 24/40; sz: 31410/52825 Feb 23 21:20:02 volumio-m1s haveged[815]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99867 Feb 23 21:20:02 volumio-m1s haveged[815]: haveged: fills: 0, generated: 0 Feb 23 21:20:02 volumio-m1s volumio[830]: Could not open config: /tmp/upmpdcli.conf Feb 23 21:20:02 volumio-m1s dbus-daemon[835]: [system] Successfully activated service 'org.freedesktop.systemd1' Feb 23 21:20:02 volumio-m1s avahi-daemon[841]: Successfully called chroot(). Feb 23 21:20:02 volumio-m1s avahi-daemon[841]: Successfully dropped remaining capabilities. Feb 23 21:20:02 volumio-m1s systemd[1]: Started Login Service. Feb 23 21:20:02 volumio-m1s systemd[1]: Started triggerhappy global hotkey daemon. Feb 23 21:20:02 volumio-m1s wpa_supplicant[838]: Successfully initialized wpa_supplicant Feb 23 21:20:02 volumio-m1s systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 21:20:02 volumio-m1s systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 21:20:02 volumio-m1s bluetoothd[833]: Starting SDP server Feb 23 21:20:02 volumio-m1s bluetoothd[833]: Excluding (cli) sap Feb 23 21:20:02 volumio-m1s avahi-daemon[841]: Loading service file /services/volumio.service. Feb 23 21:20:02 volumio-m1s avahi-daemon[841]: Network interface enumeration completed. Feb 23 21:20:02 volumio-m1s avahi-daemon[841]: Server startup complete. Host name is volumio-m1s.local. Local service cookie is 2729637520. Feb 23 21:20:02 volumio-m1s ifup[783]: ifup: waiting for lock on /run/network/ifstate.wlan0 Feb 23 21:20:02 volumio-m1s avahi-daemon[841]: Service "Volumio-m1s" (/services/volumio.service) successfully established. Feb 23 21:20:02 volumio-m1s dhcpcd[836]: no interfaces have a carrier Feb 23 21:20:02 volumio-m1s dhcpcd[836]: no interfaces have a carrier Feb 23 21:20:02 volumio-m1s dhcpcd[836]: forked to background, child pid 921 Feb 23 21:20:02 volumio-m1s dhcpcd[836]: forked to background, child pid 921 Feb 23 21:20:02 volumio-m1s dhcpcd[921]: wlan0: waiting for carrier Feb 23 21:20:02 volumio-m1s sh[782]: wlan0=wlan0 Feb 23 21:20:02 volumio-m1s kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Feb 23 21:20:02 volumio-m1s kernel: Bluetooth: BNEP filters: protocol multicast Feb 23 21:20:02 volumio-m1s kernel: Bluetooth: BNEP socket layer initialized Feb 23 21:20:02 volumio-m1s dbus-daemon[835]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=833 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Feb 23 21:20:02 volumio-m1s bluetoothd[833]: Bluetooth management interface 1.22 initialized Feb 23 21:20:02 volumio-m1s kernel: Bluetooth: MGMT ver 1.22 Feb 23 21:20:02 volumio-m1s systemd[1]: Started DHCP Client Daemon. Feb 23 21:20:02 volumio-m1s systemd[1]: Started Avahi mDNS/DNS-SD Stack. Feb 23 21:20:02 volumio-m1s systemd[1]: Started WPA supplicant. Feb 23 21:20:02 volumio-m1s systemd[1]: Started Bluetooth service. Feb 23 21:20:02 volumio-m1s systemd[1]: Started Raise network interfaces. Feb 23 21:20:02 volumio-m1s systemd[1]: Starting Hostname Service... Feb 23 21:20:02 volumio-m1s systemd[1]: Reached target Bluetooth. Feb 23 21:20:02 volumio-m1s systemd[1]: Reached target Network. Feb 23 21:20:02 volumio-m1s systemd[1]: Reached target Network is Online. Feb 23 21:20:02 volumio-m1s systemd[1]: Starting LSB: Brings up/down network automatically... Feb 23 21:20:02 volumio-m1s systemd[1]: Starting Samba NMB Daemon... Feb 23 21:20:02 volumio-m1s systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Feb 23 21:20:02 volumio-m1s systemd[1]: Starting Network Time Service... Feb 23 21:20:02 volumio-m1s systemd[1]: Starting Permit User Sessions... Feb 23 21:20:02 volumio-m1s systemd[1]: Starting /etc/rc.local Compatibility... Feb 23 21:20:02 volumio-m1s systemd[1]: Starting Daily apt download activities... Feb 23 21:20:02 volumio-m1s systemd[1]: Listening on mpd.socket. Feb 23 21:20:02 volumio-m1s systemd[1]: iptables.service: Succeeded. Feb 23 21:20:02 volumio-m1s systemd[1]: Started Permit User Sessions. Feb 23 21:20:02 volumio-m1s systemd[1]: Started /etc/rc.local Compatibility. Feb 23 21:20:02 volumio-m1s systemd[1]: Starting Hold until boot process finishes up... Feb 23 21:20:02 volumio-m1s systemd[1]: Starting Terminate Plymouth Boot Screen... Feb 23 21:20:02 volumio-m1s systemd[1]: Started Save/Restore Sound Card State. Feb 23 21:20:02 volumio-m1s systemd[1]: Received SIGRTMIN+21 from PID 396 (plymouthd). Feb 23 21:20:02 volumio-m1s systemd[1]: Reached target Sound Card. Feb 23 21:20:02 volumio-m1s systemd[1]: Starting Music Player Daemon... Feb 23 21:20:02 volumio-m1s systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 21:20:02 volumio-m1s systemd[1]: plymouth-quit-wait.service: Succeeded. Feb 23 21:20:02 volumio-m1s systemd[1]: Started Hold until boot process finishes up. Feb 23 21:20:02 volumio-m1s systemd[1]: plymouth-quit.service: Succeeded. Feb 23 21:20:02 volumio-m1s systemd[1]: Started Terminate Plymouth Boot Screen. Feb 23 21:20:02 volumio-m1s systemd[1]: Received SIGRTMIN+21 from PID 396 (n/a). Feb 23 21:20:02 volumio-m1s systemd[1]: Started Getty on tty1. Feb 23 21:20:02 volumio-m1s systemd[1]: Reached target Login Prompts. Feb 23 21:20:02 volumio-m1s loadcpufreq[853]: Loading cpufreq kernel modules...done (acpi-cpufreq). Feb 23 21:20:02 volumio-m1s systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Feb 23 21:20:02 volumio-m1s ifplugd[959]: Network Interface Plugging Daemon...skip eth0...done. Feb 23 21:20:02 volumio-m1s systemd[1]: Starting LSB: set CPUFreq kernel parameters... Feb 23 21:20:02 volumio-m1s systemd[1]: Started LSB: Brings up/down network automatically. Feb 23 21:20:02 volumio-m1s dbus-daemon[835]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 23 21:20:02 volumio-m1s systemd[1]: Started Hostname Service. Feb 23 21:20:02 volumio-m1s ntpd[966]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 23 21:20:02 volumio-m1s ntpd[966]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 23 21:20:02 volumio-m1s systemd[1]: Started Network Time Service. Feb 23 21:20:02 volumio-m1s ntpd[1015]: proto: precision = 0.250 usec (-22) Feb 23 21:20:02 volumio-m1s cpufrequtils[1010]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Feb 23 21:20:02 volumio-m1s systemd[1]: Started LSB: set CPUFreq kernel parameters. Feb 23 21:20:02 volumio-m1s ntpd[1015]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 23 21:20:02 volumio-m1s ntpd[1015]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 23 21:20:02 volumio-m1s ntpd[1015]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 789 days ago Feb 23 21:20:02 volumio-m1s ntpd[1015]: Listen and drop on 0 v6wildcard [::]:123 Feb 23 21:20:02 volumio-m1s ntpd[1015]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 23 21:20:02 volumio-m1s ntpd[1015]: Listen normally on 2 lo 127.0.0.1:123 Feb 23 21:20:02 volumio-m1s ntpd[1015]: Listening on routing socket on fd #19 for interface updates Feb 23 21:20:02 volumio-m1s ntpd[1015]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 21:20:02 volumio-m1s ntpd[1015]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 21:20:03 volumio-m1s sudo[999]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 21:20:03 volumio-m1s sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:03 volumio-m1s sudo[999]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 23 21:20:03 volumio-m1s sudo[999]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:03 volumio-m1s ntpd[1015]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 23 21:20:03 volumio-m1s nmbd[978]: [2025/02/23 21:20:03.924306, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Feb 23 21:20:03 volumio-m1s nmbd[978]: started asyncdns process 1071 Feb 23 21:20:03 volumio-m1s nmbd[978]: [2025/02/23 21:20:03.928912, 0] ../lib/util/become_daemon.c:149(daemon_status) Feb 23 21:20:03 volumio-m1s nmbd[978]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Feb 23 21:20:03 volumio-m1s nmbd[978]: [2025/02/23 21:20:03.929110, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Feb 23 21:20:03 volumio-m1s nmbd[978]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Feb 23 21:20:03 volumio-m1s wireless.js[837]: Cleaning previous... Feb 23 21:20:04 volumio-m1s systemd[1]: apt-daily.service: Succeeded. Feb 23 21:20:04 volumio-m1s systemd[1]: Started Daily apt download activities. Feb 23 21:20:04 volumio-m1s sudo[1081]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 23 21:20:04 volumio-m1s sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:04 volumio-m1s sudo[1081]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:04 volumio-m1s sudo[1083]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 23 21:20:04 volumio-m1s sudo[1083]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:04 volumio-m1s sudo[1083]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:04 volumio-m1s wireless.js[837]: Stopped aP Feb 23 21:20:04 volumio-m1s sudo[1090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 23 21:20:04 volumio-m1s sudo[1090]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:04 volumio-m1s kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Feb 23 21:20:04 volumio-m1s kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Feb 23 21:20:04 volumio-m1s kernel: iwlwifi 0000:01:00.0: FW already configured (0) - re-configuring Feb 23 21:20:04 volumio-m1s sudo[1090]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:04 volumio-m1s sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Feb 23 21:20:04 volumio-m1s sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:04 volumio-m1s sudo[1092]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:04 volumio-m1s sudo[1099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 23 21:20:04 volumio-m1s sudo[1099]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:04 volumio-m1s sudo[1099]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:04 volumio-m1s sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Feb 23 21:20:04 volumio-m1s sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:04 volumio-m1s ntpd[1015]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 23 21:20:05 volumio-m1s mpd[1029]: Feb 23 21:20 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 21:20:05 volumio-m1s systemd[1]: Started Music Player Daemon. Feb 23 21:20:05 volumio-m1s mpd_monitor.sh[834]: MPD restarted due to no mpc output. Feb 23 21:20:05 volumio-m1s ntpd[1015]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 23 21:20:06 volumio-m1s systemd[1]: systemd-rfkill.service: Succeeded. Feb 23 21:20:06 volumio-m1s ntpd[1015]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 23 21:20:07 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:07] [info] asio async_connect error: system:111 (Connection refused) Feb 23 21:20:07 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 23 21:20:07 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:07] [error] handle_connect error: Underlying Transport Error Feb 23 21:20:07 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Fetching time from Volumio... Feb 23 21:20:07 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Date not found in response Feb 23 21:20:07 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 21:20:08 volumio-m1s sudo[1101]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:08 volumio-m1s wireless.js[837]: SETTING APPROPRIATE REG DOMAIN: CN Feb 23 21:20:08 volumio-m1s sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 23 21:20:08 volumio-m1s sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:08 volumio-m1s sudo[1114]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:08 volumio-m1s sudo[1116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CN Feb 23 21:20:08 volumio-m1s sudo[1116]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:08 volumio-m1s sudo[1116]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:08 volumio-m1s wireless.js[837]: SUCCESSFULLY SET NEW REGDOMAIN: CN Feb 23 21:20:08 volumio-m1s wireless.js[837]: Start wireless flow Feb 23 21:20:08 volumio-m1s wireless.js[837]: Stopped hotspot (if there).. Feb 23 21:20:08 volumio-m1s sudo[1121]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 23 21:20:08 volumio-m1s sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:08 volumio-m1s sudo[1121]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:08 volumio-m1s sudo[1123]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 23 21:20:08 volumio-m1s sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:08 volumio-m1s sudo[1123]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:08 volumio-m1s wireless.js[837]: DHCP IP Feb 23 21:20:08 volumio-m1s wireless.js[837]: Start ap Feb 23 21:20:08 volumio-m1s wpa_supplicant[1125]: Successfully initialized wpa_supplicant Feb 23 21:20:08 volumio-m1s sudo[1126]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Feb 23 21:20:08 volumio-m1s sudo[1126]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:08 volumio-m1s dhcpcd[1127]: sending commands to master dhcpcd process Feb 23 21:20:08 volumio-m1s dhcpcd[921]: control command: /sbin/dhcpcd Feb 23 21:20:08 volumio-m1s sudo[1126]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:08 volumio-m1s kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Feb 23 21:20:08 volumio-m1s kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Feb 23 21:20:08 volumio-m1s kernel: iwlwifi 0000:01:00.0: FW already configured (0) - re-configuring Feb 23 21:20:08 volumio-m1s wpa_supplicant[1130]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=WORLD Feb 23 21:20:09 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:09 volumio-m1s sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:09 volumio-m1s sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:09 volumio-m1s sudo[1132]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:10 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:10 volumio-m1s sudo[1135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:10 volumio-m1s sudo[1135]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:10 volumio-m1s sudo[1135]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:11 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:11 volumio-m1s sudo[1138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:11 volumio-m1s sudo[1138]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:11 volumio-m1s sudo[1138]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:12 volumio-m1s wpa_supplicant[1130]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=COUNTRY alpha2=CN Feb 23 21:20:12 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Fetching time from Volumio... Feb 23 21:20:12 volumio-m1s wpa_supplicant[1130]: wlan0: SME: Trying to authenticate with a2:78:19:c3:f0:59 (SSID='hn-12-2-502' freq=5220 MHz) Feb 23 21:20:12 volumio-m1s kernel: wlan0: authenticate with a2:78:19:c3:f0:59 Feb 23 21:20:12 volumio-m1s kernel: wlan0: send auth to a2:78:19:c3:f0:59 (try 1/3) Feb 23 21:20:12 volumio-m1s wpa_supplicant[1130]: wlan0: Trying to associate with a2:78:19:c3:f0:59 (SSID='hn-12-2-502' freq=5220 MHz) Feb 23 21:20:12 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Date not found in response Feb 23 21:20:12 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 21:20:12 volumio-m1s kernel: wlan0: authenticated Feb 23 21:20:12 volumio-m1s kernel: wlan0: associate with a2:78:19:c3:f0:59 (try 1/3) Feb 23 21:20:12 volumio-m1s kernel: wlan0: RX AssocResp from a2:78:19:c3:f0:59 (capab=0x1511 status=0 aid=1) Feb 23 21:20:12 volumio-m1s wpa_supplicant[1130]: wlan0: Associated with a2:78:19:c3:f0:59 Feb 23 21:20:12 volumio-m1s wpa_supplicant[1130]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Feb 23 21:20:12 volumio-m1s kernel: wlan0: associated Feb 23 21:20:12 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:12 volumio-m1s sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:12 volumio-m1s sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:12 volumio-m1s sudo[1149]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:12 volumio-m1s wpa_supplicant[1130]: wlan0: WPA: Key negotiation completed with a2:78:19:c3:f0:59 [PTK=CCMP GTK=CCMP] Feb 23 21:20:12 volumio-m1s wpa_supplicant[1130]: wlan0: CTRL-EVENT-CONNECTED - Connection to a2:78:19:c3:f0:59 completed [id=0 id_str=] Feb 23 21:20:12 volumio-m1s dhcpcd[921]: wlan0: carrier acquired Feb 23 21:20:12 volumio-m1s dhcpcd[921]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09 Feb 23 21:20:12 volumio-m1s dhcpcd[921]: wlan0: IAID 67:79:05:45 Feb 23 21:20:12 volumio-m1s dhcpcd[921]: wlan0: adding address fe80::5e5f:67ff:fe79:545 Feb 23 21:20:12 volumio-m1s dhcpcd[921]: ipv6_addaddr1: Permission denied Feb 23 21:20:12 volumio-m1s dhcpcd[921]: wlan0: probing address 192.168.3.109/24 Feb 23 21:20:12 volumio-m1s dhcpcd[921]: wlan0: soliciting an IPv6 router Feb 23 21:20:13 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:13 volumio-m1s sudo[1165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:13 volumio-m1s sudo[1165]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:13 volumio-m1s sudo[1165]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:14 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:14 volumio-m1s sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:14 volumio-m1s sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:14 volumio-m1s sudo[1168]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:14 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:14] [info] asio async_connect error: system:111 (Connection refused) Feb 23 21:20:14 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:14] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 23 21:20:14 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:14] [error] handle_connect error: Underlying Transport Error Feb 23 21:20:15 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:15 volumio-m1s sudo[1171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:15 volumio-m1s sudo[1171]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:15 volumio-m1s sudo[1171]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:16 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:16 volumio-m1s sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:16 volumio-m1s sudo[1177]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:16 volumio-m1s sudo[1177]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:17 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Fetching time from Volumio... Feb 23 21:20:17 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Date not found in response Feb 23 21:20:17 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 21:20:17 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:17 volumio-m1s sudo[1185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:17 volumio-m1s sudo[1185]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:17 volumio-m1s sudo[1185]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:17 volumio-m1s dhcpcd[921]: wlan0: using static address 192.168.3.109/24 Feb 23 21:20:17 volumio-m1s avahi-daemon[841]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.109. Feb 23 21:20:17 volumio-m1s dhcpcd[921]: wlan0: adding route to 192.168.3.0/24 Feb 23 21:20:17 volumio-m1s avahi-daemon[841]: New relevant interface wlan0.IPv4 for mDNS. Feb 23 21:20:17 volumio-m1s avahi-daemon[841]: Registering new address record for 192.168.3.109 on wlan0.IPv4. Feb 23 21:20:17 volumio-m1s dhcpcd[921]: wlan0: adding default route via 192.168.3.1 Feb 23 21:20:18 volumio-m1s wireless.js[837]: trying... Feb 23 21:20:18 volumio-m1s sudo[1206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 21:20:18 volumio-m1s sudo[1206]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:18 volumio-m1s sudo[1206]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:18 volumio-m1s wireless.js[837]: Connected to: ----hn-12-2-502 Feb 23 21:20:18 volumio-m1s wireless.js[837]: ---- Feb 23 21:20:18 volumio-m1s sudo[1209]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 21:20:18 volumio-m1s sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:18 volumio-m1s sudo[1209]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:18 volumio-m1s wireless.js[837]: ... joined AP, wlan0 IPv4 is 192.168.3.109, ipV6 is undefined Feb 23 21:20:18 volumio-m1s wireless.js[837]: It's done! AP Feb 23 21:20:18 volumio-m1s systemd[1]: Started Wireless Services. Feb 23 21:20:18 volumio-m1s systemd[1]: Started Volumio Backend Module. Feb 23 21:20:18 volumio-m1s systemd[1]: Started Start Volumio Kiosk. Feb 23 21:20:18 volumio-m1s systemd[1]: Started Intel SST and HDA soundcard init service. Feb 23 21:20:18 volumio-m1s systemd[1]: Started Volumio Cpu Tweaker. Feb 23 21:20:18 volumio-m1s volumio-cpu-tweak[1217]: Setting RT Priority for mpd Feb 23 21:20:18 volumio-m1s volumio-cpu-tweak[1217]: Setting MPD Affinity Feb 23 21:20:18 volumio-m1s volumio-cpu-tweak[1217]: pid 1029's current affinity mask: f Feb 23 21:20:18 volumio-m1s volumio-cpu-tweak[1217]: pid 1029's new affinity mask: 3 Feb 23 21:20:18 volumio-m1s volumio-cpu-tweak[1217]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Feb 23 21:20:18 volumio-m1s systemd[1]: volumio_cpu_tweak.service: Succeeded. Feb 23 21:20:18 volumio-m1s startx[1215]: X.Org X Server 1.20.4 Feb 23 21:20:18 volumio-m1s startx[1215]: X Protocol Version 11, Revision 0 Feb 23 21:20:18 volumio-m1s startx[1215]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Feb 23 21:20:18 volumio-m1s startx[1215]: Current Operating System: Linux volumio-m1s 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Feb 23 21:20:18 volumio-m1s startx[1215]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=6b49b1d4-521e-4f98-9082-17e920062cc1 bootpart=UUID=058F-31E9 datapart=UUID=f081f14b-932f-46cd-8716-b7715f76101e 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 Feb 23 21:20:18 volumio-m1s startx[1215]: Build Date: 18 December 2021 09:05:36AM Feb 23 21:20:18 volumio-m1s startx[1215]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Feb 23 21:20:18 volumio-m1s startx[1215]: Current version of pixman: 0.36.0 Feb 23 21:20:18 volumio-m1s startx[1215]: Before reporting problems, check http://wiki.x.org Feb 23 21:20:18 volumio-m1s startx[1215]: to make sure that you have the latest version. Feb 23 21:20:18 volumio-m1s startx[1215]: Markers: (--) probed, (**) from config file, (==) default setting, Feb 23 21:20:18 volumio-m1s startx[1215]: (++) from command line, (!!) notice, (II) informational, Feb 23 21:20:18 volumio-m1s startx[1215]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Feb 23 21:20:18 volumio-m1s startx[1215]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Feb 23 21:20:18 2025 Feb 23 21:20:18 volumio-m1s startx[1215]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Feb 23 21:20:18 volumio-m1s ntpd[1015]: Listen normally on 3 wlan0 192.168.3.109:123 Feb 23 21:20:18 volumio-m1s ntpd[1015]: new interface(s) found: waking up resolver Feb 23 21:20:18 volumio-m1s nmbd[978]: [2025/02/23 21:20:18.936587, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 23 21:20:18 volumio-m1s nmbd[978]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 23 21:20:18 volumio-m1s systemd[1]: Started Samba NMB Daemon. Feb 23 21:20:18 volumio-m1s systemd[1]: Starting Samba Winbind Daemon... Feb 23 21:20:19 volumio-m1s winbindd[1280]: [2025/02/23 21:20:19.304628, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 23 21:20:19 volumio-m1s winbindd[1280]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 23 21:20:19 volumio-m1s winbindd[1280]: [2025/02/23 21:20:19.320657, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 23 21:20:19 volumio-m1s winbindd[1280]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 23 21:20:19 volumio-m1s systemd[1]: Started Samba Winbind Daemon. Feb 23 21:20:19 volumio-m1s systemd[1]: Starting Samba SMB Daemon... Feb 23 21:20:19 volumio-m1s kernel: broken atomic modeset userspace detected, disabling atomic Feb 23 21:20:19 volumio-m1s smbd[1319]: [2025/02/23 21:20:19.831801, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 23 21:20:19 volumio-m1s smbd[1319]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 23 21:20:19 volumio-m1s systemd[1]: Started Samba SMB Daemon. Feb 23 21:20:19 volumio-m1s systemd[1]: soundcard-init.service: Succeeded. Feb 23 21:20:20 volumio-m1s startx[1215]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Feb 23 21:20:21 volumio-m1s volumio[1214]: info: ------------------------------------------- Feb 23 21:20:21 volumio-m1s volumio[1214]: info: ----- Volumio3 ---- Feb 23 21:20:21 volumio-m1s volumio[1214]: info: ------------------------------------------- Feb 23 21:20:21 volumio-m1s volumio[1214]: info: ----- System startup ---- Feb 23 21:20:21 volumio-m1s volumio[1214]: info: ------------------------------------------- Feb 23 21:20:22 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Fetching time from Volumio... Feb 23 21:20:23 volumio-m1s volumio[1214]: info: MYVOLUMIO Environment detected Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Plugin folders cleanup Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Scanning into folder /volumio/app/plugins/ Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Scanning category audio_interface Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Scanning category miscellanea Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Scanning category music_service Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Scanning category plugins.json Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Scanning category system_controller Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Scanning category user_interface Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Scanning into folder /data/plugins/ Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Plugin folders cleanup completed Feb 23 21:20:23 volumio-m1s volumio[1214]: info: ------------------------------------------- Feb 23 21:20:23 volumio-m1s volumio[1214]: info: ----- Core plugins startup ---- Feb 23 21:20:23 volumio-m1s volumio[1214]: info: ------------------------------------------- Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Loading plugins from folder /volumio/app/plugins/ Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Adding plugin upnp to MyMusic Plugins Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Loading plugins from folder /data/plugins/ Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Loading plugin "system"... Feb 23 21:20:23 volumio-m1s volumio[1214]: info: Loading plugin "appearance"... Feb 23 21:20:23 volumio-m1s volumio-time-update[840]: volumio-time-update-util: Setting system time to: 2025-02-23 21:20:23 Feb 23 21:20:24 volumio-m1s sudo[1460]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-02-23 21:20:23 Feb 23 21:20:24 volumio-m1s sudo[1460]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:24 volumio-m1s dbus-daemon[835]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.9' (uid=0 pid=1461 comm="timedatectl set-time 2025-02-23 21:20:23 ") Feb 23 21:20:24 volumio-m1s systemd[1]: Starting Time & Date Service... Feb 23 21:20:24 volumio-m1s dbus-daemon[835]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 23 21:20:24 volumio-m1s systemd[1]: Started Time & Date Service. Feb 23 21:20:23 volumio-m1s systemd-timedated[1462]: Changed local time to Sun Feb 23 21:20:23 2025 Feb 23 21:20:23 volumio-m1s sudo[1460]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:23 volumio-m1s volumio-time-update[840]: volumio-time-update-util: System time updated successfully. Feb 23 21:20:23 volumio-m1s systemd[1]: Started Volumio Time Update Utility. Feb 23 21:20:23 volumio-m1s systemd[1]: Reached target Multi-User System. Feb 23 21:20:23 volumio-m1s systemd[1]: Reached target Graphical Interface. Feb 23 21:20:23 volumio-m1s systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 23 21:20:23 volumio-m1s systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 23 21:20:23 volumio-m1s systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 23 21:20:23 volumio-m1s systemd[1]: Startup finished in 4.339s (firmware) + 8.500s (loader) + 11.780s (kernel) + 26.737s (userspace) = 51.358s. Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Loading plugin "network"... Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Refreshing Cached IP Addresses Feb 23 21:20:24 volumio-m1s sudo[1491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 21:20:24 volumio-m1s sudo[1491]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:24 volumio-m1s sudo[1493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 21:20:24 volumio-m1s sudo[1493]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:24 volumio-m1s sudo[1491]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:24 volumio-m1s sudo[1493]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Loading plugin "services"... Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Loading plugin "alsa_controller"... Feb 23 21:20:24 volumio-m1s sudo[1505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 23 21:20:24 volumio-m1s sudo[1505]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:24 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Loading plugin "wizard"... Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Loading plugin "networkfs"... Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Starting Udev Watcher for removable devices Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Ignoring mount for partition: boot Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Ignoring mount for partition: volumio Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Ignoring mount for partition: volumio_data Feb 23 21:20:24 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Loading plugin "volumio_command_line_client"... Feb 23 21:20:24 volumio-m1s sudo[1539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=administrator,password=2218chb,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.15/share\media_rw\sda1 /mnt/NAS/音乐库 Feb 23 21:20:24 volumio-m1s sudo[1539]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Loading plugin "upnp"... Feb 23 21:20:24 volumio-m1s volumio[1214]: info: [1740316824558] Starting Upmpd Daemon Feb 23 21:20:24 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Loading plugin "my_music"... Feb 23 21:20:24 volumio-m1s volumio[1214]: info: Loading plugin "mpd"... Feb 23 21:20:24 volumio-m1s kernel: FS-Cache: Loaded Feb 23 21:20:24 volumio-m1s kernel: Key type dns_resolver registered Feb 23 21:20:24 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:24] [connect] Successful connection Feb 23 21:20:24 volumio-m1s kernel: Key type cifs.spnego registered Feb 23 21:20:24 volumio-m1s kernel: Key type cifs.idmap registered Feb 23 21:20:24 volumio-m1s kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Feb 23 21:20:24 volumio-m1s kernel: CIFS: Attempting to mount //192.168.3.15/share/media_rw/sda1 Feb 23 21:20:25 volumio-m1s volumio[1214]: info: Loading plugin "upnp_browser"... Feb 23 21:20:25 volumio-m1s volumio[1214]: info: Loading plugin "alarm-clock"... Feb 23 21:20:25 volumio-m1s volumio[1214]: info: Loading plugin "airplay_emulation"... Feb 23 21:20:25 volumio-m1s volumio[1214]: info: Starting Shairport Sync Feb 23 21:20:25 volumio-m1s volumio[1214]: info: Loading plugin "last_100"... Feb 23 21:20:25 volumio-m1s volumio[1214]: info: Loading plugin "webradio"... Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Loading plugin "i2s_dacs"... Feb 23 21:20:26 volumio-m1s volumio[1214]: info: I2S DAC not set, start Auto-detection Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Loading plugin "volumiodiscovery"... Feb 23 21:20:26 volumio-m1s volumio[1214]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 21:20:26 volumio-m1s volumio[1214]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 21:20:26 volumio-m1s volumio[1214]: *** WARNING *** For more information see Feb 23 21:20:26 volumio-m1s node[1214]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 21:20:26 volumio-m1s volumio[1214]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 21:20:26 volumio-m1s volumio[1214]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 21:20:26 volumio-m1s volumio[1214]: *** WARNING *** For more information see Feb 23 21:20:26 volumio-m1s node[1214]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 21:20:26 volumio-m1s node[1214]: *** WARNING *** For more information see Feb 23 21:20:26 volumio-m1s node[1214]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 21:20:26 volumio-m1s node[1214]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 21:20:26 volumio-m1s node[1214]: *** WARNING *** For more information see Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Discovery: Started advertising with name: Volumio-m1s Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Loading plugin "outputs"... Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Loading plugin "albumart"... Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Plugin example_plugin is not enabled Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Loading plugin "inputs"... Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Loading plugin "updater_comm"... Feb 23 21:20:26 volumio-m1s volumio[1214]: Forking 3 albumart workers Feb 23 21:20:26 volumio-m1s sudo[1505]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Plugin mpdemulation is not enabled Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Loading plugin "rest_api"... Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Loading plugin "websocket"... Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Starting Socket.io Server version 2.3.0 Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Loading i18n strings for locale en Feb 23 21:20:26 volumio-m1s volumio[1214]: Updating browse sources language Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::initPlayerControls Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 21:20:26 volumio-m1s volumio[1214]: Starting albumart workers Feb 23 21:20:26 volumio-m1s volumio[1214]: Express server listening on port 3000 Feb 23 21:20:26 volumio-m1s volumio[1214]: [Metrics] WebUI: 7s 821.92ms Feb 23 21:20:26 volumio-m1s volumio[1214]: Starting albumart workers Feb 23 21:20:26 volumio-m1s volumio[1214]: info: Setting Device type: x86 Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreStateMachine::resetVolumioState Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreStateMachine::getcurrentVolume Feb 23 21:20:26 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreStateMachine::pushState Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioPushState Feb 23 21:20:27 volumio-m1s volumio[1214]: Starting albumart workers Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:27 volumio-m1s volumio[1214]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Completed loading Core Plugins Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Preparing to generate the ALSA configuration file Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Volumio Network Manager: Network status updated: 2 Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Feb 23 21:20:27 volumio-m1s volumio-remote-updater[829]: [2025-02-23 21:20:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1740316824 101 Feb 23 21:20:27 volumio-m1s volumio[1214]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Reloading queue from file Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Asound.conf file unchanged, so no further update is needed Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Output device has changed, restarting MPD Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Output device has changed, restarting Shairport Sync Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:27 volumio-m1s sudo[1633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 21:20:27 volumio-m1s sudo[1633]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:27 volumio-m1s sudo[1633]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:27 volumio-m1s sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 21:20:27 volumio-m1s sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:27 volumio-m1s systemd[1]: Stopping Music Player Daemon... Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 21:20:27 volumio-m1s volumio[1214]: info: ___________ START PLUGINS ___________ Feb 23 21:20:27 volumio-m1s volumio[1214]: info: ControllerMpd::onStart: Initializing MPD Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Creating MPD Configuration file Feb 23 21:20:27 volumio-m1s systemd[1]: mpd.service: Succeeded. Feb 23 21:20:27 volumio-m1s systemd[1]: Stopped Music Player Daemon. Feb 23 21:20:27 volumio-m1s systemd[1]: Starting Music Player Daemon... Feb 23 21:20:27 volumio-m1s sudo[1664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 21:20:27 volumio-m1s sudo[1664]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:27 volumio-m1s sudo[1664]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 21:20:27 volumio-m1s volumio[1214]: info: [1740316827733] CoreMusicLibrary::Adding element Media Servers Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 21:20:27 volumio-m1s sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 21:20:27 volumio-m1s sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:27 volumio-m1s sudo[1646]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 21:20:27 volumio-m1s sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:27 volumio-m1s sudo[1646]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:27 volumio-m1s systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 23 21:20:27 volumio-m1s systemd[1]: mpd.service: Succeeded. Feb 23 21:20:27 volumio-m1s systemd[1]: Stopped Music Player Daemon. Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:27 volumio-m1s systemd[1]: Starting Music Player Daemon... Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:27 volumio-m1s sudo[1673]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 21:20:27 volumio-m1s sudo[1673]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 21:20:27 volumio-m1s volumio[1214]: info: [1740316827874] CoreMusicLibrary::Adding element Last_100 Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 21:20:27 volumio-m1s volumio[1214]: info: [1740316827877] CoreMusicLibrary::Adding element Webradio Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 21:20:27 volumio-m1s sudo[1673]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Initializing BBC Radios Feb 23 21:20:27 volumio-m1s volumio[1214]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 21:20:27 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:27 volumio-m1s volumio[1214]: info: Volumio Calling Home Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreStateMachine::setRepeat false single undefined Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreStateMachine::pushState Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioPushState Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreStateMachine::setRandom null Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreStateMachine::pushState Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioPushState Feb 23 21:20:28 volumio-m1s volumio[1214]: info: MPD Permissions set Feb 23 21:20:28 volumio-m1s volumio[1214]: info: MPD Permissions set Feb 23 21:20:28 volumio-m1s volumio[1214]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 23 21:20:28 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:20:28 volumio-m1s volumio[1214]: info: Starting Shairport Sync Feb 23 21:20:28 volumio-m1s volumio[1214]: info: Starting Shairport Sync Feb 23 21:20:28 volumio-m1s sudo[1708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 21:20:28 volumio-m1s sudo[1708]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:28 volumio-m1s volumio[1214]: info: Starting Shairport Sync Feb 23 21:20:28 volumio-m1s systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 21:20:28 volumio-m1s systemd[1]: shairport-sync.service: Succeeded. Feb 23 21:20:28 volumio-m1s systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 21:20:28 volumio-m1s sudo[1710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 21:20:28 volumio-m1s sudo[1710]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:28 volumio-m1s systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 21:20:28 volumio-m1s sudo[1713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 21:20:28 volumio-m1s sudo[1713]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:28 volumio-m1s sudo[1708]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:28 volumio-m1s volumio[1214]: info: Shairport-Sync Started Feb 23 21:20:28 volumio-m1s volumio[1214]: Error adding Membership: Error: addMembership EINVAL Feb 23 21:20:28 volumio-m1s systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 21:20:28 volumio-m1s systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 23 21:20:28 volumio-m1s systemd[1]: shairport-sync.service: Succeeded. Feb 23 21:20:28 volumio-m1s systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 21:20:28 volumio-m1s systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 21:20:28 volumio-m1s sudo[1710]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:28 volumio-m1s sudo[1713]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:28 volumio-m1s volumio[1214]: info: Shairport-Sync Started Feb 23 21:20:28 volumio-m1s volumio[1214]: info: Shairport-Sync Started Feb 23 21:20:28 volumio-m1s mpd[1681]: Feb 23 21:20 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 21:20:28 volumio-m1s systemd[1]: Started Music Player Daemon. Feb 23 21:20:28 volumio-m1s sudo[1635]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:28 volumio-m1s sudo[1670]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:29 volumio-m1s volumio[1214]: info: Completed starting Core Plugins Feb 23 21:20:29 volumio-m1s volumio[1214]: info: ------------------------------------------- Feb 23 21:20:29 volumio-m1s volumio[1214]: info: ----- MyVolumio plugins startup ---- Feb 23 21:20:29 volumio-m1s volumio[1214]: info: ------------------------------------------- Feb 23 21:20:29 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 23 21:20:29 volumio-m1s volumio[1214]: info: Discovery: adding 495178c8-b36c-45c5-baf5-a467826b8dd0 Feb 23 21:20:29 volumio-m1s volumio[1214]: info: Discovery: Found device Volumio-m1s Feb 23 21:20:29 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:29 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:29 volumio-m1s volumio[1214]: info: MPD running with PID1681 Feb 23 21:20:29 volumio-m1s volumio[1214]: ,establishing connection Feb 23 21:20:29 volumio-m1s volumio[1214]: error: MPD error: The expression evaluated to a falsy value: Feb 23 21:20:29 volumio-m1s volumio[1214]: assert.ok(self.idling) Feb 23 21:20:29 volumio-m1s volumio[1214]: error: The expression evaluated to a falsy value: Feb 23 21:20:29 volumio-m1s volumio[1214]: assert.ok(self.idling) Feb 23 21:20:29 volumio-m1s volumio[1214]: error: MPD error: The expression evaluated to a falsy value: Feb 23 21:20:29 volumio-m1s volumio[1214]: assert.ok(self.idling) Feb 23 21:20:29 volumio-m1s volumio[1214]: error: The expression evaluated to a falsy value: Feb 23 21:20:29 volumio-m1s volumio[1214]: assert.ok(self.idling) Feb 23 21:20:29 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:29 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:29 volumio-m1s volumio[1214]: error: updateQueue error: null Feb 23 21:20:29 volumio-m1s volumio[1214]: info: Volumio called home Feb 23 21:20:30 volumio-m1s systemd[1]: systemd-fsckd.service: Succeeded. Feb 23 21:20:30 volumio-m1s volumio[1214]: 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 Feb 23 21:20:30 volumio-m1s sudo[1539]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:30 volumio-m1s kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 23 21:20:30 volumio-m1s kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Feb 23 21:20:30 volumio-m1s volumio[1214]: info: Cannot mount NAS 音乐库 at system boot, trial number 1 ,retrying in 5 seconds Feb 23 21:20:31 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 21:20:31 volumio-m1s systemd[1]: systemd-hostnamed.service: Succeeded. Feb 23 21:20:31 volumio-m1s volumio[1214]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 21:20:32 volumio-m1s volumio[1214]: info: Received Get System Info Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 21:20:32 volumio-m1s volumio[1214]: info: Discovery: Getting this device information Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:32 volumio-m1s volumio[1214]: info: Listing playlists Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 23 21:20:32 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 21:20:33 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:33 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:33 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 21:20:33 volumio-m1s volumio[1214]: info: Received Get System Info Feb 23 21:20:33 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 21:20:33 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 21:20:33 volumio-m1s volumio[1214]: info: Discovery: Getting this device information Feb 23 21:20:33 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:33 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:33 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 21:20:34 volumio-m1s volumio[1214]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 23 21:20:34 volumio-m1s sudo[1743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 21:20:34 volumio-m1s sudo[1743]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:34 volumio-m1s sudo[1745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 21:20:34 volumio-m1s sudo[1745]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:34 volumio-m1s sudo[1743]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:34 volumio-m1s sudo[1745]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:34 volumio-m1s sudo[1752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 23 21:20:34 volumio-m1s sudo[1752]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:34 volumio-m1s systemd[1]: Started UPnP Renderer front-end to MPD. Feb 23 21:20:34 volumio-m1s sudo[1752]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:34 volumio-m1s volumio[1214]: info: Upmpdcli Daemon Started Feb 23 21:20:34 volumio-m1s volumio[1756]: Generating RSA private key, 4096 bit long modulus (2 primes) Feb 23 21:20:35 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 23 21:20:35 volumio-m1s sudo[1849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=administrator,password=2218chb,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.15/share\media_rw\sda1 /mnt/NAS/音乐库 Feb 23 21:20:35 volumio-m1s sudo[1849]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:36 volumio-m1s kernel: CIFS: Attempting to mount //192.168.3.15/share/media_rw/sda1 Feb 23 21:20:38 volumio-m1s volumio[1756]: .......................................................................................................................................................++++ Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 23 21:20:39 volumio-m1s volumio[1214]: info: Adding plugin bluetooth to MyMusic Plugins Feb 23 21:20:39 volumio-m1s volumio[1214]: info: Adding plugin multiroom to MyMusic Plugins Feb 23 21:20:39 volumio-m1s volumio[1214]: info: Adding plugin metavolumio to MyMusic Plugins Feb 23 21:20:39 volumio-m1s volumio[1214]: info: Adding plugin cd_controller to MyMusic Plugins Feb 23 21:20:39 volumio-m1s volumio[1214]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 23 21:20:39 volumio-m1s volumio[1214]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 23 21:20:39 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 23 21:20:40 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 23 21:20:40 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 23 21:20:40 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:40 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:40 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:40 volumio-m1s volumio[1214]: info: Starting MyVolumio Remote Streaming Endpoints Feb 23 21:20:40 volumio-m1s volumio[1214]: info: MyVolumio not started Feb 23 21:20:40 volumio-m1s volumio[1214]: info: Initializing device activation check Feb 23 21:20:40 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:40 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 23 21:20:40 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 23 21:20:41 volumio-m1s volumio[1214]: info: Starting Streaming Service Transparent Proxy Feb 23 21:20:41 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 23 21:20:41 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 23 21:20:41 volumio-m1s volumio[1214]: info: Streaming services startup Feb 23 21:20:41 volumio-m1s volumio[1214]: info: Starting Streaming Daemon Feb 23 21:20:41 volumio-m1s sudo[1961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 23 21:20:41 volumio-m1s sudo[1961]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:41 volumio-m1s sudo[1961]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:41 volumio-m1s volumio[1214]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 23 21:20:41 volumio-m1s volumio[1214]: error: Cannot start Volumio Streaming Daemon Feb 23 21:20:41 volumio-m1s volumio[1214]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 23 21:20:41 volumio-m1s volumio[1214]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 23 21:20:41 volumio-m1s volumio[1756]: ...........................................................................................................++++ Feb 23 21:20:41 volumio-m1s volumio[1756]: e is 65537 (0x010001) Feb 23 21:20:41 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 23 21:20:41 volumio-m1s volumio[1756]: writing RSA key Feb 23 21:20:42 volumio-m1s sudo[1849]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:42 volumio-m1s kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 23 21:20:42 volumio-m1s kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Feb 23 21:20:42 volumio-m1s volumio[1214]: info: Cannot mount NAS 音乐库 at system boot, trial number 2 ,retrying in 5 seconds Feb 23 21:20:42 volumio-m1s volumio[1214]: STREAMING PROXY: Starting server on port 3245 Feb 23 21:20:42 volumio-m1s volumio[1214]: Node JS runtime: 14 Feb 23 21:20:47 volumio-m1s sudo[2003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=administrator,password=2218chb,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.15/share\media_rw\sda1 /mnt/NAS/音乐库 Feb 23 21:20:47 volumio-m1s sudo[2003]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:47 volumio-m1s kernel: CIFS: Attempting to mount //192.168.3.15/share/media_rw/sda1 Feb 23 21:20:53 volumio-m1s systemd[1]: systemd-timedated.service: Succeeded. Feb 23 21:20:53 volumio-m1s sudo[2003]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:53 volumio-m1s kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 23 21:20:53 volumio-m1s kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Feb 23 21:20:53 volumio-m1s volumio[1214]: info: Cannot mount NAS 音乐库 at system boot, trial number 3 ,retrying in 5 seconds Feb 23 21:20:53 volumio-m1s sudo[2010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 21:20:53 volumio-m1s sudo[2010]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:53 volumio-m1s sudo[2013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 21:20:53 volumio-m1s sudo[2013]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:53 volumio-m1s sudo[2010]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:53 volumio-m1s sudo[2013]: pam_unix(sudo:session): session closed for user root Feb 23 21:20:53 volumio-m1s volumio[1214]: verbose: New Socket.io Connection to 192.168.3.109 from 192.168.3.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Edg/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetQueue Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreStateMachine::getQueue Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CorePlayQueue::getQueue Feb 23 21:20:54 volumio-m1s volumio[1214]: info: Listing playlists Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 21:20:54 volumio-m1s volumio[1214]: info: Received Get System Info Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 21:20:54 volumio-m1s volumio[1214]: info: Discovery: Getting this device information Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 21:20:54 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 23 21:20:55 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 21:20:55 volumio-m1s volumio[1214]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 23 21:20:55 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:55 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:55 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 21:20:55 volumio-m1s volumio[1214]: info: Received Get System Info Feb 23 21:20:55 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 21:20:55 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 21:20:55 volumio-m1s volumio[1214]: info: Discovery: Getting this device information Feb 23 21:20:55 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:55 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:55 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 21:20:56 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 23 21:20:56 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetState Feb 23 21:20:56 volumio-m1s volumio[1214]: info: CorePlayQueue::getTrack 0 Feb 23 21:20:58 volumio-m1s volumio[1214]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Retrieving Cloud Streaming UI Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Getting Tidal Cloud Configuration Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Getting Qobuz Cloud Configuration Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Asking plugin for UI Config Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Getting Spotify Cloud Configuration Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Asking plugin for UI Config Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Saving Spotify Acccount Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Got Tidal Cloud Configuration Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Got it Feb 23 21:20:58 volumio-m1s volumio[1214]: info: Got it Feb 23 21:20:58 volumio-m1s volumio[1214]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 21:20:58 volumio-m1s volumio[1214]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetBrowseSources Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetBrowseSources Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetBrowseSources Feb 23 21:20:58 volumio-m1s volumio-remote-updater[829]: No test mode Feb 23 21:20:58 volumio-m1s volumio-remote-updater[829]: No alpha test mode Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 23 21:20:58 volumio-m1s sudo[2038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=administrator,password=2218chb,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.15/share\media_rw\sda1 /mnt/NAS/音乐库 Feb 23 21:20:58 volumio-m1s sudo[2038]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 23 21:20:58 volumio-m1s kernel: CIFS: Attempting to mount //192.168.3.15/share/media_rw/sda1 Feb 23 21:20:58 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 23 21:21:00 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:21:00 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:21:00 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 23 21:21:00 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 23 21:21:00 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 23 21:21:00 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumioGetBrowseSources Feb 23 21:21:00 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 21:21:00 volumio-m1s volumio[1214]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 23 21:21:00 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 23 21:21:01 volumio-m1s volumio[1214]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 23 21:21:01 volumio-m1s volumio[1214]: info: Completed starting MyVolumio Plugin Feb 23 21:21:01 volumio-m1s volumio[1214]: [Metrics] CommandRouter: 41s 373.62ms Feb 23 21:21:01 volumio-m1s volumio[1214]: info: CoreCommandRouter::volumiosetStartupVolume Feb 23 21:21:01 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 21:21:01 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 21:21:01 volumio-m1s volumio[1214]: info: CoreCommandRouter::Close All Modals sent Feb 23 21:21:01 volumio-m1s volumio[1214]: info: CoreCommandRouter::Close All Modals sent Feb 23 21:21:02 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 23 21:21:02 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 23 21:21:02 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 21:21:02 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 23 21:21:04 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 23 21:21:04 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Feb 23 21:21:04 volumio-m1s sudo[2038]: pam_unix(sudo:session): session closed for user root Feb 23 21:21:04 volumio-m1s kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 23 21:21:04 volumio-m1s kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Feb 23 21:21:04 volumio-m1s volumio[1214]: info: Cannot mount NAS 音乐库 at system boot, trial number 4 ,retrying in 5 seconds Feb 23 21:21:05 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 23 21:21:06 volumio-m1s volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 23 21:21:08 volumio-m1s volumio[1214]: info: BOOT COMPLETED Feb 23 21:21:09 volumio-m1s volumio[1214]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 21:21:09 volumio-m1s volumio[1214]: TypeError: Cannot read property 'replace' of undefined Feb 23 21:21:09 volumio-m1s volumio[1214]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Feb 23 21:21:09 volumio-m1s volumio[1214]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Feb 23 21:21:09 volumio-m1s volumio[1214]: at listOnTimeout (internal/timers.js:557:17) Feb 23 21:21:09 volumio-m1s volumio[1214]: at processTimers (internal/timers.js:500:7) Feb 23 21:21:09 volumio-m1s volumio[1214]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 21:21:09 volumio-m1s ntpd[1015]: Soliciting pool server 193.182.111.141 Feb 23 21:21:09 volumio-m1s ntpd[1015]: Soliciting pool server 193.182.111.141 Feb 23 21:21:09 volumio-m1s sudo[2121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-23 21:20 Feb 23 21:21:09 volumio-m1s sudo[2121]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"