Charging icon shows charging when not plugged in
What problem did you encounter
Icon shows the battery charging icon when it is not plugged in
What is the actual behaviour?
Charging icon when not charging
What is the expected behaviour?
Charging icon to match cable and power charging accurately.
How to reproduce
purism-librem-5-evergreen-charging-icon-issue-2020-11-21
What hardware are you running on?
- Librem 5 Evergreen
Relevant OS information
purism@pureos:~$ uname -a
Linux pureos 5.9.0-1-librem5 #1 SMP PREEMPT Fri Nov 13 03:06:12 PST 2020 aarch64 GNU/Linux
purism@pureos:~$ dpkg -s phosh | grep Version
Version: 0.6.0
purism@pureos:~$ dpkg -s phoc | grep Version
Version: 0.5.0
purism@pureos:~$ cat uevent.txt
==> /sys/class/power_supply/bq25890-charger/uevent <==
POWER_SUPPLY_NAME=bq25890-charger
POWER_SUPPLY_TYPE=USB
POWER_SUPPLY_MANUFACTURER=Texas Instruments
POWER_SUPPLY_MODEL_NAME=BQ25895
POWER_SUPPLY_STATUS=Discharging
POWER_SUPPLY_CHARGE_TYPE=N/A
POWER_SUPPLY_ONLINE=0
POWER_SUPPLY_HEALTH=Good
POWER_SUPPLY_CONSTANT_CHARGE_CURRENT_MAX=1472000
POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE=0
POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE_MAX=4192000
POWER_SUPPLY_PRECHARGE_CURRENT=128000
POWER_SUPPLY_CHARGE_TERM_CURRENT=128000
POWER_SUPPLY_INPUT_CURRENT_LIMIT=500000
POWER_SUPPLY_VOLTAGE_NOW=2304000
POWER_SUPPLY_CURRENT_NOW=0
==> /sys/class/power_supply/max170xx_battery/uevent <==
POWER_SUPPLY_NAME=max170xx_battery
POWER_SUPPLY_TYPE=Battery
POWER_SUPPLY_STATUS=Unknown
POWER_SUPPLY_PRESENT=1
POWER_SUPPLY_TECHNOLOGY=Li-ion
POWER_SUPPLY_CYCLE_COUNT=141
POWER_SUPPLY_VOLTAGE_MAX=4200000
POWER_SUPPLY_VOLTAGE_MIN=3100000
POWER_SUPPLY_VOLTAGE_MIN_DESIGN=3300000
POWER_SUPPLY_VOLTAGE_NOW=3684062
POWER_SUPPLY_VOLTAGE_AVG=3721328
POWER_SUPPLY_VOLTAGE_OCV=3848828
POWER_SUPPLY_CAPACITY=75
POWER_SUPPLY_CHARGE_FULL_DESIGN=3000000
POWER_SUPPLY_CHARGE_FULL=2621000
POWER_SUPPLY_CHARGE_NOW=1986000
POWER_SUPPLY_CHARGE_COUNTER=32611500
POWER_SUPPLY_TEMP=309
POWER_SUPPLY_TEMP_ALERT_MIN=-1280
POWER_SUPPLY_TEMP_ALERT_MAX=1270
POWER_SUPPLY_TEMP_MIN=-2147483648
POWER_SUPPLY_TEMP_MAX=700
POWER_SUPPLY_HEALTH=Good
POWER_SUPPLY_SCOPE=System
POWER_SUPPLY_CURRENT_NOW=-338208
POWER_SUPPLY_CURRENT_AVG=-251160
POWER_SUPPLY_TIME_TO_EMPTY_NOW=27500
==> /sys/class/power_supply/tcpm-source-psy-0-003f/uevent <==
POWER_SUPPLY_NAME=tcpm-source-psy-0-003f
POWER_SUPPLY_TYPE=USB
POWER_SUPPLY_USB_TYPE=[C] PD PD_DRP PD_PPS
POWER_SUPPLY_ONLINE=0
purism@pureos:~$
Activity
-
Newest first Oldest first
-
Show all activity Show comments only Show history only
- Author
When plugged in to usb-c on laptop (and icon shows charging):
purism@pureos:~$ cat *-plugged* ==> /sys/class/power_supply/bq25890-charger/uevent <== POWER_SUPPLY_NAME=bq25890-charger POWER_SUPPLY_TYPE=USB POWER_SUPPLY_MANUFACTURER=Texas Instruments POWER_SUPPLY_MODEL_NAME=BQ25895 POWER_SUPPLY_STATUS=Discharging POWER_SUPPLY_CHARGE_TYPE=N/A POWER_SUPPLY_ONLINE=0 POWER_SUPPLY_HEALTH=Good POWER_SUPPLY_CONSTANT_CHARGE_CURRENT_MAX=1472000 POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE=0 POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE_MAX=4192000 POWER_SUPPLY_PRECHARGE_CURRENT=128000 POWER_SUPPLY_CHARGE_TERM_CURRENT=128000 POWER_SUPPLY_INPUT_CURRENT_LIMIT=500000 POWER_SUPPLY_VOLTAGE_NOW=2304000 POWER_SUPPLY_CURRENT_NOW=0 ==> /sys/class/power_supply/max170xx_battery/uevent <== POWER_SUPPLY_NAME=max170xx_battery POWER_SUPPLY_TYPE=Battery POWER_SUPPLY_STATUS=Unknown POWER_SUPPLY_PRESENT=1 POWER_SUPPLY_TECHNOLOGY=Li-ion POWER_SUPPLY_CYCLE_COUNT=142 POWER_SUPPLY_VOLTAGE_MAX=4200000 POWER_SUPPLY_VOLTAGE_MIN=3100000 POWER_SUPPLY_VOLTAGE_MIN_DESIGN=3300000 POWER_SUPPLY_VOLTAGE_NOW=3655156 POWER_SUPPLY_VOLTAGE_AVG=3691093 POWER_SUPPLY_VOLTAGE_OCV=3824062 POWER_SUPPLY_CAPACITY=73 POWER_SUPPLY_CHARGE_FULL_DESIGN=3000000 POWER_SUPPLY_CHARGE_FULL=2621000 POWER_SUPPLY_CHARGE_NOW=1915000 POWER_SUPPLY_CHARGE_COUNTER=32583000 POWER_SUPPLY_TEMP=316 POWER_SUPPLY_TEMP_ALERT_MIN=-1280 POWER_SUPPLY_TEMP_ALERT_MAX=1270 POWER_SUPPLY_TEMP_MIN=-2147483648 POWER_SUPPLY_TEMP_MAX=700 POWER_SUPPLY_HEALTH=Good POWER_SUPPLY_SCOPE=System POWER_SUPPLY_CURRENT_NOW=-333840 POWER_SUPPLY_CURRENT_AVG=-267384 POWER_SUPPLY_TIME_TO_EMPTY_NOW=24997 ==> /sys/class/power_supply/tcpm-source-psy-0-003f/uevent <== POWER_SUPPLY_NAME=tcpm-source-psy-0-003f POWER_SUPPLY_TYPE=USB POWER_SUPPLY_USB_TYPE=[C] PD PD_DRP PD_PPS POWER_SUPPLY_ONLINE=0 Device: /org/freedesktop/UPower/devices/line_power_tcpm_source_psy_0_003f native-path: tcpm-source-psy-0-003f power supply: yes updated: Sat Nov 21 07:02:37 2020 (20530 seconds ago) has history: no has statistics: no line-power warning-level: none online: yes icon-name: 'ac-adapter-symbolic' Device: /org/freedesktop/UPower/devices/battery_max170xx_battery native-path: max170xx_battery power supply: yes updated: Sat Nov 21 12:43:17 2020 (90 seconds ago) has history: yes has statistics: yes battery present: yes rechargeable: yes state: charging warning-level: none energy: 6.3426 Wh energy-empty: 0 Wh energy-full: 9.9 Wh energy-full-design: 9.9 Wh energy-rate: 0.377863 W voltage: 3.76625 V time to full: 9.4 hours percentage: 73% temperature: 31.3 degrees C capacity: 100% technology: lithium-ion icon-name: 'battery-full-charging-symbolic' History (rate): 1605991397 0.378 charging Device: /org/freedesktop/UPower/devices/battery_bq25890_charger native-path: bq25890-charger vendor: Texas Instruments model: BQ25895 power supply: yes updated: Sat Nov 21 12:44:18 2020 (29 seconds ago) has history: yes has statistics: yes battery present: yes rechargeable: yes state: discharging warning-level: action energy: 0 Wh energy-empty: 0 Wh energy-full: 0 Wh energy-full-design: 0 Wh energy-rate: 0 W voltage: 2.304 V percentage: 0% capacity: 100% icon-name: 'battery-caution-symbolic' Device: /org/freedesktop/UPower/devices/DisplayDevice power supply: yes updated: Sat Nov 21 12:43:17 2020 (90 seconds ago) has history: no has statistics: no battery present: yes state: charging warning-level: none energy: 6.3426 Wh energy-full: 9.9 Wh energy-rate: 0.377863 W time to full: 9.4 hours percentage: 64.0667% icon-name: 'battery-full-charging-symbolic' Daemon: daemon-version: 0.99.10 on-battery: no lid-is-closed: no lid-is-present: no critical-action: PowerOff purism@pureos:~$
- Author
When unplugged (and icon shows charging):
purism@pureos:~$ ls -l *plugged* -rw-r--r-- 1 purism purism 1705 Nov 21 12:44 uevent-plugged.txt -rw-r--r-- 1 purism purism 1705 Nov 21 12:45 uevent-unplugged.txt -rw-r--r-- 1 purism purism 2677 Nov 21 12:44 upower-plugged.txt -rw-r--r-- 1 purism purism 2724 Nov 21 12:45 upower-unplugged.txt purism@pureos:~$ cat *-unplugged* ==> /sys/class/power_supply/bq25890-charger/uevent <== POWER_SUPPLY_NAME=bq25890-charger POWER_SUPPLY_TYPE=USB POWER_SUPPLY_MANUFACTURER=Texas Instruments POWER_SUPPLY_MODEL_NAME=BQ25895 POWER_SUPPLY_STATUS=Discharging POWER_SUPPLY_CHARGE_TYPE=N/A POWER_SUPPLY_ONLINE=0 POWER_SUPPLY_HEALTH=Good POWER_SUPPLY_CONSTANT_CHARGE_CURRENT_MAX=1472000 POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE=0 POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE_MAX=4192000 POWER_SUPPLY_PRECHARGE_CURRENT=128000 POWER_SUPPLY_CHARGE_TERM_CURRENT=128000 POWER_SUPPLY_INPUT_CURRENT_LIMIT=500000 POWER_SUPPLY_VOLTAGE_NOW=2304000 POWER_SUPPLY_CURRENT_NOW=0 ==> /sys/class/power_supply/max170xx_battery/uevent <== POWER_SUPPLY_NAME=max170xx_battery POWER_SUPPLY_TYPE=Battery POWER_SUPPLY_STATUS=Unknown POWER_SUPPLY_PRESENT=1 POWER_SUPPLY_TECHNOLOGY=Li-ion POWER_SUPPLY_CYCLE_COUNT=142 POWER_SUPPLY_VOLTAGE_MAX=4200000 POWER_SUPPLY_VOLTAGE_MIN=3100000 POWER_SUPPLY_VOLTAGE_MIN_DESIGN=3300000 POWER_SUPPLY_VOLTAGE_NOW=3659531 POWER_SUPPLY_VOLTAGE_AVG=3688203 POWER_SUPPLY_VOLTAGE_OCV=3822968 POWER_SUPPLY_CAPACITY=72 POWER_SUPPLY_CHARGE_FULL_DESIGN=3000000 POWER_SUPPLY_CHARGE_FULL=2621000 POWER_SUPPLY_CHARGE_NOW=1912000 POWER_SUPPLY_CHARGE_COUNTER=32581500 POWER_SUPPLY_TEMP=320 POWER_SUPPLY_TEMP_ALERT_MIN=-1280 POWER_SUPPLY_TEMP_ALERT_MAX=1270 POWER_SUPPLY_TEMP_MIN=-2147483648 POWER_SUPPLY_TEMP_MAX=700 POWER_SUPPLY_HEALTH=Good POWER_SUPPLY_SCOPE=System POWER_SUPPLY_CURRENT_NOW=-325728 POWER_SUPPLY_CURRENT_AVG=-257400 POWER_SUPPLY_TIME_TO_EMPTY_NOW=25818 ==> /sys/class/power_supply/tcpm-source-psy-0-003f/uevent <== POWER_SUPPLY_NAME=tcpm-source-psy-0-003f POWER_SUPPLY_TYPE=USB POWER_SUPPLY_USB_TYPE=[C] PD PD_DRP PD_PPS POWER_SUPPLY_ONLINE=0 Device: /org/freedesktop/UPower/devices/line_power_tcpm_source_psy_0_003f native-path: tcpm-source-psy-0-003f power supply: yes updated: Sat Nov 21 07:02:37 2020 (20559 seconds ago) has history: no has statistics: no line-power warning-level: none online: yes icon-name: 'ac-adapter-symbolic' Device: /org/freedesktop/UPower/devices/battery_max170xx_battery native-path: max170xx_battery power supply: yes updated: Sat Nov 21 12:44:56 2020 (20 seconds ago) has history: yes has statistics: yes battery present: yes rechargeable: yes state: charging warning-level: none energy: 6.3129 Wh energy-empty: 0 Wh energy-full: 9.9 Wh energy-full-design: 9.9 Wh energy-rate: 0.79691 W voltage: 3.69484 V time to full: 4.5 hours percentage: 72% temperature: 32 degrees C capacity: 100% technology: lithium-ion icon-name: 'battery-full-charging-symbolic' History (charge): 1605991496 72.000 charging History (rate): 1605991496 0.797 charging Device: /org/freedesktop/UPower/devices/battery_bq25890_charger native-path: bq25890-charger vendor: Texas Instruments model: BQ25895 power supply: yes updated: Sat Nov 21 12:44:48 2020 (28 seconds ago) has history: yes has statistics: yes battery present: yes rechargeable: yes state: discharging warning-level: action energy: 0 Wh energy-empty: 0 Wh energy-full: 0 Wh energy-full-design: 0 Wh energy-rate: 0 W voltage: 2.304 V percentage: 0% capacity: 100% icon-name: 'battery-caution-symbolic' Device: /org/freedesktop/UPower/devices/DisplayDevice power supply: yes updated: Sat Nov 21 12:44:56 2020 (20 seconds ago) has history: no has statistics: no battery present: yes state: charging warning-level: none energy: 6.3129 Wh energy-full: 9.9 Wh energy-rate: 0.79691 W time to full: 4.5 hours percentage: 63.7667% icon-name: 'battery-full-charging-symbolic' Daemon: daemon-version: 0.99.10 on-battery: no lid-is-closed: no lid-is-present: no critical-action: PowerOff purism@pureos:~$
- Author
Testing by moving to a wall-wart power and it "cleared the charging state":
purism-librem-5-evergreen-charging-icon-issue-worked-2020-11-21
- Author
Adding plugged output after clearing:
purism@pureos:~/tmp$ ls -l total 120 -rw-r--r-- 1 purism purism 49576 Nov 21 13:02 dmesg-plugged.txt -rw-r--r-- 1 purism purism 49576 Nov 21 13:02 dmesg-unplugged.txt -rw-r--r-- 1 purism purism 1713 Nov 21 13:01 uevent-plugged.txt -rw-r--r-- 1 purism purism 1705 Nov 21 13:02 uevent-unplugged.txt -rw-r--r-- 1 purism purism 2902 Nov 21 13:01 upower-plugged.txt -rw-r--r-- 1 purism purism 2816 Nov 21 13:02 upower-unplugged.txt purism@pureos:~/tmp$ cat *-plugged* [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034] [ 0.000000] Linux version 5.9.0-1-librem5 (builder@cumin-amber-phone-staging-arm64-jhpb) (aarch64-linux-gnu-gcc (Debian 8.0 [ 0.000000] Machine model: Purism Librem 5r4 [ 0.000000] cma: Reserved 320 MiB at 0x00000000ea400000 [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] [ 0.000000] DMA32 [mem 0x0000000080000000-0x00000000ffffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000ffffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000ffffffff] [ 0.000000] On node 0 totalpages: 786432 [ 0.000000] DMA zone: 4096 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 262144 pages, LIFO batch:63 [ 0.000000] DMA32 zone: 8192 pages used for memmap [ 0.000000] DMA32 zone: 524288 pages, LIFO batch:63 [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: SMC Calling Convention v1.1 [ 0.000000] percpu: Embedded 31 pages/cpu s88792 r8192 d29992 u126976 [ 0.000000] pcpu-alloc: s88792 r8192 d29992 u126976 alloc=31*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Detected VIPT I-cache on CPU0 [ 0.000000] CPU features: detected: ARM erratum 845719 [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] Speculative Store Bypass Disable mitigation not required [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 774144 [ 0.000000] Kernel command line: ${console} console=ttymxc0,115200 quiet fsck.repair=yes security=apparmor splash plymouth2 [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] software IO TLB: mapped [mem 0x7bfff000-0x7ffff000] (64MB) [ 0.000000] Memory: 2651956K/3145728K available (11262K kernel code, 1632K rwdata, 4540K rodata, 4032K init, 577K bss, 166) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] ftrace: allocating 37481 entries in 147 pages [ 0.000000] ftrace: allocated 147 pages with 4 groups [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv3: GIC: Using split EOI/Deactivate mode [ 0.000000] GICv3: 128 SPIs implemented [ 0.000000] GICv3: 0 Extended SPIs implemented [ 0.000000] GICv3: Distributor has no Range Selector support [ 0.000000] GICv3: 16 PPIs implemented [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000038880000 [ 0.000000] ITS: No ITS available, not enabling LPIs [ 0.000000] random: get_random_bytes called from start_kernel+0x3c8/0x578 with crng_init=0 [ 0.000000] arch_timer: cp15 timer(s) running at 8.33MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1ec0311ec, max_idle_ns: 440795202152 ns [ 0.000004] sched_clock: 56 bits at 8MHz, resolution 120ns, wraps every 2199023255541ns [ 0.000465] Console: colour dummy device 80x25 [ 0.000503] Calibrating delay loop (skipped), value calculated using timer frequency.. 16.66 BogoMIPS (lpj=33333) [ 0.000512] pid_max: default: 32768 minimum: 301 [ 0.000619] LSM: Security Framework initializing [ 0.000704] AppArmor: AppArmor initialized [ 0.000756] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.000776] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.002254] rcu: Hierarchical SRCU implementation. [ 0.003196] smp: Bringing up secondary CPUs ... [ 0.003720] Detected VIPT I-cache on CPU1 [ 0.003753] GICv3: CPU1: found redistributor 1 region 0:0x00000000388a0000 [ 0.003784] CPU1: Booted secondary processor 0x0000000001 [0x410fd034] [ 0.004396] Detected VIPT I-cache on CPU2 [ 0.004416] GICv3: CPU2: found redistributor 2 region 0:0x00000000388c0000 [ 0.004434] CPU2: Booted secondary processor 0x0000000002 [0x410fd034] [ 0.004981] Detected VIPT I-cache on CPU3 [ 0.004999] GICv3: CPU3: found redistributor 3 region 0:0x00000000388e0000 [ 0.005018] CPU3: Booted secondary processor 0x0000000003 [0x410fd034] [ 0.005097] smp: Brought up 1 node, 4 CPUs [ 0.005101] SMP: Total of 4 processors activated. [ 0.005106] CPU features: detected: 32-bit EL0 Support [ 0.005110] CPU features: detected: CRC32 instructions [ 0.013930] CPU: All CPU(s) started at EL2 [ 0.013955] alternatives: patching kernel code [ 0.015548] devtmpfs: initialized [ 0.023898] KASLR disabled due to lack of seed [ 0.024324] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.024338] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.033817] pinctrl core: initialized pinctrl subsystem [ 0.034920] NET: Registered protocol family 16 [ 0.036566] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.036646] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.036816] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.036881] audit: initializing netlink subsys (disabled) [ 0.037029] audit: type=2000 audit(0.036:1): state=initialized audit_enabled=0 res=1 [ 0.037510] thermal_sys: Registered thermal governor 'step_wise' [ 0.037513] thermal_sys: Registered thermal governor 'power_allocator' [ 0.037981] cpuidle: using governor menu [ 0.038205] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.038279] ASID allocator initialised with 65536 entries [ 0.038371] Serial: AMBA PL011 UART driver [ 0.066725] imx8mq-pinctrl 30330000.pinctrl: initialized IMX pinctrl driver [ 0.073410] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.073419] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.073423] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.073428] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.074810] cryptd: max_cpu_qlen set to 1000 [ 0.081227] iommu: Default domain type: Translated [ 0.081390] vgaarb: loaded [ 0.081684] SCSI subsystem initialized [ 0.081724] libata version 3.00 loaded. [ 0.082645] pps_core: LinuxPPS API ver. 1 registered [ 0.082649] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> [ 0.082662] PTP clock support registered [ 0.083784] clocksource: Switched to clocksource arch_sys_counter [ 1.072069] VFS: Disk quotas dquot_6.6.0 [ 1.072125] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 1.072675] AppArmor: AppArmor Filesystem Enabled [ 1.078856] NET: Registered protocol family 2 [ 1.079366] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 1.079424] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 1.079670] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 1.080199] TCP: Hash tables configured (established 32768 bind 32768) [ 1.080303] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 1.080392] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 1.080593] NET: Registered protocol family 1 [ 1.081027] RPC: Registered named UNIX socket transport module. [ 1.081030] RPC: Registered udp transport module. [ 1.081033] RPC: Registered tcp transport module. [ 1.081036] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.081046] PCI: CLS 0 bytes, default 64 [ 1.081209] Unpacking initramfs... [ 1.805373] Freeing initrd memory: 15788K [ 1.806133] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available [ 1.808575] Initialise system trusted keyrings [ 1.808688] workingset: timestamp_bits=46 max_order=20 bucket_order=0 [ 1.813828] zbud: loaded [ 1.814971] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 1.815536] NFS: Registering the id_resolver key type [ 1.815556] Key type id_resolver registered [ 1.815559] Key type id_legacy registered [ 1.815644] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 1.858614] Key type asymmetric registered [ 1.858619] Asymmetric key parser 'x509' registered [ 1.858651] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) [ 1.865610] clk: failed to reparent audio_pll1 to sys1_pll_800m: -22 [ 1.865628] clk: failed to reparent audio_pll2 to arm_pll_out: -22 [ 1.867993] SoC: i.MX8MQ revision 2.1 [ 1.871284] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 1.873323] 30860000.serial: ttymxc0 at MMIO 0x30860000 (irq = 33, base_baud = 1562500) is a IMX [ 1.885951] printk: console [ttymxc0] enabled [ 1.886500] 30880000.serial: ttymxc2 at MMIO 0x30880000 (irq = 34, base_baud = 1562500) is a IMX [ 1.887035] 30890000.serial: ttymxc1 at MMIO 0x30890000 (irq = 35, base_baud = 1562500) is a IMX [ 1.887148] serial serial0: tty port ttymxc1 registered [ 1.887586] 30a60000.serial: ttymxc3 at MMIO 0x30a60000 (irq = 43, base_baud = 1562500) is a IMX [ 1.896781] loop: module loaded [ 1.898082] spi_imx 30820000.spi: dma setup error -19, use pio [ 1.904014] spi_imx 30820000.spi: bitbang start failed with -517 [ 1.910752] libphy: Fixed MDIO Bus: probed [ 1.911300] i2c /dev entries driver [ 1.923400] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initialised: dm-devel@redhat.com [ 1.924647] sdhci: Secure Digital Host Controller Interface driver [ 1.924649] sdhci: Copyright(c) Pierre Ossman [ 1.924669] sdhci-pltfm: SDHCI platform and OF driver helper [ 1.957958] mmc0: SDHCI controller on 30b40000.mmc [30b40000.mmc] using ADMA [ 1.962363] ledtrig-cpu: registered to indicate activity on CPUs [ 1.962652] hid: raw HID events driver (C) Jiri Kosina [ 1.964325] ashmem: initialized [ 1.969671] NET: Registered protocol family 26 [ 1.969798] NET: Registered protocol family 17 [ 1.970066] 9pnet: Installing 9P2000 support [ 1.970118] Key type dns_resolver registered [ 1.970986] registered taskstats version 1 [ 1.970997] Loading compiled-in X.509 certificates [ 1.971083] zswap: loaded using pool lzo/zbud [ 1.971327] Key type ._fscrypt registered [ 1.971331] Key type .fscrypt registered [ 1.971334] Key type fscrypt-provisioning registered [ 1.971492] AppArmor: AppArmor sha1 policy hashing enabled [ 1.997854] AUD_1V8: supplied by AUDIO_PWR_EN [ 1.999102] LCD_3V4: supplied by VSYS_3V4 [ 2.104212] ldo5: supplied by buck6 [ 2.111537] ldo6: supplied by buck7 [ 2.150158] random: fast init done [ 2.167522] rtc-m41t80 0-0068: registered as rtc0 [ 2.176214] rtc-m41t80 0-0068: setting system clock to 2020-11-21T15:02:18 UTC (1605970938) [ 2.176342] i2c i2c-0: IMX I2C adapter registered [ 2.179056] VDD_1V8: supplied by buck7 [ 2.179099] LCD_1V8: supplied by VDD_1V8 [ 2.179170] lcd_avdd: supplied by LCD_3V4 [ 2.179792] lcd_avee: supplied by LCD_3V4 [ 2.180622] i2c i2c-1: IMX I2C adapter registered [ 2.205264] i2c i2c-2: IMX I2C adapter registered [ 2.219802] i2c i2c-3: IMX I2C adapter registered [ 2.221870] led-backlight backlight-dsi: Not enough levels defined [ 2.225014] etnaviv etnaviv: bound 38000000.gpu (ops gpu_ops) [ 2.225025] etnaviv-gpu 38000000.gpu: model: GC7000, revision: 6214 [ 2.225472] [drm] Initialized etnaviv 1.3.0 20151214 for etnaviv on minor 0 [ 2.226619] spi_imx 30820000.spi: dma setup error -19, use pio [ 2.232529] flash@0 enforce active low on chipselect handle [ 2.232913] spi_imx 30820000.spi: probed [ 2.233257] imx-cpufreq-dt imx-cpufreq-dt: cpu speed grade 3 mkt segment 0 supported-hw 0x8 0x1 [ 2.235391] sdhci-esdhc-imx 30b50000.mmc: Got CD GPIO [ 2.264911] mmc1: SDHCI controller on 30b50000.mmc [30b50000.mmc] using ADMA [ 2.271001] nwl-dsi 30a00000.mipi-dsi: [drm:nwl_dsi_host_attach] lanes=4, format=0x0 flags=0x7 [ 2.271012] panel-mantix-mlaf057we51 30a00000.mipi-dsi.0: 720x1440@63 24bpp dsi 4dl - ready [ 2.271064] nwl-dsi 30a00000.mipi-dsi: [drm:nwl_dsi_probe] Using LCDIF as input source [ 2.273980] [drm] Initialized mxsfb-drm 1.0.0 20160824 for 30320000.lcd-controller on minor 1 [ 2.348303] mmc1: new high speed SDIO card at address fffd [ 2.456667] Console: switching to colour frame buffer device 90x90 [ 2.488524] mxsfb 30320000.lcd-controller: [drm] fb0: mxsfb-drmdrmfb frame buffer device [ 2.490098] input: gpio-keys as /devices/platform/gpio-keys/input/input0 [ 2.491871] input: bd718xx-pwrkey as /devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-004b/gpio-keys.0.auto/input1 [ 2.496675] Freeing unused kernel memory: 4032K [ 2.503863] Run /init as init process [ 2.503870] with arguments: [ 2.503873] /init [ 2.503877] ${console} [ 2.503880] splash [ 2.503883] with environment: [ 2.503886] HOME=/ [ 2.503889] TERM=linux [ 2.522234] max17042 3-0036: SOC threshold INTR [ 2.885547] imx8mq-usb-phy 381f0040.usb-phy: supply vbus not found, using dummy regulator [ 2.896239] OF: graph: no port node found in /soc@0/usb-phy@381f0040 [ 2.937844] usbcore: registered new interface driver usbfs [ 2.937880] usbcore: registered new interface driver hub [ 2.937965] usbcore: registered new device driver usb [ 2.945625] xhci-hcd xhci-hcd.4.auto: xHCI Host Controller [ 2.945648] xhci-hcd xhci-hcd.4.auto: new USB bus registered, assigned bus number 1 [ 2.945765] xhci-hcd xhci-hcd.4.auto: hcc params 0x0220fe6c hci version 0x110 quirks 0x0000000000010010 [ 2.945821] xhci-hcd xhci-hcd.4.auto: irq 51, io mem 0x38200000 [ 2.946091] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.09 [ 2.946095] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 2.946099] usb usb1: Product: xHCI Host Controller [ 2.946102] usb usb1: Manufacturer: Linux 5.9.0-1-librem5 xhci-hcd [ 2.946106] usb usb1: SerialNumber: xhci-hcd.4.auto [ 2.946473] hub 1-0:1.0: USB hub found [ 2.946494] hub 1-0:1.0: 1 port detected [ 2.946746] xhci-hcd xhci-hcd.4.auto: xHCI Host Controller [ 2.946755] xhci-hcd xhci-hcd.4.auto: new USB bus registered, assigned bus number 2 [ 2.946764] xhci-hcd xhci-hcd.4.auto: Host supports USB 3.0 SuperSpeed [ 2.946805] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. [ 2.946876] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.09 [ 2.946880] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 2.946884] usb usb2: Product: xHCI Host Controller [ 2.946887] usb usb2: Manufacturer: Linux 5.9.0-1-librem5 xhci-hcd [ 2.946890] usb usb2: SerialNumber: xhci-hcd.4.auto [ 2.947157] hub 2-0:1.0: USB hub found [ 2.947177] hub 2-0:1.0: 1 port detected [ 3.124486] max17042 3-0036: SOC threshold INTR [ 3.280343] usb 1-1: new high-speed USB device number 2 using xhci-hcd [ 3.430014] usb 1-1: New USB device found, idVendor=0424, idProduct=2640, bcdDevice= 9.02 [ 3.430021] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 3.492156] hub 1-1:1.0: USB hub found [ 3.492750] hub 1-1:1.0: 3 ports detected [ 3.784331] usb 1-1.1: new high-speed USB device number 3 using xhci-hcd [ 3.895345] usb 1-1.1: New USB device found, idVendor=0424, idProduct=4041, bcdDevice= 2.09 [ 3.895352] usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 3.895357] usb 1-1.1: Product: Ultra Fast Media Reader [ 3.895362] usb 1-1.1: Manufacturer: Generic [ 3.895368] usb 1-1.1: SerialNumber: 000008264001 [ 3.905871] usb-storage 1-1.1:1.0: USB Mass Storage device detected [ 3.906301] scsi host0: usb-storage 1-1.1:1.0 [ 3.906723] usbcore: registered new interface driver usb-storage [ 3.908205] usbcore: registered new interface driver uas [ 9.060321] usb 1-1.2: new high-speed USB device number 4 using xhci-hcd [ 9.161984] usb 1-1.2: New USB device found, idVendor=2020, idProduct=2060, bcdDevice= 0.00 [ 9.161994] usb 1-1.2: New USB device strings: Mfr=3, Product=2, SerialNumber=4 [ 9.162000] usb 1-1.2: Product: Qualcomm CDMA Technologies MSM [ 9.162005] usb 1-1.2: Manufacturer: Qualcomm, Incorporated [ 12.255789] mmc0: Timeout waiting for hardware interrupt. [ 12.261203] mmc0: sdhci: ============ SDHCI REGISTER DUMP =========== [ 12.267646] mmc0: sdhci: Sys addr: 0x00000800 | Version: 0x00000002 [ 12.274086] mmc0: sdhci: Blk size: 0x00000200 | Blk cnt: 0x00000001 [ 12.280527] mmc0: sdhci: Argument: 0x00000000 | Trn mode: 0x00000013 [ 12.286968] mmc0: sdhci: Present: 0x01f88a0a | Host ctl: 0x00000011 [ 12.293408] mmc0: sdhci: Power: 0x00000002 | Blk gap: 0x00000080 [ 12.299848] mmc0: sdhci: Wake-up: 0x00000008 | Clock: 0x000010ff [ 12.306288] mmc0: sdhci: Timeout: 0x0000008f | Int stat: 0x00000000 [ 12.312728] mmc0: sdhci: Int enab: 0x107f100b | Sig enab: 0x107f100b [ 12.319168] mmc0: sdhci: ACmd stat: 0x00000000 | Slot int: 0x00008402 [ 12.325609] mmc0: sdhci: Caps: 0x07eb0000 | Caps_1: 0x8000b407 [ 12.332049] mmc0: sdhci: Cmd: 0x0000083a | Max curr: 0x00ffffff [ 12.338489] mmc0: sdhci: Resp[0]: 0x00000900 | Resp[1]: 0xffffffff [ 12.344929] mmc0: sdhci: Resp[2]: 0x328f5903 | Resp[3]: 0x00d02700 [ 12.351369] mmc0: sdhci: Host ctl2: 0x00000000 [ 12.355812] mmc0: sdhci: ADMA Err: 0x00000001 | ADMA Ptr: 0xe3395200 [ 12.362252] mmc0: sdhci-esdhc-imx: ========= ESDHC IMX DEBUG STATUS DUMP ========= [ 12.369820] mmc0: sdhci-esdhc-imx: cmd debug status: 0x2100 [ 12.375476] mmc0: sdhci-esdhc-imx: data debug status: 0x2200 [ 12.381219] mmc0: sdhci-esdhc-imx: trans debug status: 0x2300 [ 12.387050] mmc0: sdhci-esdhc-imx: dma debug status: 0x2402 [ 12.392706] mmc0: sdhci-esdhc-imx: adma debug status: 0x2501 [ 12.398450] mmc0: sdhci-esdhc-imx: fifo debug status: 0x2610 [ 12.404193] mmc0: sdhci-esdhc-imx: async fifo debug status: 0x2751 [ 12.410456] mmc0: sdhci: ============================================ [ 12.418625] mmc0: error -110 whilst initialising MMC card [ 12.571745] mmc0: new HS400 MMC card at address 0001 [ 12.573003] mmcblk0: mmc0:0001 032G32 29.1 GiB [ 12.573263] mmcblk0boot0: mmc0:0001 032G32 partition 1 4.00 MiB [ 12.573505] mmcblk0boot1: mmc0:0001 032G32 partition 2 4.00 MiB [ 12.573677] mmcblk0rpmb: mmc0:0001 032G32 partition 3 4.00 MiB, chardev (245:0) [ 12.575700] mmcblk0: p1 p2 [ 13.594372] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [ 13.913356] NET: Registered protocol family 10 [ 13.914477] Segment Routing with IPv6 [ 13.935449] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +L) [ 13.936029] systemd[1]: Detected architecture arm64. [ 13.966632] systemd[1]: Set hostname to <pureos>. [ 13.967950] systemd[1]: Failed to bump fs.file-max, ignoring: Invalid argument [ 14.009206] scsi 0:0:0:0: Direct-Access Generic Ultra HS-SD/MMC 2.09 PQ: 0 ANSI: 0 [ 14.011679] sd 0:0:0:0: [sda] Attached SCSI removable disk [ 14.115242] random: lvmconfig: uninitialized urandom read (4 bytes read) [ 14.310555] random: systemd: uninitialized urandom read (16 bytes read) [ 14.314086] random: systemd: uninitialized urandom read (16 bytes read) [ 14.314130] systemd[1]: Reached target Swap. [ 14.314414] systemd[1]: Reached target Remote File Systems. [ 14.316768] systemd[1]: Created slice system-serial\x2dgetty.slice. [ 14.317253] systemd[1]: Listening on udev Control Socket. [ 14.317541] systemd[1]: Listening on LVM2 poll daemon socket. [ 14.318211] systemd[1]: Created slice User and Session Slice. [ 14.422956] EXT4-fs (mmcblk0p2): re-mounted. Opts: errors=remount-ro [ 14.426871] using random self ethernet address [ 14.426878] using random host ethernet address [ 14.438823] Mass Storage Function, version: 2009/09/11 [ 14.438832] LUN: removable file: (no medium) [ 14.438994] LUN: file: /var/lib/mass_storage_dummy [ 14.438996] Number of LUNs=1 [ 14.439500] usb0: HOST MAC fa:98:84:88:b4:c1 [ 14.439556] usb0: MAC 16:f9:c0:8c:39:98 [ 14.439740] g_multi gadget: Multifunction Composite Gadget [ 14.439745] g_multi gadget: userspace failed to provide iSerialNumber [ 14.439747] g_multi gadget: g_multi ready [ 14.554866] systemd-journald[306]: Received request to flush runtime journal from PID 1 [ 14.980000] input: pwm-vibrator as /devices/platform/vibrator/input/input2 [ 15.067614] imx-sdma 302c0000.sdma: Direct firmware load for imx/sdma/sdma-imx7d.bin failed with error -2 [ 15.067627] imx-sdma 302c0000.sdma: external firmware not found, using ROM firmware [ 15.077166] imx-sdma 30bd0000.sdma: Direct firmware load for imx/sdma/sdma-imx7d.bin failed with error -2 [ 15.077180] imx-sdma 30bd0000.sdma: external firmware not found, using ROM firmware [ 15.126542] caam 30900000.crypto: Entropy delay = 3200 [ 15.126625] caam 30900000.crypto: Entropy delay = 3600 [ 15.132131] input: 30370000.snvs:snvs-powerkey as /devices/platform/soc@0/30000000.bus/30370000.snvs/30370000.snvs:snvs-po3 [ 15.170744] wm8962_i2c_probe: 3555: defering probe [ 15.171915] spi-nor spi0.0: s25fl016k (2048 Kbytes) [ 15.177123] wm8962 2-001a: customer id 0 revision D [ 15.182041] edt_ft5x06 2-0038: probing for EDT FT5x06 I2C [ 15.190166] edt_ft5x06 2-0038: Model "EP0700M09", Rev. "", 0x0 sensors [ 15.190792] input: EP0700M09 as /devices/platform/soc@0/30800000.bus/30a40000.i2c/i2c-2/2-0038/input/input4 [ 15.190998] edt_ft5x06 2-0038: EDT FT5x06 initialized: IRQ 82, WAKE pin -1, Reset pin -1. [ 15.191403] random: crng init done [ 15.191407] random: 7 urandom warning(s) missed due to ratelimiting [ 15.194702] input: WM8962 Beep Generator as /devices/platform/soc@0/30800000.bus/30a40000.i2c/i2c-2/2-001a/input/input6 [ 15.196677] caam 30900000.crypto: Instantiated RNG4 SH0 [ 15.205881] power_supply bq25890-charger: power_supply_get_battery_info currently only supports devicetree [ 15.205892] bq25890-charger 3-006a: No battery found: -6 [ 15.209796] gnss: GNSS driver registered with major 241 [ 15.218674] wm8962 2-001a: ASoC: error at soc_component_read_no_lock on wm8962.2-001a: -16 [ 15.223959] tps6598x 0-003f: failed to register partner [ 15.227987] wm8962 2-001a: ASoC: error at snd_soc_component_update_bits on wm8962.2-001a: -16 [ 15.244392] input: wm8962 Headphones as /devices/platform/sound/sound/card1/input5 [ 15.261972] caam 30900000.crypto: Instantiated RNG4 SH1 [ 15.261987] caam 30900000.crypto: device ID = 0x0a16040100000000 (Era 9) [ 15.261991] caam 30900000.crypto: job rings = 3, qi = 0 [ 15.382445] usbcore: registered new interface driver usbserial_generic [ 15.382482] usbserial: USB Serial support registered for generic [ 15.396417] usbcore: registered new interface driver cdc_wdm [ 15.399630] usbcore: registered new interface driver option [ 15.399669] usbserial: USB Serial support registered for GSM modem (1-port) [ 15.434658] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 15.448441] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 15.448605] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 [ 15.448611] cfg80211: failed to load regulatory.db [ 15.468430] option 1-1.2:1.0: GSM modem (1-port) converter detected [ 15.468752] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0 [ 15.469050] option 1-1.2:1.1: GSM modem (1-port) converter detected [ 15.469247] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1 [ 15.491683] qmi_wwan 1-1.2:1.4: cdc-wdm0: USB WDM device [ 15.494446] qmi_wwan 1-1.2:1.4 wwan0: register 'qmi_wwan' at usb-xhci-hcd.4.auto-1.2, WWAN/QMI device, 32:02:14:27:24:45 [ 15.494611] usbcore: registered new interface driver qmi_wwan [ 15.494850] option 1-1.2:1.2: GSM modem (1-port) converter detected [ 15.495135] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2 [ 15.496794] option 1-1.2:1.3: GSM modem (1-port) converter detected [ 15.497213] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3 [ 15.586562] Bluetooth: Core ver 2.22 [ 15.586640] NET: Registered protocol family 31 [ 15.586643] Bluetooth: HCI device and connection manager initialized [ 15.586659] Bluetooth: HCI socket layer initialized [ 15.586665] Bluetooth: L2CAP socket layer initialized [ 15.586679] Bluetooth: SCO socket layer initialized [ 15.614107] redpine_91x: rsi_probe: ***** 9116 Module ***** [ 15.619965] redpine_91x: redpine_hal_device_init: oper_mode = 13, coex_mode = 2 [ 15.622259] redpine_91x: ***** Loading Firmware from Flash ***** [ 15.624454] redpine_91x: ***** Loaded Firmware to RAM - Waiting for Card Ready ***** [ 15.725843] caam algorithms registered in /proc/crypto [ 15.726663] caam 30900000.crypto: caam pkc algorithms registered in /proc/crypto [ 15.726679] caam 30900000.crypto: registering rng-caam [ 15.767415] mousedev: PS/2 mouse device common for all mice [ 15.912964] ext2 filesystem being mounted at /boot supports timestamps until 2038 (0x7fffffff) [ 16.062808] audit: type=1400 audit(1605970952.383:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.062826] audit: type=1400 audit(1605970952.383:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.062834] audit: type=1400 audit(1605970952.383:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.069821] audit: type=1400 audit(1605970952.391:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.070240] audit: type=1400 audit(1605970952.391:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.295721] audit: type=1400 audit(1605970952.615:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.295736] audit: type=1400 audit(1605970952.615:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.295743] audit: type=1400 audit(1605970952.615:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.295750] audit: type=1400 audit(1605970952.615:10): apparmor="STATUS" operation="profile_load" profile="unconfined" nam" [ 16.295757] audit: type=1400 audit(1605970952.615:11): apparmor="STATUS" operation="profile_load" profile="unconfined" nam" [ 18.174666] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 18.174689] Bluetooth: BNEP socket layer initialized [ 19.091867] redpine_91x: ================================================ [ 19.091874] redpine_91x: ================ RSI Version Info ============== [ 19.091876] redpine_91x: ================================================ [ 19.091883] redpine_91x: FW Version : 1.2.20.0 [ 19.091887] redpine_91x: Driver Version : RS9116.NB0.NL.PURISM.LNX.1.3 [ 19.091889] redpine_91x: Operating mode : 13 [Wi-Fi STA + BT DUAL] [ 19.091892] redpine_91x: ================================================ [ 19.092346] common dev config params : (length = 48) [ 19.092349] 20 00 28 00 00 00 00 00 00 00 00 00 00 00 00 00 [ 19.092362] 00 02 00 0f 00 fe 2e 00 00 0d 00 00 00 01 01 03 [ 19.092375] 00 00 00 00 00 00 01 00 13 00 00 00 01 00 00 00 [ 19.094349] redpine_91x: rsi_send_bt_reg_params: Sending BT reg frame [ 19.094362] BT REG PARAMS: (length = 21) [ 19.094364] 05 60 00 00 00 00 00 00 00 00 00 00 00 00 55 00 [ 19.094377] 00 00 01 1e 02 [ 19.094761] redpine_91x: RSI HCI DEVICE "hci0" open [ 19.103893] redpine_91x: HCI module init done... [ 19.114867] redpine_91x: Max Stations Allowed = 1 [ 19.159890] Bluetooth: RFCOMM TTY layer initialized [ 19.159914] Bluetooth: RFCOMM socket layer initialized [ 19.159948] Bluetooth: RFCOMM ver 1.11 [ 19.174553] redpine_91x: ===> Interface UP <=== [ 19.192874] redpine_91x: ===> Interface DOWN <=== [ 19.196928] redpine_91x: ===> Interface UP <=== [ 22.151572] rfkill: input handler disabled [ 23.136103] redpine_91x: ===> Interface DOWN <=== [ 23.140007] redpine_91x: ===> Interface UP <=== [ 26.816551] wlan0: authenticate with be:2e:48:be:2e:f1 [ 26.817613] wlan0: send auth to be:2e:48:be:2e:f1 (try 1/3) [ 27.019878] wlan0: send auth to be:2e:48:be:2e:f1 (try 2/3) [ 27.101299] wlan0: authenticated [ 27.103955] wlan0: associate with be:2e:48:be:2e:f1 (try 1/3) [ 27.108110] wlan0: RX AssocResp from be:2e:48:be:2e:f1 (capab=0x1411 status=0 aid=3) [ 27.109307] wlan0: associated [ 27.126401] redpine_91x: EAPOL 4 confirm [ 27.145108] redpine_91x: rsi_hal_key_config: Cipher 0xfac04 key_type: 1 key_len: 16 [ 27.145139] redpine_91x: rsi_mac80211_set_key: RSI set_key [ 27.146092] redpine_91x: rsi_hal_key_config: Cipher 0xfac04 key_type: 2 key_len: 16 [ 27.146111] redpine_91x: rsi_mac80211_set_key: RSI set_key [ 27.146508] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 27.224930] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.225788] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.226576] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.227411] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.228255] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.229103] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.229928] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.230772] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.231768] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.232641] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.233497] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.234242] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.235153] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.236483] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.236802] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.237640] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.238586] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.239424] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.241180] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.241193] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.241952] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.244480] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.244501] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.244506] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.245538] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.246290] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.247181] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.247979] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.248810] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.249671] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.250518] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.251876] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.252268] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.253291] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.254044] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.254883] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.255726] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.257101] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.257438] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.258280] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.259232] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.260063] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.260905] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.261730] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.262588] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.263425] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 33.759914] AUD_1V8: disabling [ 33.759927] VDD_SEN: disabling [ 33.759936] CAMERA_PWR_EN: disabling [ 33.759939] GNSS: disabling [ 33.759945] CAMERA1_PWR_EN: disabling [ 177.715541] max17042 3-0036: SOC threshold INTR [ 289.848536] max17042 3-0036: SOC threshold INTR [ 402.047902] max17042 3-0036: SOC threshold INTR [ 536.693407] max17042 3-0036: SOC threshold INTR [ 626.465693] max17042 3-0036: SOC threshold INTR [ 716.215458] max17042 3-0036: SOC threshold INTR [ 850.803304] max17042 3-0036: SOC threshold INTR [ 940.532295] max17042 3-0036: SOC threshold INTR [ 1075.149572] max17042 3-0036: SOC threshold INTR [ 1164.898264] max17042 3-0036: SOC threshold INTR [ 1299.493026] max17042 3-0036: SOC threshold INTR [ 1389.230894] max17042 3-0036: SOC threshold INTR [ 1478.971529] max17042 3-0036: SOC threshold INTR [ 1613.661491] max17042 3-0036: SOC threshold INTR [ 3492.353381] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 3559.569710] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 4124.326389] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 4996.452376] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 5193.132886] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 5266.255589] redpine_91x: rsi_mac80211_set_key: RSI del key [ 5266.255676] redpine_91x: rsi_hal_key_config: Cipher 0x0 key_type: 2 key_len: 0 [ 5266.258023] redpine_91x: rsi_mac80211_set_key: RSI del key [ 5266.258034] redpine_91x: rsi_hal_key_config: Cipher 0x0 key_type: 2 key_len: 0 [ 5270.038259] wlan0: authenticate with be:2e:48:be:2e:f1 [ 5270.040865] wlan0: send auth to be:2e:48:be:2e:f1 (try 1/3) [ 5270.247402] wlan0: send auth to be:2e:48:be:2e:f1 (try 2/3) [ 5270.450987] wlan0: send auth to be:2e:48:be:2e:f1 (try 3/3) [ 5270.655928] wlan0: authentication with be:2e:48:be:2e:f1 timed out [ 5275.386814] input: 74:6F:F7:C7:22:28 as /devices/virtual/input/input7 [ 5281.861779] redpine_91x: ===> Interface DOWN <=== [ 5281.867878] redpine_91x: ===> Interface UP <=== [ 5295.288923] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 5622.823653] redpine_91x: ===> Interface DOWN <=== [ 5622.853024] redpine_91x: ===> Interface UP <=== [ 5769.822398] max17042 3-0036: SOC threshold INTR [ 5930.517040] input: 74:6F:F7:C7:22:28 as /devices/virtual/input/input8 [ 5938.764129] redpine_91x: ===> Interface DOWN <=== [ 5938.765803] redpine_91x: ===> Interface UP <=== [ 5958.525401] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6135.922512] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6191.095917] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6253.814264] redpine_91x: ===> Interface DOWN <=== [ 6253.841078] redpine_91x: ===> Interface UP <=== [ 6309.020675] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6341.325299] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6351.666838] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6568.803572] redpine_91x: ===> Interface DOWN <=== [ 6568.825179] redpine_91x: ===> Interface UP <=== [ 6884.738409] redpine_91x: ===> Interface DOWN <=== [ 6884.755520] redpine_91x: ===> Interface UP <=== [ 7190.591073] max17042 3-0036: SOC threshold INTR [ 7200.783952] redpine_91x: ===> Interface DOWN <=== [ 7200.804505] redpine_91x: ===> Interface UP <=== [ 7516.771832] redpine_91x: ===> Interface DOWN <=== [ 7516.783725] redpine_91x: ===> Interface UP <=== [ 7832.718940] redpine_91x: ===> Interface DOWN <=== [ 7832.734630] redpine_91x: ===> Interface UP <=== [ 8148.722133] redpine_91x: ===> Interface DOWN <=== [ 8148.757958] redpine_91x: ===> Interface UP <=== [ 8459.176197] max17042 3-0036: SOC threshold INTR [ 8464.728034] redpine_91x: ===> Interface DOWN <=== [ 8464.740329] redpine_91x: ===> Interface UP <=== [ 8525.802669] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 8780.710516] redpine_91x: ===> Interface DOWN <=== [ 8780.724535] redpine_91x: ===> Interface UP <=== [ 9095.717951] redpine_91x: ===> Interface DOWN <=== [ 9095.743561] redpine_91x: ===> Interface UP <=== [ 9410.651424] redpine_91x: ===> Interface DOWN <=== [ 9410.671074] redpine_91x: ===> Interface UP <=== [ 9725.695546] redpine_91x: ===> Interface DOWN <=== [ 9725.710512] redpine_91x: ===> Interface UP <=== [ 9751.673379] max17042 3-0036: SOC threshold INTR [10040.630327] redpine_91x: ===> Interface DOWN <=== [10040.646647] redpine_91x: ===> Interface UP <=== [10171.943312] usb 1-1.2: reset high-speed USB device number 4 using xhci-hcd [10172.084060] usb 1-1.2: USB disconnect, device number 4 [10172.089318] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 [10172.089795] option 1-1.2:1.0: device disconnected [10172.097216] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 [10172.097609] option 1-1.2:1.1: device disconnected [10172.102830] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 [10172.103435] option 1-1.2:1.2: device disconnected [10172.117318] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 [10172.117920] option 1-1.2:1.3: device disconnected [10172.120368] qmi_wwan 1-1.2:1.4 wwan0: unregister 'qmi_wwan' usb-xhci-hcd.4.auto-1.2, WWAN/QMI device [10172.444583] usb 1-1.2: new high-speed USB device number 5 using xhci-hcd [10172.557425] usb 1-1.2: New USB device found, idVendor=2020, idProduct=2060, bcdDevice= 0.00 [10172.557489] usb 1-1.2: New USB device strings: Mfr=3, Product=2, SerialNumber=4 [10172.557504] usb 1-1.2: Product: Qualcomm CDMA Technologies MSM [10172.557508] usb 1-1.2: Manufacturer: Qualcomm, Incorporated [10172.688226] option 1-1.2:1.0: GSM modem (1-port) converter detected [10172.692911] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0 [10172.697542] option 1-1.2:1.1: GSM modem (1-port) converter detected [10172.700846] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1 [10172.704031] option 1-1.2:1.2: GSM modem (1-port) converter detected [10172.706147] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2 [10172.709294] option 1-1.2:1.3: GSM modem (1-port) converter detected [10172.711529] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3 [10172.750144] qmi_wwan 1-1.2:1.4: cdc-wdm0: USB WDM device [10172.772316] qmi_wwan 1-1.2:1.4 wwan0: register 'qmi_wwan' at usb-xhci-hcd.4.auto-1.2, WWAN/QMI device, 32:02:14:27:24:45 [10355.675084] redpine_91x: ===> Interface DOWN <=== [10355.687787] redpine_91x: ===> Interface UP <=== [10670.664679] redpine_91x: ===> Interface DOWN <=== [10670.691508] redpine_91x: ===> Interface UP <=== [10961.282416] max17042 3-0036: SOC threshold INTR [10985.601726] redpine_91x: ===> Interface DOWN <=== [10985.626193] redpine_91x: ===> Interface UP <=== [11300.641950] redpine_91x: ===> Interface DOWN <=== [11300.670087] redpine_91x: ===> Interface UP <=== [11615.632314] redpine_91x: ===> Interface DOWN <=== [11615.647906] redpine_91x: ===> Interface UP <=== [11931.573025] redpine_91x: ===> Interface DOWN <=== [11931.587516] redpine_91x: ===> Interface UP <=== [12117.644779] max17042 3-0036: SOC threshold INTR [12246.583710] redpine_91x: ===> Interface DOWN <=== [12246.605756] redpine_91x: ===> Interface UP <=== [12561.551892] redpine_91x: ===> Interface DOWN <=== [12561.570117] redpine_91x: ===> Interface UP <=== [12624.338170] usb 1-1.2: reset high-speed USB device number 5 using xhci-hcd [12624.457504] usb 1-1.2: USB disconnect, device number 5 [12624.464771] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 [12624.465148] option 1-1.2:1.0: device disconnected [12624.469494] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 [12624.469728] option 1-1.2:1.1: device disconnected [12624.472806] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 [12624.473003] option 1-1.2:1.2: device disconnected [12624.474732] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 [12624.474944] option 1-1.2:1.3: device disconnected [12624.476362] qmi_wwan 1-1.2:1.4 wwan0: unregister 'qmi_wwan' usb-xhci-hcd.4.auto-1.2, WWAN/QMI device [12624.777771] usb 1-1.2: new high-speed USB device number 6 using xhci-hcd [12624.885479] usb 1-1.2: New USB device found, idVendor=2020, idProduct=2060, bcdDevice= 0.00 [12624.885574] usb 1-1.2: New USB device strings: Mfr=3, Product=2, SerialNumber=4 [12624.885582] usb 1-1.2: Product: Qualcomm CDMA Technologies MSM [12624.885597] usb 1-1.2: Manufacturer: Qualcomm, Incorporated [12625.004164] option 1-1.2:1.0: GSM modem (1-port) converter detected [12625.012711] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0 [12625.016844] option 1-1.2:1.1: GSM modem (1-port) converter detected [12625.026558] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1 [12625.030887] option 1-1.2:1.2: GSM modem (1-port) converter detected [12625.040322] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2 [12625.045810] option 1-1.2:1.3: GSM modem (1-port) converter detected [12625.053200] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3 [12625.116451] qmi_wwan 1-1.2:1.4: cdc-wdm0: USB WDM device [12625.123295] qmi_wwan 1-1.2:1.4 wwan0: register 'qmi_wwan' at usb-xhci-hcd.4.auto-1.2, WWAN/QMI device, 32:02:14:27:24:45 [12876.589791] redpine_91x: ===> Interface DOWN <=== [12876.605076] redpine_91x: ===> Interface UP <=== [13156.020241] max17042 3-0036: SOC threshold INTR [13179.703714] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [13191.552449] redpine_91x: ===> Interface DOWN <=== [13191.554126] redpine_91x: ===> Interface UP <=== [13261.321194] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [13506.567780] redpine_91x: ===> Interface DOWN <=== [13506.585935] redpine_91x: ===> Interface UP <=== [13821.502821] redpine_91x: ===> Interface DOWN <=== [13821.523571] redpine_91x: ===> Interface UP <=== [14137.496629] redpine_91x: ===> Interface DOWN <=== [14137.520627] redpine_91x: ===> Interface UP <=== [14159.477260] input: 74:6F:F7:C7:22:28 as /devices/virtual/input/input9 [14182.340083] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [14234.725790] max17042 3-0036: SOC threshold INTR [14453.501028] redpine_91x: ===> Interface DOWN <=== [14453.523963] redpine_91x: ===> Interface UP <=== [14753.375099] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [14768.474759] redpine_91x: ===> Interface DOWN <=== [14768.490154] redpine_91x: ===> Interface UP <=== [15084.458289] redpine_91x: ===> Interface DOWN <=== [15084.487654] redpine_91x: ===> Interface UP <=== [15400.447486] redpine_91x: ===> Interface DOWN <=== [15400.477343] redpine_91x: ===> Interface UP <=== [15434.099443] max17042 3-0036: SOC threshold INTR [15716.437888] redpine_91x: ===> Interface DOWN <=== [15716.456376] redpine_91x: ===> Interface UP <=== [16031.482012] redpine_91x: ===> Interface DOWN <=== [16031.493799] redpine_91x: ===> Interface UP <=== [16347.470439] redpine_91x: ===> Interface DOWN <=== [16347.482329] redpine_91x: ===> Interface UP <=== [16636.478241] max17042 3-0036: SOC threshold INTR [16663.447448] redpine_91x: ===> Interface DOWN <=== [16663.459584] redpine_91x: ===> Interface UP <=== [16979.393110] redpine_91x: ===> Interface DOWN <=== [16979.421026] redpine_91x: ===> Interface UP <=== [17294.396543] redpine_91x: ===> Interface DOWN <=== [17294.420760] redpine_91x: ===> Interface UP <=== [17609.371145] redpine_91x: ===> Interface DOWN <=== [17609.384611] redpine_91x: ===> Interface UP <=== [17823.966448] max17042 3-0036: SOC threshold INTR [17894.376976] input: 74:6F:F7:C7:22:28 as /devices/virtual/input/input10 [17917.411116] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [17925.375812] redpine_91x: ===> Interface DOWN <=== [17925.390707] redpine_91x: ===> Interface UP <=== [18118.703565] redpine_91x: ===> Interface DOWN <=== [18118.706895] redpine_91x: ===> Interface UP <=== [18118.756132] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [18122.035982] wlan0: authenticate with be:2e:48:be:2e:f1 [18122.038190] wlan0: send auth to be:2e:48:be:2e:f1 (try 1/3) [18122.054448] wlan0: authenticated [18122.061927] wlan0: associate with be:2e:48:be:2e:f1 (try 1/3) [18122.082506] wlan0: RX AssocResp from be:2e:48:be:2e:f1 (capab=0x1411 status=0 aid=3) [18122.084798] wlan0: associated [18122.173799] redpine_91x: rsi_hal_key_config: Cipher 0xfac04 key_type: 1 key_len: 16 [18122.174012] redpine_91x: EAPOL 4 confirm [18122.174097] redpine_91x: rsi_mac80211_set_key: RSI set_key [18122.188439] redpine_91x: rsi_hal_key_config: Cipher 0xfac04 key_type: 2 key_len: 16 [18122.188651] redpine_91x: rsi_mac80211_set_key: RSI set_key [18122.191904] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [18122.313171] redpine_91x: Packet Dropped as RX PN is less than last received PN [18458.571718] IPv6: ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [18458.699245] NOHZ: local_softirq_pending 08 [18458.699251] NOHZ: local_softirq_pending 08 [18458.882039] NOHZ: local_softirq_pending 08 [18458.895389] NOHZ: local_softirq_pending 08 [18458.895394] NOHZ: local_softirq_pending 08 [18459.139520] NOHZ: local_softirq_pending 08 [18459.139527] NOHZ: local_softirq_pending 08 [18459.395372] NOHZ: local_softirq_pending 08 [18459.395381] NOHZ: local_softirq_pending 08 [18459.951327] NOHZ: local_softirq_pending 08 [18478.409533] dwc3 38100000.usb: request 00000000d2b8447c was not queued to ep3in [18532.108291] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [18666.038538] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [18739.641374] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [18873.143155] max17042 3-0036: SOC threshold INTR [19515.131402] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [19860.939543] max17042 3-0036: SOC threshold INTR [19902.835933] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20084.359157] dwc3 38100000.usb: request 0000000096439b22 was not queued to ep3in [20096.377209] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20180.806224] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20262.775018] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20370.238647] dwc3 38100000.usb: request 000000006fb38003 was not queued to ep3in [20459.979366] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20556.419756] dwc3 38100000.usb: request 00000000300d2d70 was not queued to ep3in [20559.526755] max17042 3-0036: SOC threshold INTR [20640.570445] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20835.534443] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20933.439618] dwc3 38100000.usb: request 00000000249ae05a was not queued to ep3in [20951.698964] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [21336.631671] max17042 3-0036: SOC threshold INTR [21403.112606] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [21458.987246] edt_ft5x06 2-0038: Unable to fetch data, error: -6 ==> /sys/class/power_supply/bq25890-charger/uevent <== POWER_SUPPLY_NAME=bq25890-charger POWER_SUPPLY_TYPE=USB POWER_SUPPLY_MANUFACTURER=Texas Instruments POWER_SUPPLY_MODEL_NAME=BQ25895 POWER_SUPPLY_STATUS=Charging POWER_SUPPLY_CHARGE_TYPE=Fast POWER_SUPPLY_ONLINE=1 POWER_SUPPLY_HEALTH=Good POWER_SUPPLY_CONSTANT_CHARGE_CURRENT_MAX=1472000 POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE=3964000 POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE_MAX=4192000 POWER_SUPPLY_PRECHARGE_CURRENT=128000 POWER_SUPPLY_CHARGE_TERM_CURRENT=128000 POWER_SUPPLY_INPUT_CURRENT_LIMIT=500000 POWER_SUPPLY_VOLTAGE_NOW=3984000 POWER_SUPPLY_CURRENT_NOW=-350000 ==> /sys/class/power_supply/max170xx_battery/uevent <== POWER_SUPPLY_NAME=max170xx_battery POWER_SUPPLY_TYPE=Battery POWER_SUPPLY_STATUS=Unknown POWER_SUPPLY_PRESENT=1 POWER_SUPPLY_TECHNOLOGY=Li-ion POWER_SUPPLY_CYCLE_COUNT=143 POWER_SUPPLY_VOLTAGE_MAX=4200000 POWER_SUPPLY_VOLTAGE_MIN=3100000 POWER_SUPPLY_VOLTAGE_MIN_DESIGN=3300000 POWER_SUPPLY_VOLTAGE_NOW=3918750 POWER_SUPPLY_VOLTAGE_AVG=3959765 POWER_SUPPLY_VOLTAGE_OCV=3837265 POWER_SUPPLY_CAPACITY=73 POWER_SUPPLY_CHARGE_FULL_DESIGN=3000000 POWER_SUPPLY_CHARGE_FULL=2621000 POWER_SUPPLY_CHARGE_NOW=1926000 POWER_SUPPLY_CHARGE_COUNTER=32593500 POWER_SUPPLY_TEMP=352 POWER_SUPPLY_TEMP_ALERT_MIN=-1280 POWER_SUPPLY_TEMP_ALERT_MAX=1270 POWER_SUPPLY_TEMP_MIN=-2147483648 POWER_SUPPLY_TEMP_MAX=700 POWER_SUPPLY_HEALTH=Good POWER_SUPPLY_SCOPE=System POWER_SUPPLY_CURRENT_NOW=53976 POWER_SUPPLY_CURRENT_AVG=151320 POWER_SUPPLY_TIME_TO_EMPTY_NOW=368634 ==> /sys/class/power_supply/tcpm-source-psy-0-003f/uevent <== POWER_SUPPLY_NAME=tcpm-source-psy-0-003f POWER_SUPPLY_TYPE=USB POWER_SUPPLY_USB_TYPE=[C] PD PD_DRP PD_PPS POWER_SUPPLY_ONLINE=1 Device: /org/freedesktop/UPower/devices/line_power_tcpm_source_psy_0_003f native-path: tcpm-source-psy-0-003f power supply: yes updated: Sat Nov 21 13:01:03 2020 (35 seconds ago) has history: no has statistics: no line-power warning-level: none online: yes icon-name: 'ac-adapter-symbolic' Device: /org/freedesktop/UPower/devices/battery_max170xx_battery native-path: max170xx_battery power supply: yes updated: Sat Nov 21 13:01:03 2020 (35 seconds ago) has history: yes has statistics: yes battery present: yes rechargeable: yes state: charging warning-level: none energy: 6.3525 Wh energy-empty: 0 Wh energy-full: 9.9 Wh energy-full-design: 9.9 Wh energy-rate: 0.215186 W voltage: 3.87281 V time to full: 16.5 hours percentage: 73% temperature: 33.6 degrees C capacity: 100% technology: lithium-ion icon-name: 'battery-full-charging-symbolic' History (rate): 1605992463 0.215 charging 1605992462 0.794 discharging 1605992462 0.769 discharging 1605992459 0.853 discharging 1605992459 0.575 discharging 1605992459 0.382 charging 1605992459 0.505 charging 1605992444 0.941 charging Device: /org/freedesktop/UPower/devices/battery_bq25890_charger native-path: bq25890-charger vendor: Texas Instruments model: BQ25895 power supply: yes updated: Sat Nov 21 13:01:03 2020 (35 seconds ago) has history: yes has statistics: yes battery present: yes rechargeable: yes state: charging warning-level: none energy: 0 Wh energy-empty: 0 Wh energy-full: 0 Wh energy-full-design: 0 Wh energy-rate: 0 W voltage: 3.924 V percentage: 0% capacity: 100% icon-name: 'battery-caution-charging-symbolic' Device: /org/freedesktop/UPower/devices/DisplayDevice power supply: yes updated: Sat Nov 21 13:01:03 2020 (35 seconds ago) has history: no has statistics: no battery present: yes state: charging warning-level: none energy: 6.3525 Wh energy-full: 9.9 Wh energy-rate: 0.215186 W time to full: 16.5 hours percentage: 64.1667% icon-name: 'battery-full-charging-symbolic' Daemon: daemon-version: 0.99.10 on-battery: no lid-is-closed: no lid-is-present: no critical-action: PowerOff purism@pureos:~/tmp$
- Author
And after unplugging:
purism@pureos:~/tmp$ cat *-unplugged* [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034] [ 0.000000] Linux version 5.9.0-1-librem5 (builder@cumin-amber-phone-staging-arm64-jhpb) (aarch64-linux-gnu-gcc (Debian 8.0 [ 0.000000] Machine model: Purism Librem 5r4 [ 0.000000] cma: Reserved 320 MiB at 0x00000000ea400000 [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] [ 0.000000] DMA32 [mem 0x0000000080000000-0x00000000ffffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000ffffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000ffffffff] [ 0.000000] On node 0 totalpages: 786432 [ 0.000000] DMA zone: 4096 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 262144 pages, LIFO batch:63 [ 0.000000] DMA32 zone: 8192 pages used for memmap [ 0.000000] DMA32 zone: 524288 pages, LIFO batch:63 [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: SMC Calling Convention v1.1 [ 0.000000] percpu: Embedded 31 pages/cpu s88792 r8192 d29992 u126976 [ 0.000000] pcpu-alloc: s88792 r8192 d29992 u126976 alloc=31*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Detected VIPT I-cache on CPU0 [ 0.000000] CPU features: detected: ARM erratum 845719 [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] Speculative Store Bypass Disable mitigation not required [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 774144 [ 0.000000] Kernel command line: ${console} console=ttymxc0,115200 quiet fsck.repair=yes security=apparmor splash plymouth2 [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] software IO TLB: mapped [mem 0x7bfff000-0x7ffff000] (64MB) [ 0.000000] Memory: 2651956K/3145728K available (11262K kernel code, 1632K rwdata, 4540K rodata, 4032K init, 577K bss, 166) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] ftrace: allocating 37481 entries in 147 pages [ 0.000000] ftrace: allocated 147 pages with 4 groups [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv3: GIC: Using split EOI/Deactivate mode [ 0.000000] GICv3: 128 SPIs implemented [ 0.000000] GICv3: 0 Extended SPIs implemented [ 0.000000] GICv3: Distributor has no Range Selector support [ 0.000000] GICv3: 16 PPIs implemented [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000038880000 [ 0.000000] ITS: No ITS available, not enabling LPIs [ 0.000000] random: get_random_bytes called from start_kernel+0x3c8/0x578 with crng_init=0 [ 0.000000] arch_timer: cp15 timer(s) running at 8.33MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1ec0311ec, max_idle_ns: 440795202152 ns [ 0.000004] sched_clock: 56 bits at 8MHz, resolution 120ns, wraps every 2199023255541ns [ 0.000465] Console: colour dummy device 80x25 [ 0.000503] Calibrating delay loop (skipped), value calculated using timer frequency.. 16.66 BogoMIPS (lpj=33333) [ 0.000512] pid_max: default: 32768 minimum: 301 [ 0.000619] LSM: Security Framework initializing [ 0.000704] AppArmor: AppArmor initialized [ 0.000756] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.000776] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.002254] rcu: Hierarchical SRCU implementation. [ 0.003196] smp: Bringing up secondary CPUs ... [ 0.003720] Detected VIPT I-cache on CPU1 [ 0.003753] GICv3: CPU1: found redistributor 1 region 0:0x00000000388a0000 [ 0.003784] CPU1: Booted secondary processor 0x0000000001 [0x410fd034] [ 0.004396] Detected VIPT I-cache on CPU2 [ 0.004416] GICv3: CPU2: found redistributor 2 region 0:0x00000000388c0000 [ 0.004434] CPU2: Booted secondary processor 0x0000000002 [0x410fd034] [ 0.004981] Detected VIPT I-cache on CPU3 [ 0.004999] GICv3: CPU3: found redistributor 3 region 0:0x00000000388e0000 [ 0.005018] CPU3: Booted secondary processor 0x0000000003 [0x410fd034] [ 0.005097] smp: Brought up 1 node, 4 CPUs [ 0.005101] SMP: Total of 4 processors activated. [ 0.005106] CPU features: detected: 32-bit EL0 Support [ 0.005110] CPU features: detected: CRC32 instructions [ 0.013930] CPU: All CPU(s) started at EL2 [ 0.013955] alternatives: patching kernel code [ 0.015548] devtmpfs: initialized [ 0.023898] KASLR disabled due to lack of seed [ 0.024324] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.024338] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.033817] pinctrl core: initialized pinctrl subsystem [ 0.034920] NET: Registered protocol family 16 [ 0.036566] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.036646] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.036816] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.036881] audit: initializing netlink subsys (disabled) [ 0.037029] audit: type=2000 audit(0.036:1): state=initialized audit_enabled=0 res=1 [ 0.037510] thermal_sys: Registered thermal governor 'step_wise' [ 0.037513] thermal_sys: Registered thermal governor 'power_allocator' [ 0.037981] cpuidle: using governor menu [ 0.038205] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.038279] ASID allocator initialised with 65536 entries [ 0.038371] Serial: AMBA PL011 UART driver [ 0.066725] imx8mq-pinctrl 30330000.pinctrl: initialized IMX pinctrl driver [ 0.073410] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.073419] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.073423] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.073428] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.074810] cryptd: max_cpu_qlen set to 1000 [ 0.081227] iommu: Default domain type: Translated [ 0.081390] vgaarb: loaded [ 0.081684] SCSI subsystem initialized [ 0.081724] libata version 3.00 loaded. [ 0.082645] pps_core: LinuxPPS API ver. 1 registered [ 0.082649] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> [ 0.082662] PTP clock support registered [ 0.083784] clocksource: Switched to clocksource arch_sys_counter [ 1.072069] VFS: Disk quotas dquot_6.6.0 [ 1.072125] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 1.072675] AppArmor: AppArmor Filesystem Enabled [ 1.078856] NET: Registered protocol family 2 [ 1.079366] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 1.079424] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 1.079670] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 1.080199] TCP: Hash tables configured (established 32768 bind 32768) [ 1.080303] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 1.080392] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 1.080593] NET: Registered protocol family 1 [ 1.081027] RPC: Registered named UNIX socket transport module. [ 1.081030] RPC: Registered udp transport module. [ 1.081033] RPC: Registered tcp transport module. [ 1.081036] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.081046] PCI: CLS 0 bytes, default 64 [ 1.081209] Unpacking initramfs... [ 1.805373] Freeing initrd memory: 15788K [ 1.806133] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available [ 1.808575] Initialise system trusted keyrings [ 1.808688] workingset: timestamp_bits=46 max_order=20 bucket_order=0 [ 1.813828] zbud: loaded [ 1.814971] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 1.815536] NFS: Registering the id_resolver key type [ 1.815556] Key type id_resolver registered [ 1.815559] Key type id_legacy registered [ 1.815644] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 1.858614] Key type asymmetric registered [ 1.858619] Asymmetric key parser 'x509' registered [ 1.858651] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) [ 1.865610] clk: failed to reparent audio_pll1 to sys1_pll_800m: -22 [ 1.865628] clk: failed to reparent audio_pll2 to arm_pll_out: -22 [ 1.867993] SoC: i.MX8MQ revision 2.1 [ 1.871284] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 1.873323] 30860000.serial: ttymxc0 at MMIO 0x30860000 (irq = 33, base_baud = 1562500) is a IMX [ 1.885951] printk: console [ttymxc0] enabled [ 1.886500] 30880000.serial: ttymxc2 at MMIO 0x30880000 (irq = 34, base_baud = 1562500) is a IMX [ 1.887035] 30890000.serial: ttymxc1 at MMIO 0x30890000 (irq = 35, base_baud = 1562500) is a IMX [ 1.887148] serial serial0: tty port ttymxc1 registered [ 1.887586] 30a60000.serial: ttymxc3 at MMIO 0x30a60000 (irq = 43, base_baud = 1562500) is a IMX [ 1.896781] loop: module loaded [ 1.898082] spi_imx 30820000.spi: dma setup error -19, use pio [ 1.904014] spi_imx 30820000.spi: bitbang start failed with -517 [ 1.910752] libphy: Fixed MDIO Bus: probed [ 1.911300] i2c /dev entries driver [ 1.923400] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initialised: dm-devel@redhat.com [ 1.924647] sdhci: Secure Digital Host Controller Interface driver [ 1.924649] sdhci: Copyright(c) Pierre Ossman [ 1.924669] sdhci-pltfm: SDHCI platform and OF driver helper [ 1.957958] mmc0: SDHCI controller on 30b40000.mmc [30b40000.mmc] using ADMA [ 1.962363] ledtrig-cpu: registered to indicate activity on CPUs [ 1.962652] hid: raw HID events driver (C) Jiri Kosina [ 1.964325] ashmem: initialized [ 1.969671] NET: Registered protocol family 26 [ 1.969798] NET: Registered protocol family 17 [ 1.970066] 9pnet: Installing 9P2000 support [ 1.970118] Key type dns_resolver registered [ 1.970986] registered taskstats version 1 [ 1.970997] Loading compiled-in X.509 certificates [ 1.971083] zswap: loaded using pool lzo/zbud [ 1.971327] Key type ._fscrypt registered [ 1.971331] Key type .fscrypt registered [ 1.971334] Key type fscrypt-provisioning registered [ 1.971492] AppArmor: AppArmor sha1 policy hashing enabled [ 1.997854] AUD_1V8: supplied by AUDIO_PWR_EN [ 1.999102] LCD_3V4: supplied by VSYS_3V4 [ 2.104212] ldo5: supplied by buck6 [ 2.111537] ldo6: supplied by buck7 [ 2.150158] random: fast init done [ 2.167522] rtc-m41t80 0-0068: registered as rtc0 [ 2.176214] rtc-m41t80 0-0068: setting system clock to 2020-11-21T15:02:18 UTC (1605970938) [ 2.176342] i2c i2c-0: IMX I2C adapter registered [ 2.179056] VDD_1V8: supplied by buck7 [ 2.179099] LCD_1V8: supplied by VDD_1V8 [ 2.179170] lcd_avdd: supplied by LCD_3V4 [ 2.179792] lcd_avee: supplied by LCD_3V4 [ 2.180622] i2c i2c-1: IMX I2C adapter registered [ 2.205264] i2c i2c-2: IMX I2C adapter registered [ 2.219802] i2c i2c-3: IMX I2C adapter registered [ 2.221870] led-backlight backlight-dsi: Not enough levels defined [ 2.225014] etnaviv etnaviv: bound 38000000.gpu (ops gpu_ops) [ 2.225025] etnaviv-gpu 38000000.gpu: model: GC7000, revision: 6214 [ 2.225472] [drm] Initialized etnaviv 1.3.0 20151214 for etnaviv on minor 0 [ 2.226619] spi_imx 30820000.spi: dma setup error -19, use pio [ 2.232529] flash@0 enforce active low on chipselect handle [ 2.232913] spi_imx 30820000.spi: probed [ 2.233257] imx-cpufreq-dt imx-cpufreq-dt: cpu speed grade 3 mkt segment 0 supported-hw 0x8 0x1 [ 2.235391] sdhci-esdhc-imx 30b50000.mmc: Got CD GPIO [ 2.264911] mmc1: SDHCI controller on 30b50000.mmc [30b50000.mmc] using ADMA [ 2.271001] nwl-dsi 30a00000.mipi-dsi: [drm:nwl_dsi_host_attach] lanes=4, format=0x0 flags=0x7 [ 2.271012] panel-mantix-mlaf057we51 30a00000.mipi-dsi.0: 720x1440@63 24bpp dsi 4dl - ready [ 2.271064] nwl-dsi 30a00000.mipi-dsi: [drm:nwl_dsi_probe] Using LCDIF as input source [ 2.273980] [drm] Initialized mxsfb-drm 1.0.0 20160824 for 30320000.lcd-controller on minor 1 [ 2.348303] mmc1: new high speed SDIO card at address fffd [ 2.456667] Console: switching to colour frame buffer device 90x90 [ 2.488524] mxsfb 30320000.lcd-controller: [drm] fb0: mxsfb-drmdrmfb frame buffer device [ 2.490098] input: gpio-keys as /devices/platform/gpio-keys/input/input0 [ 2.491871] input: bd718xx-pwrkey as /devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-004b/gpio-keys.0.auto/input1 [ 2.496675] Freeing unused kernel memory: 4032K [ 2.503863] Run /init as init process [ 2.503870] with arguments: [ 2.503873] /init [ 2.503877] ${console} [ 2.503880] splash [ 2.503883] with environment: [ 2.503886] HOME=/ [ 2.503889] TERM=linux [ 2.522234] max17042 3-0036: SOC threshold INTR [ 2.885547] imx8mq-usb-phy 381f0040.usb-phy: supply vbus not found, using dummy regulator [ 2.896239] OF: graph: no port node found in /soc@0/usb-phy@381f0040 [ 2.937844] usbcore: registered new interface driver usbfs [ 2.937880] usbcore: registered new interface driver hub [ 2.937965] usbcore: registered new device driver usb [ 2.945625] xhci-hcd xhci-hcd.4.auto: xHCI Host Controller [ 2.945648] xhci-hcd xhci-hcd.4.auto: new USB bus registered, assigned bus number 1 [ 2.945765] xhci-hcd xhci-hcd.4.auto: hcc params 0x0220fe6c hci version 0x110 quirks 0x0000000000010010 [ 2.945821] xhci-hcd xhci-hcd.4.auto: irq 51, io mem 0x38200000 [ 2.946091] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.09 [ 2.946095] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 2.946099] usb usb1: Product: xHCI Host Controller [ 2.946102] usb usb1: Manufacturer: Linux 5.9.0-1-librem5 xhci-hcd [ 2.946106] usb usb1: SerialNumber: xhci-hcd.4.auto [ 2.946473] hub 1-0:1.0: USB hub found [ 2.946494] hub 1-0:1.0: 1 port detected [ 2.946746] xhci-hcd xhci-hcd.4.auto: xHCI Host Controller [ 2.946755] xhci-hcd xhci-hcd.4.auto: new USB bus registered, assigned bus number 2 [ 2.946764] xhci-hcd xhci-hcd.4.auto: Host supports USB 3.0 SuperSpeed [ 2.946805] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. [ 2.946876] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.09 [ 2.946880] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 2.946884] usb usb2: Product: xHCI Host Controller [ 2.946887] usb usb2: Manufacturer: Linux 5.9.0-1-librem5 xhci-hcd [ 2.946890] usb usb2: SerialNumber: xhci-hcd.4.auto [ 2.947157] hub 2-0:1.0: USB hub found [ 2.947177] hub 2-0:1.0: 1 port detected [ 3.124486] max17042 3-0036: SOC threshold INTR [ 3.280343] usb 1-1: new high-speed USB device number 2 using xhci-hcd [ 3.430014] usb 1-1: New USB device found, idVendor=0424, idProduct=2640, bcdDevice= 9.02 [ 3.430021] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 3.492156] hub 1-1:1.0: USB hub found [ 3.492750] hub 1-1:1.0: 3 ports detected [ 3.784331] usb 1-1.1: new high-speed USB device number 3 using xhci-hcd [ 3.895345] usb 1-1.1: New USB device found, idVendor=0424, idProduct=4041, bcdDevice= 2.09 [ 3.895352] usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 3.895357] usb 1-1.1: Product: Ultra Fast Media Reader [ 3.895362] usb 1-1.1: Manufacturer: Generic [ 3.895368] usb 1-1.1: SerialNumber: 000008264001 [ 3.905871] usb-storage 1-1.1:1.0: USB Mass Storage device detected [ 3.906301] scsi host0: usb-storage 1-1.1:1.0 [ 3.906723] usbcore: registered new interface driver usb-storage [ 3.908205] usbcore: registered new interface driver uas [ 9.060321] usb 1-1.2: new high-speed USB device number 4 using xhci-hcd [ 9.161984] usb 1-1.2: New USB device found, idVendor=2020, idProduct=2060, bcdDevice= 0.00 [ 9.161994] usb 1-1.2: New USB device strings: Mfr=3, Product=2, SerialNumber=4 [ 9.162000] usb 1-1.2: Product: Qualcomm CDMA Technologies MSM [ 9.162005] usb 1-1.2: Manufacturer: Qualcomm, Incorporated [ 12.255789] mmc0: Timeout waiting for hardware interrupt. [ 12.261203] mmc0: sdhci: ============ SDHCI REGISTER DUMP =========== [ 12.267646] mmc0: sdhci: Sys addr: 0x00000800 | Version: 0x00000002 [ 12.274086] mmc0: sdhci: Blk size: 0x00000200 | Blk cnt: 0x00000001 [ 12.280527] mmc0: sdhci: Argument: 0x00000000 | Trn mode: 0x00000013 [ 12.286968] mmc0: sdhci: Present: 0x01f88a0a | Host ctl: 0x00000011 [ 12.293408] mmc0: sdhci: Power: 0x00000002 | Blk gap: 0x00000080 [ 12.299848] mmc0: sdhci: Wake-up: 0x00000008 | Clock: 0x000010ff [ 12.306288] mmc0: sdhci: Timeout: 0x0000008f | Int stat: 0x00000000 [ 12.312728] mmc0: sdhci: Int enab: 0x107f100b | Sig enab: 0x107f100b [ 12.319168] mmc0: sdhci: ACmd stat: 0x00000000 | Slot int: 0x00008402 [ 12.325609] mmc0: sdhci: Caps: 0x07eb0000 | Caps_1: 0x8000b407 [ 12.332049] mmc0: sdhci: Cmd: 0x0000083a | Max curr: 0x00ffffff [ 12.338489] mmc0: sdhci: Resp[0]: 0x00000900 | Resp[1]: 0xffffffff [ 12.344929] mmc0: sdhci: Resp[2]: 0x328f5903 | Resp[3]: 0x00d02700 [ 12.351369] mmc0: sdhci: Host ctl2: 0x00000000 [ 12.355812] mmc0: sdhci: ADMA Err: 0x00000001 | ADMA Ptr: 0xe3395200 [ 12.362252] mmc0: sdhci-esdhc-imx: ========= ESDHC IMX DEBUG STATUS DUMP ========= [ 12.369820] mmc0: sdhci-esdhc-imx: cmd debug status: 0x2100 [ 12.375476] mmc0: sdhci-esdhc-imx: data debug status: 0x2200 [ 12.381219] mmc0: sdhci-esdhc-imx: trans debug status: 0x2300 [ 12.387050] mmc0: sdhci-esdhc-imx: dma debug status: 0x2402 [ 12.392706] mmc0: sdhci-esdhc-imx: adma debug status: 0x2501 [ 12.398450] mmc0: sdhci-esdhc-imx: fifo debug status: 0x2610 [ 12.404193] mmc0: sdhci-esdhc-imx: async fifo debug status: 0x2751 [ 12.410456] mmc0: sdhci: ============================================ [ 12.418625] mmc0: error -110 whilst initialising MMC card [ 12.571745] mmc0: new HS400 MMC card at address 0001 [ 12.573003] mmcblk0: mmc0:0001 032G32 29.1 GiB [ 12.573263] mmcblk0boot0: mmc0:0001 032G32 partition 1 4.00 MiB [ 12.573505] mmcblk0boot1: mmc0:0001 032G32 partition 2 4.00 MiB [ 12.573677] mmcblk0rpmb: mmc0:0001 032G32 partition 3 4.00 MiB, chardev (245:0) [ 12.575700] mmcblk0: p1 p2 [ 13.594372] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [ 13.913356] NET: Registered protocol family 10 [ 13.914477] Segment Routing with IPv6 [ 13.935449] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +L) [ 13.936029] systemd[1]: Detected architecture arm64. [ 13.966632] systemd[1]: Set hostname to <pureos>. [ 13.967950] systemd[1]: Failed to bump fs.file-max, ignoring: Invalid argument [ 14.009206] scsi 0:0:0:0: Direct-Access Generic Ultra HS-SD/MMC 2.09 PQ: 0 ANSI: 0 [ 14.011679] sd 0:0:0:0: [sda] Attached SCSI removable disk [ 14.115242] random: lvmconfig: uninitialized urandom read (4 bytes read) [ 14.310555] random: systemd: uninitialized urandom read (16 bytes read) [ 14.314086] random: systemd: uninitialized urandom read (16 bytes read) [ 14.314130] systemd[1]: Reached target Swap. [ 14.314414] systemd[1]: Reached target Remote File Systems. [ 14.316768] systemd[1]: Created slice system-serial\x2dgetty.slice. [ 14.317253] systemd[1]: Listening on udev Control Socket. [ 14.317541] systemd[1]: Listening on LVM2 poll daemon socket. [ 14.318211] systemd[1]: Created slice User and Session Slice. [ 14.422956] EXT4-fs (mmcblk0p2): re-mounted. Opts: errors=remount-ro [ 14.426871] using random self ethernet address [ 14.426878] using random host ethernet address [ 14.438823] Mass Storage Function, version: 2009/09/11 [ 14.438832] LUN: removable file: (no medium) [ 14.438994] LUN: file: /var/lib/mass_storage_dummy [ 14.438996] Number of LUNs=1 [ 14.439500] usb0: HOST MAC fa:98:84:88:b4:c1 [ 14.439556] usb0: MAC 16:f9:c0:8c:39:98 [ 14.439740] g_multi gadget: Multifunction Composite Gadget [ 14.439745] g_multi gadget: userspace failed to provide iSerialNumber [ 14.439747] g_multi gadget: g_multi ready [ 14.554866] systemd-journald[306]: Received request to flush runtime journal from PID 1 [ 14.980000] input: pwm-vibrator as /devices/platform/vibrator/input/input2 [ 15.067614] imx-sdma 302c0000.sdma: Direct firmware load for imx/sdma/sdma-imx7d.bin failed with error -2 [ 15.067627] imx-sdma 302c0000.sdma: external firmware not found, using ROM firmware [ 15.077166] imx-sdma 30bd0000.sdma: Direct firmware load for imx/sdma/sdma-imx7d.bin failed with error -2 [ 15.077180] imx-sdma 30bd0000.sdma: external firmware not found, using ROM firmware [ 15.126542] caam 30900000.crypto: Entropy delay = 3200 [ 15.126625] caam 30900000.crypto: Entropy delay = 3600 [ 15.132131] input: 30370000.snvs:snvs-powerkey as /devices/platform/soc@0/30000000.bus/30370000.snvs/30370000.snvs:snvs-po3 [ 15.170744] wm8962_i2c_probe: 3555: defering probe [ 15.171915] spi-nor spi0.0: s25fl016k (2048 Kbytes) [ 15.177123] wm8962 2-001a: customer id 0 revision D [ 15.182041] edt_ft5x06 2-0038: probing for EDT FT5x06 I2C [ 15.190166] edt_ft5x06 2-0038: Model "EP0700M09", Rev. "", 0x0 sensors [ 15.190792] input: EP0700M09 as /devices/platform/soc@0/30800000.bus/30a40000.i2c/i2c-2/2-0038/input/input4 [ 15.190998] edt_ft5x06 2-0038: EDT FT5x06 initialized: IRQ 82, WAKE pin -1, Reset pin -1. [ 15.191403] random: crng init done [ 15.191407] random: 7 urandom warning(s) missed due to ratelimiting [ 15.194702] input: WM8962 Beep Generator as /devices/platform/soc@0/30800000.bus/30a40000.i2c/i2c-2/2-001a/input/input6 [ 15.196677] caam 30900000.crypto: Instantiated RNG4 SH0 [ 15.205881] power_supply bq25890-charger: power_supply_get_battery_info currently only supports devicetree [ 15.205892] bq25890-charger 3-006a: No battery found: -6 [ 15.209796] gnss: GNSS driver registered with major 241 [ 15.218674] wm8962 2-001a: ASoC: error at soc_component_read_no_lock on wm8962.2-001a: -16 [ 15.223959] tps6598x 0-003f: failed to register partner [ 15.227987] wm8962 2-001a: ASoC: error at snd_soc_component_update_bits on wm8962.2-001a: -16 [ 15.244392] input: wm8962 Headphones as /devices/platform/sound/sound/card1/input5 [ 15.261972] caam 30900000.crypto: Instantiated RNG4 SH1 [ 15.261987] caam 30900000.crypto: device ID = 0x0a16040100000000 (Era 9) [ 15.261991] caam 30900000.crypto: job rings = 3, qi = 0 [ 15.382445] usbcore: registered new interface driver usbserial_generic [ 15.382482] usbserial: USB Serial support registered for generic [ 15.396417] usbcore: registered new interface driver cdc_wdm [ 15.399630] usbcore: registered new interface driver option [ 15.399669] usbserial: USB Serial support registered for GSM modem (1-port) [ 15.434658] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 15.448441] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 15.448605] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 [ 15.448611] cfg80211: failed to load regulatory.db [ 15.468430] option 1-1.2:1.0: GSM modem (1-port) converter detected [ 15.468752] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0 [ 15.469050] option 1-1.2:1.1: GSM modem (1-port) converter detected [ 15.469247] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1 [ 15.491683] qmi_wwan 1-1.2:1.4: cdc-wdm0: USB WDM device [ 15.494446] qmi_wwan 1-1.2:1.4 wwan0: register 'qmi_wwan' at usb-xhci-hcd.4.auto-1.2, WWAN/QMI device, 32:02:14:27:24:45 [ 15.494611] usbcore: registered new interface driver qmi_wwan [ 15.494850] option 1-1.2:1.2: GSM modem (1-port) converter detected [ 15.495135] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2 [ 15.496794] option 1-1.2:1.3: GSM modem (1-port) converter detected [ 15.497213] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3 [ 15.586562] Bluetooth: Core ver 2.22 [ 15.586640] NET: Registered protocol family 31 [ 15.586643] Bluetooth: HCI device and connection manager initialized [ 15.586659] Bluetooth: HCI socket layer initialized [ 15.586665] Bluetooth: L2CAP socket layer initialized [ 15.586679] Bluetooth: SCO socket layer initialized [ 15.614107] redpine_91x: rsi_probe: ***** 9116 Module ***** [ 15.619965] redpine_91x: redpine_hal_device_init: oper_mode = 13, coex_mode = 2 [ 15.622259] redpine_91x: ***** Loading Firmware from Flash ***** [ 15.624454] redpine_91x: ***** Loaded Firmware to RAM - Waiting for Card Ready ***** [ 15.725843] caam algorithms registered in /proc/crypto [ 15.726663] caam 30900000.crypto: caam pkc algorithms registered in /proc/crypto [ 15.726679] caam 30900000.crypto: registering rng-caam [ 15.767415] mousedev: PS/2 mouse device common for all mice [ 15.912964] ext2 filesystem being mounted at /boot supports timestamps until 2038 (0x7fffffff) [ 16.062808] audit: type=1400 audit(1605970952.383:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.062826] audit: type=1400 audit(1605970952.383:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.062834] audit: type=1400 audit(1605970952.383:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.069821] audit: type=1400 audit(1605970952.391:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.070240] audit: type=1400 audit(1605970952.391:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.295721] audit: type=1400 audit(1605970952.615:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.295736] audit: type=1400 audit(1605970952.615:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.295743] audit: type=1400 audit(1605970952.615:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name" [ 16.295750] audit: type=1400 audit(1605970952.615:10): apparmor="STATUS" operation="profile_load" profile="unconfined" nam" [ 16.295757] audit: type=1400 audit(1605970952.615:11): apparmor="STATUS" operation="profile_load" profile="unconfined" nam" [ 18.174666] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 18.174689] Bluetooth: BNEP socket layer initialized [ 19.091867] redpine_91x: ================================================ [ 19.091874] redpine_91x: ================ RSI Version Info ============== [ 19.091876] redpine_91x: ================================================ [ 19.091883] redpine_91x: FW Version : 1.2.20.0 [ 19.091887] redpine_91x: Driver Version : RS9116.NB0.NL.PURISM.LNX.1.3 [ 19.091889] redpine_91x: Operating mode : 13 [Wi-Fi STA + BT DUAL] [ 19.091892] redpine_91x: ================================================ [ 19.092346] common dev config params : (length = 48) [ 19.092349] 20 00 28 00 00 00 00 00 00 00 00 00 00 00 00 00 [ 19.092362] 00 02 00 0f 00 fe 2e 00 00 0d 00 00 00 01 01 03 [ 19.092375] 00 00 00 00 00 00 01 00 13 00 00 00 01 00 00 00 [ 19.094349] redpine_91x: rsi_send_bt_reg_params: Sending BT reg frame [ 19.094362] BT REG PARAMS: (length = 21) [ 19.094364] 05 60 00 00 00 00 00 00 00 00 00 00 00 00 55 00 [ 19.094377] 00 00 01 1e 02 [ 19.094761] redpine_91x: RSI HCI DEVICE "hci0" open [ 19.103893] redpine_91x: HCI module init done... [ 19.114867] redpine_91x: Max Stations Allowed = 1 [ 19.159890] Bluetooth: RFCOMM TTY layer initialized [ 19.159914] Bluetooth: RFCOMM socket layer initialized [ 19.159948] Bluetooth: RFCOMM ver 1.11 [ 19.174553] redpine_91x: ===> Interface UP <=== [ 19.192874] redpine_91x: ===> Interface DOWN <=== [ 19.196928] redpine_91x: ===> Interface UP <=== [ 22.151572] rfkill: input handler disabled [ 23.136103] redpine_91x: ===> Interface DOWN <=== [ 23.140007] redpine_91x: ===> Interface UP <=== [ 26.816551] wlan0: authenticate with be:2e:48:be:2e:f1 [ 26.817613] wlan0: send auth to be:2e:48:be:2e:f1 (try 1/3) [ 27.019878] wlan0: send auth to be:2e:48:be:2e:f1 (try 2/3) [ 27.101299] wlan0: authenticated [ 27.103955] wlan0: associate with be:2e:48:be:2e:f1 (try 1/3) [ 27.108110] wlan0: RX AssocResp from be:2e:48:be:2e:f1 (capab=0x1411 status=0 aid=3) [ 27.109307] wlan0: associated [ 27.126401] redpine_91x: EAPOL 4 confirm [ 27.145108] redpine_91x: rsi_hal_key_config: Cipher 0xfac04 key_type: 1 key_len: 16 [ 27.145139] redpine_91x: rsi_mac80211_set_key: RSI set_key [ 27.146092] redpine_91x: rsi_hal_key_config: Cipher 0xfac04 key_type: 2 key_len: 16 [ 27.146111] redpine_91x: rsi_mac80211_set_key: RSI set_key [ 27.146508] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 27.224930] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.225788] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.226576] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.227411] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.228255] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.229103] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.229928] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.230772] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.231768] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.232641] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.233497] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.234242] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.235153] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.236483] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.236802] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.237640] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.238586] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.239424] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.241180] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.241193] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.241952] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.244480] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.244501] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.244506] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.245538] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.246290] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.247181] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.247979] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.248810] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.249671] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.250518] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.251876] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.252268] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.253291] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.254044] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.254883] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.255726] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.257101] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.257438] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.258280] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.259232] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.260063] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.260905] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.261730] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.262588] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 27.263425] redpine_91x: Packet Dropped as RX PN is less than last received PN [ 33.759914] AUD_1V8: disabling [ 33.759927] VDD_SEN: disabling [ 33.759936] CAMERA_PWR_EN: disabling [ 33.759939] GNSS: disabling [ 33.759945] CAMERA1_PWR_EN: disabling [ 177.715541] max17042 3-0036: SOC threshold INTR [ 289.848536] max17042 3-0036: SOC threshold INTR [ 402.047902] max17042 3-0036: SOC threshold INTR [ 536.693407] max17042 3-0036: SOC threshold INTR [ 626.465693] max17042 3-0036: SOC threshold INTR [ 716.215458] max17042 3-0036: SOC threshold INTR [ 850.803304] max17042 3-0036: SOC threshold INTR [ 940.532295] max17042 3-0036: SOC threshold INTR [ 1075.149572] max17042 3-0036: SOC threshold INTR [ 1164.898264] max17042 3-0036: SOC threshold INTR [ 1299.493026] max17042 3-0036: SOC threshold INTR [ 1389.230894] max17042 3-0036: SOC threshold INTR [ 1478.971529] max17042 3-0036: SOC threshold INTR [ 1613.661491] max17042 3-0036: SOC threshold INTR [ 3492.353381] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 3559.569710] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 4124.326389] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 4996.452376] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 5193.132886] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 5266.255589] redpine_91x: rsi_mac80211_set_key: RSI del key [ 5266.255676] redpine_91x: rsi_hal_key_config: Cipher 0x0 key_type: 2 key_len: 0 [ 5266.258023] redpine_91x: rsi_mac80211_set_key: RSI del key [ 5266.258034] redpine_91x: rsi_hal_key_config: Cipher 0x0 key_type: 2 key_len: 0 [ 5270.038259] wlan0: authenticate with be:2e:48:be:2e:f1 [ 5270.040865] wlan0: send auth to be:2e:48:be:2e:f1 (try 1/3) [ 5270.247402] wlan0: send auth to be:2e:48:be:2e:f1 (try 2/3) [ 5270.450987] wlan0: send auth to be:2e:48:be:2e:f1 (try 3/3) [ 5270.655928] wlan0: authentication with be:2e:48:be:2e:f1 timed out [ 5275.386814] input: 74:6F:F7:C7:22:28 as /devices/virtual/input/input7 [ 5281.861779] redpine_91x: ===> Interface DOWN <=== [ 5281.867878] redpine_91x: ===> Interface UP <=== [ 5295.288923] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 5622.823653] redpine_91x: ===> Interface DOWN <=== [ 5622.853024] redpine_91x: ===> Interface UP <=== [ 5769.822398] max17042 3-0036: SOC threshold INTR [ 5930.517040] input: 74:6F:F7:C7:22:28 as /devices/virtual/input/input8 [ 5938.764129] redpine_91x: ===> Interface DOWN <=== [ 5938.765803] redpine_91x: ===> Interface UP <=== [ 5958.525401] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6135.922512] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6191.095917] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6253.814264] redpine_91x: ===> Interface DOWN <=== [ 6253.841078] redpine_91x: ===> Interface UP <=== [ 6309.020675] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6341.325299] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6351.666838] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 6568.803572] redpine_91x: ===> Interface DOWN <=== [ 6568.825179] redpine_91x: ===> Interface UP <=== [ 6884.738409] redpine_91x: ===> Interface DOWN <=== [ 6884.755520] redpine_91x: ===> Interface UP <=== [ 7190.591073] max17042 3-0036: SOC threshold INTR [ 7200.783952] redpine_91x: ===> Interface DOWN <=== [ 7200.804505] redpine_91x: ===> Interface UP <=== [ 7516.771832] redpine_91x: ===> Interface DOWN <=== [ 7516.783725] redpine_91x: ===> Interface UP <=== [ 7832.718940] redpine_91x: ===> Interface DOWN <=== [ 7832.734630] redpine_91x: ===> Interface UP <=== [ 8148.722133] redpine_91x: ===> Interface DOWN <=== [ 8148.757958] redpine_91x: ===> Interface UP <=== [ 8459.176197] max17042 3-0036: SOC threshold INTR [ 8464.728034] redpine_91x: ===> Interface DOWN <=== [ 8464.740329] redpine_91x: ===> Interface UP <=== [ 8525.802669] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [ 8780.710516] redpine_91x: ===> Interface DOWN <=== [ 8780.724535] redpine_91x: ===> Interface UP <=== [ 9095.717951] redpine_91x: ===> Interface DOWN <=== [ 9095.743561] redpine_91x: ===> Interface UP <=== [ 9410.651424] redpine_91x: ===> Interface DOWN <=== [ 9410.671074] redpine_91x: ===> Interface UP <=== [ 9725.695546] redpine_91x: ===> Interface DOWN <=== [ 9725.710512] redpine_91x: ===> Interface UP <=== [ 9751.673379] max17042 3-0036: SOC threshold INTR [10040.630327] redpine_91x: ===> Interface DOWN <=== [10040.646647] redpine_91x: ===> Interface UP <=== [10171.943312] usb 1-1.2: reset high-speed USB device number 4 using xhci-hcd [10172.084060] usb 1-1.2: USB disconnect, device number 4 [10172.089318] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 [10172.089795] option 1-1.2:1.0: device disconnected [10172.097216] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 [10172.097609] option 1-1.2:1.1: device disconnected [10172.102830] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 [10172.103435] option 1-1.2:1.2: device disconnected [10172.117318] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 [10172.117920] option 1-1.2:1.3: device disconnected [10172.120368] qmi_wwan 1-1.2:1.4 wwan0: unregister 'qmi_wwan' usb-xhci-hcd.4.auto-1.2, WWAN/QMI device [10172.444583] usb 1-1.2: new high-speed USB device number 5 using xhci-hcd [10172.557425] usb 1-1.2: New USB device found, idVendor=2020, idProduct=2060, bcdDevice= 0.00 [10172.557489] usb 1-1.2: New USB device strings: Mfr=3, Product=2, SerialNumber=4 [10172.557504] usb 1-1.2: Product: Qualcomm CDMA Technologies MSM [10172.557508] usb 1-1.2: Manufacturer: Qualcomm, Incorporated [10172.688226] option 1-1.2:1.0: GSM modem (1-port) converter detected [10172.692911] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0 [10172.697542] option 1-1.2:1.1: GSM modem (1-port) converter detected [10172.700846] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1 [10172.704031] option 1-1.2:1.2: GSM modem (1-port) converter detected [10172.706147] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2 [10172.709294] option 1-1.2:1.3: GSM modem (1-port) converter detected [10172.711529] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3 [10172.750144] qmi_wwan 1-1.2:1.4: cdc-wdm0: USB WDM device [10172.772316] qmi_wwan 1-1.2:1.4 wwan0: register 'qmi_wwan' at usb-xhci-hcd.4.auto-1.2, WWAN/QMI device, 32:02:14:27:24:45 [10355.675084] redpine_91x: ===> Interface DOWN <=== [10355.687787] redpine_91x: ===> Interface UP <=== [10670.664679] redpine_91x: ===> Interface DOWN <=== [10670.691508] redpine_91x: ===> Interface UP <=== [10961.282416] max17042 3-0036: SOC threshold INTR [10985.601726] redpine_91x: ===> Interface DOWN <=== [10985.626193] redpine_91x: ===> Interface UP <=== [11300.641950] redpine_91x: ===> Interface DOWN <=== [11300.670087] redpine_91x: ===> Interface UP <=== [11615.632314] redpine_91x: ===> Interface DOWN <=== [11615.647906] redpine_91x: ===> Interface UP <=== [11931.573025] redpine_91x: ===> Interface DOWN <=== [11931.587516] redpine_91x: ===> Interface UP <=== [12117.644779] max17042 3-0036: SOC threshold INTR [12246.583710] redpine_91x: ===> Interface DOWN <=== [12246.605756] redpine_91x: ===> Interface UP <=== [12561.551892] redpine_91x: ===> Interface DOWN <=== [12561.570117] redpine_91x: ===> Interface UP <=== [12624.338170] usb 1-1.2: reset high-speed USB device number 5 using xhci-hcd [12624.457504] usb 1-1.2: USB disconnect, device number 5 [12624.464771] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 [12624.465148] option 1-1.2:1.0: device disconnected [12624.469494] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 [12624.469728] option 1-1.2:1.1: device disconnected [12624.472806] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 [12624.473003] option 1-1.2:1.2: device disconnected [12624.474732] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 [12624.474944] option 1-1.2:1.3: device disconnected [12624.476362] qmi_wwan 1-1.2:1.4 wwan0: unregister 'qmi_wwan' usb-xhci-hcd.4.auto-1.2, WWAN/QMI device [12624.777771] usb 1-1.2: new high-speed USB device number 6 using xhci-hcd [12624.885479] usb 1-1.2: New USB device found, idVendor=2020, idProduct=2060, bcdDevice= 0.00 [12624.885574] usb 1-1.2: New USB device strings: Mfr=3, Product=2, SerialNumber=4 [12624.885582] usb 1-1.2: Product: Qualcomm CDMA Technologies MSM [12624.885597] usb 1-1.2: Manufacturer: Qualcomm, Incorporated [12625.004164] option 1-1.2:1.0: GSM modem (1-port) converter detected [12625.012711] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0 [12625.016844] option 1-1.2:1.1: GSM modem (1-port) converter detected [12625.026558] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1 [12625.030887] option 1-1.2:1.2: GSM modem (1-port) converter detected [12625.040322] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2 [12625.045810] option 1-1.2:1.3: GSM modem (1-port) converter detected [12625.053200] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3 [12625.116451] qmi_wwan 1-1.2:1.4: cdc-wdm0: USB WDM device [12625.123295] qmi_wwan 1-1.2:1.4 wwan0: register 'qmi_wwan' at usb-xhci-hcd.4.auto-1.2, WWAN/QMI device, 32:02:14:27:24:45 [12876.589791] redpine_91x: ===> Interface DOWN <=== [12876.605076] redpine_91x: ===> Interface UP <=== [13156.020241] max17042 3-0036: SOC threshold INTR [13179.703714] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [13191.552449] redpine_91x: ===> Interface DOWN <=== [13191.554126] redpine_91x: ===> Interface UP <=== [13261.321194] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [13506.567780] redpine_91x: ===> Interface DOWN <=== [13506.585935] redpine_91x: ===> Interface UP <=== [13821.502821] redpine_91x: ===> Interface DOWN <=== [13821.523571] redpine_91x: ===> Interface UP <=== [14137.496629] redpine_91x: ===> Interface DOWN <=== [14137.520627] redpine_91x: ===> Interface UP <=== [14159.477260] input: 74:6F:F7:C7:22:28 as /devices/virtual/input/input9 [14182.340083] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [14234.725790] max17042 3-0036: SOC threshold INTR [14453.501028] redpine_91x: ===> Interface DOWN <=== [14453.523963] redpine_91x: ===> Interface UP <=== [14753.375099] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [14768.474759] redpine_91x: ===> Interface DOWN <=== [14768.490154] redpine_91x: ===> Interface UP <=== [15084.458289] redpine_91x: ===> Interface DOWN <=== [15084.487654] redpine_91x: ===> Interface UP <=== [15400.447486] redpine_91x: ===> Interface DOWN <=== [15400.477343] redpine_91x: ===> Interface UP <=== [15434.099443] max17042 3-0036: SOC threshold INTR [15716.437888] redpine_91x: ===> Interface DOWN <=== [15716.456376] redpine_91x: ===> Interface UP <=== [16031.482012] redpine_91x: ===> Interface DOWN <=== [16031.493799] redpine_91x: ===> Interface UP <=== [16347.470439] redpine_91x: ===> Interface DOWN <=== [16347.482329] redpine_91x: ===> Interface UP <=== [16636.478241] max17042 3-0036: SOC threshold INTR [16663.447448] redpine_91x: ===> Interface DOWN <=== [16663.459584] redpine_91x: ===> Interface UP <=== [16979.393110] redpine_91x: ===> Interface DOWN <=== [16979.421026] redpine_91x: ===> Interface UP <=== [17294.396543] redpine_91x: ===> Interface DOWN <=== [17294.420760] redpine_91x: ===> Interface UP <=== [17609.371145] redpine_91x: ===> Interface DOWN <=== [17609.384611] redpine_91x: ===> Interface UP <=== [17823.966448] max17042 3-0036: SOC threshold INTR [17894.376976] input: 74:6F:F7:C7:22:28 as /devices/virtual/input/input10 [17917.411116] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [17925.375812] redpine_91x: ===> Interface DOWN <=== [17925.390707] redpine_91x: ===> Interface UP <=== [18118.703565] redpine_91x: ===> Interface DOWN <=== [18118.706895] redpine_91x: ===> Interface UP <=== [18118.756132] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [18122.035982] wlan0: authenticate with be:2e:48:be:2e:f1 [18122.038190] wlan0: send auth to be:2e:48:be:2e:f1 (try 1/3) [18122.054448] wlan0: authenticated [18122.061927] wlan0: associate with be:2e:48:be:2e:f1 (try 1/3) [18122.082506] wlan0: RX AssocResp from be:2e:48:be:2e:f1 (capab=0x1411 status=0 aid=3) [18122.084798] wlan0: associated [18122.173799] redpine_91x: rsi_hal_key_config: Cipher 0xfac04 key_type: 1 key_len: 16 [18122.174012] redpine_91x: EAPOL 4 confirm [18122.174097] redpine_91x: rsi_mac80211_set_key: RSI set_key [18122.188439] redpine_91x: rsi_hal_key_config: Cipher 0xfac04 key_type: 2 key_len: 16 [18122.188651] redpine_91x: rsi_mac80211_set_key: RSI set_key [18122.191904] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [18122.313171] redpine_91x: Packet Dropped as RX PN is less than last received PN [18458.571718] IPv6: ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [18458.699245] NOHZ: local_softirq_pending 08 [18458.699251] NOHZ: local_softirq_pending 08 [18458.882039] NOHZ: local_softirq_pending 08 [18458.895389] NOHZ: local_softirq_pending 08 [18458.895394] NOHZ: local_softirq_pending 08 [18459.139520] NOHZ: local_softirq_pending 08 [18459.139527] NOHZ: local_softirq_pending 08 [18459.395372] NOHZ: local_softirq_pending 08 [18459.395381] NOHZ: local_softirq_pending 08 [18459.951327] NOHZ: local_softirq_pending 08 [18478.409533] dwc3 38100000.usb: request 00000000d2b8447c was not queued to ep3in [18532.108291] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [18666.038538] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [18739.641374] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [18873.143155] max17042 3-0036: SOC threshold INTR [19515.131402] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [19860.939543] max17042 3-0036: SOC threshold INTR [19902.835933] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20084.359157] dwc3 38100000.usb: request 0000000096439b22 was not queued to ep3in [20096.377209] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20180.806224] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20262.775018] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20370.238647] dwc3 38100000.usb: request 000000006fb38003 was not queued to ep3in [20459.979366] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20556.419756] dwc3 38100000.usb: request 00000000300d2d70 was not queued to ep3in [20559.526755] max17042 3-0036: SOC threshold INTR [20640.570445] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20835.534443] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [20933.439618] dwc3 38100000.usb: request 00000000249ae05a was not queued to ep3in [20951.698964] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [21336.631671] max17042 3-0036: SOC threshold INTR [21403.112606] edt_ft5x06 2-0038: Unable to fetch data, error: -6 [21458.987246] edt_ft5x06 2-0038: Unable to fetch data, error: -6 ==> /sys/class/power_supply/bq25890-charger/uevent <== POWER_SUPPLY_NAME=bq25890-charger POWER_SUPPLY_TYPE=USB POWER_SUPPLY_MANUFACTURER=Texas Instruments POWER_SUPPLY_MODEL_NAME=BQ25895 POWER_SUPPLY_STATUS=Discharging POWER_SUPPLY_CHARGE_TYPE=N/A POWER_SUPPLY_ONLINE=0 POWER_SUPPLY_HEALTH=Good POWER_SUPPLY_CONSTANT_CHARGE_CURRENT_MAX=1472000 POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE=0 POWER_SUPPLY_CONSTANT_CHARGE_VOLTAGE_MAX=4192000 POWER_SUPPLY_PRECHARGE_CURRENT=128000 POWER_SUPPLY_CHARGE_TERM_CURRENT=128000 POWER_SUPPLY_INPUT_CURRENT_LIMIT=500000 POWER_SUPPLY_VOLTAGE_NOW=3724000 POWER_SUPPLY_CURRENT_NOW=0 ==> /sys/class/power_supply/max170xx_battery/uevent <== POWER_SUPPLY_NAME=max170xx_battery POWER_SUPPLY_TYPE=Battery POWER_SUPPLY_STATUS=Unknown POWER_SUPPLY_PRESENT=1 POWER_SUPPLY_TECHNOLOGY=Li-ion POWER_SUPPLY_CYCLE_COUNT=143 POWER_SUPPLY_VOLTAGE_MAX=4200000 POWER_SUPPLY_VOLTAGE_MIN=3100000 POWER_SUPPLY_VOLTAGE_MIN_DESIGN=3300000 POWER_SUPPLY_VOLTAGE_NOW=3721875 POWER_SUPPLY_VOLTAGE_AVG=3787812 POWER_SUPPLY_VOLTAGE_OCV=3838281 POWER_SUPPLY_CAPACITY=73 POWER_SUPPLY_CHARGE_FULL_DESIGN=3000000 POWER_SUPPLY_CHARGE_FULL=2621000 POWER_SUPPLY_CHARGE_NOW=1926000 POWER_SUPPLY_CHARGE_COUNTER=32594000 POWER_SUPPLY_TEMP=338 POWER_SUPPLY_TEMP_ALERT_MIN=-1280 POWER_SUPPLY_TEMP_ALERT_MAX=1270 POWER_SUPPLY_TEMP_MIN=-2147483648 POWER_SUPPLY_TEMP_MAX=700 POWER_SUPPLY_HEALTH=Good POWER_SUPPLY_SCOPE=System POWER_SUPPLY_CURRENT_NOW=-282360 POWER_SUPPLY_CURRENT_AVG=-178776 POWER_SUPPLY_TIME_TO_EMPTY_NOW=37496 ==> /sys/class/power_supply/tcpm-source-psy-0-003f/uevent <== POWER_SUPPLY_NAME=tcpm-source-psy-0-003f POWER_SUPPLY_TYPE=USB POWER_SUPPLY_USB_TYPE=[C] PD PD_DRP PD_PPS POWER_SUPPLY_ONLINE=0 Device: /org/freedesktop/UPower/devices/line_power_tcpm_source_psy_0_003f native-path: tcpm-source-psy-0-003f power supply: yes updated: Sat Nov 21 13:02:19 2020 (30 seconds ago) has history: no has statistics: no line-power warning-level: none online: no icon-name: 'ac-adapter-symbolic' Device: /org/freedesktop/UPower/devices/battery_max170xx_battery native-path: max170xx_battery power supply: yes updated: Sat Nov 21 13:02:19 2020 (30 seconds ago) has history: yes has statistics: yes battery present: yes rechargeable: yes state: discharging warning-level: none energy: 6.3591 Wh energy-empty: 0 Wh energy-full: 9.9 Wh energy-full-design: 9.9 Wh energy-rate: 0.778378 W voltage: 3.75594 V time to empty: 8.2 hours percentage: 73% temperature: 35.8 degrees C capacity: 100% technology: lithium-ion icon-name: 'battery-full-symbolic' History (rate): 1605992539 0.778 unknown 1605992538 0.770 discharging 1605992538 0.836 charging 1605992500 0.335 charging 1605992460 0.747 discharging 1605992459 0.443 charging Device: /org/freedesktop/UPower/devices/battery_bq25890_charger native-path: bq25890-charger vendor: Texas Instruments model: BQ25895 power supply: yes updated: Sat Nov 21 13:02:49 2020 (1 seconds ago) has history: yes has statistics: yes battery present: yes rechargeable: yes state: discharging warning-level: action energy: 0 Wh energy-empty: 0 Wh energy-full: 0 Wh energy-full-design: 0 Wh energy-rate: 0 W voltage: 3.724 V percentage: 0% capacity: 100% icon-name: 'battery-caution-symbolic' Device: /org/freedesktop/UPower/devices/DisplayDevice power supply: yes updated: Sat Nov 21 13:02:19 2020 (31 seconds ago) has history: no has statistics: no battery present: yes state: discharging warning-level: none energy: 6.3591 Wh energy-full: 9.9 Wh energy-rate: 0.778378 W time to empty: 8.2 hours percentage: 64.2333% icon-name: 'battery-full-symbolic' Daemon: daemon-version: 0.99.10 on-battery: yes lid-is-closed: no lid-is-present: no critical-action: PowerOff purism@pureos:~/tmp$
- Guido Gunther moved from OS-issues#171 (moved)
moved from OS-issues#171 (moved)
- Owner
i assume it's
[ 15.223959] tps6598x 0-003f: failed to register partner
because if that happens we fail to call
power_supply_changed(tps->psy);
which makes userspace miss that change.Edited by Guido Gunther I am seeing this too, on Librem 5 Birch.
About an hour ago it had been charging for a while and showed it was fully charged. Then I disconnected the charging cable, and I did see that it reacted to the cable being removed, phosh showed the normal battery symbol instead of the charging symbol (the little lightning thing disappeared), as it should.
Then I left it lying there for an hour without the cable connected. But now when I look at it, it is showing the charging symbol again even though the cable is not connected.
purism@pureos:~$ upower -i /org/freedesktop/UPower/devices/DisplayDevice power supply: yes updated: Sun Feb 21 19:08:31 2021 (3 seconds ago) has history: no has statistics: no battery present: yes state: charging warning-level: none energy: 5.0028 Wh energy-full: 6.8541 Wh energy-rate: 0.99 W time to full: 1.9 hours percentage: 72.9899% icon-name: 'battery-full-charging-symbolic'
So at some point during the last hour it suddenly decided it was "charging", it decided that on its own, no cable was connected.
Here is the output of
sudo journalctl
between the two "Power key pressed" times, at some point during that time it decided to change to "charging" even though the cable was not connected:Feb 21 17:22:55 pureos systemd-logind[508]: Power key pressed. Feb 21 17:22:55 pureos phoc[542]: [backend/drm/drm.c:972] Skipping pageflip on output 'DSI-1' Feb 21 17:22:55 pureos gsd-color[789]: unable to get EDID for xrandr-DSI-1: unable to get EDID for output Feb 21 17:22:57 pureos kernel: bq25890-charger 3-006a: Upstream supply changed: 1. Feb 21 17:22:57 pureos kernel: bq25890-charger 3-006a: Disabling OTG_EN pin Feb 21 17:23:10 pureos phoc[542]: [backend/drm/atomic.c:57] DSI-1: Atomic commit failed (modeset): Invalid argument Feb 21 17:23:10 pureos kernel: edt_ft5x06 2-0038: Unable to fetch data, error: -6 Feb 21 17:23:10 pureos gsd-color[789]: unable to get EDID for xrandr-DSI-1: unable to get EDID for output Feb 21 17:24:00 pureos phoc[542]: [backend/drm/atomic.c:57] DSI-1: Atomic commit failed (pageflip): Invalid argument Feb 21 17:26:48 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 17:34:39 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 17:42:41 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 17:50:42 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 17:58:41 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 18:03:30 pureos wpa_supplicant[503]: wlan0: WPA: Group rekeying completed with 44:d4:37:5d:86:d4 [GTK=CCMP] Feb 21 18:03:30 pureos kernel: redpine_91x: rsi_mac80211_set_key: RSI del key Feb 21 18:03:30 pureos kernel: redpine_91x: rsi_hal_key_config: Cipher 0x0 key_type: 2 key_len: 0 Feb 21 18:03:30 pureos kernel: redpine_91x: rsi_hal_key_config: Cipher 0xfac04 key_type: 2 key_len: 16 Feb 21 18:03:30 pureos kernel: redpine_91x: rsi_mac80211_set_key: RSI set_key Feb 21 18:06:37 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 18:14:31 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 18:17:01 pureos CRON[2063]: pam_unix(cron:account): account root has expired (account expired) Feb 21 18:17:01 pureos CRON[2063]: Authentication failure Feb 21 18:17:01 pureos cron[485]: Authentication failure Feb 21 18:22:24 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 18:30:14 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 18:37:55 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 18:39:11 pureos wpa_supplicant[503]: nl80211: send_and_recv->nl_recvmsgs failed: -33 Feb 21 18:45:43 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 18:53:29 pureos kernel: max17042 3-0036: SOC threshold INTR Feb 21 18:58:25 pureos sshd[1444]: Received disconnect from 192.168.1.210 port 35686:11: disconnected by user Feb 21 18:58:25 pureos sshd[1444]: Disconnected from user purism 192.168.1.210 port 35686 Feb 21 18:58:25 pureos sshd[1438]: pam_unix(sshd:session): session closed for user purism Feb 21 18:58:26 pureos systemd[1]: session-3.scope: Succeeded. Feb 21 18:58:26 pureos systemd-logind[508]: Session 3 logged out. Waiting for processes to exit. Feb 21 18:58:26 pureos systemd-logind[508]: Removed session 3. Feb 21 18:58:33 pureos sshd[2186]: Accepted publickey for purism from 192.168.1.210 port 36264 ssh2: RSA SHA256:8BMX6Dj4lxa7qUyCUVOZZ+6lYqlOHdsr11Q0AeKc9MM Feb 21 18:58:33 pureos sshd[2186]: pam_unix(sshd:session): session opened for user purism by (uid=0) Feb 21 18:58:33 pureos systemd-logind[508]: New session 4 of user purism. Feb 21 18:58:34 pureos systemd[1]: Started Session 4 of user purism. Feb 21 18:59:21 pureos systemd-logind[508]: Power key pressed.
From the above, maybe
bq25890-charger 3-006a: Upstream supply changed: 1
could be related to this, at least it says something about "charger"?The
CRON[2063]: pam_unix(cron:account): account root has expired
looks strange, but perhaps it has nothing to do with this issue.The "failed to register partner" that @guido.gunther mentioned does appear in the log but earlier:
purism@pureos:~$ sudo journalctl -b | grep "failed to register partner" Feb 21 16:29:12 pureos kernel: tps6598x 0-003f: failed to register partner Feb 21 16:38:13 pureos kernel: tps6598x 0-003f: failed to register partner
Reproduced the issue again after adding some debug printouts, looks like the point where it decides that it is "charging" is in
up_device_supply_refresh_battery
in https://source.puri.sm/Librem5/upower/-/blob/pureos/amber-phone/src/linux/up-device-supply.c where it comes to this part, see "<--- HERE!" below:/* the battery isn't charging or discharging, it's just * sitting there half full doing nothing: try to guess a state */ if (state == UP_DEVICE_STATE_UNKNOWN && supply->priv->is_power_supply) { daemon = up_device_get_daemon (device); /* If we have any online AC, assume charging, otherwise * discharging */ devices_list = up_daemon_get_device_list (daemon); devices = up_device_list_get_array (devices_list); for (i=0; i < devices->len; i++) { if (up_device_get_online ((UpDevice *) g_ptr_array_index (devices, i), &online)) { has_ac = TRUE; if (online) { ac_online = TRUE; } break; } } g_ptr_array_unref (devices); g_object_unref (devices_list); if (has_ac) { if (ac_online) { if (percentage > UP_DEVICE_SUPPLY_CHARGED_THRESHOLD) state = UP_DEVICE_STATE_FULLY_CHARGED; else state = UP_DEVICE_STATE_CHARGING; <--- HERE! } else {
What is the meaning of the
up_device_get_online()
function there, is it supposed to determine if the charging cable is plugged in or not? Apparently it returns true and it sets "online" to true also, even though the cable is not connected.After looking some more at this, here is what seems to be happening:
The
g_object_set()
function is called in https://source.puri.sm/Librem5/upower/-/blob/pureos/amber-phone/src/linux/up-device-supply.c to set the "online" property for the device. That is done at startup and the value comes from this path:/sys/devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-003f/power_supply/tps6598x-source-psy-0-003f/online
And then later on,
g_object_get()
is called to fetch the value of the "online" property that was stored in the gobject.At upower startup that path seems to give correct info, 0 or 1 saying if the cable is plugged in or not. I can check that like this:
purism@pureos:~$ cat /sys/devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-003f/power_supply/tps6598x-source-psy-0-003f/online 0
I get 0 there if the cable was not plugged in at startup, and if the cable was plugged in I get 1 instead of 0. So that path does work to find out what the situation was at startup. However, the value at that path stays the same all the time, it is not updated when the cable is plugged or unplugged. It looks like the authors of the upower source code were expecting it to get updated.
Is the value at that path supposed to be updated when the cable is plugged or unplugged?
There must be some other mechanism as well to detect that the cable is plugged/unplugged because phosh is normally detecting that and changing the battery charging symbol accordingly. So is seems there is another mechanism that does work and that is used for some things, but unfortunately upower is trying to use the path above which does not get updated. The "online" property set using
g_object_set()
at startup just remains the same all the time, it never gets updated.Edited by Elias Rudberg@elias What's the result of
sudo i2cget -f -y 0 0x3f 0x03 w
in a state when you reproduce this?Collapse replies purism@pureos:~$ sudo i2cget -f -y 0 0x3f 0x03 w 0x4104
It seems to give 0x4104 always, regardless of whether the charging cable is plugged in or not. This is on Librem 5 Birch in case that matters.
And to confirm - this is when the UI icon doesn't match the actual state, right?
Yes.
For comparison, on a Librem 13 laptop it works to check if the power cable is connected using the corresponding path, although the path is different in that case. On Librem 13 I can do this:
cat /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/device:01/PNP0C09:00/ACPI0003:00/power_supply/AC/online
And that will give 0 or 1 indicating whether the power cable is plugged in or not, and that info is updated, so if running the above cat command several times and just plugging/unplugging the cable in between, if will give different results, 0, 1, 0 and so on depending on if the cable is plugged in at that moment. So that behaves differently compared to the Librem 5 Birch where the value from
cat /sys/devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-003f/power_supply/tps6598x-source-psy-0-003f/online
seems to be set at boot time and then never changes.
Edited by Elias RudbergCollapse replies - Owner
@elias that's due to https://source.puri.sm/Librem5/linux-next/-/issues/250#note_131227 mentioned above.
Thanks, I looked into that and have an idea for a fix, see https://source.puri.sm/Librem5/linux-next/-/issues/277 but it seems something more is needed, at least for me this problem still remains after that fix.
- Elias Rudberg mentioned in issue #277 (closed)
mentioned in issue #277 (closed)
- Elias Rudberg mentioned in merge request !337 (closed)
mentioned in merge request !337 (closed)
- Elias Rudberg mentioned in issue #278
mentioned in issue #278
Seems like upower gets its information for the "online" property from one or both of the following places under /sys/:
purism@pureos:~$ sudo find /sys/ -name online | grep -v cpu /sys/devices/platform/soc@0/30800000.bus/30a50000.i2c/i2c-3/3-006a/power_supply/bq25890-charger/online /sys/devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-003f/power_supply/tps6598x-source-psy-0-003f/online
One of those, the one called "bq25890-charger", gives accurate information, it shows 0 or 1 to indeicate if the charging cable is currently connected or not.
The other one, called "tps6598x-source-psy-0-003f", seems to just be set to 0 or 1 at boot time but then it is not updated when the cable is plugged or unplugged later on.
For example, here is what it looks like when the cable was plugged in when the phone was booted:
purism@pureos:~$ cat /sys/devices/platform/soc@0/30800000.bus/30a50000.i2c/i2c-3/3-006a/power_supply/bq25890-charger/online 1 purism@pureos:~$ cat /sys/devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-003f/power_supply/tps6598x-source-psy-0-003f/online 1
Now unplugging the cable, then checking again:
purism@pureos:~$ cat /sys/devices/platform/soc@0/30800000.bus/30a50000.i2c/i2c-3/3-006a/power_supply/bq25890-charger/online 0 purism@pureos:~$ cat /sys/devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-003f/power_supply/tps6598x-source-psy-0-003f/online 1
Plugging in the cable again, then checking again:
purism@pureos:~$ cat /sys/devices/platform/soc@0/30800000.bus/30a50000.i2c/i2c-3/3-006a/power_supply/bq25890-charger/online 1 purism@pureos:~$ cat /sys/devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-003f/power_supply/tps6598x-source-psy-0-003f/online 1
So in this case "tps6598x-source-psy-0-003f" always showed 1. If the cable was unplugged when booting, it instead shows 0.
Anyway, seems like there are two possible ways of solving this:
(1) Fix something in the kernel so that
/sys/devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-003f/power_supply/tps6598x-source-psy-0-003f/online
gets updated when the cable is (un)plugged, in the same way thatbq25890-charger
gets updatedor
(2) Workaround the issue by changing upower so that it ignores "tps6598x-source-psy-0-003f" and only uses the info from "bq25890-charger"
Probably (1) would be better, if possible?
@elias The tps6598x
online
property gets updated here correctly, so I'd say it's rather "figuring out what makes the reading from tps6598x stuck for you".Collapse replies Is it working for you on Birch? (my tests are on Birch)
I just tried on Birch, Dogwood and Evergreen and it works on all of them for me.
Have you tried the 5.11 kernel? I'm using 5.11 on all of them.
I did try the 5.11 kernel but I get the same problem there: bq25890-charger gets updated but tps6598x-source-psy-0-003f does not get updated.
My installation procedure was as follows. First reflashed specifying "--board librem5r2" like this:
./scripts/librem5-flash-image --board librem5r2
then built and installed the 5.11 kernel (5.11.4-librem5), using the pureos/amber-phone branch of the linux-next repo. Also tried with the fix https://source.puri.sm/Librem5/linux-next/-/commit/51877d8f2070c0fdd901a3606ab5de2f00639eb1 but that did not help.
What could be the difference between your Birch device and mine? Could it be that you fixed something that I have not done, like upgrading firmware or something? I suppose no other package than the kernel should matter for this, it's only the kernel that decides what appears under
/sys/
?Edited by Elias Rudberg
I also get these "did not recognise USB path" messages, not sure if they could be important.
purism@pureos:~$ sudo journalctl -b | grep "did not recognise" Mar 10 16:53:11 pureos upowerd[797]: did not recognise USB path /sys/devices/platform/soc@0/30800000.bus/30a20000.i2c/i2c-0/0-003f/power_supply/tps6598x-source-psy-0-003f, please report Mar 10 16:53:11 pureos upowerd[797]: did not recognise USB path /sys/devices/platform/soc@0/30800000.bus/30a50000.i2c/i2c-3/3-006a/power_supply/bq25890-charger, please report
This is related to https://source.puri.sm/Librem5/linux-next/-/issues/291 I think.
- Elias Rudberg mentioned in commit elias/linux-next@6010d5ba
mentioned in commit elias/linux-next@6010d5ba