On 17/12/2018 10:28, Marc Gonzalez wrote: > On 17/12/2018 08:14, Kyuho Choi wrote: > >> On Thursday, December 13, 2018, Marc Gonzalez wrote: >> >> I'm having trouble getting UFS working on an APQ8098 MEDIABOX dev board. >> (I'm running v4.20-rc4 with a few UFS patches taken off the MSM list.) >> >> I'm hoping someone with experience with the UFSHC will spot the one thing >> missing that will make everything work! >> >> [ 4.929036] ufshcd-qcom 1da4000.ufshc: ufshcd_wait_for_dev_cmd: dev_cmd request timedout, tag 31 >> [ 4.929229] ufshcd_upiu: query_complete_err: 1da4000.ufshc: HDR:16 00 00 1f 00 81 00 00 00 00 00 00, CDB:06 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 >> [ 4.937060] ufshcd-qcom 1da4000.ufshc: ufshcd_query_flag: Sending flag query for idn 1 failed, err = -11 >> [ 4.950633] ufshcd-qcom 1da4000.ufshc: ufshcd_query_flag_retry: failed with error -11, retries 0 >> [ 4.960131] ufshcd_upiu: query_send: 1da4000.ufshc: HDR:16 00 00 1f 00 81 00 00 00 00 00 00, CDB:06 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 >> [ 4.968909] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 >> [ 5.034505] ufshcd-qcom 1da4000.ufshc: ufshcd_update_uic_error: UIC error flags = 0x00000000 >> [ 5.098107] ufshcd-qcom 1da4000.ufshc: ufshcd_update_uic_error: UIC error flags = 0x00000000 >> [ 5.168571] ufshcd-qcom 1da4000.ufshc: ufshcd_update_uic_error: UIC error flags = 0x00000001 >> >> Here, your ufs has UIC layer error. Maybe it'll be >> affected (or not) fDeviceInit set query cmnd. >> >> Does this error reproduced every bootup? > > Yes, the error occurs every single time. > >> Just for test, Increase query timeout value to over 1.5sec. And how about >> another kernel versions like APQ808's reference kernel env? > > Indeed, this is something I forgot to mention! > > UFS does work on the downstream kernel (v4.4) using the qcom driver. > > So this is purely a software initialization issue. > > I will test your suggestion, thanks. I am also making a minimal vendor kernel, > with all drivers removed except UFS, so I can dump all memory accesses at init > for clock, regulators, UFS PHY, and UFSHC :-) Below, the raw boot log for the downstream kernel. Now the fun begins, to find the tiny difference that makes/breaks everything :-) (P.S. I just noticed that my mainline kernel now times out on the very first UFS command. I need to revert a bunch of patches to figure out what happened.) [ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Initializing cgroup subsys schedtune [ 0.000000] Linux version 4.4.78 (mgonzalez@venus) (gcc version 7.3.1 20180425 [linaro-7.3-2018.05 revision d29120a424ecfbc167ef90065c0eeb7f91977701] (Linaro GCC 7.3-2018.05) ) #4 SMP PREEMPT Tue Dec 18 16:44:01 CET 2018 [ 0.000000] Boot CPU: AArch64 Processor [51af8014] [ 0.000000] Machine: Qualcomm Technologies, Inc. APQ 8098 V2.1 mediabox [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] Reserved memory: reserved region for node 'removed_regions@85800000': base 0x0000000085800000, size 55 MiB [ 0.000000] Reserved memory: reserved region for node 'pil_ipa_gpu_region@95200000': base 0x0000000095200000, size 1 MiB [ 0.000000] Reserved memory: reserved region for node 'pil_slpi_region@94300000': base 0x0000000094300000, size 15 MiB [ 0.000000] Reserved memory: reserved region for node 'pil_mba_region@94100000': base 0x0000000094100000, size 2 MiB [ 0.000000] Reserved memory: reserved region for node 'pil_video_region@93c00000': base 0x0000000093c00000, size 5 MiB [ 0.000000] Reserved memory: reserved region for node 'modem_region@8cc00000': base 0x000000008cc00000, size 112 MiB [ 0.000000] Reserved memory: reserved region for node 'pil_adsp_region@0x8b200000': base 0x000000008b200000, size 26 MiB [ 0.000000] Reserved memory: reserved region for node 'spss_region@8ab00000': base 0x000000008ab00000, size 7 MiB [ 0.000000] Reserved memory: reserved region for node 'splash_region@9d600000': base 0x000000009d400000, size 36 MiB [ 0.000000] Reserved memory: allocated memory for 'qseecom_region' node: base 0x00000000fe800000, size 20 MiB [ 0.000000] Reserved memory: created CMA memory pool at 0x00000000fe800000, size 20 MiB [ 0.000000] Reserved memory: initialized node qseecom_region, compatible id shared-dma-pool [ 0.000000] Reserved memory: allocated memory for 'adsp_region' node: base 0x00000000fe000000, size 8 MiB [ 0.000000] Reserved memory: created CMA memory pool at 0x00000000fe000000, size 8 MiB [ 0.000000] Reserved memory: initialized node adsp_region, compatible id shared-dma-pool [ 0.000000] Reserved memory: allocated memory for 'sp_region' node: base 0x00000000fd800000, size 8 MiB [ 0.000000] Reserved memory: created CMA memory pool at 0x00000000fd800000, size 8 MiB [ 0.000000] Reserved memory: initialized node sp_region, compatible id shared-dma-pool [ 0.000000] Reserved memory: allocated memory for 'secure_region' node: base 0x00000000f7c00000, size 92 MiB [ 0.000000] Reserved memory: created CMA memory pool at 0x00000000f7c00000, size 92 MiB [ 0.000000] Reserved memory: initialized node secure_region, compatible id shared-dma-pool [ 0.000000] Reserved memory: allocated memory for 'linux,cma' node: base 0x00000000f5c00000, size 32 MiB [ 0.000000] Reserved memory: created CMA memory pool at 0x00000000f5c00000, size 32 MiB [ 0.000000] Reserved memory: initialized node linux,cma, compatible id shared-dma-pool [ 0.000000] Removed memory: created DMA memory pool at 0x0000000085800000, size 55 MiB [ 0.000000] Reserved memory: initialized node removed_regions@85800000, compatible id removed-dma-pool [ 0.000000] Removed memory: created DMA memory pool at 0x000000008ab00000, size 7 MiB [ 0.000000] Reserved memory: initialized node spss_region@8ab00000, compatible id removed-dma-pool [ 0.000000] Removed memory: created DMA memory pool at 0x000000008b200000, size 26 MiB [ 0.000000] Reserved memory: initialized node pil_adsp_region@0x8b200000, compatible id removed-dma-pool [ 0.000000] Removed memory: created DMA memory pool at 0x000000008cc00000, size 112 MiB [ 0.000000] Reserved memory: initialized node modem_region@8cc00000, compatible id removed-dma-pool [ 0.000000] Removed memory: created DMA memory pool at 0x0000000093c00000, size 5 MiB [ 0.000000] Reserved memory: initialized node pil_video_region@93c00000, compatible id removed-dma-pool [ 0.000000] Removed memory: created DMA memory pool at 0x0000000094100000, size 2 MiB [ 0.000000] Reserved memory: initialized node pil_mba_region@94100000, compatible id removed-dma-pool [ 0.000000] Removed memory: created DMA memory pool at 0x0000000094300000, size 15 MiB [ 0.000000] Reserved memory: initialized node pil_slpi_region@94300000, compatible id removed-dma-pool [ 0.000000] Removed memory: created DMA memory pool at 0x0000000095200000, size 1 MiB [ 0.000000] Reserved memory: initialized node pil_ipa_gpu_region@95200000, compatible id removed-dma-pool [ 0.000000] On node 0 totalpages: 984256 [ 0.000000] DMA zone: 7300 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 467200 pages, LIFO batch:31 [ 0.000000] Normal zone: 8079 pages used for memmap [ 0.000000] Normal zone: 517056 pages, LIFO batch:31 [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv1.0 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: Initializing psci_cpu_init [ 0.000000] psci: Initializing psci_cpu_init [ 0.000000] psci: Initializing psci_cpu_init [ 0.000000] psci: Initializing psci_cpu_init [ 0.000000] psci: Initializing psci_cpu_init [ 0.000000] psci: Initializing psci_cpu_init [ 0.000000] psci: Initializing psci_cpu_init [ 0.000000] PERCPU: Embedded 21 pages/cpu @ffffffc0fdb5a000 s45856 r8192 d31968 u86016 [ 0.000000] pcpu-alloc: s45856 r8192 d31968 u86016 alloc=21*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [0] 4 [0] 5 [0] 6 [0] 7 [ 0.000000] CPU features: enabling workaround for Kryo2xx Silver erratum 845719 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 968877 [ 0.000000] Kernel command line: rcupdate.rcu_expedited=1 console=ttyMSM0,115200,n8 ignore_loglevel trace_event=ufs:*,scsi:*,regulator:*,power:clock_state,power:clock_set_parent,power:clock_set_rate_complete,power:clock_set_rate,power:clock_disable,power:clock_enable tp_printk androidboot.bootdevice=1da4000.ufshc androidboot.serialno=53733c35 androidboot.baseband=apq mdss_mdp.panel=1:hdmi:16 [ 0.000000] log_buf_len individual max cpu contribution: 131072 bytes [ 0.000000] log_buf_len total cpu_extra contributions: 917504 bytes [ 0.000000] log_buf_len min size: 131072 bytes [ 0.000000] log_buf_len: 1048576 bytes [ 0.000000] early log buf free: 124332(94%) [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes) [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.000000] software IO TLB [mem 0xf1c00000-0xf5c00000] (64MB) mapped at [ffffffc071c00000-ffffffc075bfffff] [ 0.000000] Memory: 3569584K/3937024K available (3518K kernel code, 688K rwdata, 1924K rodata, 8064K init, 2892K bss, 203600K reserved, 163840K cma-reserved) [ 0.000000] Virtual kernel memory layout: [ 0.000000] modules : 0xffffff8000000000 - 0xffffff8008000000 ( 128 MB) [ 0.000000] vmalloc : 0xffffff8008000000 - 0xffffffbdbfff0000 ( 246 GB) [ 0.000000] .init : 0xffffff80085e0000 - 0xffffff8008dc0000 ( 8064 KB) [ 0.000000] .text : 0xffffff8008080000 - 0xffffff80083f0000 ( 3520 KB) [ 0.000000] .rodata : 0xffffff80083f0000 - 0xffffff80085e0000 ( 1984 KB) [ 0.000000] .data : 0xffffff8008dc0000 - 0xffffff8008e6c0b8 ( 689 KB) [ 0.000000] vmemmap : 0xffffffbdc0000000 - 0xffffffbfc0000000 ( 8 GB maximum) [ 0.000000] 0xffffffbdc0000000 - 0xffffffbdc3f8f000 ( 63 MB actual) [ 0.000000] fixed : 0xffffffbffe7fd000 - 0xffffffbffec00000 ( 4108 KB) [ 0.000000] PCI I/O : 0xffffffbffee00000 - 0xffffffbfffe00000 ( 16 MB) [ 0.000000] memory : 0xffffffc000000000 - 0xffffffc0fe3c0000 ( 4067 MB) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1 [ 0.000000] HMP scheduling enabled. [ 0.000000] Preemptible hierarchical RCU implementation. [ 0.000000] [ 0.000000] ********************************************************** [ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.000000] ** ** [ 0.000000] ** trace_printk() being used. Allocating extra memory. ** [ 0.000000] ** ** [ 0.000000] ** This means that this is a DEBUG kernel and it is ** [ 0.000000] ** unsafe for production use. ** [ 0.000000] ** ** [ 0.000000] ** If you see this message and you are not debugging ** [ 0.000000] ** the kernel, report this immediately to your vendor! ** [ 0.000000] ** ** [ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.000000] ********************************************************** [ 0.000000] NR_IRQS:64 nr_irqs:64 0 [ 0.000000] Architected cp15 and mmio timer(s) running at 19.20MHz (virt/virt). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns [ 0.000003] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns [ 0.000011] clocksource: Switched to clocksource arch_sys_counter [ 0.001825] Console: colour dummy device 80x25 [ 0.011353] allocated 25165824 bytes of page_ext [ 0.013662] Node 0, zone DMA: page owner found early allocated 256 pages [ 0.019678] Node 0, zone Normal: page owner found early allocated 6775 pages [ 0.021930] kmemleak: Kernel memory leak detector disabled [ 0.021951] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000) [ 0.021958] pid_max: default: 32768 minimum: 301 [ 0.022209] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.022224] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.023957] Initializing cgroup subsys freezer [ 0.023977] Initializing cgroup subsys debug [ 0.024644] /cpus/cpu@0: Missing clock-frequency property [ 0.024652] /cpus/cpu@1: Missing clock-frequency property [ 0.024659] /cpus/cpu@2: Missing clock-frequency property [ 0.024668] /cpus/cpu@3: Missing clock-frequency property [ 0.024678] /cpus/cpu@100: Missing clock-frequency property [ 0.024687] /cpus/cpu@101: Missing clock-frequency property [ 0.024697] /cpus/cpu@102: Missing clock-frequency property [ 0.024708] /cpus/cpu@103: Missing clock-frequency property [ 0.024713] CPU0: update cpu_capacity 1024 [ 0.024796] ASID allocator initialised with 65536 entries [ 0.024959] NOHZ: local_softirq_pending 02 [ 0.043839] CPU1: update cpu_capacity 1024 [ 0.043886] CPU1: Booted secondary processor [51af8014] [ 0.052393] CPU2: update cpu_capacity 1024 [ 0.052436] CPU2: Booted secondary processor [51af8014] [ 0.061083] CPU3: update cpu_capacity 1024 [ 0.061126] CPU3: Booted secondary processor [51af8014] [ 0.070269] CPU4: update cpu_capacity 1024 [ 0.070356] CPU4: Booted secondary processor [51af8001] [ 0.079712] CPU5: update cpu_capacity 1024 [ 0.079789] CPU5: Booted secondary processor [51af8001] [ 0.089362] CPU6: update cpu_capacity 1024 [ 0.089441] CPU6: Booted secondary processor [51af8001] [ 0.099350] CPU7: update cpu_capacity 1024 [ 0.099432] CPU7: Booted secondary processor [51af8001] [ 0.099569] Brought up 8 CPUs [ 0.099601] SMP: Total of 8 processors activated. [ 0.099607] CPU features: detected feature: GIC system register CPU interface [ 0.100156] CPU: All CPU(s) started at EL1 [ 0.100225] alternatives: patching kernel code [ 0.100534] CPU7: update max cpu_capacity 1024 [ 0.101765] devtmpfs: initialized [ 0.110108] CPU0: update max cpu_capacity 1024 [ 1.197643] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 1.197738] futex hash table entries: 2048 (order: 5, 131072 bytes) [ 1.241356] pinctrl core: initialized pinctrl subsystem [ 1.244167] regulator_enable: name=regulator-dummy [ 1.252765] schedtune: init normalization constants... [ 1.252781] schedtune: disabled! [ 1.256066] cpuidle: using governor ladder [ 1.256120] cpuidle: using governor menu [ 1.256168] cpuidle: using governor qcom [ 1.256394] vdso: 2 pages (1 code @ ffffff80083f5000, 1 data @ ffffff8008dc4000) [ 1.260681] DMA: preallocated 256 KiB pool for atomic allocations [ 1.320555] unable to find DT imem DLOAD mode node [ 1.322551] unable to find DT imem EDLOAD mode node [ 1.327427] sps:sps is ready. [ 1.356840] platform soc:qcom,msm-adsprpc-mem: assigned reserved memory node adsp_region [ 1.359727] msm_rpm_dev_probe: APSS-RPM communication over GLINK [ 1.410564] mpm: set wake is null [ 1.410586] glink_smem_native_probe: enable_irq_wake() failed on 24 [ 1.413561] mpm: set wake is null [ 1.413580] glink_smem_native_probe: enable_irq_wake() failed on 25 [ 1.417354] mpm: set wake is null [ 1.417373] glink_smem_native_probe: enable_irq_wake() failed on 26 [ 1.420161] mpm: set wake is null [ 1.420180] glink_rpm_native_probe: enable_irq_wake() failed on 27 [ 1.421056] msm_rpm_trans_notify_state: glink config params: transport=(null), edge=rpm, name=rpm_requests [ 1.423212] mpm: set wake is null [ 1.423231] glink_mailbox_probe: enable_irq_wake() failed on 28 [ 1.441791] platform 17300000.qcom,lpass: assigned reserved memory node pil_adsp_region@0x8b200000 [ 1.444263] platform 4080000.qcom,mss: assigned reserved memory node modem_region@8cc00000 [ 1.477600] platform 5c00000.qcom,ssc: assigned reserved memory node pil_slpi_region@94300000 [ 1.478912] platform cce0000.qcom,venus: assigned reserved memory node pil_video_region@93c00000 [ 1.481319] platform 1d0101c.qcom,spss: assigned reserved memory node spss_region@8ab00000 [ 1.648926] irq: no irq domain found for /soc/qcom,mdss_mdp@c900000 ! [ 1.685245] irq: no irq domain found for /soc/qcom,sde_kms@c900000 ! [ 1.688990] irq: no irq domain found for /soc/qcom,hdmi_tx_8998@c9a0000 ! [ 1.705096] regulator_set_voltage: name=pm8998_s2 (1128000-1128000) [ 1.705114] regulator_set_voltage_complete: name=pm8998_s2, val=1128000 [ 1.706287] regulator_set_voltage: name=pm8998_s3 (1352000-1352000) [ 1.706296] regulator_set_voltage_complete: name=pm8998_s3, val=1352000 [ 1.707486] regulator_set_voltage: name=pm8998_s4 (1800000-1800000) [ 1.707494] regulator_set_voltage_complete: name=pm8998_s4, val=1800000 [ 1.714762] regulator_set_voltage: name=pm8998_s8 (800000-800000) [ 1.714797] regulator_set_voltage_complete: name=pm8998_s8, val=800000 [ 1.727525] regulator_set_voltage: name=pm8998_l1 (880000-880000) [ 1.727554] regulator_set_voltage_complete: name=pm8998_l1, val=880000 [ 1.728545] regulator_enable: name=pm8998_l1 [ 1.728826] regulator_enable_delay: name=pm8998_l1 [ 1.728850] regulator_enable_complete: name=pm8998_l1 [ 1.731768] regulator_set_voltage: name=pm8998_l2 (1200000-1200000) [ 1.731798] regulator_set_voltage_complete: name=pm8998_l2, val=1200000 [ 1.732689] regulator_enable: name=pm8998_l2 [ 1.732954] regulator_enable_delay: name=pm8998_l2 [ 1.732976] regulator_enable_complete: name=pm8998_l2 [ 1.735854] regulator_set_voltage: name=pm8998_l3 (1000000-1000000) [ 1.735882] regulator_set_voltage_complete: name=pm8998_l3, val=1000000 [ 1.745559] regulator_set_voltage: name=pm8998_l5 (800000-800000) [ 1.745588] regulator_set_voltage_complete: name=pm8998_l5, val=800000 [ 1.748963] regulator_set_voltage: name=pm8998_l6 (1808000-1808000) [ 1.748990] regulator_set_voltage_complete: name=pm8998_l6, val=1808000 [ 1.752456] regulator_set_voltage: name=pm8998_l7 (1800000-1800000) [ 1.752484] regulator_set_voltage_complete: name=pm8998_l7, val=1800000 [ 1.755368] regulator_set_voltage: name=pm8998_l7_pin_ctrl (1800000-1800000) [ 1.755395] regulator_set_voltage_complete: name=pm8998_l7_pin_ctrl, val=1800000 [ 1.758936] regulator_set_voltage: name=pm8998_l8 (1200000-1200000) [ 1.758963] regulator_set_voltage_complete: name=pm8998_l8, val=1200000 [ 1.768927] regulator_set_voltage: name=pm8998_l11 (1000000-1000000) [ 1.768955] regulator_set_voltage_complete: name=pm8998_l11, val=1000000 [ 1.772290] regulator_set_voltage: name=pm8998_l12 (1800000-1800000) [ 1.772319] regulator_set_voltage_complete: name=pm8998_l12, val=1800000 [ 1.779081] regulator_set_voltage: name=pm8998_l14 (1880000-1880000) [ 1.779110] regulator_set_voltage_complete: name=pm8998_l14, val=1880000 [ 1.780017] regulator_enable: name=pm8998_l14 [ 1.780689] regulator_enable_delay: name=pm8998_l14 [ 1.780714] regulator_enable_complete: name=pm8998_l14 [ 1.783608] regulator_set_voltage: name=pm8998_l15 (1800000-1800000) [ 1.783636] regulator_set_voltage_complete: name=pm8998_l15, val=1800000 [ 1.786971] regulator_set_voltage: name=pm8998_l16 (2704000-2704000) [ 1.786998] regulator_set_voltage_complete: name=pm8998_l16, val=2704000 [ 1.790351] regulator_set_voltage: name=pm8998_l17 (1304000-1304000) [ 1.790379] regulator_set_voltage_complete: name=pm8998_l17, val=1304000 [ 1.793554] regulator_set_voltage: name=pm8998_l17_pin_ctrl (1304000-1304000) [ 1.793581] regulator_set_voltage_complete: name=pm8998_l17_pin_ctrl, val=1304000 [ 1.796858] regulator_set_voltage: name=pm8998_l18 (2704000-2704000) [ 1.796886] regulator_set_voltage_complete: name=pm8998_l18, val=2704000 [ 1.800412] regulator_set_voltage: name=pm8998_l19 (3008000-3008000) [ 1.800440] regulator_set_voltage_complete: name=pm8998_l19, val=3008000 [ 1.803736] regulator_set_voltage: name=pm8998_l20 (2960000-2960000) [ 1.803763] regulator_set_voltage_complete: name=pm8998_l20, val=2960000 [ 1.807169] regulator_set_voltage: name=pm8998_l21 (2960000-2960000) [ 1.807195] regulator_set_voltage_complete: name=pm8998_l21, val=2960000 [ 1.810620] regulator_set_voltage: name=pm8998_l22 (2864000-2864000) [ 1.810648] regulator_set_voltage_complete: name=pm8998_l22, val=2864000 [ 1.813941] regulator_set_voltage: name=pm8998_l23 (3312000-3312000) [ 1.813968] regulator_set_voltage_complete: name=pm8998_l23, val=3312000 [ 1.817700] pm8998_l24: supplied by pm8998_l12 [ 1.827400] regulator_set_voltage: name=pm8998_l26 (1200000-1200000) [ 1.827430] regulator_set_voltage_complete: name=pm8998_l26, val=1200000 [ 1.837071] regulator_set_voltage: name=pm8998_l28 (3008000-3008000) [ 1.837100] regulator_set_voltage_complete: name=pm8998_l28, val=3008000 [ 1.863974] clock_set_rate: cnoc_periph_a_clk state=4294967295 cpu_id=4 [ 1.864250] clock_set_rate_complete: cnoc_periph_a_clk state=4294967295 cpu_id=4 [ 1.864517] clock_set_rate: bimc_clk state=4294967295 cpu_id=4 [ 1.864883] clock_set_rate_complete: bimc_clk state=4294967295 cpu_id=4 [ 1.865120] clock_set_rate: bimc_a_clk state=4294967295 cpu_id=4 [ 1.865142] clock_set_rate_complete: bimc_a_clk state=4294967295 cpu_id=4 [ 1.866299] clock_set_rate: cnoc_clk state=4294967295 cpu_id=4 [ 1.866649] clock_set_rate_complete: cnoc_clk state=4294967295 cpu_id=4 [ 1.866894] clock_set_rate: cnoc_a_clk state=4294967295 cpu_id=4 [ 1.866915] clock_set_rate_complete: cnoc_a_clk state=4294967295 cpu_id=4 [ 1.877854] clock_set_rate: ce1_clk state=85710000 cpu_id=4 [ 1.877987] clock_set_rate_complete: ce1_clk state=85710000 cpu_id=4 [ 1.888764] clock_set_rate: snoc_clk state=4294967295 cpu_id=4 [ 1.889178] clock_set_rate_complete: snoc_clk state=4294967295 cpu_id=4 [ 1.889555] clock_set_rate: snoc_a_clk state=4294967295 cpu_id=4 [ 1.889578] clock_set_rate_complete: snoc_a_clk state=4294967295 cpu_id=4 [ 1.891815] regulator_set_voltage: name=pm8998_s1_level (384-384) [ 1.891845] regulator_set_voltage_complete: name=pm8998_s1_level, val=384 [ 1.891871] regulator_enable: name=pm8998_s1_level [ 1.892110] regulator_enable_delay: name=pm8998_s1_level [ 1.892133] regulator_enable_complete: name=pm8998_s1_level [ 1.892181] regulator_set_voltage: name=pm8998_s1_level_ao (384-384) [ 1.892208] regulator_set_voltage_complete: name=pm8998_s1_level_ao, val=384 [ 1.892230] regulator_enable: name=pm8998_s1_level_ao [ 1.892251] regulator_enable_delay: name=pm8998_s1_level_ao [ 1.892267] regulator_enable_complete: name=pm8998_s1_level_ao [ 1.894488] clock_enable: gpll0_out_main state=1 cpu_id=4 [ 1.931786] branch_clk_handoff: gcc_mss_mnoc_bimc_axi_clk clock is enabled in HW even though ENABLE_BIT is not set [ 1.934860] clock_set_rate: cnoc_periph_keepalive_a_clk state=19200000 cpu_id=4 [ 1.934884] clock_set_rate: cnoc_periph_a_clk state=19200000 cpu_id=4 [ 1.935229] clock_set_rate_complete: cnoc_periph_a_clk state=19200000 cpu_id=4 [ 1.935254] clock_set_rate_complete: cnoc_periph_keepalive_a_clk state=19200000 cpu_id=4 [ 1.935281] clock_enable: gcc_bimc_gfx_clk state=1 cpu_id=4 [ 1.935347] qcom,gcc-8998 100000.qcom,gcc: Registered GCC clocks [ 1.937100] regulator_set_voltage: name=pm8998_s9_level (384-384) [ 1.937131] regulator_set_voltage_complete: name=pm8998_s9_level, val=384 [ 1.937157] regulator_enable: name=pm8998_s9_level [ 1.937462] regulator_enable_delay: name=pm8998_s9_level [ 1.937484] regulator_enable_complete: name=pm8998_s9_level [ 1.937535] regulator_set_voltage: name=pm8998_s1_level (384-384) [ 1.937562] regulator_set_voltage_complete: name=pm8998_s1_level, val=384 [ 1.942918] clock_enable: mmsscc_gpll0 state=1 cpu_id=4 [ 1.996585] qcom,mmsscc-8998 c8c0000.qcom,mmsscc: Registered MMSS clocks. [ 1.997640] regulator_set_voltage: name=pm8998_s1_level (384-384) [ 1.997677] regulator_set_voltage_complete: name=pm8998_s1_level, val=384 [ 1.998208] clock_enable: gpucc_xo state=1 cpu_id=4 [ 2.008596] qcom,gpucc-8998 5065000.qcom,gpucc: Registered GPU clocks (barring gfx3d clocks) [ 2.051665] socinfo_print: v0.11, id=319, ver=2.1, raw_id=98, raw_ver=2, hw_plat=8, hw_plat_ver=65536 [ 2.051665] accessory_chip=0, hw_plat_subtype=1, pmic_model=65556, pmic_die_revision=131072 foundry_id=3 serial_number=329995814 num_pmics=3 [ 2.051728] msm_bus_fabric_init_driver [ 2.196585] clock_set_rate: gcc_ufs_axi_clk state=50000000 cpu_id=6 [ 2.196623] clock_set_rate: ufs_axi_clk_src state=50000000 cpu_id=6 [ 2.196665] clock_set_rate_complete: ufs_axi_clk_src state=50000000 cpu_id=6 [ 2.196687] clock_set_rate_complete: gcc_ufs_axi_clk state=50000000 cpu_id=6 [ 2.196767] clock_set_rate: ipa_clk state=1 cpu_id=6 [ 2.196906] clock_set_rate_complete: ipa_clk state=1 cpu_id=6 [ 2.196933] clock_enable: gcc_sdcc2_ahb_clk state=1 cpu_id=6 [ 2.196958] clock_enable: gcc_sdcc4_ahb_clk state=1 cpu_id=6 [ 2.196980] clock_enable: gcc_blsp1_ahb_clk state=1 cpu_id=6 [ 2.197012] clock_disable: gcc_blsp1_ahb_clk state=0 cpu_id=6 [ 2.197033] clock_disable: gcc_sdcc4_ahb_clk state=0 cpu_id=6 [ 2.197053] clock_disable: gcc_sdcc2_ahb_clk state=0 cpu_id=6 [ 2.197097] msm_bus_dev_init_qos: Skipping QOS init for 1 [ 2.197233] msm-bus-type fab-mnoc: Error: Failed to get regulator clk-camss-ahb-no-rate:-517 [ 2.197333] msm-bus-type fab-mnoc: Error: Failed to get regulator clk-camss-ahb-no-rate:-517 [ 2.197440] fab-mnoc supply clk-mdss-ahb-no-rate not found, using dummy regulator [ 2.197700] clock_enable: mmss_mdss_ahb_clk state=1 cpu_id=6 [ 2.198570] enable_nodeclk: failed to enable clk [ 2.198670] msm-bus-type fab-mnoc: Error: Failed to get regulator clk-camss-ahb-no-rate:-517 [ 2.198762] msm-bus-type fab-mnoc: Error: Failed to get regulator clk-camss-ahb-no-rate:-517 [ 2.198849] msm-bus-type fab-mnoc: Error: Failed to get regulator clk-camss-ahb-no-rate:-517 [ 2.198933] msm-bus-type fab-mnoc: Error: Failed to get regulator clk-camss-ahb-no-rate:-517 [ 2.199019] msm_bus_dev_init_qos: Skipping QOS init for 727 [ 2.204450] rear_vana_regulator: supplied by pm8998_bob [ 2.209401] SCSI subsystem initialized [ 2.210974] msm-cpufreq soc:qcom,msm-cpufreq: probe deferral not supported [ 2.234672] gdsc_vfe0: supplied by gdsc_camss_top [ 2.236823] gdsc_vfe1: supplied by gdsc_camss_top [ 2.239182] gdsc_cpp: supplied by gdsc_camss_top [ 2.242111] regulator_enable: name=gdsc_mdss [ 2.242164] regulator_enable_delay: name=gdsc_mdss [ 2.242184] regulator_enable_complete: name=gdsc_mdss [ 2.247391] dev-cpufreq: No tables parsed from DT. [ 2.255446] clocksource: Switched to clocksource arch_sys_counter [ 3.523460] vmscan: error setting kswapd cpu affinity mask [ 3.619631] io scheduler noop registered [ 3.622486] io scheduler cfq registered (default) [ 3.664634] <SSR> glink_ssr_probe: Could not register SSR notifier cb [ 3.664726] msm_glink_ssr: probe of soc:qcom,glink-ssr-modem failed with error -22 [ 3.664953] <SSR> glink_ssr_probe: Could not register SSR notifier cb [ 3.665031] msm_glink_ssr: probe of soc:qcom,glink-ssr-adsp failed with error -22 [ 3.665246] <SSR> glink_ssr_probe: Could not register SSR notifier cb [ 3.665320] msm_glink_ssr: probe of soc:qcom,glink-ssr-dsps failed with error -22 [ 3.665534] <SSR> glink_ssr_probe: Could not register SSR notifier cb [ 3.665606] msm_glink_ssr: probe of soc:qcom,glink-ssr-rpm failed with error -22 [ 3.665818] <SSR> glink_ssr_probe: Could not register SSR notifier cb [ 3.665889] msm_glink_ssr: probe of soc:qcom,glink-ssr-spss failed with error -22 [ 3.671304] mpm: set wake is null [ 3.671325] msm_smp2p_probe: enable_irq_wake() failed on 6 (edge 1) [ 3.671894] mpm: set wake is null [ 3.671911] msm_smp2p_probe: enable_irq_wake() failed on 7 (edge 2) [ 3.672517] mpm: set wake is null [ 3.672534] msm_smp2p_probe: enable_irq_wake() failed on 8 (edge 3) [ 3.678146] qiib_parse_node: Could not register SSR notifier cb [ 3.678189] qsee_ipc_irq_bridge_probe:qiib_parse_node failed 0 [ 3.678364] qsee_ipc_irq_bridge: probe of soc:qcom,qsee_ipc_irq_bridge failed with error -22 [ 3.681516] msm_serial c1b0000.serial: msm_serial: detected port #0 [ 3.681715] msm_serial c1b0000.serial: uartclk = 0 [ 3.681834] c1b0000.serial: ttyMSM0 at MMIO 0xc1b0000 (irq = 11, base_baud = 0) is a MSM [ 3.681863] msm_serial: console setup on port #0 [ 3.681902] clock_set_rate: gcc_blsp2_uart2_apps_clk state=3686400 cpu_id=5 [ 3.681933] clock_set_rate: blsp2_uart2_apps_clk_src state=3686400 cpu_id=5 [ 3.681963] clock_enable: gpll0_early_div state=1 cpu_id=5 [ 3.681998] clock_set_rate_complete: blsp2_uart2_apps_clk_src state=3686400 cpu_id=5 [ 3.682018] clock_set_rate_complete: gcc_blsp2_uart2_apps_clk state=3686400 cpu_id=5 [ 6.075666] console [ttyMSM0] enabled [ 6.086562] msm_serial: driver initialized [ 6.091216] uart_tx_gpio is not available [ 6.091256] uart_rx_gpio is not available [ 6.094925] uart_cts_gpio is not available [ 6.098918] uart_rfr_gpio is not available [ 6.105935] sps: BAM device 0x000000000c144000 is not registered yet. [ 6.108962] sps:BAM 0x000000000c144000 is registered.clock_set_rate: gcc_blsp1_uart3_apps_clk state=7372800 cpu_id=5 [ 6.118214] clock_set_rate: blsp1_uart3_apps_clk_src state=7372800 cpu_id=5 [ 6.124179] clock_set_rate_complete: blsp1_uart3_apps_clk_src state=7372800 cpu_id=5 [ 6.130837] clock_set_rate_complete: gcc_blsp1_uart3_apps_clk state=7372800 cpu_id=5 [ 6.139274] clock_set_rate: aggre2_noc_clk state=50000 cpu_id=5 [ 6.146671] clock_set_rate_complete: aggre2_noc_clk state=50000 cpu_id=5 [ 6.152195] clock_set_rate: aggre2_noc_a_clk state=50000 cpu_id=5 [ 6.159363] clock_set_rate_complete: aggre2_noc_a_clk state=50000 cpu_id=5 [ 6.165876] clock_set_rate: snoc_clk state=50000 cpu_id=5 [ 6.172004] clock_set_rate_complete: snoc_clk state=50000 cpu_id=5 [ 6.177323] clock_set_rate: snoc_a_clk state=50000 cpu_id=5 [ 6.183691] clock_set_rate_complete: snoc_a_clk state=50000 cpu_id=5 [ 6.189596] clock_set_rate: bimc_msmbus_clk state=100000 cpu_id=5 [ 6.195511] clock_set_rate: bimc_clk state=100000 cpu_id=5 [ 6.201593] clock_set_rate_complete: bimc_clk state=100000 cpu_id=5 [ 6.206832] clock_set_rate_complete: bimc_msmbus_clk state=100000 cpu_id=5 [ 6.213039] clock_set_rate: bimc_msmbus_a_clk state=100000 cpu_id=5 [ 6.219939] clock_set_rate: bimc_a_clk state=100000 cpu_id=5 [ 6.226806] clock_set_rate_complete: bimc_a_clk state=100000 cpu_id=5 [ 6.232080] clock_set_rate_complete: bimc_msmbus_a_clk state=100000 cpu_id=5 [ 6.238888] clock_enable: gcc_blsp1_ahb_clk state=1 cpu_id=5 [ 6.245559] clock_enable: blsp1_uart3_apps_clk_src state=1 cpu_id=5 [ 6.251130] clock_enable: gcc_blsp1_uart3_apps_clk state=1 cpu_id=5 [ 6.258282] c171000.uart: ttyHS0 at MMIO 0xc171000 (irq = 335, base_baud = 460800) is a MSM HS UART [ 6.265644] clock_disable: gcc_blsp1_uart3_apps_clk state=0 cpu_id=5 [ 6.272404] clock_disable: blsp1_uart3_apps_clk_src state=0 cpu_id=5 [ 6.279060] clock_disable: gcc_blsp1_ahb_clk state=0 cpu_id=5 [ 6.289231] msm_serial_hs module loaded [ 6.326910] clock_set_rate: gcc_ufs_axi_hw_ctl_clk state=200000000 cpu_id=5 [ 6.327022] clock_set_rate: gcc_ufs_axi_clk state=200000000 cpu_id=5 [ 6.332819] clock_set_rate: ufs_axi_clk_src state=200000000 cpu_id=5 [ 6.339367] clock_set_rate_complete: ufs_axi_clk_src state=200000000 cpu_id=5 [ 6.345712] clock_set_rate_complete: gcc_ufs_axi_clk state=200000000 cpu_id=5 [ 6.352746] clock_set_rate_complete: gcc_ufs_axi_hw_ctl_clk state=200000000 cpu_id=5 [ 6.359846] ufshcd-qcom 1da4000.ufshc: ufshcd_init_clocks: clk: core_clk, rate: 200000000 [ 6.367775] ufshcd-qcom 1da4000.ufshc: ufshcd_init_clocks: clk: bus_aggr_clk, rate: 200000000 [ 6.375866] ufshcd-qcom 1da4000.ufshc: ufshcd_init_clocks: clk: iface_clk, rate: 0 [ 6.384382] clock_set_rate: gcc_ufs_unipro_core_hw_ctl_clk state=150000000 cpu_id=5 [ 6.391733] clock_set_rate_complete: gcc_ufs_unipro_core_hw_ctl_clk state=150000000 cpu_id=5 [ 6.399247] ufshcd-qcom 1da4000.ufshc: ufshcd_init_clocks: clk: core_clk_unipro, rate: 150000000 [ 6.408116] clock_set_rate: gcc_ufs_ice_core_hw_ctl_clk state=300000000 cpu_id=5 [ 6.416725] clock_set_rate_complete: gcc_ufs_ice_core_hw_ctl_clk state=300000000 cpu_id=5 [ 6.424098] ufshcd-qcom 1da4000.ufshc: ufshcd_init_clocks: clk: core_clk_ice, rate: 300000000 [ 6.432347] ufshcd-qcom 1da4000.ufshc: ufshcd_init_clocks: clk: ref_clk, rate: 1000 [ 6.440865] ufshcd-qcom 1da4000.ufshc: ufshcd_init_clocks: clk: tx_lane0_sync_clk, rate: 0 [ 6.448306] ufshcd-qcom 1da4000.ufshc: ufshcd_init_clocks: clk: rx_lane0_sync_clk, rate: 0 [ 6.456707] ufshcd-qcom 1da4000.ufshc: ufshcd_init_clocks: clk: rx_lane1_sync_clk, rate: 0 [ 6.464744] clock_enable: gcc_ufs_axi_hw_ctl_clk state=1 cpu_id=5 [ 6.472969] ufshcd-qcom 1da4000.ufshc: ufshcd_setup_clocks: clk: core_clk enabled [ 6.479096] ufshcd-qcom 1da4000.ufshc: ufshcd_setup_clocks: clk: bus_aggr_clk enabled [ 6.486592] ufshcd-qcom 1da4000.ufshc: ufshcd_setup_clocks: clk: iface_clk enabled [ 6.494401] clock_enable: gcc_ufs_unipro_core_hw_ctl_clk state=1 cpu_id=5 [ 6.501863] ufshcd-qcom 1da4000.ufshc: ufshcd_setup_clocks: clk: core_clk_unipro enabled [ 6.508699] clock_enable: gcc_ufs_ice_core_hw_ctl_clk state=1 cpu_id=5 [ 6.516878] ufshcd-qcom 1da4000.ufshc: ufshcd_setup_clocks: clk: core_clk_ice enabled [ 6.523241] ufshcd-qcom 1da4000.ufshc: ufshcd_setup_clocks: clk: ref_clk enabled [ 6.531124] ufshcd-qcom 1da4000.ufshc: ufshcd_setup_clocks: clk: tx_lane0_sync_clk enabled [ 6.538562] ufshcd-qcom 1da4000.ufshc: ufshcd_setup_clocks: clk: rx_lane0_sync_clk enabled [ 6.546663] ufshcd-qcom 1da4000.ufshc: ufshcd_setup_clocks: clk: rx_lane1_sync_clk enabled [ 6.554943] ufshcd_clk_gating: 1da4000.ufshc: state changed to CLKS_ON [ 6.563164] ufshcd_profile_clk_gating: 1da4000.ufshc: on: took 98420 usecs, err 0 [ 6.570854] regulator_set_voltage: name=pm8998_l20 (2960000-2960000) [ 6.577206] regulator_set_voltage_complete: name=pm8998_l20, val=2960000 [ 6.583686] regulator_enable: name=pm8998_l20 [ 6.590762] regulator_enable_delay: name=pm8998_l20 [ 6.594534] regulator_enable_complete: name=pm8998_l20 [ 6.599227] regulator_set_voltage: name=pm8998_l26 (1200000-1200000) [ 6.604494] regulator_set_voltage_complete: name=pm8998_l26, val=1200000 [ 6.610987] regulator_enable: name=pm8998_l26 [ 6.617956] regulator_enable_delay: name=pm8998_l26 [ 6.621916] regulator_enable_complete: name=pm8998_l26 [ 6.626566] regulator_set_voltage: name=pm8998_s4 (1800000-1800000) [ 6.631818] regulator_set_voltage_complete: name=pm8998_s4, val=1800000 [ 6.637943] regulator_enable: name=pm8998_s4 [ 6.644888] regulator_enable_delay: name=pm8998_s4 [ 6.649039] regulator_enable_complete: name=pm8998_s4 [ 6.653720] ufshcd-qcom 1da4000.ufshc: ufs_qcom_init: ICE device is not enabled [ 6.660614] scm_call failed: func id 0x42000c02, ret: -2, syscall returns: 0xfffffffffffffffc, 0x0, 0x0 [ 6.665926] ufshcd-qcom 1da4000.ufshc: ufs_qcom_update_sec_cfg: failed, ret -22 scm_ret 0 [ 6.675331] ufshcd-qcom 1da4000.ufshc: ufs_qcom_update_sec_cfg: ip: restore_sec_cfg 1, op: restore_sec_cfg 0, ret -22 scm_ret 0 [ 6.686447] ufshcd-qcom 1da4000.ufshc: ufs_qcom_parse_reg_info: Unable to find qcom,vddp-ref-clk-supply regulator, assuming enabled [ 6.696778] regulator_set_voltage: name=pm8998_l1 (880000-880000) [ 6.706763] regulator_set_voltage_complete: name=pm8998_l1, val=880000 [ 6.713296] PHY: [ffffff800ae6cc04] = 00000001 [ 6.719364] regulator_set_voltage: name=pm8998_l2 (1200000-1200000) [ 6.723858] regulator_set_voltage_complete: name=pm8998_l2, val=1200000 [ 6.730297] clock_enable: gcc_ufs_phy_aux_hw_ctl_clk state=1 cpu_id=5 [ 6.736563] regulator_set_voltage: name=pm8998_l26 (1200000-1200000) [ 6.743210] regulator_set_voltage_complete: name=pm8998_l26, val=1200000 [ 6.753321] scsi host0: ufshcd [ 6.763104] PHY: [ffffff800ae6cc04] = 00000001 [ 6.763161] PHY: [ffffff800ae6c15c] = 00000006 [ 6.766468] PHY: [ffffff800ae6c080] = 000000d5 [ 6.770939] PHY: [ffffff800ae6c088] = 00000020 [ 6.775322] PHY: [ffffff800ae6c138] = 00000030 [ 6.779749] PHY: [ffffff800ae6c03c] = 00000002 [ 6.784225] PHY: [ffffff800ae6c034] = 00000004 [ 6.788601] PHY: [ffffff800ae6c00c] = 0000000a [ 6.793064] PHY: [ffffff800ae6c13c] = 00000000 [ 6.797454] PHY: [ffffff800ae6c090] = 00000001 [ 6.801915] PHY: [ffffff800ae6c0ec] = 00000000 [ 6.806311] PHY: [ffffff800ae6c154] = 00000000 [ 6.810765] PHY: [ffffff800ae6c0f0] = 00000004 [ 6.815164] PHY: [ffffff800ae6c164] = 00000005 [ 6.819589] PHY: [ffffff800ae6c048] = 0000000f [ 6.824046] PHY: [ffffff800ae6c104] = 000000ff [ 6.828444] PHY: [ffffff800ae6c108] = 00000000 [ 6.832897] PHY: [ffffff800ae6c0b0] = 00000082 [ 6.837301] PHY: [ffffff800ae6c060] = 00000006 [ 6.841753] PHY: [ffffff800ae6c068] = 00000016 [ 6.846152] PHY: [ffffff800ae6c070] = 00000036 [ 6.850609] PHY: [ffffff800ae6c0d8] = 0000003f [ 6.855006] PHY: [ffffff800ae6c0dc] = 00000000 [ 6.859434] PHY: [ffffff800ae6c0f4] = 000000da [ 6.863885] PHY: [ffffff800ae6c0f8] = 00000001 [ 6.868286] PHY: [ffffff800ae6c098] = 000000ff [ 6.872747] PHY: [ffffff800ae6c09c] = 0000000c [ 6.877141] PHY: [ffffff800ae6c0b4] = 00000098 [ 6.881595] PHY: [ffffff800ae6c064] = 00000006 [ 6.885996] PHY: [ffffff800ae6c06c] = 00000016 [ 6.890691] PHY: [ffffff800ae6c074] = 00000036 [ 6.894851] PHY: [ffffff800ae6c0e0] = 0000003f [ 6.899276] PHY: [ffffff800ae6c0e4] = 00000000 [ 6.903746] PHY: [ffffff800ae6c0fc] = 000000c1 [ 6.908131] PHY: [ffffff800ae6c100] = 00000000 [ 6.912589] PHY: [ffffff800ae6c0a4] = 00000032 [ 6.916986] PHY: [ffffff800ae6c0a8] = 0000000f [ 6.921439] PHY: [ffffff800ae6c48c] = 00000006 [ 6.925841] PHY: [ffffff800ae6c708] = 00000024 [ 6.930294] PHY: [ffffff800ae6c704] = 0000000f [ 6.934696] PHY: [ffffff800ae6c70c] = 0000001e [ 6.939121] PHY: [ffffff800ae6c71c] = 00000040 [ 6.943579] PHY: [ffffff800ae6c630] = 0000000b [ 6.947976] PHY: [ffffff800ae6c67c] = 0000005b [ 6.952431] PHY: [ffffff800ae6c6d4] = 00000006 [ 6.956828] PHY: [ffffff800ae6c6d8] = 00000004 [ 6.961283] PHY: [ffffff800ae6c6dc] = 0000001d [ 6.965684] PHY: [ffffff800ae6c624] = 00000004 [ 6.970138] PHY: [ffffff800ae6c628] = 00000004 [ 6.974539] PHY: [ffffff800ae6c62c] = 00000004 [ 6.978963] PHY: [ffffff800ae6c634] = 0000004b [ 6.983418] PHY: [ffffff800ae6c644] = 00000081 [ 6.987819] PHY: [ffffff800ae6c63c] = 00000080 [ 6.992273] PHY: [ffffff800ae6c88c] = 00000006 [ 6.996674] PHY: [ffffff800ae6cb08] = 00000024 [ 7.001125] PHY: [ffffff800ae6cb04] = 0000000f [ 7.005526] PHY: [ffffff800ae6cb0c] = 0000001e [ 7.009954] PHY: [ffffff800ae6cb1c] = 00000040 [ 7.014414] PHY: [ffffff800ae6ca30] = 0000000b [ 7.018808] PHY: [ffffff800ae6ca7c] = 0000005b [ 7.023263] PHY: [ffffff800ae6cad4] = 00000006 [ 7.027660] PHY: [ffffff800ae6cad8] = 00000004 [ 7.032118] PHY: [ffffff800ae6cadc] = 0000001d [ 7.036515] PHY: [ffffff800ae6ca24] = 00000004 [ 7.040981] PHY: [ffffff800ae6ca28] = 00000004 [ 7.045371] PHY: [ffffff800ae6ca2c] = 00000004 [ 7.049799] PHY: [ffffff800ae6ca34] = 0000004b [ 7.054252] PHY: [ffffff800ae6ca44] = 00000081 [ 7.058652] PHY: [ffffff800ae6ca3c] = 00000080 [ 7.063104] PHY: [ffffff800ae6cdc4] = 00000002 [ 7.067504] PHY: [ffffff800ae6cd40] = 0000006e [ 7.071959] PHY: [ffffff800ae6cc2c] = 0000000a [ 7.076360] PHY: [ffffff800ae6cc34] = 00000002 [ 7.080814] PHY: [ffffff800ae6cd34] = 00000003 [ 7.085215] PHY: [ffffff800ae6cdbc] = 00000043 [ 7.089639] PHY: [ffffff800ae6cd3c] = 0000000f [ 7.094094] PHY: [ffffff800ae6cd38] = 0000009a [ 7.098495] PHY: [ffffff800ae6c0f0] = 00000044 [ 7.104115] PHY: [ffffff800ae6cc00] = 00000001 [ 7.121125] PHY: [ffffff800ae6cd30] = 00000000 [ 7.129026] SCSI Media Changer driver v0.25 [ 7.130556] msm_sharedmem: sharedmem_register_qmi: Creating sharedmem_qmi qmi handle failed [ 7.132789] sharedmem_qmi_w (94) used greatest stack depth: 14400 bytes left [ 7.140666] ufshcd-qcom 1da4000.ufshc: ufshcd_print_pwr_info:[RX, TX]: gear=[1, 1], lane[1, 1], pwr[SLOWAUTO_MODE, SLOWAUTO_MODE], rate = 0 [ 7.147960] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.160072] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.172186] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.172830] msm_sharedmem: msm_sharedmem_probe: Device created for client 'rmtfs' [ 7.196348] bimc-bwmon 1008000.qcom,cpu-bwmon: BW HWmon governor registered. [ 7.210803] clock_set_rate: bimc_msmbus_a_clk state=99876864 cpu_id=4 [ 7.210898] clock_set_rate: bimc_a_clk state=99876864 cpu_id=4 [ 7.216684] clock_set_rate_complete: bimc_a_clk state=99876864 cpu_id=4 [ 7.222079] clock_set_rate_complete: bimc_msmbus_a_clk state=99876864 cpu_id=4 [ 7.228573] clock_set_rate: bimc_msmbus_a_clk state=1803943936 cpu_id=4 [ 7.235914] clock_set_rate: bimc_a_clk state=1803943936 cpu_id=4 [ 7.243545] clock_set_rate_complete: bimc_a_clk state=1803943936 cpu_id=4 [ 7.248543] clock_set_rate_complete: bimc_msmbus_a_clk state=1803943936 cpu_id=4 [ 7.255286] devfreq soc:qcom,cpubw: Couldn't update frequency transition information. [ 7.274584] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available [ 7.290175] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.290359] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.300150] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.311887] Registered cp15_barrier emulation handler [ 7.311947] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.312608] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.312678] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.313542] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.314604] regulator_set_voltage: name=pm8998_l26 (1200000-1200000) [ 7.314628] regulator_set_voltage_complete: name=pm8998_l26, val=1200000 [ 7.314800] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.315247] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.315315] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.315963] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.316015] ufshcd_auto_bkops_state: 1da4000.ufshc: state changed to OFF [ 7.318596] clock_set_rate: aggre1_noc_clk state=262144000 cpu_id=5 [ 7.318738] clock_set_rate_complete: aggre1_noc_clk state=262144000 cpu_id=5 [ 7.318755] clock_set_rate: aggre1_noc_a_clk state=262144000 cpu_id=5 [ 7.319043] clock_set_rate_complete: aggre1_noc_a_clk state=262144000 cpu_id=5 [ 7.319794] clock_set_rate: snoc_clk state=262144000 cpu_id=5 [ 7.320209] clock_set_rate_complete: snoc_clk state=262144000 cpu_id=5 [ 7.320227] clock_set_rate: snoc_a_clk state=262144000 cpu_id=5 [ 7.320240] clock_set_rate_complete: snoc_a_clk state=262144000 cpu_id=5 [ 7.320960] clock_set_rate: bimc_msmbus_clk state=401080320 cpu_id=5 [ 7.320975] clock_set_rate: bimc_clk state=401080320 cpu_id=5 [ 7.321091] clock_set_rate_complete: bimc_clk state=401080320 cpu_id=5 [ 7.321104] clock_set_rate_complete: bimc_msmbus_clk state=401080320 cpu_id=5 [ 7.322511] clock_set_rate: cnoc_clk state=51200000 cpu_id=5 [ 7.322626] clock_set_rate_complete: cnoc_clk state=51200000 cpu_id=5 [ 7.322641] clock_set_rate: cnoc_a_clk state=51200000 cpu_id=5 [ 7.322891] clock_set_rate_complete: cnoc_a_clk state=51200000 cpu_id=5 [ 7.322925] ufshcd-qcom 1da4000.ufshc: ufshcd_print_pwr_info:[RX, TX]: gear=[3, 3], lane[2, 2], pwr[FAST MODE, FAST MODE], rate = 2 [ 7.322957] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.323016] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.323082] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.323097] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.323150] ufshcd-qcom 1da4000.ufshc: ufshcd_init_icc_levels: setting icc_level 0xf [ 7.323176] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.323190] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.324960] ufshcd-qcom 1da4000.ufshc: ufshcd_set_queue_depth: activate tcq with queue depth 1 [ 7.325244] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49488 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 00 00 00 24 00) [ 7.325325] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.325340] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.325389] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49488 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 00 00 00 24 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.325556] scsi 0:0:0:49488: Well-known LUN SAMSUNG KLUCG4J1EB-B0B1 0200 PQ: 0 ANSI: 6 [ 7.325746] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49488 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 00 00 ff 00) [ 7.325807] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.325821] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.325847] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49488 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 00 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.326087] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49488 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 80 00 ff 00) [ 7.326141] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.326157] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.326196] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49488 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 80 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.326421] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49488 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 83 00 ff 00) [ 7.326471] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.326485] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.326509] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49488 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 83 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.332776] ufshcd-qcom 1da4000.ufshc: ufshcd_set_queue_depth: activate tcq with queue depth 1 [ 7.332972] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49456 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 00 00 00 24 00) [ 7.333059] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.333075] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.333104] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49456 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 00 00 00 24 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.333248] scsi 0:0:0:49456: Well-known LUN SAMSUNG KLUCG4J1EB-B0B1 0200 PQ: 0 ANSI: 6 [ 7.333426] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49456 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 00 00 ff 00) [ 7.333486] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.333501] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.333525] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49456 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 00 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.333771] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49456 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 80 00 ff 00) [ 7.333826] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.333843] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.333865] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49456 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 80 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.334096] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49456 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 83 00 ff 00) [ 7.334152] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.334166] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.334190] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49456 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 83 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.339595] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.339612] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.339666] ufshcd-qcom 1da4000.ufshc: ufshcd_set_queue_depth: activate tcq with queue depth 32 [ 7.339843] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49476 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 00 00 00 24 00) [ 7.339919] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.339934] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.339963] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49476 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 00 00 00 24 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.340150] scsi 0:0:0:49476: Well-known LUN SAMSUNG KLUCG4J1EB-B0B1 0200 PQ: 0 ANSI: 6 [ 7.340324] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49476 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 00 00 ff 00) [ 7.340385] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.340400] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.340428] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49476 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 00 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.340672] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49476 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 80 00 ff 00) [ 7.340730] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.340746] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.340769] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49476 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 80 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.340996] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=49476 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 83 00 ff 00) [ 7.341047] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.341062] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.341085] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=49476 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 83 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.346353] ufshcd_init: 1da4000.ufshc: took 225252 usecs, dev_state: ACTIVE, link_state: LINK_ACTIVE, err 0 [ 7.346374] ufshcd_clk_gating: 1da4000.ufshc: state changed to REQ_CLKS_OFF [ 7.348038] ufshcd_clk_gating: 1da4000.ufshc: state changed to CLKS_ON [ 7.348069] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.348787] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.348809] ufshcd_clk_gating: 1da4000.ufshc: state changed to REQ_CLKS_OFF [ 7.348824] ufshcd-qcom 1da4000.ufshc: ufshcd_set_queue_depth: activate tcq with queue depth 32 [ 7.348928] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 00 00 00 24 00) [ 7.348935] ufshcd_clk_gating: 1da4000.ufshc: state changed to CLKS_ON [ 7.348961] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.348981] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.348986] ufshcd_clk_gating: 1da4000.ufshc: state changed to REQ_CLKS_OFF [ 7.349007] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 00 00 00 24 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.349157] scsi 0:0:0:0: Direct-Access SAMSUNG KLUCG4J1EB-B0B1 0200 PQ: 0 ANSI: 6 [ 7.349220] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 00 00 ff 00) [ 7.349227] ufshcd_clk_gating: 1da4000.ufshc: state changed to CLKS_ON [ 7.349253] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.349274] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.349279] ufshcd_clk_gating: 1da4000.ufshc: state changed to REQ_CLKS_OFF [ 7.349307] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 00 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.349387] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 80 00 ff 00) [ 7.349393] ufshcd_clk_gating: 1da4000.ufshc: state changed to CLKS_ON [ 7.349421] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.349452] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.349458] ufshcd_clk_gating: 1da4000.ufshc: state changed to REQ_CLKS_OFF [ 7.349487] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 80 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.349578] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 83 00 ff 00) [ 7.349583] ufshcd_clk_gating: 1da4000.ufshc: state changed to CLKS_ON [ 7.349610] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.349630] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x12 [ 7.349637] ufshcd_clk_gating: 1da4000.ufshc: state changed to REQ_CLKS_OFF [ 7.349669] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=0 data_sgl=1 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(INQUIRY - raw=12 01 83 00 ff 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.349774] scsi_dispatch_cmd_start: host_no=0 channel=0 id=0 lun=0 data_sgl=2 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(REPORT_LUNS - raw=a0 00 00 00 00 00 00 00 10 00 00 00) [ 7.349780] ufshcd_clk_gating: 1da4000.ufshc: state changed to CLKS_ON [ 7.349808] ufshcd_command: send: 1da4000.ufshc: tag: 0, DB: 0x1, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0xa0 [ 7.349830] ufshcd_command: complete: 1da4000.ufshc: tag: 0, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0xa0 [ 7.349837] ufshcd_clk_gating: 1da4000.ufshc: state changed to REQ_CLKS_OFF [ 7.349868] scsi_dispatch_cmd_done: host_no=0 channel=0 id=0 lun=0 data_sgl=2 prot_sgl=0 prot_op=SCSI_PROT_NORMAL cmnd=(REPORT_LUNS - raw=a0 00 00 00 00 00 00 00 10 00 00 00) result=(driver=DRIVER_OK host=DID_OK message=COMMAND_COMPLETE status=SAM_STAT_GOOD) [ 7.351414] ufshcd_clk_gating: 1da4000.ufshc: state changed to CLKS_ON [ 7.351433] ufshcd_command: send: 1da4000.ufshc: tag: 31, DB: 0x80000000, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.352150] ufshcd_command: dcmp: 1da4000.ufshc: tag: 31, DB: 0x0, size: -1, IS: 0, LBA: 18446744073709551615, opcode: 0x0 [ 7.352171] ufshcd_clk_gating: 1da4000.ufshc: state changed to REQ_CLKS_OFF ...
