Oct 22 00:42:21 truenas kernel: sd 0:0:1:0: [sdb] Attached SCSI disk Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: New USB device found, idVendor=0624, idProduct=0249, bcdDevice= 0.00 Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: New USB device strings: Mfr=4, Product=5, SerialNumber=6 Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: Product: Keyboard/Mouse Function Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: Manufacturer: Avocent Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: SerialNumber: 20121018 Oct 22 00:42:21 truenas kernel: hid: raw HID events driver (C) Jiri Kosina Oct 22 00:42:21 truenas kernel: usbcore: registered new interface driver usbhid Oct 22 00:42:21 truenas kernel: usbhid: USB HID core driver Oct 22 00:42:21 truenas kernel: input: Avocent Keyboard/Mouse Function as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6.1/1-1.6.1:1.0/0003:0624:0249.0001/input/input0 Oct 22 00:42:21 truenas kernel: hid-generic 0003:0624:0249.0001: input,hidraw0: USB HID v1.00 Keyboard [Avocent Keyboard/Mouse Function] on usb-0000:00:1a.0-1.6.1/input0 Oct 22 00:42:21 truenas kernel: input: Avocent Keyboard/Mouse Function as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6.1/1-1.6.1:1.1/0003:0624:0249.0002/input/input1 Oct 22 00:42:21 truenas kernel: hid-generic 0003:0624:0249.0002: input,hidraw1: USB HID v1.00 Mouse [Avocent Keyboard/Mouse Function] on usb-0000:00:1a.0-1.6.1/input1 Oct 22 00:42:21 truenas kernel: input: Avocent Keyboard/Mouse Function as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6.1/1-1.6.1:1.2/0003:0624:0249.0003/input/input2 Oct 22 00:42:21 truenas kernel: hid-generic 0003:0624:0249.0003: input,hidraw2: USB HID v1.00 Mouse [Avocent Keyboard/Mouse Function] on usb-0000:00:1a.0-1.6.1/input2 Oct 22 00:42:21 truenas kernel: raid6: sse2x4 gen() 10092 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x4 xor() 6393 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x2 gen() 9339 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x2 xor() 6541 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x1 gen() 9271 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x1 xor() 5875 MB/s Oct 22 00:42:21 truenas kernel: raid6: using algorithm sse2x4 gen() 10092 MB/s Oct 22 00:42:21 truenas kernel: raid6: .... xor() 6393 MB/s, rmw enabled Oct 22 00:42:21 truenas kernel: raid6: using ssse3x2 recovery algorithm Oct 22 00:42:21 truenas kernel: xor: automatically using best checksumming function avx Oct 22 00:42:21 truenas kernel: async_tx: api initialized (async) Oct 22 00:42:21 truenas kernel: spl: loading out-of-tree module taints kernel. Oct 22 00:42:21 truenas kernel: znvpair: module license 'CDDL' taints kernel. Oct 22 00:42:21 truenas kernel: Disabling lock debugging due to kernel taint Oct 22 00:42:21 truenas kernel: ZFS: Loaded module v2.1.5-1, ZFS pool version 5000, ZFS filesystem version 5 Oct 22 00:42:21 truenas kernel: random: crng init done Oct 22 00:42:21 truenas kernel: Not activating Mandatory Access Control as /sbin/tomoyo-init does not exist. Oct 22 00:42:21 truenas kernel: ERST: NVRAM ERST Log Address Range not implemented yet. Oct 22 00:42:21 truenas kernel: RPC: Registered named UNIX socket transport module. Oct 22 00:42:21 truenas kernel: RPC: Registered udp transport module. Oct 22 00:42:21 truenas kernel: RPC: Registered tcp transport module. Oct 22 00:42:21 truenas kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 22 00:42:21 truenas kernel: fuse: init (API version 7.32) Oct 22 00:42:21 truenas kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Oct 22 00:42:21 truenas kernel: ACPI: Power Button [PWRF] Oct 22 00:42:21 truenas kernel: Aborting method \_SB.PMI0._GHL due to previous error (AE_NOT_EXIST) (20200925/psparse-529) Oct 22 00:42:21 truenas kernel: IPMI message handler: version 39.2 Oct 22 00:42:21 truenas kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:1:0: Attached scsi generic sg1 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:2:0: Attached scsi generic sg2 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:3:0: Attached scsi generic sg3 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:4:0: Attached scsi generic sg4 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:5:0: Attached scsi generic sg5 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:6:0: Attached scsi generic sg6 type 0 Oct 22 00:42:21 truenas kernel: ses 7:0:0:0: Attached scsi generic sg7 type 13 Oct 22 00:42:21 truenas kernel: sd 5:0:0:0: Attached scsi generic sg8 type 0 Oct 22 00:42:21 truenas kernel: ipmi device interface Oct 22 00:42:21 truenas kernel: iTCO_vendor_support: vendor-support=0 Oct 22 00:42:21 truenas kernel: mei_me 0000:00:16.0: Device doesn't have valid ME Interface Oct 22 00:42:21 truenas kernel: ipmi_si: IPMI System Interface driver Oct 22 00:42:21 truenas kernel: ipmi_si dmi-ipmi-si.0: ipmi_platform: probing via SMBIOS Oct 22 00:42:21 truenas kernel: ipmi_platform: ipmi_si: SMBIOS: io 0xca8 regsize 1 spacing 4 irq 10 Oct 22 00:42:21 truenas kernel: ipmi_si: Adding SMBIOS-specified kcs state machine Oct 22 00:42:21 truenas kernel: ipmi_si: Trying SMBIOS-specified kcs state machine at i/o address 0xca8, slave address 0x20, irq 10 Oct 22 00:42:21 truenas kernel: iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11 Oct 22 00:42:21 truenas kernel: iTCO_wdt: Found a Patsburg TCO device (Version=2, TCOBASE=0x0860) Oct 22 00:42:21 truenas kernel: input: PC Speaker as /devices/platform/pcspkr/input/input4 Oct 22 00:42:21 truenas kernel: iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0) Oct 22 00:42:21 truenas kernel: mgag200 0000:0b:00.0: vgaarb: deactivate vga console Oct 22 00:42:21 truenas kernel: Console: switching to colour dummy device 80x25 Oct 22 00:42:21 truenas kernel: [drm] Initialized mgag200 1.0.0 20110418 for 0000:0b:00.0 on minor 0 Oct 22 00:42:21 truenas kernel: fbcon: mgag200drmfb (fb0) is primary device Oct 22 00:42:22 truenas kernel: Console: switching to colour frame buffer device 128x48 Oct 22 00:42:22 truenas kernel: mgag200 0000:0b:00.0: [drm] fb0: mgag200drmfb frame buffer device Oct 22 00:42:22 truenas kernel: ipmi_si dmi-ipmi-si.0: The BMC does not support setting the recv irq bit, compensating, but the BMC needs to be fixed. Oct 22 00:42:22 truenas kernel: RAPL PMU: API unit is 2^-32 Joules, 3 fixed counters, 163840 ms ovfl timer Oct 22 00:42:22 truenas kernel: RAPL PMU: hw unit of domain pp0-core 2^-16 Joules Oct 22 00:42:22 truenas kernel: RAPL PMU: hw unit of domain package 2^-16 Joules Oct 22 00:42:22 truenas kernel: RAPL PMU: hw unit of domain dram 2^-16 Joules Oct 22 00:42:22 truenas kernel: ipmi_si dmi-ipmi-si.0: Using irq 10 Oct 22 00:42:22 truenas kernel: ipmi_si dmi-ipmi-si.0: IPMI message handler: Found new BMC (man_id: 0x0002a2, prod_id: 0x0100, dev_id: 0x20) Oct 22 00:42:22 truenas kernel: ipmi_si dmi-ipmi-si.0: IPMI kcs interface initialized Oct 22 00:42:22 truenas kernel: ipmi_ssif: IPMI SSIF Interface driver Oct 22 00:42:22 truenas kernel: EDAC MC0: Giving out device to module sb_edac controller Sandy Bridge SrcID#0_Ha#0: DEV 0000:3f:0e.0 (INTERRUPT) Oct 22 00:42:22 truenas kernel: EDAC MC1: Giving out device to module sb_edac controller Sandy Bridge SrcID#1_Ha#0: DEV 0000:7f:0e.0 (INTERRUPT) Oct 22 00:42:22 truenas kernel: EDAC sbridge: Ver: 1.1.2 Oct 22 00:42:23 truenas kernel: dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.4) Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain package Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain core Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain dram Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain package Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain core Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain dram Oct 22 00:42:52 truenas kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 22 00:42:52 truenas kernel: NTB Resource Split driver, version 1 Oct 22 00:42:52 truenas kernel: Software Queue-Pair Transport over NTB, version 4 Oct 22 00:42:52 truenas kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Oct 22 00:42:56 truenas kernel: igb 0000:01:00.0 eno1: igb: eno1 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX Oct 22 00:42:56 truenas kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eno1: link becomes ready Oct 22 00:43:04 truenas kernel: md/raid1:md127: not clean -- starting background reconstruction Oct 22 00:43:04 truenas kernel: md/raid1:md127: active with 2 out of 2 mirrors Oct 22 00:43:04 truenas kernel: md127: detected capacity change from 0 to 2147483648 Oct 22 00:43:04 truenas kernel: md/raid1:md126: not clean -- starting background reconstruction Oct 22 00:43:04 truenas kernel: md/raid1:md126: active with 2 out of 2 mirrors Oct 22 00:43:04 truenas kernel: md126: detected capacity change from 0 to 2147483648 Oct 22 00:43:05 truenas kernel: device-mapper: uevent: version 1.0.3 Oct 22 00:43:05 truenas kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 22 00:43:05 truenas kernel: md: resync of RAID array md127 Oct 22 00:43:05 truenas kernel: Adding 2097148k swap on /dev/mapper/md127. Priority:-2 extents:1 across:2097148k FS Oct 22 00:43:05 truenas kernel: md: resync of RAID array md126 Oct 22 00:43:06 truenas kernel: Adding 2097148k swap on /dev/mapper/md126. Priority:-3 extents:1 across:2097148k FS Oct 22 00:43:19 truenas kernel: md: md127: resync done. Oct 22 00:43:19 truenas kernel: md: md126: resync done. Oct 22 00:43:55 truenas kernel: md/raid1:md125: not clean -- starting background reconstruction Oct 22 00:43:55 truenas kernel: md/raid1:md125: active with 2 out of 2 mirrors Oct 22 00:43:55 truenas kernel: md125: detected capacity change from 0 to 2147483648 Oct 22 00:43:55 truenas kernel: md: resync of RAID array md125 Oct 22 00:43:55 truenas kernel: Adding 2097148k swap on /dev/mapper/md125. Priority:-4 extents:1 across:2097148k FS Oct 22 00:44:12 truenas kernel: md: md125: resync done. Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="lsb_release" pid=5952 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe" pid=5946 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe//kmod" pid=5946 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="virt-aa-helper" pid=5949 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/man" pid=5948 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_filter" pid=5948 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_groff" pid=5948 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.031:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="libvirtd" pid=5947 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.031:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="libvirtd//qemu_bridge_helper" pid=5947 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.031:11): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/ntpd" pid=5950 comm="apparmor_parser" Oct 22 00:58:10 truenas systemd-journald: Received SIGTERM from PID 1 (systemd). Oct 22 00:58:10 truenas rrdcached[9523]: rrdcached started. Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-i522yjlr' Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-bm74o_hc' Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-hsuixsrs' Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-p5bmojwc' Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-qi1cisqx' Oct 22 00:58:16 truenas systemd-journald: Received client request to relinquish /var/log/journal/944c5d6fa95d4c8582e6c8a9ec40a1fc access. Oct 22 00:58:16 truenas systemd-journald: Received SIGTERM from PID 1 (systemd). Oct 22 00:58:28 truenas kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 22 00:58:28 truenas kernel: Bridge firewalling registered : Using MSI-X interrupts. 8 rx queue(s), 8 tx queue(s) Oct 22 00:42:21 truenas kernel: usb 1-1: new high-speed USB device number 2 using ehci-pci Oct 22 00:42:21 truenas kernel: scsi 0:0:1:0: SATA: handle(0x0009), sas_addr(0x4433221101000000), phy(1), device_name(0x50014ee20f1e076a) Oct 22 00:42:21 truenas kernel: scsi 0:0:1:0: enclosure logical id (0x5842b2b0186a0400), slot(2) Oct 22 00:42:21 truenas kernel: igb 0000:01:00.3: added PHC on eth3 Oct 22 00:42:21 truenas kernel: scsi 0:0:1:0: atapi(n), ncq(y), asyn_notify(n), smart(y), fua(y), sw_preserve(y) Oct 22 00:42:21 truenas kernel: igb 0000:01:00.3: Intel(R) Gigabit Ethernet Network Connection Oct 22 00:42:21 truenas kernel: scsi 0:0:1:0: qdepth(32), tagged(1), scsi_level(7), cmd_que(1) Oct 22 00:42:21 truenas kernel: end_device-0:1: add: handle(0x0009), sas_addr(0x4433221101000000) Oct 22 00:42:21 truenas kernel: igb 0000:01:00.3: eth3: (PCIe:5.0Gb/s:Width x4) b8:ca:3a:5c:ba:97 Oct 22 00:42:21 truenas kernel: scsi 0:0:2:0: Direct-Access ATA ST2000VM003-1CT1 ES22 PQ: 0 ANSI: 6 Oct 22 00:42:21 truenas kernel: igb 0000:01:00.3: eth3: PBA No: G10565-000 Oct 22 00:42:21 truenas kernel: scsi 0:0:2:0: SATA: handle(0x000e), sas_addr(0x4433221102000000), phy(2), device_name(0x5000c5007c17206d) Oct 22 00:42:21 truenas kernel: igb 0000:01:00.3: Using MSI-X interrupts. 8 rx queue(s), 8 tx queue(s) Oct 22 00:42:21 truenas kernel: scsi 0:0:2:0: enclosure logical id (0x5842b2b0186a0400), slot(1) Oct 22 00:42:21 truenas kernel: scsi 0:0:2:0: atapi(n), ncq(y), asyn_notify(n), smart(y), fua(y), sw_preserve(y) Oct 22 00:42:21 truenas kernel: scsi 0:0:2:0: qdepth(32), tagged(1), scsi_level(7), cmd_que(1) Oct 22 00:42:21 truenas kernel: end_device-0:2: add: handle(0x000e), sas_addr(0x4433221102000000) Oct 22 00:42:21 truenas kernel: scsi 0:0:3:0: Direct-Access ATA ST2000VN000-1H31 SC42 PQ: 0 ANSI: 6 Oct 22 00:42:21 truenas kernel: usb 2-1: new high-speed USB device number 2 using ehci-pci Oct 22 00:42:21 truenas kernel: scsi 0:0:3:0: SATA: handle(0x000f), sas_addr(0x4433221103000000), phy(3), device_name(0x5000c5006a4a3f8e) Oct 22 00:42:21 truenas kernel: ata3: SATA link down (SStatus 0 SControl 300) Oct 22 00:42:21 truenas kernel: scsi 0:0:3:0: enclosure logical id (0x5842b2b0186a0400), slot(0) Oct 22 00:42:21 truenas kernel: ata2: SATA link down (SStatus 0 SControl 300) Oct 22 00:42:21 truenas kernel: usb 1-1: New USB device found, idVendor=8087, idProduct=0024, bcdDevice= 0.00 Oct 22 00:42:21 truenas kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Oct 22 00:42:21 truenas kernel: hub 1-1:1.0: USB hub found Oct 22 00:42:21 truenas kernel: hub 1-1:1.0: 6 ports detected Oct 22 00:42:21 truenas kernel: scsi 0:0:3:0: atapi(n), ncq(y), asyn_notify(n), smart(y), fua(y), sw_preserve(y) Oct 22 00:42:21 truenas kernel: ata1: SATA link down (SStatus 0 SControl 300) Oct 22 00:42:21 truenas kernel: igb 0000:01:00.1 eno2: renamed from eth1 Oct 22 00:42:21 truenas kernel: scsi 0:0:3:0: qdepth(32), tagged(1), scsi_level(7), cmd_que(1) Oct 22 00:42:21 truenas kernel: ata4: SATA link down (SStatus 0 SControl 300) Oct 22 00:42:21 truenas kernel: end_device-0:3: add: handle(0x000f), sas_addr(0x4433221103000000) Oct 22 00:42:21 truenas kernel: ata5: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Oct 22 00:42:21 truenas kernel: scsi 0:0:4:0: Direct-Access HITACHI HUS723030ALS640 P2B4 PQ: 0 ANSI: 6 Oct 22 00:42:21 truenas kernel: ata6: SATA link down (SStatus 0 SControl 300) Oct 22 00:42:21 truenas kernel: scsi 0:0:4:0: SSP: handle(0x000a), sas_addr(0x5000cca03e9be401), phy(4), device_name(0x5000cca03e9be403) Oct 22 00:42:21 truenas kernel: ata5.00: ATA-10: SDEZS25-240G-Z01, EF870400, max UDMA/133 Oct 22 00:42:21 truenas kernel: scsi 0:0:4:0: enclosure logical id (0x5842b2b0186a0400), slot(7) Oct 22 00:42:21 truenas kernel: scsi 0:0:4:0: qdepth(254), tagged(1), scsi_level(7), cmd_que(1) Oct 22 00:42:21 truenas kernel: ata5.00: 468862128 sectors, multi 1: LBA48 NCQ (depth 32) Oct 22 00:42:21 truenas kernel: ata5.00: configured for UDMA/133 Oct 22 00:42:21 truenas kernel: end_device-0:4: add: handle(0x000a), sas_addr(0x5000cca03e9be401) Oct 22 00:42:21 truenas kernel: igb 0000:01:00.3 eno4: renamed from eth3 Oct 22 00:42:21 truenas kernel: scsi 0:0:5:0: Direct-Access HITACHI HUS723030ALS640 P2B4 PQ: 0 ANSI: 6 Oct 22 00:42:21 truenas kernel: usb 2-1: New USB device found, idVendor=8087, idProduct=0024, bcdDevice= 0.00 Oct 22 00:42:21 truenas kernel: scsi 0:0:5:0: SSP: handle(0x000b), sas_addr(0x5000cca03e9be42d), phy(5), device_name(0x5000cca03e9be42f) Oct 22 00:42:21 truenas kernel: usb 2-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Oct 22 00:42:21 truenas kernel: scsi 0:0:5:0: enclosure logical id (0x5842b2b0186a0400), slot(6) Oct 22 00:42:21 truenas kernel: scsi 0:0:5:0: qdepth(254), tagged(1), scsi_level(7), cmd_que(1) Oct 22 00:42:21 truenas kernel: hub 2-1:1.0: USB hub found Oct 22 00:42:21 truenas kernel: end_device-0:5: add: handle(0x000b), sas_addr(0x5000cca03e9be42d) Oct 22 00:42:21 truenas kernel: igb 0000:01:00.2 eno3: renamed from eth2 Oct 22 00:42:21 truenas kernel: hub 2-1:1.0: 8 ports detected Oct 22 00:42:21 truenas kernel: scsi 0:0:6:0: Direct-Access HITACHI HUS723030ALS640 P2B4 PQ: 0 ANSI: 6 Oct 22 00:42:21 truenas kernel: scsi 0:0:6:0: SSP: handle(0x000c), sas_addr(0x5000cca03e9c0ec9), phy(6), device_name(0x5000cca03e9c0ecb) Oct 22 00:42:21 truenas kernel: scsi 0:0:6:0: enclosure logical id (0x5842b2b0186a0400), slot(5) Oct 22 00:42:21 truenas kernel: scsi 0:0:6:0: qdepth(254), tagged(1), scsi_level(7), cmd_que(1) Oct 22 00:42:21 truenas kernel: end_device-0:6: add: handle(0x000c), sas_addr(0x5000cca03e9c0ec9) Oct 22 00:42:21 truenas kernel: scsi 7:0:0:0: Enclosure AHCI SGPIO Enclosure 2.00 PQ: 0 ANSI: 7 Oct 22 00:42:21 truenas kernel: scsi 5:0:0:0: Direct-Access ATA SDEZS25-240G-Z01 0400 PQ: 0 ANSI: 5 Oct 22 00:42:21 truenas kernel: usb 1-1.6: new high-speed USB device number 3 using ehci-pci Oct 22 00:42:21 truenas kernel: igb 0000:01:00.0 eno1: renamed from eth0 Oct 22 00:42:21 truenas kernel: ses 7:0:0:0: Attached Enclosure device Oct 22 00:42:21 truenas kernel: sd 5:0:0:0: [sda] 468862128 512-byte logical blocks: (240 GB/224 GiB) Oct 22 00:42:21 truenas kernel: sd 0:0:4:0: [sde] 5860533168 512-byte logical blocks: (3.00 TB/2.73 TiB) Oct 22 00:42:21 truenas kernel: sd 0:0:5:0: [sdg] 5860533168 512-byte logical blocks: (3.00 TB/2.73 TiB) Oct 22 00:42:21 truenas kernel: sd 0:0:6:0: [sdh] 5860533168 512-byte logical blocks: (3.00 TB/2.73 TiB) Oct 22 00:42:21 truenas kernel: sd 0:0:5:0: [sdg] Write Protect is off Oct 22 00:42:21 truenas kernel: sd 0:0:6:0: [sdh] Write Protect is off Oct 22 00:42:21 truenas kernel: sd 0:0:5:0: [sdg] Write cache: enabled, read cache: enabled, supports DPO and FUA Oct 22 00:42:21 truenas kernel: sd 0:0:6:0: [sdh] Write cache: enabled, read cache: enabled, supports DPO and FUA Oct 22 00:42:21 truenas kernel: sd 0:0:3:0: [sdf] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB) Oct 22 00:42:21 truenas kernel: sd 0:0:3:0: [sdf] 4096-byte physical blocks Oct 22 00:42:21 truenas kernel: sd 0:0:2:0: [sdd] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB) Oct 22 00:42:21 truenas kernel: sd 0:0:2:0: [sdd] 4096-byte physical blocks Oct 22 00:42:21 truenas kernel: sd 0:0:1:0: [sdb] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB) Oct 22 00:42:21 truenas kernel: sd 0:0:1:0: [sdb] 4096-byte physical blocks Oct 22 00:42:21 truenas kernel: sd 0:0:2:0: [sdd] Write Protect is off Oct 22 00:42:21 truenas kernel: sd 0:0:2:0: [sdd] Write cache: enabled, read cache: enabled, supports DPO and FUA Oct 22 00:42:21 truenas kernel: sd 0:0:1:0: [sdb] Write Protect is off Oct 22 00:42:21 truenas kernel: sd 0:0:0:0: [sdc] 5860533168 512-byte logical blocks: (3.00 TB/2.73 TiB) Oct 22 00:42:21 truenas kernel: sd 0:0:0:0: [sdc] Write Protect is off Oct 22 00:42:21 truenas kernel: sd 0:0:1:0: [sdb] Write cache: enabled, read cache: enabled, supports DPO and FUA Oct 22 00:42:21 truenas kernel: sd 0:0:0:0: [sdc] Write cache: enabled, read cache: enabled, supports DPO and FUA Oct 22 00:42:21 truenas kernel: sd 5:0:0:0: [sda] Write Protect is off Oct 22 00:42:21 truenas kernel: sd 0:0:4:0: [sde] Write Protect is off Oct 22 00:42:21 truenas kernel: sd 5:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Oct 22 00:42:21 truenas kernel: sd 0:0:4:0: [sde] Write cache: enabled, read cache: enabled, supports DPO and FUA Oct 22 00:42:21 truenas kernel: sdh: sdh1 sdh2 Oct 22 00:42:21 truenas kernel: sdc: sdc1 sdc2 Oct 22 00:42:21 truenas kernel: sdg: sdg1 sdg2 Oct 22 00:42:21 truenas kernel: sd 0:0:3:0: [sdf] Write Protect is off Oct 22 00:42:21 truenas kernel: usb 1-1.6: New USB device found, idVendor=413c, idProduct=a001, bcdDevice= 0.00 Oct 22 00:42:21 truenas kernel: sd 0:0:3:0: [sdf] Write cache: enabled, read cache: enabled, supports DPO and FUA Oct 22 00:42:21 truenas kernel: usb 1-1.6: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Oct 22 00:42:21 truenas kernel: usb 1-1.6: Product: Gadget USB HUB Oct 22 00:42:21 truenas kernel: usb 1-1.6: Manufacturer: no manufacturer Oct 22 00:42:21 truenas kernel: usb 1-1.6: SerialNumber: 0123456789 Oct 22 00:42:21 truenas kernel: hub 1-1.6:1.0: USB hub found Oct 22 00:42:21 truenas kernel: sda: sda1 sda2 sda3 Oct 22 00:42:21 truenas kernel: sde: sde1 sde2 Oct 22 00:42:21 truenas kernel: hub 1-1.6:1.0: 6 ports detected Oct 22 00:42:21 truenas kernel: sd 0:0:0:0: [sdc] Attached SCSI disk Oct 22 00:42:21 truenas kernel: sd 0:0:5:0: [sdg] Attached SCSI disk Oct 22 00:42:21 truenas kernel: sdd: sdd1 sdd2 Oct 22 00:42:21 truenas kernel: sd 0:0:6:0: [sdh] Attached SCSI disk Oct 22 00:42:21 truenas kernel: sd 5:0:0:0: [sda] Attached SCSI disk Oct 22 00:42:21 truenas kernel: sd 0:0:4:0: [sde] Attached SCSI disk Oct 22 00:42:21 truenas kernel: sd 0:0:2:0: [sdd] Attached SCSI disk Oct 22 00:42:21 truenas kernel: sdf: sdf1 sdf2 Oct 22 00:42:21 truenas kernel: sd 0:0:3:0: [sdf] Attached SCSI disk Oct 22 00:42:21 truenas kernel: sdb: sdb1 sdb2 Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: new high-speed USB device number 4 using ehci-pci Oct 22 00:42:21 truenas kernel: sd 0:0:1:0: [sdb] Attached SCSI disk Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: New USB device found, idVendor=0624, idProduct=0249, bcdDevice= 0.00 Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: New USB device strings: Mfr=4, Product=5, SerialNumber=6 Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: Product: Keyboard/Mouse Function Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: Manufacturer: Avocent Oct 22 00:42:21 truenas kernel: usb 1-1.6.1: SerialNumber: 20121018 Oct 22 00:42:21 truenas kernel: hid: raw HID events driver (C) Jiri Kosina Oct 22 00:42:21 truenas kernel: usbcore: registered new interface driver usbhid Oct 22 00:42:21 truenas kernel: usbhid: USB HID core driver Oct 22 00:42:21 truenas kernel: input: Avocent Keyboard/Mouse Function as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6.1/1-1.6.1:1.0/0003:0624:0249.0001/input/input0 Oct 22 00:42:21 truenas kernel: hid-generic 0003:0624:0249.0001: input,hidraw0: USB HID v1.00 Keyboard [Avocent Keyboard/Mouse Function] on usb-0000:00:1a.0-1.6.1/input0 Oct 22 00:42:21 truenas kernel: input: Avocent Keyboard/Mouse Function as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6.1/1-1.6.1:1.1/0003:0624:0249.0002/input/input1 Oct 22 00:42:21 truenas kernel: hid-generic 0003:0624:0249.0002: input,hidraw1: USB HID v1.00 Mouse [Avocent Keyboard/Mouse Function] on usb-0000:00:1a.0-1.6.1/input1 Oct 22 00:42:21 truenas kernel: input: Avocent Keyboard/Mouse Function as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6.1/1-1.6.1:1.2/0003:0624:0249.0003/input/input2 Oct 22 00:42:21 truenas kernel: hid-generic 0003:0624:0249.0003: input,hidraw2: USB HID v1.00 Mouse [Avocent Keyboard/Mouse Function] on usb-0000:00:1a.0-1.6.1/input2 Oct 22 00:42:21 truenas kernel: raid6: sse2x4 gen() 10092 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x4 xor() 6393 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x2 gen() 9339 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x2 xor() 6541 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x1 gen() 9271 MB/s Oct 22 00:42:21 truenas kernel: raid6: sse2x1 xor() 5875 MB/s Oct 22 00:42:21 truenas kernel: raid6: using algorithm sse2x4 gen() 10092 MB/s Oct 22 00:42:21 truenas kernel: raid6: .... xor() 6393 MB/s, rmw enabled Oct 22 00:42:21 truenas kernel: raid6: using ssse3x2 recovery algorithm Oct 22 00:42:21 truenas kernel: xor: automatically using best checksumming function avx Oct 22 00:42:21 truenas kernel: async_tx: api initialized (async) Oct 22 00:42:21 truenas kernel: spl: loading out-of-tree module taints kernel. Oct 22 00:42:21 truenas kernel: znvpair: module license 'CDDL' taints kernel. Oct 22 00:42:21 truenas kernel: Disabling lock debugging due to kernel taint Oct 22 00:42:21 truenas kernel: ZFS: Loaded module v2.1.5-1, ZFS pool version 5000, ZFS filesystem version 5 Oct 22 00:42:21 truenas kernel: random: crng init done Oct 22 00:42:21 truenas kernel: Not activating Mandatory Access Control as /sbin/tomoyo-init does not exist. Oct 22 00:42:21 truenas kernel: ERST: NVRAM ERST Log Address Range not implemented yet. Oct 22 00:42:21 truenas kernel: RPC: Registered named UNIX socket transport module. Oct 22 00:42:21 truenas kernel: RPC: Registered udp transport module. Oct 22 00:42:21 truenas kernel: RPC: Registered tcp transport module. Oct 22 00:42:21 truenas kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 22 00:42:21 truenas kernel: fuse: init (API version 7.32) Oct 22 00:42:21 truenas kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Oct 22 00:42:21 truenas kernel: ACPI: Power Button [PWRF] Oct 22 00:42:21 truenas kernel: Aborting method \_SB.PMI0._GHL due to previous error (AE_NOT_EXIST) (20200925/psparse-529) Oct 22 00:42:21 truenas kernel: IPMI message handler: version 39.2 Oct 22 00:42:21 truenas kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:1:0: Attached scsi generic sg1 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:2:0: Attached scsi generic sg2 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:3:0: Attached scsi generic sg3 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:4:0: Attached scsi generic sg4 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:5:0: Attached scsi generic sg5 type 0 Oct 22 00:42:21 truenas kernel: sd 0:0:6:0: Attached scsi generic sg6 type 0 Oct 22 00:42:21 truenas kernel: ses 7:0:0:0: Attached scsi generic sg7 type 13 Oct 22 00:42:21 truenas kernel: sd 5:0:0:0: Attached scsi generic sg8 type 0 Oct 22 00:42:21 truenas kernel: ipmi device interface Oct 22 00:42:21 truenas kernel: iTCO_vendor_support: vendor-support=0 Oct 22 00:42:21 truenas kernel: mei_me 0000:00:16.0: Device doesn't have valid ME Interface Oct 22 00:42:21 truenas kernel: ipmi_si: IPMI System Interface driver Oct 22 00:42:21 truenas kernel: ipmi_si dmi-ipmi-si.0: ipmi_platform: probing via SMBIOS Oct 22 00:42:21 truenas kernel: ipmi_platform: ipmi_si: SMBIOS: io 0xca8 regsize 1 spacing 4 irq 10 Oct 22 00:42:21 truenas kernel: ipmi_si: Adding SMBIOS-specified kcs state machine Oct 22 00:42:21 truenas kernel: ipmi_si: Trying SMBIOS-specified kcs state machine at i/o address 0xca8, slave address 0x20, irq 10 Oct 22 00:42:21 truenas kernel: iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11 Oct 22 00:42:21 truenas kernel: iTCO_wdt: Found a Patsburg TCO device (Version=2, TCOBASE=0x0860) Oct 22 00:42:21 truenas kernel: input: PC Speaker as /devices/platform/pcspkr/input/input4 Oct 22 00:42:21 truenas kernel: iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0) Oct 22 00:42:21 truenas kernel: mgag200 0000:0b:00.0: vgaarb: deactivate vga console Oct 22 00:42:21 truenas kernel: Console: switching to colour dummy device 80x25 Oct 22 00:42:21 truenas kernel: [drm] Initialized mgag200 1.0.0 20110418 for 0000:0b:00.0 on minor 0 Oct 22 00:42:21 truenas kernel: fbcon: mgag200drmfb (fb0) is primary device Oct 22 00:42:22 truenas kernel: Console: switching to colour frame buffer device 128x48 Oct 22 00:42:22 truenas kernel: mgag200 0000:0b:00.0: [drm] fb0: mgag200drmfb frame buffer device Oct 22 00:42:22 truenas kernel: ipmi_si dmi-ipmi-si.0: The BMC does not support setting the recv irq bit, compensating, but the BMC needs to be fixed. Oct 22 00:42:22 truenas kernel: RAPL PMU: API unit is 2^-32 Joules, 3 fixed counters, 163840 ms ovfl timer Oct 22 00:42:22 truenas kernel: RAPL PMU: hw unit of domain pp0-core 2^-16 Joules Oct 22 00:42:22 truenas kernel: RAPL PMU: hw unit of domain package 2^-16 Joules Oct 22 00:42:22 truenas kernel: RAPL PMU: hw unit of domain dram 2^-16 Joules Oct 22 00:42:22 truenas kernel: ipmi_si dmi-ipmi-si.0: Using irq 10 Oct 22 00:42:22 truenas kernel: ipmi_si dmi-ipmi-si.0: IPMI message handler: Found new BMC (man_id: 0x0002a2, prod_id: 0x0100, dev_id: 0x20) Oct 22 00:42:22 truenas kernel: ipmi_si dmi-ipmi-si.0: IPMI kcs interface initialized Oct 22 00:42:22 truenas kernel: ipmi_ssif: IPMI SSIF Interface driver Oct 22 00:42:22 truenas kernel: EDAC MC0: Giving out device to module sb_edac controller Sandy Bridge SrcID#0_Ha#0: DEV 0000:3f:0e.0 (INTERRUPT) Oct 22 00:42:22 truenas kernel: EDAC MC1: Giving out device to module sb_edac controller Sandy Bridge SrcID#1_Ha#0: DEV 0000:7f:0e.0 (INTERRUPT) Oct 22 00:42:22 truenas kernel: EDAC sbridge: Ver: 1.1.2 Oct 22 00:42:23 truenas kernel: dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.4) Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain package Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain core Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain dram Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain package Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain core Oct 22 00:42:23 truenas kernel: intel_rapl_common: Found RAPL domain dram Oct 22 00:42:52 truenas kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 22 00:42:52 truenas kernel: NTB Resource Split driver, version 1 Oct 22 00:42:52 truenas kernel: Software Queue-Pair Transport over NTB, version 4 Oct 22 00:42:52 truenas kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Oct 22 00:42:56 truenas kernel: igb 0000:01:00.0 eno1: igb: eno1 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX Oct 22 00:42:56 truenas kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eno1: link becomes ready Oct 22 00:43:04 truenas kernel: md/raid1:md127: not clean -- starting background reconstruction Oct 22 00:43:04 truenas kernel: md/raid1:md127: active with 2 out of 2 mirrors Oct 22 00:43:04 truenas kernel: md127: detected capacity change from 0 to 2147483648 Oct 22 00:43:04 truenas kernel: md/raid1:md126: not clean -- starting background reconstruction Oct 22 00:43:04 truenas kernel: md/raid1:md126: active with 2 out of 2 mirrors Oct 22 00:43:04 truenas kernel: md126: detected capacity change from 0 to 2147483648 Oct 22 00:43:05 truenas kernel: device-mapper: uevent: version 1.0.3 Oct 22 00:43:05 truenas kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 22 00:43:05 truenas kernel: md: resync of RAID array md127 Oct 22 00:43:05 truenas kernel: Adding 2097148k swap on /dev/mapper/md127. Priority:-2 extents:1 across:2097148k FS Oct 22 00:43:05 truenas kernel: md: resync of RAID array md126 Oct 22 00:43:06 truenas kernel: Adding 2097148k swap on /dev/mapper/md126. Priority:-3 extents:1 across:2097148k FS Oct 22 00:43:19 truenas kernel: md: md127: resync done. Oct 22 00:43:19 truenas kernel: md: md126: resync done. Oct 22 00:43:55 truenas kernel: md/raid1:md125: not clean -- starting background reconstruction Oct 22 00:43:55 truenas kernel: md/raid1:md125: active with 2 out of 2 mirrors Oct 22 00:43:55 truenas kernel: md125: detected capacity change from 0 to 2147483648 Oct 22 00:43:55 truenas kernel: md: resync of RAID array md125 Oct 22 00:43:55 truenas kernel: Adding 2097148k swap on /dev/mapper/md125. Priority:-4 extents:1 across:2097148k FS Oct 22 00:44:12 truenas kernel: md: md125: resync done. Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="lsb_release" pid=5952 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe" pid=5946 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe//kmod" pid=5946 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="virt-aa-helper" pid=5949 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/man" pid=5948 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_filter" pid=5948 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.027:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_groff" pid=5948 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.031:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="libvirtd" pid=5947 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.031:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="libvirtd//qemu_bridge_helper" pid=5947 comm="apparmor_parser" Oct 22 00:57:51 truenas kernel: audit: type=1400 audit(1666418271.031:11): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/ntpd" pid=5950 comm="apparmor_parser" Oct 22 00:58:10 truenas systemd-journald: Received SIGTERM from PID 1 (systemd). Oct 22 00:58:10 truenas rrdcached[9523]: rrdcached started. Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-i522yjlr' Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-bm74o_hc' Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-hsuixsrs' Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-p5bmojwc' Oct 22 00:58:15 truenas middlewared[9971]: Traceback (most recent call last): Oct 22 00:58:15 truenas middlewared[9971]: File "/usr/lib/python3.9/multiprocessing/resource_tracker.py", line 201, in main Oct 22 00:58:15 truenas middlewared[9971]: cache[rtype].remove(name) Oct 22 00:58:15 truenas middlewared[9971]: KeyError: '/mp-qi1cisqx' Oct 22 00:58:16 truenas systemd-journald: Received client request to relinquish /var/log/journal/944c5d6fa95d4c8582e6c8a9ec40a1fc access. Oct 22 00:58:16 truenas systemd-journald: Received SIGTERM from PID 1 (systemd). Oct 22 00:58:28 truenas kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 22 00:58:28 truenas kernel: Bridge firewalling registered Oct 22 00:58:46 truenas kernel: IPVS: Registered protocols (TCP, UDP, SCTP, AH, ESP) Oct 22 00:58:46 truenas kernel: IPVS: Connection hash table configured (size=4096, memory=32Kbytes) Oct 22 00:58:46 truenas kernel: IPVS: ipvs loaded. Oct 22 00:58:46 truenas kernel: IPVS: [rr] scheduler registered. Oct 22 00:58:46 truenas wsdd.py[9476]: ERROR: error in main loop Oct 22 00:58:46 truenas wsdd.py[9476]: Traceback (most recent call last): Oct 22 00:58:46 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 1734, in main Oct 22 00:58:46 truenas wsdd.py[9476]: key.data.handle_request() Oct 22 00:58:46 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 1278, in handle_request Oct 22 00:58:46 truenas wsdd.py[9476]: self.handle_new_address(addr, ifa_family, iface) Oct 22 00:58:46 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 1082, in handle_new_address Oct 22 00:58:46 truenas wsdd.py[9476]: mch = MulticastHandler(addr_family, addr, interface, self.selector) Oct 22 00:58:46 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 77, in __init__ Oct 22 00:58:46 truenas wsdd.py[9476]: self.init_v4() Oct 22 00:58:46 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 171, in init_v4 Oct 22 00:58:46 truenas wsdd.py[9476]: self.uc_send_socket.bind((self.address, WSD_UDP_PORT)) Oct 22 00:58:46 truenas wsdd.py[9476]: OSError: [Errno 98] Address already in use Oct 22 00:58:48 truenas kernel: cgroup: cgroup: disabling cgroup2 socket matching due to net_prio or net_cls activation Oct 22 00:59:06 truenas kernel: IPv6: ADDRCONF(NETDEV_CHANGE): vethb7c56158: link becomes ready Oct 22 00:59:06 truenas kernel: kube-bridge: port 1(vethb7c56158) entered blocking state Oct 22 00:59:06 truenas kernel: kube-bridge: port 1(vethb7c56158) entered disabled state Oct 22 00:59:06 truenas kernel: device vethb7c56158 entered promiscuous mode Oct 22 00:59:06 truenas kernel: kube-bridge: port 1(vethb7c56158) entered blocking state Oct 22 00:59:06 truenas kernel: kube-bridge: port 1(vethb7c56158) entered forwarding state Oct 22 00:59:08 truenas kernel: IPv6: ADDRCONF(NETDEV_CHANGE): vethe86f5fdb: link becomes ready Oct 22 00:59:08 truenas kernel: kube-bridge: port 2(vethe86f5fdb) entered blocking state Oct 22 00:59:08 truenas kernel: kube-bridge: port 2(vethe86f5fdb) entered disabled state Oct 22 00:59:08 truenas kernel: device vethe86f5fdb entered promiscuous mode Oct 22 00:59:08 truenas kernel: kube-bridge: port 2(vethe86f5fdb) entered blocking state Oct 22 00:59:08 truenas kernel: kube-bridge: port 2(vethe86f5fdb) entered forwarding state Oct 22 00:59:10 truenas kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth90a5b93e: link becomes ready Oct 22 00:59:10 truenas kernel: kube-bridge: port 3(veth90a5b93e) entered blocking state Oct 22 00:59:10 truenas kernel: kube-bridge: port 3(veth90a5b93e) entered disabled state Oct 22 00:59:10 truenas kernel: device veth90a5b93e entered promiscuous mode Oct 22 00:59:10 truenas kernel: kube-bridge: port 3(veth90a5b93e) entered blocking state Oct 22 00:59:10 truenas kernel: kube-bridge: port 3(veth90a5b93e) entered forwarding state Oct 22 00:59:14 truenas kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth5153f319: link becomes ready Oct 22 00:59:14 truenas kernel: kube-bridge: port 4(veth5153f319) entered blocking state Oct 22 00:59:14 truenas kernel: kube-bridge: port 4(veth5153f319) entered disabled state Oct 22 00:59:14 truenas kernel: device veth5153f319 entered promiscuous mode Oct 22 00:59:14 truenas kernel: kube-bridge: port 4(veth5153f319) entered blocking state Oct 22 00:59:14 truenas kernel: kube-bridge: port 4(veth5153f319) entered forwarding state Oct 22 00:59:14 truenas kernel: kube-bridge: port 5(veth00f0b764) entered blocking state Oct 22 00:59:14 truenas kernel: kube-bridge: port 5(veth00f0b764) entered disabled state Oct 22 00:59:14 truenas kernel: device veth00f0b764 entered promiscuous mode Oct 22 00:59:14 truenas kernel: kube-bridge: port 5(veth00f0b764) entered blocking state Oct 22 00:59:14 truenas kernel: kube-bridge: port 5(veth00f0b764) entered forwarding state Oct 22 00:59:15 truenas kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth149161d9: link becomes ready Oct 22 00:59:15 truenas kernel: kube-bridge: port 6(veth149161d9) entered blocking state Oct 22 00:59:15 truenas kernel: kube-bridge: port 6(veth149161d9) entered disabled state Oct 22 00:59:15 truenas kernel: device veth149161d9 entered promiscuous mode Oct 22 00:59:15 truenas kernel: kube-bridge: port 6(veth149161d9) entered blocking state Oct 22 00:59:15 truenas kernel: kube-bridge: port 6(veth149161d9) entered forwarding state Oct 22 01:00:02 truenas kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth05c45561: link becomes ready Oct 22 01:00:02 truenas kernel: kube-bridge: port 7(veth05c45561) entered blocking state Oct 22 01:00:02 truenas kernel: kube-bridge: port 7(veth05c45561) entered disabled state Oct 22 01:00:02 truenas kernel: device veth05c45561 entered promiscuous mode Oct 22 01:00:02 truenas kernel: kube-bridge: port 7(veth05c45561) entered blocking state Oct 22 01:00:02 truenas kernel: kube-bridge: port 7(veth05c45561) entered forwarding state Oct 22 01:02:50 truenas wsdd.py[9476]: ERROR: error in main loop Oct 22 01:02:50 truenas wsdd.py[9476]: Traceback (most recent call last): Oct 22 01:02:50 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 1732, in main Oct 22 01:02:50 truenas wsdd.py[9476]: key.data.handle_request(key) Oct 22 01:02:50 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 213, in handle_request Oct 22 01:02:50 truenas wsdd.py[9476]: handler.handle_request(msg, address) Oct 22 01:02:50 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 728, in handle_request Oct 22 01:02:50 truenas wsdd.py[9476]: reply = self.handle_message(msg, self.mch, address) Oct 22 01:02:50 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 373, in handle_message Oct 22 01:02:50 truenas wsdd.py[9476]: tree = ElementTree.fromstring(msg) Oct 22 01:02:50 truenas wsdd.py[9476]: File "/usr/lib/python3.9/xml/etree/ElementTree.py", line 1347, in XML Oct 22 01:02:50 truenas wsdd.py[9476]: parser.feed(text) Oct 22 01:02:50 truenas wsdd.py[9476]: xml.etree.ElementTree.ParseError: not well-formed (invalid token): line 1, column 99 Oct 22 01:07:50 truenas wsdd.py[9476]: ERROR: error in main loop Oct 22 01:07:50 truenas wsdd.py[9476]: Traceback (most recent call last): Oct 22 01:07:50 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 1732, in main Oct 22 01:07:50 truenas wsdd.py[9476]: key.data.handle_request(key) Oct 22 01:07:50 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 213, in handle_request Oct 22 01:07:50 truenas wsdd.py[9476]: handler.handle_request(msg, address) Oct 22 01:07:50 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 728, in handle_request Oct 22 01:07:50 truenas wsdd.py[9476]: reply = self.handle_message(msg, self.mch, address) Oct 22 01:07:50 truenas wsdd.py[9476]: File "/usr/bin/wsdd.py", line 373, in handle_message Oct 22 01:07:50 truenas wsdd.py[9476]: tree = ElementTree.fromstring(msg) Oct 22 01:07:50 truenas wsdd.py[9476]: File "/usr/lib/python3.9/xml/etree/ElementTree.py", line 1347, in XML Oct 22 01:07:50 truenas wsdd.py[9476]: parser.feed(text) Oct 22 01:07:50 truenas wsdd.py[9476]: xml.etree.ElementTree.ParseError: not well-formed (invalid token): line 1, column 99