T265 not enumerating correctly after boot

jmachuca77 commented 5 years ago

Required Info
Camera Model	T265
Firmware Version	0.0.18.5715
Operating System & Version	Nvidia Jetpack 4.2.1
Kernel Version (Linux Only)	4.9.140-tegra
Platform	Nvidia Xavier/Nano/TX2
SDK Version	2.25.0
Language	N/A
Segment	N/A

Issue Description

Possibly related to #4284 When booting up a system the T265 is enumerated on the USB bus as 03e7:2150 which I believe is the Movidius Chip, so when trying to use the camera with any script like rs-enumerate-devices or rs-pose I get an error:

() $ rs-enumerate-devices 
No device detected. Is it plugged in?

() $ rs-pose
RealSense error calling rs2_pipeline_start_with_config(pipe:0x558d0bffe0, config:0x558d09f5e0):
    No device connected

This is the sequence of events after boot: Running lsusb, rs-enumerate-devices and then lsusb again.

() $ lsusb
Bus 002 Device 002: ID 2109:0813 VIA Labs, Inc. 
Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 001 Device 004: ID 2dae:1011  
Bus 001 Device 003: ID 03e7:2150  
Bus 001 Device 002: ID 2109:2813 VIA Labs, Inc. 
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub

() $ rs-enumerate-devices 
No device detected. Is it plugged in?

() $ lsusb
Bus 002 Device 002: ID 2109:0813 VIA Labs, Inc. 
Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 001 Device 004: ID 2dae:1011  
Bus 001 Device 003: ID 03e7:2150  
Bus 001 Device 002: ID 2109:2813 VIA Labs, Inc. 
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub

After unplugging and replugging the camera I get the correct behavior and everything works as expected

This the output from lsusb after replugging the camera, then rs-enumerate-devices, and then lsusb again:

() $ lsusb
Bus 002 Device 002: ID 2109:0813 VIA Labs, Inc. 
Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 001 Device 004: ID 2dae:1011  
Bus 001 Device 005: ID 03e7:2150  
Bus 001 Device 002: ID 2109:2813 VIA Labs, Inc. 
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub

() $ rs-enumerate-devices 
Device info: 
    Name                          :     Intel RealSense T265
    Serial Number                 :     845412110624
    Firmware Version              :     0.0.18.5715
    Physical Port                 :     vid_8087 pid_0B37 bus_2 port_1
    Product Id                    :     0B37
    Product Line                  :     T200

Stream Profiles supported by Tracking Module
 Supported modes:
    stream       resolution      fps       format   
    Fisheye 1     848x800   @ 30Hz     Y8
    Fisheye 2     848x800   @ 30Hz     Y8
    Gyro     N/A        @ 200Hz    MOTION_XYZ32F
    Accel    N/A        @ 62Hz     MOTION_XYZ32F
    Pose     N/A        @ 200Hz    6DOF

() $ lsusb
Bus 002 Device 003: ID 8087:0b37 Intel Corp. 
Bus 002 Device 002: ID 2109:0813 VIA Labs, Inc. 
Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 001 Device 004: ID 2dae:1011  
Bus 001 Device 002: ID 2109:2813 VIA Labs, Inc. 
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub

This is the output from dmesg, Initial detection of the device is at [ 12.274866] camera is un-plugged and re-plugged in at [ 148.021150] and I believe rs-enumerate-device triggers the second usb disconnect at [ 165.684438] after which the camera is detected correctly:

() $ dmesg
[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 4.9.140-tegra (root@AIONio-FlashXavier) (gcc version 7.4.0 (Ubuntu/Linaro 7.4.0-1ubuntu1~18.04.1) ) #1 SMP PREEMPT Thu Jul 4 12:43:11 MDT 2019
[    0.000000] Boot CPU: AArch64 Processor [4e0f0040]
[    0.000000] OF: fdt:memory scan node memory, reg size 48,
[    0.000000] OF: fdt: - 80000000 ,  2b000000
[    0.000000] OF: fdt: - ab200000 ,  3da00000
[    0.000000] OF: fdt: - 100000000 ,  380000000
[    0.000000] earlycon: tegra_comb_uart0 at MMIO32 0x000000000c168000 (options '')
[    0.000000] bootconsole [tegra_comb_uart0] enabled
[    0.000000] Found vpr, start=0xf0000000 size=8000000
[    0.000000] OF: fdt:Reserved memory: failed to reserve memory for node 'fb0_carveout': base 0x0000000000000000, size 0 MiB
[    0.000000] OF: fdt:Reserved memory: failed to reserve memory for node 'fb0_carveout': base 0x0000000000000000, size 0 MiB
[    0.000000] OF: fdt:Reserved memory: failed to reserve memory for node 'fb1_carveout': base 0x0000000000000000, size 0 MiB
[    0.000000] OF: fdt:Reserved memory: failed to reserve memory for node 'fb1_carveout': base 0x0000000000000000, size 0 MiB
[    0.000000] OF: fdt:Reserved memory: failed to reserve memory for node 'fb2_carveout': base 0x0000000000000000, size 0 MiB
[    0.000000] OF: fdt:Reserved memory: failed to reserve memory for node 'fb2_carveout': base 0x0000000000000000, size 0 MiB
[    0.000000] OF: fdt:Reserved memory: failed to reserve memory for node 'fb3_carveout': base 0x0000000000000000, size 0 MiB
[    0.000000] OF: fdt:Reserved memory: failed to reserve memory for node 'fb3_carveout': base 0x0000000000000000, size 0 MiB
[    0.000000] OF: reserved mem: initialized node ramoops_carveout, compatible id nvidia,ramoops
[    0.000000] OF: reserved mem: initialized node grid-of-semaphores, compatible id nvidia,gosmem
[    0.000000] cma: Reserved 64 MiB at 0x00000000e4800000
[    0.000000] On node 0 totalpages: 4098048
[    0.000000]   DMA zone: 6688 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 428032 pages, LIFO batch:31
[    0.000000]   Normal zone: 57344 pages used for memmap
[    0.000000]   Normal zone: 3670016 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: SMC Calling Convention v1.1
[    0.000000] percpu: Embedded 23 pages/cpu @ffffffc3ffda7000 s53400 r8192 d32616 u94208
[    0.000000] pcpu-alloc: s53400 r8192 d32616 u94208 alloc=23*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [0] 4 [0] 5 [0] 6 [0] 7 
[    0.000000] Speculative Store Bypass Disable mitigation not required
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 4034016
[    0.000000] Kernel command line: root=/dev/mmcblk0p1 rw rootwait console=ttyTCU0,115200n8 console=tty0 fbcon=map:0 net.ifnames=0 rootfstype=ext4 video=tegrafb no_console_suspend=1 earlycon=tegra_comb_uart,mmio32,0x0c168000 gpt usbcore.old_scheme_first=1 tegraid=19.1.2.0.0 maxcpus=8 boot.slot_suffix= boot.ratchetvalues=0.2.2 vpr=0x8000000@0xf0000000 sdhci_tegra.en_boot_part_access=1  
[    0.000000] log_buf_len individual max cpu contribution: 32768 bytes
[    0.000000] log_buf_len total cpu_extra contributions: 229376 bytes
[    0.000000] log_buf_len min size: 32768 bytes
[    0.000000] log_buf_len: 262144 bytes
[    0.000000] early log buf free: 29204(89%)
[    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[    0.000000] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes)
[    0.000000] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes)
[    0.000000] Memory: 16002756K/16392192K available (15166K kernel code, 2914K rwdata, 6836K rodata, 8512K init, 605K bss, 323900K reserved, 65536K cma-reserved)
[    0.000000] Virtual kernel memory layout:
[    0.000000]     modules : 0xffffff8000000000 - 0xffffff8008000000   (   128 MB)
[    0.000000]     vmalloc : 0xffffff8008000000 - 0xffffffbebfff0000   (   250 GB)
[    0.000000]       .text : 0xffffff8008080000 - 0xffffff8008f50000   ( 15168 KB)
[    0.000000]     .rodata : 0xffffff8008f50000 - 0xffffff8009610000   (  6912 KB)
[    0.000000]       .init : 0xffffff8009610000 - 0xffffff8009e60000   (  8512 KB)
[    0.000000]       .data : 0xffffff8009e60000 - 0xffffff800a138808   (  2915 KB)
[    0.000000]        .bss : 0xffffff800a138808 - 0xffffff800a1cfe3c   (   606 KB)
[    0.000000]     fixed   : 0xffffffbefe7fd000 - 0xffffffbefec00000   (  4108 KB)
[    0.000000]     PCI I/O : 0xffffffbefee00000 - 0xffffffbeffe00000   (    16 MB)
[    0.000000]     vmemmap : 0xffffffbf00000000 - 0xffffffc000000000   (     4 GB maximum)
[    0.000000]               0xffffffbf00000000 - 0xffffffbf10000000   (   256 MB actual)
[    0.000000]     memory  : 0xffffffc000000000 - 0xffffffc400000000   ( 16384 MB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
[    0.000000] Preemptible hierarchical RCU implementation.
[    0.000000]  Build-time adjustment of leaf fanout to 64.
[    0.000000]  RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=8.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=8
[    0.000000] NR_IRQS:64 nr_irqs:64 0
[    0.000000] GIC: Using split EOI/Deactivate mode
[    0.000000] arm_arch_timer: Architected cp15 timer(s) running at 31.25MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xe6a171046, max_idle_ns: 881590405314 ns
[    0.000007] sched_clock: 56 bits at 31MHz, resolution 32ns, wraps every 4398046511088ns
[    0.009454] Console: colour dummy device 80x25
[    0.012431] console [tty0] enabled
[    0.015884] bootconsole [tegra_comb_uart0] disabled
[    0.021037] kmemleak: Kernel memory leak detector disabled
[    0.021133] Calibrating delay loop (skipped), value calculated using timer frequency.. 62.50 BogoMIPS (lpj=125000)
[    0.021184] pid_max: default: 32768 minimum: 301
[    0.022861] Security Framework initialized
[    0.023616] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.023744] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.026114] ftrace: allocating 46802 entries in 183 pages
[    0.520409] sched-energy: Sched-energy-costs installed from DT
[    0.520580] ASID allocator initialised with 65536 entries
[    0.563611] tegra-id: chipid=21917.
[    0.563685] tegra-id: opt_subrevision=0.
[    0.563775] Tegra Revision: A02 SKU: 0xd0 CPU Process: 0 SoC Process: 0
[    0.563886] DTS File Name: /dvs/git/dirty/git-master_linux/kernel/kernel-4.9/arch/arm64/boot/dts/../../../../../../hardware/nvidia/platform/t19x/galen/kernel-dts/common/tegra194-p2888-0001-p2822-0000-common.dtsi
[    0.563978] DTB Build time: Mar 13 2019 00:34:33
[    0.611826] CPU1: Booted secondary processor [4e0f0040]
[    0.643752] CPU2: Booted secondary processor [4e0f0040]
[    0.676288] CPU3: Booted secondary processor [4e0f0040]
[    0.708738] CPU4: Booted secondary processor [4e0f0040]
[    0.740987] CPU5: Booted secondary processor [4e0f0040]
[    0.773732] CPU6: Booted secondary processor [4e0f0040]
[    0.805748] CPU7: Booted secondary processor [4e0f0040]
[    0.806805] Brought up 8 CPUs
[    0.807332] SMP: Total of 8 processors activated.
[    0.807384] CPU features: detected feature: Privileged Access Never
[    0.807438] CPU features: detected feature: LSE atomic instructions
[    0.807497] CPU features: detected feature: User Access Override
[    0.807549] CPU features: detected feature: 32-bit EL0 Support
[    0.813263] CPU: All CPU(s) started at EL2
[    0.813488] alternatives: patching kernel code
[    0.827591] devtmpfs: initialized
[    0.916850] Initilizing CustomIPI irq domain
[    0.917315] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.917416] futex hash table entries: 2048 (order: 5, 131072 bytes)
[    0.919234] pinctrl core: initialized pinctrl subsystem
[    0.919528] OS set in device tree is not L4T.
[    0.919883] regulator-dummy: no parameters
[    0.920290] Initializing plugin-manager
[    0.920386] Plugin module not found
[    0.920460] Plugin-manager status disabled
[    0.922245] NET: Registered protocol family 16
[    0.930690] pstore: using zlib compression
[    0.932251] console [pstore-1] enabled
[    0.932297] pstore: Registered ramoops as persistent store backend
[    0.932359] ramoops: attached 0x200000@0xe8a00000, ecc: 0/0
[    0.942228] cpuidle: using governor menu
[    0.943855] bpmp: waiting for handshake
[    0.943911] bpmp: handshake completed
[    0.944014] bpmp: synchronizing channels
[    0.944067] bpmp: channels synchronized
[    0.944120] bpmp: mail init ok
[    0.948676] t19x-arm-smmu 12000000.iommu: found 3 SMMUs and ISO SMMU id is 2
[    0.949099] t19x-arm-smmu 12000000.iommu: probing hardware configuration...
[    0.949171] t19x-arm-smmu 12000000.iommu: SMMUv2 with:
[    0.949228] t19x-arm-smmu 12000000.iommu:    stage 1 translation
[    0.949289] t19x-arm-smmu 12000000.iommu:    stage 2 translation
[    0.949348] t19x-arm-smmu 12000000.iommu:    nested translation
[    0.949422] t19x-arm-smmu 12000000.iommu:    stream matching with 128 register groups, mask 0x7f80
[    0.949545] t19x-arm-smmu 12000000.iommu: SMMU address space size (0x800000) differs from mapped region size (0x1000000)!
[    0.949651] t19x-arm-smmu 12000000.iommu:    64 context banks (0 stage-2 only)
[    0.949719] t19x-arm-smmu 12000000.iommu:    Stage-1: 39-bit VA -> 48-bit IPA
[    0.949790] t19x-arm-smmu 12000000.iommu:    Stage-2: 39-bit IPA -> 48-bit PA
[    0.955881] vdso: 2 pages (1 code @ ffffff8008f57000, 1 data @ ffffff8009e64000)
[    0.956491] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.960946] atomic_pool_init():622: DMA: preallocated 1024 KiB pool for atomic allocations
[    0.962495] Registering BPMP clocks...
[    0.962725] tegra_bpmp_clk_init: clock init ok (395 clks)
[    0.963258] tegra_bpmp_of_clk_init: EMC proxy not found.
[    0.963781] tegra_powergate_init: DONE
[    0.963978] DTS File Name: /dvs/git/dirty/git-master_linux/kernel/kernel-4.9/arch/arm64/boot/dts/../../../../../../hardware/nvidia/platform/t19x/galen/kernel-dts/common/tegra194-p2888-0001-p2822-0000-common.dtsi
[    0.964133] DTB Build time: Mar 13 2019 00:34:33
[    0.968424] Tegra reboot handler registered.
[    0.978934] iommu: Adding device 14180000.pcie to group 0
[    0.979997] iommu: Adding device 14100000.pcie to group 1
[    0.981116] iommu: Adding device 14140000.pcie to group 2
[    0.982160] iommu: Adding device 141a0000.pcie to group 3
[    0.984256] iommu: Adding device 2490000.ether_qos to group 4
[    0.985110] iommu: Adding device 3100000.serial to group 5
[    0.985916] iommu: Adding device 3110000.serial to group 6
[    0.986578] iommu: Adding device 3140000.serial to group 7
[    0.987480] tegra-pmc c360000.pmc: scratch reg offset dts data not present
[    0.987800] tegra-pmc: get_secure_pmc_setting: done secure_pmc=0
[    0.987896] tegra-pmc: ### PMC reset source: TEGRA_SOFTWARE_RESET
[    0.987958] tegra-pmc: ### PMC reset level: TEGRA_RESET_LEVEL_L1
[    0.988029] tegra-pmc: ### PMC reset status reg: 0x2d
[    0.988177] tegra-pmc: PMC Prod config success
[    0.988526] padctrl padctrl.0: Pad control driver tegra-pmc-padctrl registered
[    0.988625] tegra-pmc c360000.pmc: IO padctrl driver initialized
[    0.989252] iommu: Adding device 3460000.sdhci to group 8
[    0.990061] iommu: Adding device 3400000.sdhci to group 9
[    0.990926] iommu: Adding device 2450000.ufshci to group 10
[    0.991738] iommu: Adding device c260000.spi to group 11
[    0.992897] iommu: Adding device 3160000.i2c to group 12
[    0.993508] iommu: Adding device c240000.i2c to group 13
[    0.994117] iommu: Adding device 3180000.i2c to group 14
[    0.994753] iommu: Adding device 3190000.i2c to group 15
[    0.995570] iommu: Adding device 31b0000.i2c to group 16
[    0.996160] iommu: Adding device 31c0000.i2c to group 17
[    0.996840] iommu: Adding device c250000.i2c to group 18
[    0.997460] iommu: Adding device 31e0000.i2c to group 19
[    0.998649] iommu: Adding device sound to group 20
[    0.999472] iommu: Adding device 3510000.hda to group 21
[    1.000325] iommu: Adding device bc00000.rtcpu to group 22
[    1.003478] iommu: Adding device 13e10000.host1x to group 23
[    1.004141] iommu: Adding device 13e10000.host1x:ctx0 to group 24
[    1.004731] iommu: Adding device 13e10000.host1x:ctx1 to group 25
[    1.005322] iommu: Adding device 13e10000.host1x:ctx2 to group 26
[    1.005940] iommu: Adding device 13e10000.host1x:ctx3 to group 27
[    1.006568] iommu: Adding device 13e10000.host1x:ctx4 to group 28
[    1.007217] iommu: Adding device 13e10000.host1x:ctx5 to group 29
[    1.007824] iommu: Adding device 13e10000.host1x:ctx6 to group 30
[    1.008434] iommu: Adding device 13e10000.host1x:ctx7 to group 31
[    1.009318] iommu: Adding device 15340000.vic to group 32
[    1.009967] iommu: Adding device 15380000.nvjpg to group 33
[    1.010641] iommu: Adding device 15500000.tsec to group 34
[    1.011141] iommu: Adding device 15100000.tsecb to group 35
[    1.011595] iommu: Adding device 15480000.nvdec to group 36
[    1.012080] iommu: Adding device 15140000.nvdec1 to group 37
[    1.012569] iommu: Adding device 154c0000.nvenc to group 38
[    1.013017] iommu: Adding device 15a80000.nvenc1 to group 39
[    1.013684] iommu: Adding device 15880000.nvdla0 to group 40
[    1.014324] iommu: Adding device 158c0000.nvdla1 to group 41
[    1.015223] iommu: Adding device 15200000.nvdisplay to group 42
[    1.016804] platform 15200000.nvdisplay: IOVA linear map 0x00000000f0000000(8000000)
[    1.016886] t19x-arm-smmu: Adding 15200000.nvdisplay to ISO SMMU client
[    1.017591] iommu: Adding device 15210000.nvdisplay to group 43
[    1.017700] t19x-arm-smmu: Adding 15210000.nvdisplay to ISO SMMU client
[    1.018306] iommu: Adding device 15220000.nvdisplay to group 44
[    1.018411] t19x-arm-smmu: Adding 15220000.nvdisplay to ISO SMMU client
[    1.021392] iommu: Adding device 15c10000.vi to group 45
[    1.021710] t19x-arm-smmu: Adding 15c10000.vi to ISO SMMU client
[    1.022319] iommu: Adding device 14800000.isp to group 46
[    1.024368] iommu: Adding device 16000000.pva0 to group 47
[    1.025199] iommu: Adding device 16800000.pva1 to group 48
[    1.025827] iommu: Adding device 15810000.se to group 49
[    1.026458] iommu: Adding device 15820000.se to group 50
[    1.026869] iommu: Adding device 15830000.se to group 51
[    1.027362] iommu: Adding device 15840000.se to group 52
[    1.027795] iommu: Adding device c1a0000.aon to group 53
[    1.029813] iommu: Adding device d000000.bpmp to group 54
[    1.030336] bpmp: ping status is 0
[    1.030533] bpmp d000000.bpmp: firmware tag is 1c1b2165fe52a0a54ad7caf60d40cdc3
[    1.034509] bpmp d000000.bpmp: probe ok
[    1.036603] tegra-reset 0.bpmp_reset: registered 186 resets.
[    1.037385] iommu: Adding device smmu_test to group 55
[    1.038880] mc: mapped MMIO address: 0xffffff800a590000 -> 0x2c10000
[    1.038977] mc: mapped MMIO address: 0xffffff800a5b0000 -> 0x2c20000
[    1.039075] mc: mapped MMIO address: 0xffffff800a5d0000 -> 0x2c30000
[    1.039168] mc: mapped MMIO address: 0xffffff800a7b0000 -> 0x2c40000
[    1.039300] mc: mapped MMIO address: 0xffffff800a7d0000 -> 0x2c50000
[    1.039395] mc: mapped MMIO address: 0xffffff800b010000 -> 0x2b80000
[    1.039483] mc: mapped MMIO address: 0xffffff800b030000 -> 0x2b90000
[    1.039569] mc: mapped MMIO address: 0xffffff800b050000 -> 0x2ba0000
[    1.039656] mc: mapped MMIO address: 0xffffff800b070000 -> 0x2bb0000
[    1.039742] mc: mapped MMIO address: 0xffffff800b090000 -> 0x1700000
[    1.039828] mc: mapped MMIO address: 0xffffff800b0b0000 -> 0x1710000
[    1.039913] mc: mapped MMIO address: 0xffffff800b0d0000 -> 0x1720000
[    1.040022] mc: mapped MMIO address: 0xffffff800b0f0000 -> 0x1730000
[    1.040112] mc: mapped MMIO address: 0xffffff800b110000 -> 0x1740000
[    1.040199] mc: mapped MMIO address: 0xffffff800b130000 -> 0x1750000
[    1.040285] mc: mapped MMIO address: 0xffffff800b150000 -> 0x1760000
[    1.040372] mc: mapped MMIO address: 0xffffff800b170000 -> 0x1770000
[    1.040537] mc-err: mcerr ops are set to t19x
[    1.049351] iommu: Adding device 2600000.dma to group 56
[    1.058019] GPIO line 490 (pcie-reg-enable) hogged as output/high
[    1.058128] GPIO line 289 (pcie-reg-enable) hogged as output/high
[    1.058256] GPIO line 339 (wifi-enable) hogged as output/high
[    1.058923] gpiochip_setup_dev: registered GPIOs 288 to 511 on device: gpiochip0 (tegra-gpio)
[    1.070070] GPIO line 253 (pex-refclk-sel-low) hogged as output/low
[    1.070520] gpiochip_setup_dev: registered GPIOs 248 to 287 on device: gpiochip1 (tegra-gpio-aon)
[    1.073943] tegra186-aowake c370000.pmc: WAKE_AOWAKE_CTRL_0 = 3
[    1.074015] tegra186-aowake c370000.pmc: WAKE_AOWAKE_CNTRL_24(PMU_INT) = 256
[    1.075407] iommu: Adding device 3550000.xudc to group 57
[    1.076610] iommu: Adding device 3610000.xhci to group 58
[    1.080125] arm64_ras arm64_ras: probed
[    1.080885] ras_fhi_enable: FHI 477 enabled on CPU0
[    1.081011] ras_fhi_enable: FHI 478 enabled on CPU1
[    1.081202] ras_fhi_enable: FHI 479 enabled on CPU2
[    1.081354] ras_fhi_enable: FHI 480 enabled on CPU3
[    1.081485] ras_fhi_enable: FHI 481 enabled on CPU4
[    1.081687] ras_fhi_enable: FHI 482 enabled on CPU5
[    1.082049] ras_fhi_enable: FHI 483 enabled on CPU6
[    1.082207] ras_fhi_enable: FHI 484 enabled on CPU7
[    1.082574] carmel_ras_enable: RAS enabled on cpu0
[    1.082876] carmel_ras_enable: RAS enabled on cpu1
[    1.083200] carmel_ras_enable: RAS enabled on cpu2
[    1.083487] carmel_ras_enable: RAS enabled on cpu3
[    1.083745] carmel_ras_enable: RAS enabled on cpu4
[    1.083988] carmel_ras_enable: RAS enabled on cpu5
[    1.084274] carmel_ras_enable: RAS enabled on cpu6
[    1.084547] carmel_ras_enable: RAS enabled on cpu7
[    1.084685] carmel_ras carmel_ras: probed
[    1.086512] tegra-cbb 2300000.cbb-noc: noc_secure_irq = 486, noc_nonsecure_irq = 485>
[    1.087369] tegra-cbb c600000.aon-noc: noc_secure_irq = 488, noc_nonsecure_irq = 487>
[    1.088590] tegra-cbb d600000.bpmp-noc: noc_secure_irq = 490, noc_nonsecure_irq = 489>
[    1.089807] tegra-cbb be00000.rce-noc: noc_secure_irq = 492, noc_nonsecure_irq = 491>
[    1.091048] tegra-cbb b600000.sce-noc: noc_secure_irq = 494, noc_nonsecure_irq = 493>
[    1.091716] tegra-cbb 14040000.cv-noc: defer probe as CV-NOC not probed yet
[    1.095511] vdd-3v3-cvb: 3300 mV 
[    1.096005] vdd-1v8-cvb: 1800 mV 
[    1.096571] vdd-1v8-sd: 1800 mV 
[    1.097180] vdd-epb-1v0: supplied by vdd-3v3-cvb
[    1.097267] vdd-epb-1v0: 1000 mV 
[    1.097764] vdd-sdmmc1-sw: 3300 mV 
[    1.098327] avdd-cam-2v8: 2800 mV 
[    1.098793] vdd-sata-1v5: 1500 mV 
[    1.099227] vdd-1v8-slt: 1800 mV 
[    1.099655] vdd-3v3-slt: 3300 mV 
[    1.100140] vdd-fan: 5000 mV 
[    1.100647] vdd-hdmi-5v0: 5000 mV 
[    1.101201] vdd_sys_en: 1200 mV 
[    1.101840] vdd-5v-sata: 5000 mV 
[    1.102413] vdd-ac-bat: 5000 mV 
[    1.102755] vdd-5v-sata: supplied by vdd-ac-bat
[    1.144054] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[    1.150026] eventlib_kernel: keventlib is initialized, test id: 0
[    1.150557] SCSI subsystem initialized
[    1.151087] libata version 3.00 loaded.
[    1.151361] usbcore: registered new interface driver usbfs
[    1.151472] usbcore: registered new interface driver hub
[    1.151684] usbcore: registered new device driver usb
[    1.166464] tegra-i2c 31e0000.i2c: could not find pctldev for node /host1x/dpaux@155F0000/pinmux@0, deferring probe
[    1.169738] max77620 4-003c: PMIC Version OTP:0x51 and ES:0x1
[    1.176670] vdd-1v0: at 1000 mV 
[    1.180674] vdd-1v8-hs: at 1800 mV 
[    1.184715] vdd-1v8-ls: at 1800 mV 
[    1.188805] vdd-1v8-ao: at 1800 mV 
[    1.192847] vddio-ddr-1v1: at 1100 mV 
[    1.196614] vdd-rtc: at 800 mV 
[    1.197887] spmic-ldo1: at 2375 mV 
[    1.204677] vdd-ao-3v3: at 3300 mV 
[    1.212814] vddio-emmc-3v3: at 3300 mV 
[    1.214239] spmic-ldo4: at 1587 mV 
[    1.220915] vdd-usb-3v3: at 3300 mV 
[    1.229257] vddio-sdmmc1-3v3: at 3300 mV 
[    1.233307] vdd-csi-1v2: at 1200 mV 
[    1.234665] spmic-ldo8: at 1800 mV 
[    1.236266] GPIO line 246 (gpio_default) hogged as output/high
[    1.237432] GPIO line 247 (gpio_default) hogged as output/high
[    1.238271] gpiochip_setup_dev: registered GPIOs 240 to 247 on device: gpiochip2 (max77620-gpio)
[    1.242515] max77620 4-003c: max77620 probe successful
[    1.243398] media: Linux media interface: v0.10
[    1.243533] Linux video capture interface: v2.00
[    1.245470] pps_core: LinuxPPS API ver. 1 registered
[    1.245530] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    1.245657] PTP clock support registered
[    1.246643] tegra_wdt_t18x 30c0000.watchdog: Tegra WDT init timeout = 120 sec
[    1.246792] tegra_wdt_t18x 30c0000.watchdog: Registered successfully
[    1.248493] tegra_fiq_debugger_init: found FIQ source (IRQ 469)
[    1.250706] Advanced Linux Sound Architecture Driver Initialized.
[    1.251444] Bluetooth: Core ver 2.22
[    1.251555] NET: Registered protocol family 31
[    1.251642] Bluetooth: HCI device and connection manager initialized
[    1.251723] Bluetooth: HCI socket layer initialized
[    1.251792] Bluetooth: L2CAP socket layer initialized
[    1.251878] Bluetooth: SCO socket layer initialized
[    1.255746] camchar: rtcpu character device driver loaded
[    1.258800] clocksource: Switched to clocksource arch_sys_counter
[    1.325526] VFS: Disk quotas dquot_6.6.0
[    1.325750] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    1.326308] nvmap_heap_init: nvmap_heap_init: created heap block cache
[    1.328434] tegra-carveouts tegra-carveouts: assigned reserved memory node grid-of-semaphores
[    1.328617] tegra-carveouts tegra-carveouts: vpr :dma coherent mem declare 0x00000000f0000000,134217728
[    1.328717] nvmap: nvmap_select_cache_ops() nvmap cache ops set to scf
[    1.328799] nvmap_page_pool_init: Total RAM pages: 4017073
[    1.328861] nvmap_page_pool_init: nvmap page pool size: 502134 pages (1961 MB)
[    1.329283] nvmap_background_zero_thread: PP zeroing thread starting.
[    1.329976] misc nvmap: created heap vpr base 0x00000000f0000000 size (131072KiB)
[    1.332138] tegra-gpcdma 2600000.dma: GPC DMA driver register 31 channels
[    1.350397] thermal thermal_zone0: Registering thermal zone thermal_zone0 for type CPU-therm
[    1.350965] thermal thermal_zone1: Registering thermal zone thermal_zone1 for type GPU-therm
[    1.351432] thermal thermal_zone2: Registering thermal zone thermal_zone2 for type AUX-therm
[    1.351848] thermal thermal_zone3: Registering thermal zone thermal_zone3 for type AO-therm
[    1.352430] thermal thermal_zone4: Registering thermal zone thermal_zone4 for type Tdiode_tegra
[    1.352857] thermal thermal_zone5: Registering thermal zone thermal_zone5 for type PMIC-Die
[    1.353116] thermal thermal_zone6: Registering thermal zone thermal_zone6 for type Tboard_tegra
[    1.354659] la/ptsa driver initialized.
[    1.355226] NET: Registered protocol family 2
[    1.356670] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[    1.357562] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[    1.358370] TCP: Hash tables configured (established 131072 bind 65536)
[    1.358529] UDP hash table entries: 8192 (order: 6, 262144 bytes)
[    1.358932] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes)
[    1.359677] NET: Registered protocol family 1
[    1.360695] RPC: Registered named UNIX socket transport module.
[    1.360757] RPC: Registered udp transport module.
[    1.360803] RPC: Registered tcp transport module.
[    1.360849] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    1.360907] PCI: CLS 0 bytes, default 64
[    1.361203] Trying to unpack rootfs image as initramfs...
[    1.392616] host1x 13e10000.host1x: initialized
[    1.395919] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available
[    1.403114] audit: initializing netlink subsys (disabled)
[    1.403252] audit: type=2000 audit(0.920:1): initialized
[    1.404382] workingset: timestamp_bits=46 max_order=22 bucket_order=0
[    1.424049] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    1.426422] ntfs: driver 2.1.32 [Flags: R/W].
[    1.427552] 9p: Installing v9fs 9p2000 file system support
[    1.434856] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 240)
[    1.435178] io scheduler noop registered
[    1.435599] io scheduler cfq registered (default)
[    1.440640] gic 2a41000.agic-controller: GIC IRQ controller registered
[    1.442104] random: fast init done
[    1.480759] iommu: Adding device 2993000.adsp to group 59
[    1.590568] iommu: Adding device aconnect@2a41000:adsp_audio to group 60
[    1.591963] tegra-aconnect aconnect@2a41000: Tegra ACONNECT bus registered
[    1.611370] tegra-pwm c340000.pwm: PWM clk can sleep in ops
[    1.612141] tegra-pwm 32c0000.pwm: PWM clk can sleep in ops
[    1.612887] tegra-pwm 32f0000.pwm: PWM clk can sleep in ops
[    1.616531] tegra_camera_platform tegra-camera-platform: tegra_camera_probe:camera_platform_driver probe
[    1.616914] misc tegra_camera_ctrl: tegra_camera_isomgr_register tpg_max_iso = 3916800KBs
[    1.617019] misc tegra_camera_ctrl: tegra_camera_isomgr_register isp_iso_bw=4687500, vi_iso_bw=2000000, max_bw=4687500
[    1.622228] tsec 15500000.tsec: initialized
[    1.624769] tsec 15100000.tsecb: initialized
[    1.630489] nvdec 15480000.nvdec: initialized
[    1.634124] nvdec 15140000.nvdec1: initialized
[    1.641702] falcon 15340000.vic: initialized
[    1.644442] falcon 15380000.nvjpg: initialized
[    1.647242] falcon 154c0000.nvenc: initialized
[    1.649830] falcon 15a80000.nvenc1: initialized
[    1.654616] iommu_context_dev 13e10000.host1x:ctx0: initialized (streamid=56)
[    1.658816] iommu_context_dev 13e10000.host1x:ctx1: initialized (streamid=57)
[    1.662906] iommu_context_dev 13e10000.host1x:ctx2: initialized (streamid=58)
[    1.667010] iommu_context_dev 13e10000.host1x:ctx3: initialized (streamid=59)
[    1.669710] iommu_context_dev 13e10000.host1x:ctx4: initialized (streamid=60)
[    1.671867] iommu_context_dev 13e10000.host1x:ctx5: initialized (streamid=61)
[    1.674048] iommu_context_dev 13e10000.host1x:ctx6: initialized (streamid=62)
[    1.676368] iommu_context_dev 13e10000.host1x:ctx7: initialized (streamid=63)
[    1.681506] t194-nvcsi 15a00000.nvcsi: initialized
[    1.688224] scare-pigeon 13e10000.host1x:vi-thi@15f00000: initialized
[    1.688836] scare-pigeon 14b00000.isp-thi: initialized
[    1.699842] pva 16000000.pva0: initialized
[    1.732769] pva 16800000.pva1: initialized
[    1.764620] nvdla 15880000.nvdla0: initialized
[    1.796083] nvdla 158c0000.nvdla1: initialized
[    1.800748] tegra-slvs-ec 15ac0000.slvs-ec: initialized
[    1.801030] tegra-slvs-ec 15ac0000.slvs-ec: no streams defined
[    1.801086] tegra-slvs-ec 15ac0000.slvs-ec: failed to init SLVS media controller (-19)
[    1.801149] tegra-slvs-ec 15ac0000.slvs-ec: probed
[    1.802573] tegradccommon 15200000.dc_common: host1x channel mapped
[    1.802688] tegradccommon 15200000.dc_common: dc_common syncpt # 1 allocated
[    1.802838] tegradccommon 15200000.dc_common: dma mapping done
[    1.804270] tegradc 15200000.nvdisplay: disp0 connected to head0->/host1x/sor2
[    1.804412] generic_infoframe_type: 0x87
[    1.804671] tegradc 15200000.nvdisplay: DT parsed successfully
[    1.804783] tegradc 15200000.nvdisplay: Display dc.ffffff800bdd0000 registered with id=0
[    1.811765] tegra_nvdisp_bandwidth_register_max_config: max config iso bw = 15681600 KB/s
[    1.811857] tegra_nvdisp_bandwidth_register_max_config: max config EMC floor = 1066500000 Hz
[    1.811930] tegra_nvdisp_bandwidth_register_max_config: max config hubclk = 358400000 Hz
[    1.812499] tegradc 15200000.nvdisplay: vblank syncpt # 8 for dc 0
[    1.812556] tegradc 15200000.nvdisplay: vpulse3 syncpt # 9 for dc 0
[    1.816653] tegradc 15200000.nvdisplay: hdmi: invalid prod list prod_list_hdmi_board
[    1.816720] tegradc 15200000.nvdisplay: hdmi: tegra_hdmi_tmds_range_read(bd) failed
[    1.818169] tegra-adma 2930000.adma: Tegra210 ADMA driver registered 16 channels
[    1.819816] tegra-fuse-burn 3820000.efuse:efuse-burn: Fuse burn driver initialized
[    1.821387] kfuse 3830000.kfuse: initialized
[    1.823856] tegradc 15200000.nvdisplay: probed
[    1.842633] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    1.847053] 3100000.serial: ttyTHS0 at MMIO 0x3100000 (irq = 50, base_baud = 0) is a TEGRA_UART
[    1.849138] 3110000.serial: ttyTHS1 at MMIO 0x3110000 (irq = 51, base_baud = 0) is a TEGRA_UART
[    1.850412] 3140000.serial: ttyTHS4 at MMIO 0x3140000 (irq = 52, base_baud = 0) is a TEGRA_UART
[    4.308813] console [ttyTCU0] enabled
[    4.309300] Console: switching to colour frame buffer device 80x30
[    4.309465] [drm] Initialized
[    4.321584] tegradc 15200000.nvdisplay: fb registered
[    4.327581] gpio tegra-gpio wake71 for gpio=98(M:2)
[    4.332552] Could not get extcon-dev /host1x/nvdisplay@15210000:typec0(0)
[    4.334949] brd: module loaded
[    4.341737] Could not get extcon-dev /host1x/nvdisplay@15220000:typec1(1)
[    4.344433] loop: module loaded
[    4.344590] tegra_profiler: version: 1.132, samples/io: 46/26
[    4.344811] tegra_profiler: auth: init
[    4.345500] nct1008_nct72 4-004c: starting parse dt
[    4.345643] nct1008_nct72 4-004c: !!!Found deprecated property!!!
[    4.345652] nct1008_nct72 4-004c: success parsing dt
[    4.345920] nct1008_nct72 4-004c: success in enabling tmp451 VDD rail
[    4.346324] THERMAL EST: found 3 subdevs
[    4.346334] THERMAL EST num_resources: 0
[    4.346342] [THERMAL EST subdev 0]
[    4.346357] [THERMAL EST subdev 1]
[    4.346388] [THERMAL EST subdev 2]
[    4.347029] thermal thermal_zone7: Registering thermal zone thermal_zone7 for type thermal-fan-est
[    4.347032] THERMAL EST: thz register success.
[    4.347335] THERMAL EST: end of probe, return err: 0
[    4.348481] ufs_tegra 2450000.ufshci: freq-table-hz property not specified
[    4.348495] ufs_tegra 2450000.ufshci: ufshcd_populate_vreg: Unable to find vdd-hba-supply regulator, assuming enabled
[    4.349577] ufs_tegra 2450000.ufshci: wakeup init done, cdirq 459
[    4.349594] gpio tegra-gpio-aon wake25 for gpio=32(EE:0)
[    4.364549] scsi host0: ufshcd
[    4.375705] hisi_sas: driver version v1.6
[    4.378570] nct1008_nct72 4-004c: LOC shutdown limit 107
[    4.379612] nct1008_nct72 4-004c: EXT shutdown limit 109
[    4.384538] libphy: Fixed MDIO Bus: probed
[    4.385318] tun: Universal TUN/TAP device driver, 1.6
[    4.385327] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[    4.386384] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k
[    4.386394] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    4.386510] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k
[    4.386516] igb: Copyright (c) 2007-2014 Intel Corporation.
[    4.386592] igbvf: Intel(R) Gigabit Virtual Function Network Driver - version 2.4.0-k
[    4.386599] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[    4.386678] Intel(R) 10GbE PCI Express Linux Network Driver - version 4.6.4
[    4.386684] Copyright(c) 1999 - 2017 Intel Corporation.
[    4.388384] eqos 2490000.ether_qos: no PHY interrupt found
[    4.392590] eqos 2490000.ether_qos: Setting local MAC: 0 4 4b cb 8f 86
[    4.392748] libphy: dwc_phy: probed
[    4.395858] PPP generic driver version 2.4.2
[    4.396190] PPP BSD Compression module registered
[    4.396194] PPP Deflate Compression module registered
[    4.396214] PPP MPPE Compression module registered
[    4.396219] NET: Registered protocol family 24
[    4.396310] usbcore: registered new interface driver r8152
[    4.396378] usbcore: registered new interface driver asix
[    4.396571] usbcore: registered new interface driver ax88179_178a
[    4.396628] usbcore: registered new interface driver cdc_ether
[    4.396678] usbcore: registered new interface driver net1080
[    4.396720] usbcore: registered new interface driver cdc_subset
[    4.396776] usbcore: registered new interface driver zaurus
[    4.396876] usbcore: registered new interface driver cdc_ncm
[    4.397147] VFIO - User Level meta-driver version: 0.3
[    4.398900] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    4.398918] ehci-pci: EHCI PCI platform driver
[    4.398993] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    4.399005] ohci-pci: OHCI PCI platform driver
[    4.399064] ohci-platform: OHCI generic platform driver
[    4.407299] tegra-xusb 3610000.xhci: USB2 port 0 has OTG_CAP
[    4.407306] tegra-xusb 3610000.xhci: USB3 port 2 has OTG_CAP
[    4.410417] Could not get extcon-dev /xhci@3610000:id(0)
[    4.413352] nct1008_nct72 4-004c: initial LOC temp: 34000 
[    4.413961] nct1008_nct72 4-004c: initial EXT temp: 38250 
[    4.414339] usbcore: registered new interface driver uas
[    4.414447] usbcore: registered new interface driver usb-storage
[    4.414560] usbcore: registered new interface driver usbserial
[    4.415015] nct1008_nct72 4-004c: hi_b:-10, lo_b:128
[    4.416150] nct1008_nct72 4-004c: nct1008_probe: initialized
[    4.419453] tegra-xudc-new 3550000.xudc: PMQOS CPU boost enabled
[    4.419549] Could not get extcon-dev /xudc@3550000:vbus(0)
[    4.422688] ucsi_ccg 1-0008: FW1 Version: gn v12.05, [Base 3.1.2.1487]
[    4.422698] ucsi_ccg 1-0008: FW2 Version: gn v12.05, [Base 3.1.2.1487]
[    4.423868] ucsi_ccg 1-0008: fw_mode: 2
[    4.423875] ucsi_ccg 1-0008: fw1_invalid: 0
[    4.423880] ucsi_ccg 1-0008: fw2_invalid: 0
[    4.423886] ucsi_ccg 1-0008: silicon_id: 0x1f00
[    4.424221] ucsi_ccg 1-0008: typec-port0 extcon dev created
[    4.424420] ucsi_ccg 1-0008: typec-port1 extcon dev created
[    4.424591] ucsi_ccg 1-0008: typec-pd extcon dev created
[    4.424802] gpio tegra-gpio-aon wake48 for gpio=10(BB:2)
[    4.428566] ucsi_ccg 1-0008: [typec-port1] Cable state:1, cable id:2
[    4.430770] ucsi_ccg 1-0008: HPI Command Success.
[    4.433410] ucsi_ccg 1-0008: HPI Command Success.
[    4.433435] ucsi_ccg 1-0008: ucsi_ccg_init: complete
[    4.434306] mousedev: PS/2 mouse device common for all mice
[    4.434401] usbcore: registered new interface driver xpad
[    4.569799] max77686-rtc max77620-rtc: rtc core: registered max77620-rtc as rtc0
[    4.572050] Wake73 for irq=42
[    4.573714] rtc rtc1: alarm rtc device
[    4.573736] tegra_rtc c2a0000.rtc: rtc core: registered c2a0000.rtc as rtc1
[    4.573806] tegra_rtc c2a0000.rtc: Tegra internal Real Time Clock
[    4.574124] i2c /dev entries driver
[    4.580197] max77620-power max20024-power: Event recorder REG_NVERC : 0x0
[    4.585687] tegra-bpmp-thermal d000000.bpmp:bpmpthermal: zone 0 not supported
[    4.586104] tegra-bpmp-thermal d000000.bpmp:bpmpthermal: zone 2 not supported
[    4.589409] tegra-thermal-throttle bthrot_cdev: clk:cpu max:2265600000, min:115200000 steps:28
[    4.642015] tegra-thermal-throttle bthrot_cdev: clk:gpu max:1377000000, min:114750000 steps:13
[    4.642072] tegra-thermal-throttle bthrot_cdev: cdev:skin-balanced clk:0:cpu off:0 slope-adj:200
[    4.642080] tegra-thermal-throttle bthrot_cdev: cdev:skin-balanced clk:1:gpu off:0 slope-adj:400
[    4.642315] tegra-thermal-throttle bthrot_cdev: cdev:skin-balanced max_state:56 cutoff:0
[    4.642440] tegra-thermal-throttle bthrot_cdev: cdev:gpu-balanced clk:0:cpu off:0 slope-adj:400
[    4.642448] tegra-thermal-throttle bthrot_cdev: cdev:gpu-balanced clk:1:gpu off:0 slope-adj:400
[    4.642824] tegra-thermal-throttle bthrot_cdev: cdev:gpu-balanced max_state:52 cutoff:1
[    4.642909] tegra-thermal-throttle bthrot_cdev: cdev:cpu-balanced clk:0:cpu off:0 slope-adj:200
[    4.642918] tegra-thermal-throttle bthrot_cdev: cdev:cpu-balanced clk:1:gpu off:365500000 slope-adj:300
[    4.643310] tegra-thermal-throttle bthrot_cdev: cdev:cpu-balanced max_state:56 cutoff:0
[    4.643410] tegra-thermal-throttle bthrot_cdev: cdev:emergency-balanced clk:0:cpu off:38400000 slope-adj:10
[    4.643446] tegra-thermal-throttle bthrot_cdev: cdev:emergency-balanced clk:1:gpu off:25500000 slope-adj:10
[    4.643835] tegra-thermal-throttle bthrot_cdev: cdev:emergency-balanced max_state:2 cutoff:0
[    4.643925] tegra-thermal-throttle bthrot_cdev: cdev:aux-balanced clk:0:cpu off:0 slope-adj:400
[    4.643934] tegra-thermal-throttle bthrot_cdev: cdev:aux-balanced clk:1:gpu off:0 slope-adj:400
[    4.644268] tegra-thermal-throttle bthrot_cdev: cdev:aux-balanced max_state:52 cutoff:1
[    4.645086] FAN dev name: pwm-fan
[    4.645155] FAN:gpio request success.
[    4.645165] FAN: can't find tach_gpio
[    4.645228] pwm_fan_driver pwm-fan: cap state:7, cap pwm:255
[    4.645755] pwm_fan_driver pwm-fan: got pwm for fan. polarity is normal
[    4.645762] pwm_fan_driver pwm-fan: tach period: 1000
[    4.646192] pwm_fan_driver pwm-fan: index 0: pwm=0, rpm=0, rru=40, rrd=40, state:2
[    4.646241] pwm_fan_driver pwm-fan: index 1: pwm=77, rpm=1000, rru=2, rrd=2, state:2
[    4.646249] pwm_fan_driver pwm-fan: index 2: pwm=120, rpm=2000, rru=1, rrd=1, state:2
[    4.646256] pwm_fan_driver pwm-fan: index 3: pwm=160, rpm=3000, rru=1, rrd=1, state:2
[    4.646262] pwm_fan_driver pwm-fan: index 4: pwm=255, rpm=4000, rru=1, rrd=1, state:3
[    4.646269] pwm_fan_driver pwm-fan: index 5: pwm=255, rpm=5000, rru=1, rrd=1, state:3
[    4.646275] pwm_fan_driver pwm-fan: index 6: pwm=255, rpm=6000, rru=1, rrd=1, state:3
[    4.646282] pwm_fan_driver pwm-fan: index 7: pwm=255, rpm=7000, rru=1, rrd=1, state:4
[    4.646290] pwm_fan_driver pwm-fan: index 8: pwm=255, rpm=10000, rru=1, rrd=1, state:4
[    4.646297] pwm_fan_driver pwm-fan: index 9: pwm=255, rpm=11000, rru=1, rrd=1, state:4
[    4.647717] device-mapper: uevent: version 1.0.3
[    4.648472] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com
[    4.669858] tegra194_cpufreq_probe: platform driver Initialization: pass
[    4.676585] cpuidle: Initializing cpuidle driver
[    4.688694] sdhci: Secure Digital Host Controller Interface driver
[    4.688713] sdhci: Copyright(c) Pierre Ossman
[    4.688714] sdhci-pltfm: SDHCI platform and OF driver helper
[    4.690272] sdhci-tegra 3460000.sdhci: Client registration for eMC Successful
[    4.692641] CMDQ: cmdq_platfm_init successful
[    4.693103] sdhci-tegra 3400000.sdhci: Got CD GPIO
[    4.694626] sdhci-tegra 3400000.sdhci: Client registration for eMC Successful
[    4.696183] sdhci-tegra 3400000.sdhci: wakeup init done, cdirq 254
[    4.700359] tegra-se-elp 3ad0000.se_elp: tegra_se_elp_probe: complete
[    4.738802] mmc0: SDHCI controller on 3460000.sdhci [3460000.sdhci] using ADMA 64-bit with 64 bit addr
[    4.738925] gpio tegra-gpio wake8 for gpio=55(G:7)
[    4.738993] mmc1: SDHCI controller on 3400000.sdhci [3400000.sdhci] using ADMA 64-bit with 64 bit addr
[    4.820709] mmc0: mmc_decode_ext_csd: CMDQ supported: depth: 31, cmdq_support: 1
[    4.833174] mmc0: periodic cache flush enabled
[    4.833187] mmc0: new HS400 Enhanced strobe MMC card at address 0001
[    4.833853] mmcblk0: mmc0:0001 HBG4a2 29.1 GiB 
[    4.834125] mmcblk0boot0: mmc0:0001 HBG4a2 partition 1 8.00 MiB
[    4.834365] mmcblk0boot1: mmc0:0001 HBG4a2 partition 2 8.00 MiB
[    4.834551] mmcblk0rpmb: mmc0:0001 HBG4a2 partition 3 4.00 MiB
[    4.837573]  mmcblk0: p1 p2 p3 p4 p5 p6 p7 p8 p9 p10 p11 p12 p13 p14 p15 p16 p17 p18 p19 p20 p21 p22 p23 p24 p25 p26 p27 p28 p29 p30 p31 p32 p33 p34 p35 p36 p37
[    5.265159] tegra-se-nvhost 15810000.se: initialized
[    5.268990] tegra-se-nvhost 15810000.se: tegra_se_probe: complete
[    5.275358] tegra-se-nvhost 15820000.se: initialized
[    5.280485] tegra-se-nvhost 15820000.se: tegra_se_probe: complete
[    5.285686] tegra-se-nvhost 15830000.se: initialized
[    5.290665] tegra-se-nvhost 15830000.se: tegra_se_probe: complete
[    5.296990] tegra-se-nvhost 15840000.se: initialized
[    5.302230] tegra-se-nvhost 15840000.se: tegra_se_probe: complete
[    5.307604] hidraw: raw HID events driver (C) Jiri Kosina
[    5.314060] usbcore: registered new interface driver usbhid
[    5.318140] usbhid: USB HID core driver
[    5.328053] tegra186-cam-rtcpu bc00000.rtcpu: deferring, 14800000.isp is not probed
[    5.331273] tegra_aon c1a0000.aon: tegra aon driver probe OK
[    5.336438] tegra186-aondbg aondbg: aondbg driver probe() OK
[    5.342150] denver_knobs_init:MTS_VERSION:44201972
[    5.346790] tegra19x_actmon d230000.actmon: in actmon_register()...
[    5.353439] tegra19x_actmon d230000.actmon: initialization Completed for the device mc_all
[    5.361474] t19x_cache tegra-cache: probed
[    5.371901] misc nvmap: cvsram :dma coherent mem declare 0x0000000050000000,4194304
[    5.372936] misc nvmap: created heap cvsram base 0x0000000050000000 size (4096KiB)
[    5.382297] nvpmodel: initialized successfully
[    5.385827] tegra-hda 3510000.hda: Override SDO lines to 4
[    5.390106] usbcore: registered new interface driver snd-usb-audio
[    5.407361] input: tegra-hda-galen-t194 HDMI/DP,pcm=3 as /devices/3510000.hda/sound/card0/input0
[    5.407696] input: tegra-hda-galen-t194 HDMI/DP,pcm=7 as /devices/3510000.hda/sound/card0/input1
[    5.413902] input: tegra-hda-galen-t194 HDMI/DP,pcm=8 as /devices/3510000.hda/sound/card0/input2
[    5.422542] input: tegra-hda-galen-t194 HDMI/DP,pcm=9 as /devices/3510000.hda/sound/card0/input3
[    7.198882] gpio tegra-gpio wake12 for gpio=149(S:5)
[    7.290929] OPE platform probe
[    7.291176] OPE platform probe successful
[    7.427862] tegra-asoc: sound: ADMAIF1 <-> ADMAIF1 mapping ok
[    7.428143] tegra-asoc: sound: ADMAIF2 <-> ADMAIF2 mapping ok
[    7.428379] tegra-asoc: sound: ADMAIF3 <-> ADMAIF3 mapping ok
[    7.428577] tegra-asoc: sound: ADMAIF4 <-> ADMAIF4 mapping ok
[    7.428765] tegra-asoc: sound: ADMAIF5 <-> ADMAIF5 mapping ok
[    7.428980] tegra-asoc: sound: ADMAIF6 <-> ADMAIF6 mapping ok
[    7.429178] tegra-asoc: sound: ADMAIF7 <-> ADMAIF7 mapping ok
[    7.429379] tegra-asoc: sound: ADMAIF8 <-> ADMAIF8 mapping ok
[    7.429605] tegra-asoc: sound: ADMAIF9 <-> ADMAIF9 mapping ok
[    7.429809] tegra-asoc: sound: ADMAIF10 <-> ADMAIF10 mapping ok
[    7.430026] tegra-asoc: sound: ADMAIF11 <-> ADMAIF11 mapping ok
[    7.430256] tegra-asoc: sound: ADMAIF12 <-> ADMAIF12 mapping ok
[    7.430476] tegra-asoc: sound: ADMAIF13 <-> ADMAIF13 mapping ok
[    7.430694] tegra-asoc: sound: ADMAIF14 <-> ADMAIF14 mapping ok
[    7.430939] tegra-asoc: sound: ADMAIF15 <-> ADMAIF15 mapping ok
[    7.431146] tegra-asoc: sound: ADMAIF16 <-> ADMAIF16 mapping ok
[    7.431389] tegra-asoc: sound: ADMAIF17 <-> ADMAIF17 mapping ok
[    7.436234] tegra-asoc: sound: ADMAIF18 <-> ADMAIF18 mapping ok
[    7.442216] tegra-asoc: sound: ADMAIF19 <-> ADMAIF19 mapping ok
[    7.448260] tegra-asoc: sound: ADMAIF20 <-> ADMAIF20 mapping ok
[    7.494737] input: tegra-snd-t19x-mobile-rt565x Headset Jack as /devices/sound/sound/card1/input4
[    7.496253] u32 classifier
[    7.496323]     Actions configured
[    7.496444] Initializing XFRM netlink socket
[    7.497155] NET: Registered protocol family 10
[    7.497928] NET: Registered protocol family 17
[    7.498026] NET: Registered protocol family 15
[    7.498196] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
[    7.499857] Bluetooth: RFCOMM socket layer initialized
[    7.504917] Bluetooth: RFCOMM ver 1.11
[    7.508737] Bluetooth: HIDP (Human Interface Emulation) ver 1.2
[    7.514441] Bluetooth: HIDP socket layer initialized
[    7.519711] 9pnet: Installing 9P2000 support
[    7.524134] Key type dns_resolver registered
[    7.528734] Registered cp15_barrier emulation handler
[    7.533614] Registered setend emulation handler
[    7.539981] registered taskstats version 1
[    7.542852] tegra-pcie-dw 14180000.pcie: Setting init speed to max speed
[    7.550398] OF: PCI: host bridge /pcie@14180000 ranges:
[    7.554463] OF: PCI:    IO 0x38100000..0x381fffff -> 0x38100000
[    7.560490] OF: PCI:   MEM 0x38200000..0x39ffffff -> 0x38200000
[    7.566420] OF: PCI:   MEM 0x1800000000..0x1bffffffff -> 0x1800000000
[    7.678870] tegra-pcie-dw 14180000.pcie: link is up
[    7.679164] tegra-pcie-dw 14180000.pcie: PCI host bridge to bus 0000:00
[    7.679294] pci_bus 0000:00: root bus resource [bus 00-ff]
[    7.679393] pci_bus 0000:00: root bus resource [io  0x0000-0xfffff] (bus address [0x38100000-0x381fffff])
[    7.679556] pci_bus 0000:00: root bus resource [mem 0x38200000-0x39ffffff]
[    7.679676] pci_bus 0000:00: root bus resource [mem 0x1800000000-0x1bffffffff pref]
[    7.679834] pci 0000:00:00.0: [10de:1ad0] type 01 class 0x060400
[    7.679981] pci 0000:00:00.0: PME# supported from D0 D3hot D3cold
[    7.680230] iommu: Adding device 0000:00:00.0 to group 61
[    7.680596] pci 0000:01:00.0: [144d:a808] type 00 class 0x010802
[    7.680719] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00003fff 64bit]
[    7.681771] iommu: Adding device 0000:01:00.0 to group 62
[    7.691786] pci 0000:00:00.0: BAR 14: assigned [mem 0x38200000-0x382fffff]
[    7.691933] pci 0000:01:00.0: BAR 0: assigned [mem 0x38200000-0x38203fff 64bit]
[    7.692128] pci 0000:00:00.0: PCI bridge to [bus 01-ff]
[    7.692223] pci 0000:00:00.0:   bridge window [mem 0x38200000-0x382fffff]
[    7.692377] pci 0000:00:00.0: Max Payload Size set to  256/ 256 (was  256), Max Read Rq  512
[    7.692580] pci 0000:01:00.0: Max Payload Size set to  256/ 256 (was  128), Max Read Rq  512
[    7.692999] pcieport 0000:00:00.0: Signaling PME through PCIe PME interrupt
[    7.693122] pci 0000:01:00.0: Signaling PME through PCIe PME interrupt
[    7.696594] pcie_pme 0000:00:00.0:pcie001: service driver pcie_pme loaded
[    7.696724] aer 0000:00:00.0:pcie002: service driver aer loaded
[    7.697183] nvme nvme0: pci function 0000:01:00.0
[    7.701257] nvme 0000:01:00.0: enabling device (0000 -> 0002)
[    7.701411] tegra-pcie-dw 14100000.pcie: Setting init speed to max speed
[    7.702212] OF: PCI: host bridge /pcie@14100000 ranges:
[    7.702241] OF: PCI:    IO 0x30100000..0x301fffff -> 0x30100000
[    7.702249] OF: PCI:   MEM 0x30200000..0x31ffffff -> 0x30200000
[    7.702252] OF: PCI:   MEM 0x1200000000..0x123fffffff -> 0x1200000000
[    7.810829] tegra-pcie-dw 14100000.pcie: link is up
[    7.811164] tegra-pcie-dw 14100000.pcie: PCI host bridge to bus 0001:00
[    7.811307] pci_bus 0001:00: root bus resource [bus 00-ff]
[    7.811424] pci_bus 0001:00: root bus resource [io  0x100000-0x1fffff] (bus address [0x30100000-0x301fffff])
[    7.811590] pci_bus 0001:00: root bus resource [mem 0x30200000-0x31ffffff]
[    7.811728] pci_bus 0001:00: root bus resource [mem 0x1200000000-0x123fffffff pref]
[    7.811886] pci 0001:00:00.0: [10de:1ad2] type 01 class 0x060400
[    7.812042] pci 0001:00:00.0: PME# supported from D0 D3hot D3cold
[    7.812240] iommu: Adding device 0001:00:00.0 to group 63
[    7.812722] pci 0001:01:00.0: [1b4b:9171] type 00 class 0x010601
[    7.812832] pci 0001:01:00.0: reg 0x10: [io  0x8000-0x8007]
[    7.812894] pci 0001:01:00.0: reg 0x14: [io  0x8040-0x8043]
[    7.812956] pci 0001:01:00.0: reg 0x18: [io  0x8100-0x8107]
[    7.813017] pci 0001:01:00.0: reg 0x1c: [io  0x8140-0x8143]
[    7.813080] pci 0001:01:00.0: reg 0x20: [io  0x800000-0x80000f]
[    7.813162] pci 0001:01:00.0: reg 0x24: [mem 0x00900000-0x009001ff]
[    7.813224] pci 0001:01:00.0: reg 0x30: [mem 0xd0000000-0xd000ffff pref]
[    7.813547] pci 0001:01:00.0: PME# supported from D3hot
[    7.813809] iommu: Adding device 0001:01:00.0 to group 64
[    7.823583] pci 0001:00:00.0: BAR 14: assigned [mem 0x30200000-0x302fffff]
[    7.823743] pci 0001:00:00.0: BAR 13: assigned [io  0x100000-0x100fff]
[    7.823856] pci 0001:01:00.0: BAR 6: assigned [mem 0x30200000-0x3020ffff pref]
[    7.823980] pci 0001:01:00.0: BAR 5: assigned [mem 0x30210000-0x302101ff]
[    7.824171] pci 0001:01:00.0: BAR 4: assigned [io  0x100000-0x10000f]
[    7.824370] pci 0001:01:00.0: BAR 0: assigned [io  0x100010-0x100017]
[    7.830716] pci 0001:01:00.0: BAR 2: assigned [io  0x100018-0x10001f]
[    7.837138] pci 0001:01:00.0: BAR 1: assigned [io  0x100020-0x100023]
[    7.843558] pci 0001:01:00.0: BAR 3: assigned [io  0x100024-0x100027]
[    7.849959] pci 0001:00:00.0: PCI bridge to [bus 01-ff]
[    7.855056] pci 0001:00:00.0:   bridge window [io  0x100000-0x100fff]
[    7.861525] pci 0001:00:00.0:   bridge window [mem 0x30200000-0x302fffff]
[    7.868182] pci 0001:00:00.0: Max Payload Size set to  256/ 256 (was  256), Max Read Rq  512
[    7.876920] pci 0001:01:00.0: Max Payload Size set to  256/ 512 (was  128), Max Read Rq  512
[    7.885704] pcieport 0001:00:00.0: Signaling PME through PCIe PME interrupt
[    7.892399] pci 0001:01:00.0: Signaling PME through PCIe PME interrupt
[    7.898872] pcie_pme 0001:00:00.0:pcie001: service driver pcie_pme loaded
[    7.898980] aer 0001:00:00.0:pcie002: service driver aer loaded
[    7.899495] ahci 0001:01:00.0: version 3.0
[    7.900109] ahci 0001:01:00.0: AHCI 0001.0000 32 slots 1 ports 6 Gbps 0x1 impl SATA mode
[    7.907011] ahci 0001:01:00.0: flags: 64bit ncq sntf led only pmp fbs pio slum part sxs 
[    7.915528] scsi host1: ahci
[    7.917692] ata1: SATA max UDMA/133 abar m512@0x30210000 port 0x30210100 irq 595
[    7.925574] tegra-pcie-dw 14140000.pcie: Setting init speed to max speed
[    7.933033] OF: PCI: host bridge /pcie@14140000 ranges:
[    7.937417] OF: PCI:    IO 0x34100000..0x341fffff -> 0x34100000
[    7.943259] OF: PCI:   MEM 0x34200000..0x35ffffff -> 0x34200000
[    7.949304] OF: PCI:   MEM 0x1280000000..0x12bfffffff -> 0x1280000000
[    7.957183]  nvme0n1: p1
[    8.062875] tegra-pcie-dw 14140000.pcie: link is up
[    8.063203] tegra-pcie-dw 14140000.pcie: PCI host bridge to bus 0003:00
[    8.063333] pci_bus 0003:00: root bus resource [bus 00-ff]
[    8.063430] pci_bus 0003:00: root bus resource [io  0x200000-0x2fffff] (bus address [0x34100000-0x341fffff])
[    8.063594] pci_bus 0003:00: root bus resource [mem 0x34200000-0x35ffffff]
[    8.063713] pci_bus 0003:00: root bus resource [mem 0x1280000000-0x12bfffffff pref]
[    8.063900] pci 0003:00:00.0: [10de:1ad2] type 01 class 0x060400
[    8.064059] pci 0003:00:00.0: PME# supported from D0 D3hot D3cold
[    8.064277] iommu: Adding device 0003:00:00.0 to group 65
[    8.064782] pci 0003:01:00.0: [168c:003c] type 00 class 0x028000
[    8.064930] pci 0003:01:00.0: reg 0x10: [mem 0x00000000-0x001fffff 64bit]
[    8.065177] pci 0003:01:00.0: reg 0x30: [mem 0x00000000-0x0000ffff pref]
[    8.065672] pci 0003:01:00.0: supports D1 D2
[    8.065676] pci 0003:01:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[    8.065996] iommu: Adding device 0003:01:00.0 to group 66
[    8.075605] pci 0003:00:00.0: BAR 14: assigned [mem 0x34200000-0x344fffff]
[    8.075750] pci 0003:01:00.0: BAR 0: assigned [mem 0x34200000-0x343fffff 64bit]
[    8.075961] pci 0003:01:00.0: BAR 6: assigned [mem 0x34400000-0x3440ffff pref]
[    8.076096] pci 0003:00:00.0: PCI bridge to [bus 01-ff]
[    8.076215] pci 0003:00:00.0:   bridge window [mem 0x34200000-0x344fffff]
[    8.076356] pci 0003:00:00.0: Max Payload Size set to  256/ 256 (was  256), Max Read Rq  512
[    8.076559] pci 0003:01:00.0: Max Payload Size set to  256/ 256 (was  128), Max Read Rq  512
[    8.077015] pcieport 0003:00:00.0: Signaling PME through PCIe PME interrupt
[    8.081663] pci 0003:01:00.0: Signaling PME through PCIe PME interrupt
[    8.088113] pcie_pme 0003:00:00.0:pcie001: service driver pcie_pme loaded
[    8.088267] aer 0003:00:00.0:pcie002: service driver aer loaded
[    8.088937] tegra-pcie-dw 141a0000.pcie: Setting init speed to max speed
[    8.096148] OF: PCI: host bridge /pcie@141a0000 ranges:
[    8.099939] OF: PCI:    IO 0x3a100000..0x3a1fffff -> 0x3a100000
[    8.105977] OF: PCI:   MEM 0x3a200000..0x3bffffff -> 0x3a200000
[    8.111924] OF: PCI:   MEM 0x1c00000000..0x1fffffffff -> 0x1c00000000
[    8.238309] ata1: SATA link down (SStatus 0 SControl 300)
[    8.631453] tegra-pcie-dw 141a0000.pcie: link is down
[    8.631838] tegra-pcie-dw 141a0000.pcie: PCI host bridge to bus 0005:00
[    8.631970] pci_bus 0005:00: root bus resource [bus 00-ff]
[    8.632066] pci_bus 0005:00: root bus resource [io  0x300000-0x3fffff] (bus address [0x3a100000-0x3a1fffff])
[    8.632229] pci_bus 0005:00: root bus resource [mem 0x3a200000-0x3bffffff]
[    8.632368] pci_bus 0005:00: root bus resource [mem 0x1c00000000-0x1fffffffff pref]
[    8.632653] pci 0005:00:00.0: [10de:1ad0] type 01 class 0x060400
[    8.632795] pci 0005:00:00.0: PME# supported from D0 D3hot D3cold
[    8.633004] iommu: Adding device 0005:00:00.0 to group 67
[    8.633480] pci 0005:00:00.0: PCI bridge to [bus 01-ff]
[    8.633591] pci 0005:00:00.0: Max Payload Size set to  256/ 256 (was  256), Max Read Rq  512
[    8.634049] pcieport 0005:00:00.0: Signaling PME through PCIe PME interrupt
[    8.634173] pcie_pme 0005:00:00.0:pcie001: service driver pcie_pme loaded
[    8.634360] aer 0005:00:00.0:pcie002: service driver aer loaded
[    8.634555] pcie_pme 0005:00:00.0:pcie001: unloading service driver pcie_pme
[    8.634600] aer 0005:00:00.0:pcie002: unloading service driver aer
[    8.634664] pci_bus 0005:01: busn_res: [bus 01-ff] is released
[    8.634735] iommu: Removing device 0005:00:00.0 from group 67
[    8.634968] pci_bus 0005:00: busn_res: [bus 00-ff] is released
[    8.635212] tegra-pcie-dw 141a0000.pcie: PCIe link is not up...!
[    8.648299] tegra-cbb 14040000.cv-noc: noc_secure_irq = 98, noc_nonsecure_irq = 97>
[    8.653126] tegra194-isp5 14800000.isp: initialized
[    8.661629] tegra194-vi5 15c10000.vi: initialized
[    8.667302] tegra194-vi5 15c10000.vi: ep of_device is not enabled /host1x/vi@15c10000/ports/port@0/endpoint.
[    8.667477] tegra194-vi5 15c10000.vi: ep of_device is not enabled /host1x/vi@15c10000/ports/port@1/endpoint.
[    8.668655] tegradc 15210000.nvdisplay: disp1 connected to head1->/host1x/sor
[    8.668879] tegradc 15210000.nvdisplay: parse_dp_settings: No dp-lt-settings node
[    8.670168] tegra-xusb 3610000.xhci: USB2 port 0 has OTG_CAP
[    8.670171] tegra-xusb 3610000.xhci: USB3 port 2 has OTG_CAP
[    8.672770] tegra-xusb 3610000.xhci: extcon 0: ffffffc3daa53000 id
[    8.673396] tegra-xudc-new 3550000.xudc: PMQOS CPU boost enabled
[    8.673427] tegra-xudc-new 3550000.xudc: device count: 1
[    8.673619] tegra-xusb 3610000.xhci: Direct firmware load for tegra19x_xusb_firmware failed with error -2
[    8.673621] tegra-xusb 3610000.xhci: Falling back to user helper
[    8.674260] tegra-xudc-new 3550000.xudc: vbus state: 0
[    8.674265] tegra-xudc-new 3550000.xudc: Initialize boost_cpufreq work
[    8.675313] tegra186-cam-rtcpu bc00000.rtcpu: Trace buffer configured at IOVA=0xbff00000
[    8.675562] tegra-xudc-new 3550000.xudc: entering ELPG
[    8.675781] tegra-xudc-new 3550000.xudc: entering ELPG done
[    8.746801] tegradc 15210000.nvdisplay: DT parsed successfully
[    8.752645] tegradc 15210000.nvdisplay: Display dc.ffffff8011010000 registered with id=1
[    8.760915] tegradc 15210000.nvdisplay: vblank syncpt # 15 for dc 1
[    8.761345] tegra-ivc ivc-bc00000.rtcpu: region 0: iova=0xbfee0000-0xbfefffff size=131072
[    8.761791] tegra-ivc ivc-bc00000.rtcpu:echo@0: echo: ver=0 grp=1 RX[16x64]=0x1000-0x1480 TX[16x64]=0x1480-0x1900
[    8.762025] tegra-ivc ivc-bc00000.rtcpu:dbg@1: dbg: ver=0 grp=1 RX[1x384]=0x1900-0x1b00 TX[1x384]=0x1b00-0x1d00
[    8.762274] tegra-ivc ivc-bc00000.rtcpu:dbg@2: dbg: ver=0 grp=1 RX[1x8192]=0x1d00-0x3d80 TX[1x8192]=0x3d80-0x5e00
[    8.762656] tegra-ivc ivc-bc00000.rtcpu:ivccontrol@3: ivccontrol: ver=0 grp=1 RX[64x320]=0x5e00-0xae80 TX[64x320]=0xae80-0xff00
[    8.762721] tegra-ivc ivc-bc00000.rtcpu:ivccapture@4: ivccapture: ver=0 grp=1 RX[512x64]=0xff00-0x17f80 TX[512x64]=0x17f80-0x20000
[    8.762957] tegra186-cam-rtcpu bc00000.rtcpu: using cam RTCPU IRQ (69)
[    8.762959] tegra186-cam-rtcpu bc00000.rtcpu: tegra_camrtc_mon_create is successful
[    8.843448] tegradc 15210000.nvdisplay: vpulse3 syncpt # 16 for dc 1
[    8.851131] tegra186-cam-rtcpu bc00000.rtcpu: firmware version cpu=rce cmd=5 sha1=cf2bef3ad10e437272857b76308abef8ffb80bda
[    8.861699] gpio tegra-gpio wake67 for gpio=48(G:0)
[    8.866094] gpio tegra-gpio-aon wake29 for gpio=36(EE:4)
[    8.871958] input: gpio-keys as /devices/gpio-keys/input/input5
[    8.884485] tegradc 15210000.nvdisplay: probed
[    8.904376] tegradc 15210000.nvdisplay: fb registered
[    8.908081] tegra_rtc c2a0000.rtc: setting system clock to 2019-08-20 16:44:53 UTC (1566319493)
[    8.908205] hpd: state 7 (Takeover from bootloader), hpd 0, pending_hpd_evt 1
[    8.908208] hpd: switching from state 7 (Takeover from bootloader) to state 0 (Reset)
[    8.908239] hpd: state 0 (Reset), hpd 0, pending_hpd_evt 0
[    8.908526] tegradc 15220000.nvdisplay: disp2 connected to head2->/host1x/sor1
[    8.908555] tegradc 15220000.nvdisplay: parse_dp_settings: No dp-lt-settings node
[    8.908617] tegradc 15220000.nvdisplay: DT parsed successfully
[    8.908664] tegradc 15220000.nvdisplay: Display dc.ffffff8011310000 registered with id=2
[    8.908884] tegradc 15220000.nvdisplay: vblank syncpt # 17 for dc 2
[    8.908888] tegradc 15220000.nvdisplay: vpulse3 syncpt # 18 for dc 2
[    8.957985] tegradc 15210000.nvdisplay: blank - powerdown
[    8.958714] mmcblk mmc0:0001: Card claimed for testing.
[    8.968277] extcon-disp-state external-connection:disp-state: cable 44 state 0 already set.
[    8.976754] Extcon DP: HPD disabled
[    8.980427] hpd: hpd_switch 0
[    8.983572] hpd: switching from state 0 (Reset) to state 1 (Check Plug)
[    8.986128] tegradc 15220000.nvdisplay: probed
[    8.994564] hpd: state 1 (Check Plug), hpd 0, pending_hpd_evt 0
[    8.999269] bpmp: mounted debugfs mirror
[    9.004509] hpd: switching from state 1 (Check Plug) to state 3 (Disabled)
[    9.005640] vdd-1v8-cvb: disabling
[    9.005643] vdd-1v8-sd: disabling
[    9.005645] vdd-epb-1v0: disabling
[    9.005646] avdd-cam-2v8: disabling
[    9.005648] vdd-sata-1v5: disabling
[    9.005649] vdd-3v3-slt: disabling
[    9.005650] vdd-fan: disabling
[    9.005651] vdd_sys_en: disabling
[    9.005652] vdd-5v-sata: disabling
[    9.005658] ALSA device list:
[    9.005661]   #0: tegra-hda-galen-t194 at 0x3518000 irq 68
[    9.005662]   #1: tegra-snd-t19x-mobile-rt565x
[    9.055148] tegradc 15220000.nvdisplay: fb registered
[    9.063428] hpd: state 7 (Takeover from bootloader), hpd 0, pending_hpd_evt 1
[    9.067403] hpd: switching from state 7 (Takeover from bootloader) to state 0 (Reset)
[    9.075325] hpd: state 0 (Reset), hpd 0, pending_hpd_evt 0
[    9.080637] tegradc 15220000.nvdisplay: blank - powerdown
[    9.086061] extcon-disp-state external-connection:disp-state: cable 44 state 0 already set.
[    9.094275] Extcon DP: HPD disabled
[    9.097775] hpd: hpd_switch 0
[    9.100923] hpd: switching from state 0 (Reset) to state 1 (Check Plug)
[    9.107605] hpd: state 1 (Check Plug), hpd 0, pending_hpd_evt 0
[    9.113178] hpd: switching from state 1 (Check Plug) to state 3 (Disabled)
[    9.124674] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
[    9.128539] VFS: Mounted root (ext4 filesystem) on device 179:1.
[    9.135862] devtmpfs: mounted
[    9.139284] Freeing unused kernel memory: 8512K
[    9.280711] ip_tables: (C) 2000-2006 Netfilter Core Team
[    9.286006] cgroup: cgroup2: unknown option "nsdelegate"
[    9.294416] systemd[1]: systemd 237 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[    9.295486] systemd[1]: Detected architecture arm64.
[    9.306029] systemd[1]: Set hostname to <AIONio-M6>.
[    9.383373] systemd[1]: File /lib/systemd/system/systemd-journald.service:36 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling.
[    9.383713] systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.)
[    9.518013] random: systemd: uninitialized urandom read (16 bytes read)
[    9.522608] systemd[1]: Created slice System Slice.
[    9.523275] random: systemd: uninitialized urandom read (16 bytes read)
[    9.523536] systemd[1]: Listening on udev Kernel Socket.
[    9.523770] random: systemd: uninitialized urandom read (16 bytes read)
[    9.523915] systemd[1]: Reached target User and Group Name Lookups.
[    9.524553] systemd[1]: Listening on Syslog Socket.
[    9.524961] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[    9.557408] gpio tegra-gpio wake44 for gpio=192(Y:0)
[    9.566056] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null)
[    9.922090] systemd-journald[2381]: Received request to flush runtime journal from PID 1
[   10.252418] nvgpu: 17000000.gv11b          nvgpu_nvhost_syncpt_init:291  [INFO]  syncpt_unit_base 60000000 syncpt_unit_size 400000 size 1000

[   10.548295] tegra-xusb 3610000.xhci: cannot find firmware....retry after 1 second
[   10.584922] bmi160 1-0069: nvs_vregs_init vdd err=-19
[   10.601875] bmi160 1-0069: nvs_vregs_init vdd_IO err=-19
[   10.632042] using random self ethernet address
[   10.632154] using random host ethernet address
[   10.657329] tegra-i2c c240000.i2c: no acknowledge from address 0x69
[   10.657522] bmi160 1-0069: bmi_i2c_rd ERR: 0x00
[   10.657608] bmi160 1-0069: bmi_init _id_i2c ERR
[   10.657696] bmi160 1-0069: bmi_remove
[   10.657699] bmi160 1-0069: bmi_probe done
[   10.657891] bmi160 8-0069: nvs_vregs_init vdd err=-19
[   10.658009] bmi160 8-0069: nvs_vregs_init vdd_IO err=-19
[   10.660046] Mass Storage Function, version: 2009/09/11
[   10.660053] LUN: removable file: (no medium)
[   10.666480] using random self ethernet address
[   10.666585] using random host ethernet address
[   10.674987] rndis0: HOST MAC 32:53:bd:a1:1b:68
[   10.675153] rndis0: MAC 32:53:bd:a1:1b:69
[   10.677487] usb0: HOST MAC 32:53:bd:a1:1b:6a
[   10.677519] usb0: MAC 32:53:bd:a1:1b:6b
[   10.677540] tegra-xudc-new 3550000.xudc: exiting ELPG
[   10.678983] tegra-xudc-new 3550000.xudc: exiting ELPG done
[   10.679000] tegra-xudc-new 3550000.xudc: ep 0 (type: 0, dir: out) enabled
[   10.679035] tegra-xudc-new 3550000.xudc: entering ELPG
[   10.679236] tegra-xudc-new 3550000.xudc: entering ELPG done
[   10.679256] tegra-xudc-new 3550000.xudc: exiting ELPG
[   10.680677] tegra-xudc-new 3550000.xudc: exiting ELPG done
[   10.680701] tegra-xudc-new 3550000.xudc: entering ELPG
[   10.680885] tegra-xudc-new 3550000.xudc: entering ELPG done
[   10.711114] tegra-i2c 31e0000.i2c: no acknowledge from address 0x69
[   10.711153] bmi160 8-0069: bmi_i2c_rd ERR: 0x00
[   10.711156] bmi160 8-0069: bmi_init _id_i2c ERR
[   10.711160] bmi160 8-0069: bmi_remove
[   10.711162] bmi160 8-0069: bmi_probe done
[   10.722915] l4tbr0: port 1(rndis0) entered blocking state
[   10.722920] l4tbr0: port 1(rndis0) entered disabled state
[   10.723108] device rndis0 entered promiscuous mode
[   10.729721] IPv6: ADDRCONF(NETDEV_UP): rndis0: link is not ready
[   10.733328] l4tbr0: port 2(usb0) entered blocking state
[   10.733333] l4tbr0: port 2(usb0) entered disabled state
[   10.734567] device usb0 entered promiscuous mode
[   10.741291] IPv6: ADDRCONF(NETDEV_UP): usb0: link is not ready
[   10.741299] l4tbr0: port 2(usb0) entered blocking state
[   10.741301] l4tbr0: port 2(usb0) entered forwarding state
[   10.789803] random: crng init done
[   10.789901] random: 7 urandom warning(s) missed due to ratelimiting
[   11.013549] EXT4-fs (nvme0n1p1): mounted filesystem with ordered data mode. Opts: (null)
[   11.288339] ath10k_pci 0003:01:00.0: enabling device (0000 -> 0002)
[   11.288908] ath10k_pci 0003:01:00.0: pci irq msi oper_irq_mode 2 irq_mode 0 reset_mode 0
[   11.489911] ath10k_pci 0003:01:00.0: Direct firmware load for ath10k/pre-cal-pci-0003:01:00.0.bin failed with error -2
[   11.490357] ath10k_pci 0003:01:00.0: Falling back to user helper
[   11.556034] tegra-xusb 3610000.xhci: Firmware timestamp: 2018-03-29 14:24:42 UTC, Version: 60.05 release
[   11.556080] tegra-xusb 3610000.xhci: xHCI Host Controller
[   11.556105] tegra-xusb 3610000.xhci: new USB bus registered, assigned bus number 1
[   11.557320] tegra-xusb 3610000.xhci: hcc params 0x0184ff25 hci version 0x110 quirks 0x00050810
[   11.557354] tegra-xusb 3610000.xhci: irq 472, io mem 0x03610000
[   11.557477] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[   11.557481] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   11.557483] usb usb1: Product: xHCI Host Controller
[   11.557485] usb usb1: Manufacturer: Linux 4.9.140-tegra xhci-hcd
[   11.557487] usb usb1: SerialNumber: 3610000.xhci
[   11.557973] hub 1-0:1.0: USB hub found
[   11.557999] hub 1-0:1.0: 4 ports detected
[   11.558339] tegra-xusb 3610000.xhci: xHCI Host Controller
[   11.558347] tegra-xusb 3610000.xhci: new USB bus registered, assigned bus number 2
[   11.558354] tegra-xusb 3610000.xhci: Host supports USB 3.1 Enhanced SuperSpeed
[   11.558484] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003
[   11.558487] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   11.558489] usb usb2: Product: xHCI Host Controller
[   11.558492] usb usb2: Manufacturer: Linux 4.9.140-tegra xhci-hcd
[   11.558494] usb usb2: SerialNumber: 3610000.xhci
[   11.558835] hub 2-0:1.0: USB hub found
[   11.558870] hub 2-0:1.0: 4 ports detected
[   11.561688] Wake76 for irq=199
[   11.561691] Wake77 for irq=199
[   11.561693] Wake78 for irq=199
[   11.561694] Wake79 for irq=199
[   11.561695] Wake80 for irq=199
[   11.561696] Wake81 for irq=199
[   11.561698] Wake82 for irq=199
[   11.663169] usb usb2: usb_suspend_both: status 0
[   11.675195] nvgpu: 17000000.gv11b                 tpc_pg_mask_store:901  [INFO]  no value change, same mask already set
[   11.679893] l4tbr0: port 2(usb0) entered disabled state
[   11.789389] ath10k_pci 0003:01:00.0: Direct firmware load for ath10k/cal-pci-0003:01:00.0.bin failed with error -2
[   11.789604] ath10k_pci 0003:01:00.0: Falling back to user helper
[   11.882846] usb 1-2: new high-speed USB device number 2 using tegra-xusb
[   11.888249] ath10k_pci 0003:01:00.0: qca988x hw2.0 target 0x4100016c chip_id 0x043202ff sub 0000:0000
[   11.888255] ath10k_pci 0003:01:00.0: kconfig debug 0 debugfs 1 tracing 0 dfs 0 testmode 0
[   11.888607] ath10k_pci 0003:01:00.0: firmware ver 10.2.4-1.0-00037 api 5 features no-p2p,raw-mode,mfp crc32 a4a52adb
[   11.908098] usb 1-2: New USB device found, idVendor=2109, idProduct=2813
[   11.908104] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[   11.908108] usb 1-2: Product: USB2.0 Hub             
[   11.908111] usb 1-2: Manufacturer: VIA Labs, Inc.         
[   11.909674] hub 1-2:1.0: USB hub found
[   11.910567] hub 1-2:1.0: 4 ports detected
[   11.921930] ath10k_pci 0003:01:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/board-2.bin failed with error -2
[   11.922150] ath10k_pci 0003:01:00.0: Falling back to user helper
[   11.940957] ath10k_pci 0003:01:00.0: board_file api 1 bmi_id N/A crc32 bebc7c08
[   12.073891] usb 2-1: new SuperSpeed USB device number 2 using tegra-xusb
[   12.193475] usb 2-1: New USB device found, idVendor=2109, idProduct=0813
[   12.193483] usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[   12.193487] usb 2-1: Product: USB3.0 Hub             
[   12.193490] usb 2-1: Manufacturer: VIA Labs, Inc.         
[   12.209680] hub 2-1:1.0: USB hub found
[   12.211649] hub 2-1:1.0: 4 ports detected
[   12.274866] usb 1-2.1: new high-speed USB device number 3 using tegra-xusb
[   12.299640] usb 1-2.1: config 1 interface 0 altsetting 0 bulk endpoint 0x81 has invalid maxpacket 64
[   12.299847] usb 1-2.1: config 1 interface 0 altsetting 0 bulk endpoint 0x1 has invalid maxpacket 64
[   12.301565] usb 1-2.1: New USB device found, idVendor=03e7, idProduct=2150
[   12.301570] usb 1-2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[   12.301573] usb 1-2.1: Product: Movidius MA2X5X
[   12.301575] usb 1-2.1: Manufacturer: Movidius Ltd.
[   12.301578] usb 1-2.1: SerialNumber: 03e72150
[   12.365243] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   12.378632] tegra-gpcdma 2600000.dma: DMA pause timed out
[   12.379428] tegra-gpcdma 2600000.dma: DMA pause timed out
[   12.394811] usb 1-2.2: new full-speed USB device number 4 using tegra-xusb
[   12.417165] usb 1-2.2: New USB device found, idVendor=2dae, idProduct=1011
[   12.417171] usb 1-2.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[   12.417174] usb 1-2.2: Product: CubeBlack
[   12.417176] usb 1-2.2: Manufacturer: Hex/ProfiCNC
[   12.417178] usb 1-2.2: SerialNumber: 390053000851383236333932
[   12.435756] gpio tegra-gpio wake20 for gpio=52(G:4)
[   12.440371] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   12.500411] cdc_acm 1-2.2:1.0: ttyACM0: USB ACM device
[   12.501999] usbcore: registered new interface driver cdc_acm
[   12.502003] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
[   12.502843] usb 2-1: usb_suspend_both: status 0
[   12.503161] usb usb2: usb_suspend_both: status 0
[   13.124097] ath10k_pci 0003:01:00.0: htt-ver 2.1 wmi-op 5 htt-op 2 cal otp max-sta 128 raw 0 hwcrypto 1
[   13.216805] ath: EEPROM regdomain: 0x0
[   13.216814] ath: EEPROM indicates default country code should be used
[   13.216816] ath: doing EEPROM country->regdmn map search
[   13.216821] ath: country maps to regdmn code: 0x3a
[   13.216824] ath: Country alpha2 being used: US
[   13.216827] ath: Regpair used: 0x3a
[   13.262242] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   13.632288] tegradc 15200000.nvdisplay: blank - powerdown
[   13.632298] tegradc 15210000.nvdisplay: blank - powerdown
[   13.632303] tegradc 15220000.nvdisplay: blank - powerdown
[   14.603376] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   14.710427] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   17.049646] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   17.049657] Bluetooth: BNEP socket layer initialized
[   17.328377] fuse init (API version 7.26)
[   18.432397] wlan0: authenticate with f0:9f:c2:25:f9:c9
[   18.439909] wlan0: send auth to f0:9f:c2:25:f9:c9 (try 1/3)
[   18.444293] wlan0: authenticated
[   18.446837] wlan0: associate with f0:9f:c2:25:f9:c9 (try 1/3)
[   18.451455] wlan0: RX AssocResp from f0:9f:c2:25:f9:c9 (capab=0x411 status=0 aid=1)
[   18.453847] wlan0: associated
[   18.457525] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[  148.021150] usb 1-2.1: USB disconnect, device number 3
[  155.168833] usb 1-2.1: new high-speed USB device number 5 using tegra-xusb
[  155.191314] usb 1-2.1: New USB device found, idVendor=03e7, idProduct=2150
[  155.191327] usb 1-2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[  155.191332] usb 1-2.1: Product: Movidius MA2X5X
[  155.191336] usb 1-2.1: Manufacturer: Movidius Ltd.
[  155.191340] usb 1-2.1: SerialNumber: 03e72150
[  165.684438] usb 1-2.1: USB disconnect, device number 5
[  165.905137] usb usb2: usb_suspend_both: status -16
[  165.924122] usb usb2: usb_suspend_both: status 0
[  166.193646] usb 2-1.1: new SuperSpeed USB device number 3 using tegra-xusb
[  166.214490] usb 2-1.1: New USB device found, idVendor=8087, idProduct=0b37
[  166.214524] usb 2-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[  166.214657] usb 2-1.1: Product: Intel(R) RealSense(TM) Tracking Camera T265
[  166.214661] usb 2-1.1: Manufacturer: Intel(R) Corporation
[  166.214665] usb 2-1.1: SerialNumber: 8454121106240000

MartyG-RealSense commented 5 years ago

I was not quite sure of the sequence of events from your description. From the title about a hard reboot, it sounds as though the camera works the first time that the computer is started up, but is no longer detected after a reboot of the computer. Is that what is happening, please?

If it is, it sounds similar to an effect reported in a couple of cases with 400 Series cameras, where the camera stops working after the computer's reboot but is corrected with an unplug-replug of the USB cable. It was believed that the problem in those cases may be related to an issue with the computer's BIOS configuration.

Below are links to the reported cases that I know of:

https://github.com/IntelRealSense/librealsense/issues/1283

https://github.com/IntelRealSense/librealsense/issues/1615

jmachuca77 commented 5 years ago

Sorry for the confusing name. But no this happens after any type of boot, be it initial boot (hard boot) or a soft reboot. Always the camera is detected as the Movidius processor without a way to change it to be the camera. Only after power cycling the camera (unplug usb and replug) then it can be accessed as a camera.

MartyG-RealSense commented 5 years ago

Thanks for the clarification. I have seen a couple of past cases where the T265 has been ID'd as Movidius. Here's one of them:

https://github.com/IntelRealSense/librealsense/issues/3436

jmachuca77 commented 5 years ago

Yes, I have gone through those issues. But running rs-pose does not work as the camera is not detected. And I am running the latest release built from source on the jetson platform with the options -DBUILD_PYTHON_BINDINGS=bool:true -DPYTHON_EXECUTABLE=/usr/bin/python -DBUILD_EXAMPLES=true -DBUILD_WITH_CUDA=true -DBUILD_WITH_TM2=ON Which should include support for the t265 and they do as replugging the camera fixes the issue but coming from boot it does not work and unplugging the camera is not an option as it will be inside a housing.

MartyG-RealSense commented 5 years ago

It looks as though you have covered most of the possibilities that I can think of. There have been a couple of Jetson users who had different errors that were solved by trying a different USB cable.

https://github.com/IntelRealSense/librealsense/issues/4578

I apologize that I'm unable to provide more specific solutions, as my knowledge of the deeper workings of the T265 model is limited. One of the Intel support guys on this forum will likely be able to advise you well.

jmachuca77 commented 5 years ago

I have tried with different cables but the one that comes with the camera seems to be the best one to use (this is the one I am using) I am going through a powered USB3 hub. However I cannot connect the camera directly to the Xavier because when I do that I get disconnected from the camera randomly, I think the port on the Xavier cannot give enough power to keep the camera alive. I will try that again later today. And I'll report back on the findings here. Thank you.

MartyG-RealSense commented 5 years ago

USB power issues have also been known with the RealSense 400 Series camera models on some single-board computing devices such as Up Board and Intel Compute Stick. An Intel support representative once said that the camera needs 2W of power reliably supplied to it, which was why a powered USB 3 hub was ideal because it could supply around 12W and so could meet the camera's power needs if the power supply was unreliable when the camera was inserted directly into a USB port on the board.

Good luck!

jmachuca77 commented 5 years ago

Tried with different USB cables and even connecting the camera directly to the USB port on the Xavier and got exactly the same issue.

MartyG-RealSense commented 5 years ago

I am wondering if it is a physical issue with the USB port on the Xavier. With my own laptop computer, a Windows machine, I sometimes hear a repeating USB disconnect and reconnect sound effect from my mouse even if I am not touching it at the time (though my leg may brush against the cable slightly) My mouse will go dead and its lights go out, sometimes accompanied by an on-screen warning message, and comes back to life when I give its USB connector a gentle push into the port.

This happens even more with the ports on another PC I have too, a single-board device (an Intel Compute Stick).

rdinoff commented 5 years ago

This also happens on an UP Board running Ubuntu 16.04.6 LTS. with a NetMate USB hub. Is the only solution to unplug and re-plug? If so this makes the T265 not usable in my environment.

$ dpkg -l | fgrep realsense ii librealsense2:amd64 2.26.0-0~realsense0.1435 amd64 Intel(R) RealSense(tm) Cross Platform API - runtime ii librealsense2-dkms 1.3.5-0ubuntu1 all Modified kernel modules for librealsense2 ii librealsense2-gl:amd64 2.26.0-0~realsense0.1435 amd64 Intel(R) RealSense(tm) - GLSL-enabled extensions ii librealsense2-udev-rules:amd64 2.26.0-0~realsense0.1435 amd64 Intel(R) RealSense(tm) Camera Capture API - udev rules ii librealsense2-utils:amd64 2.26.0-0~realsense0.1435 amd64 Intel(R) RealSense(tm) Camera Capture API - utils and demos

$ modinfo uvcvideo | fgrep realsense version: 1.1.2.realsense-1.3.5

firmware version: 0.1.0.242

MartyG-RealSense commented 5 years ago

@rdinoff Is your NetMate hub one that plugs into the mains electricity please, or is it a "passive" hub that draws its power from the PC?

rdinoff commented 5 years ago

@rdinoff Is your NetMate hub one that plugs into the mains electricity please, or is it a "passive" hub that draws its power from the PC?

It is passive.

MartyG-RealSense commented 5 years ago

When a RealSense model has apparent USB related issues with an Up Board, a mains powered USB hub has a better chance of correcting the problem than a passive hub, which cannot provide the stable wattage that a mains hub can. I understand how it impacts mobility though.

rdinoff commented 5 years ago

Just checked with a J5 Create USB Hub that plugs into the mains electricity and it also does not work. Though plugging into a USB 3.0 port on the UP Board with no hub, T265 identified properly after running rs-enumerate-devices.

MartyG-RealSense commented 5 years ago

The original Up Board only has a 'USB 3.0 OTG' micro port (not a full size USB 3 port) and a USB 2.0 port. The newer UP Squared has a full USB 3.0 port. Is your Up model an Up Squared, please?

rdinoff commented 5 years ago

The original Up Board only has a 'USB 3.0 OTG' micro port (not a full size USB 3 port) and a USB 2.0 port. The newer UP Squared has a full USB 3.0 port. Is your Up model an Up Squared, please?

correct used the 3.0 OTG micro port. Have an UP board and UP core, but no UP Squared.

MartyG-RealSense commented 5 years ago

Ok, thank you very much.

Some further digging brought to light that the T265 has had issues earlier this year with rs-enumerate-devices not detecting the T265.

https://github.com/IntelRealSense/librealsense/issues/3465

Are you able to get the T265 to be detected in the RealSense Viewer even if rs-enumerate-devices said it is not detected when connecting via a hub?

rdinoff commented 5 years ago

If I use a USB hub, none of the rs commands or realsense-viewer works unless I unplug and replug the T265 after the system has booted.

MartyG-RealSense commented 5 years ago

I apologize that the diagnostic process is taking some time and I appreciate all the information that you and others with this problem are patiently providing.

Since the T265 can function after unplug-replug, it is presumably not a mechanical fault with the OTG port or the hubs that is preventing initial detection on boot.

If it can start from boot when plugged directly in, it is probably not due to a BIOS issue.

It is probably not an OTG dongle / adapter cable compatibility issue with the camera, since you need to use an adapter to connect the camera directly to the OTG port. Though that would not rule out an incompatibility between the adaptor and the hub, unless the powered hub works fine with the Up Board when non-RealSense devices are plugged into it.

I'll refer this case back to Intel member @ev-mp who had some initial contact with this case 6 days ago, though they may not be able to respond until at least tomorrow now.

jmachuca77 commented 5 years ago

Thanks @MartyG-RealSense , for keeping tabs on this. I don’t think it’s a problem with the port. I have a hub connected to each port on the Xavier. So two total. They are both powered. I’m currently running 3 D435, and 2 D435i plus the T265. All other cameras enumerate correctly after boot(with the ocasional One detected as usb2.1 but corrects after a SW, reset of that camera) the T265 always needs to be unplugged and replugged even if it’s the only camera connected.

radfordi commented 5 years ago

@rdinoff, this is a known hardware issue. We are trying to work with Movidius to find a workaround. Currently, if the Movidius processor gets voltage before the hub itself, then it fails to detect the USB speed correctly.

MartyG-RealSense commented 5 years ago

@radfordi Thanks so much for the information!

@rdinoff. @jmachuca77 I am not an Intel employee, so are not on the inside loop on internal discussions. So I rely on the brains of kind fellows like @radfordi to fill in my knowledge gaps. :)

BriceRenaudeau commented 5 years ago

Thanks for the information, I also have the same problem

rdinoff commented 5 years ago

@rdinoff, this is a known hardware issue. We are trying to work with Movidius to find a workaround. Currently, if the Movidius processor get voltage before the hub itself, then it fails to detect the USB speed correctly.

@radfordi Thanks .. when you have updated firmware let me know and I will be more then happy to check it out.

jmachuca77 commented 5 years ago

@radfordi Thanks please keep us updated on the progress, I'd like to keep this open so we know when the fix is in place, and we can test and close this issue. Thanks again.

doisyg commented 5 years ago

@rdinoff, this is a known hardware issue. We are trying to work with Movidius to find a workaround. Currently, if the Movidius processor get voltage before the hub itself, then it fails to detect the USB speed correctly.

Is there a rough estimate of when the problem will be fixed? Days, weeks or months? We would like to use the t265 on some production system and we need to make a decision soon.

patrickpoirier51 commented 5 years ago

Following... Same Issue on my mini powered hub

Sequence from cold start [ 5.185719] hub 1-1:1.0: 4 ports detected [ 5.519724] usb 1-1.1: new high-speed USB device number 3 using ehci-platform [ 5.689179] usb 1-1.1: config 1 interface 0 altsetting 0 bulk endpoint 0x81 has invalid maxpacket 64 [ 5.707505] usb 1-1.1: config 1 interface 0 altsetting 0 bulk endpoint 0x1 has invalid maxpacket 64 [ 5.740710] usb 1-1.1: New USB device found, idVendor=03e7, idProduct=2150, bcdDevice= 0.01 [ 5.757399] usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 5.772002] usb 1-1.1: Product: Movidius MA2X5X [ 5.781053] usb 1-1.1: Manufacturer: Movidius Ltd. [ 5.790624] usb 1-1.1: SerialNumber: 03e72150

disconnect reconnects [ 496.769441] usb 1-1.1: USB disconnect, device number 3 [ 502.624214] usb 1-1.1: new high-speed USB device number 4 using ehci-platform [ 502.795307] usb 1-1.1: New USB device found, idVendor=03e7, idProduct=2150, bcdDevice= 0.01 [ 502.795324] usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 502.795330] usb 1-1.1: Product: Movidius MA2X5X [ 502.795335] usb 1-1.1: Manufacturer: Movidius Ltd. [ 502.795340] usb 1-1.1: SerialNumber: 03e72150 [ 506.633665] usb 1-1.1: USB disconnect, device number 4 [ 507.133848] usb 1-1.1: new high-speed USB device number 5 using ehci-platform [ 507.285287] usb 1-1.1: New USB device found, idVendor=8087, idProduct=0b37, bcdDevice=ff.ff [ 507.285298] usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 507.285304] usb 1-1.1: Product: Intel(R) RealSense(TM) Tracking Camera T265 [ 507.285310] usb 1-1.1: Manufacturer: Intel(R) Corporation [ 507.285315] usb 1-1.1: SerialNumber: 9053121115070000

patrickpoirier51 commented 5 years ago

Well... that could be a short term solution: uhubctl is utility to control USB power per-port on smart USB hubs. Smart hub is defined as one that implements per-port power switching. https://github.com/mvp/uhubctl

patrickpoirier51 commented 5 years ago

@radfordi Jim, here is my '' Plan B '' to get the T265 flying without having to disconnect-reconnect

Home made USB cable with power routing to an external cable
Relay control of the power with the NC contact on T265 power
Driven by BananaPi GPIO (opto-Driver)
Shell script to Power reset before launching LibRealsense

Please note the Masking Tape Skirt to reduce direct sunlight exposure during outdoor tests

skylouis commented 4 years ago

hi @jmachuca77 I have the same issue, how did you get around this problem ?

jmachuca77 commented 4 years ago

didn't, its still an issue.

skylouis commented 4 years ago

hi @ev-mp @dorodnic when is Intel planning to patch this issue ?

RealSenseCustomerSupport commented 4 years ago

At this point in time, the workaround is to make sure that the host platform or USB hub has power and ready for enumeration prior to power provided to the T265.

Datasheet Statement (https://dev.intelrealsense.com/docs/tracking-camera-t265-datasheet): If T261/T265 is being connected to host system via USB hub, keep in mind that T261/T265 will enter into USB enumeration protocol as soon as 5V has been provided on VBUS pin. USB protocol is handled by the Movidius MA215x device. Make sure USB hub is connected and enumerated to host system prior to power being supplied to T261/T265.

doisyg commented 4 years ago

Why closing the issue? Does this mean this problem will not be solved? This make it hard to use in a production ready system

MrG4dget commented 4 years ago

I have to agree with @doisyg ! Its a real pain to get the T265 going! Having to hack a cable, and having scripts to power on/of the camera is just not a solution.

skylouis commented 4 years ago

Same for us, @RealSenseCustomerSupport you have now released the T261 for production environment but this issue make it really difficult for us to integrate it in our product. We have done complex HW modification to accommodate this lack of flexibility for Intel. We hope that a FW patch will solve this issue soon !

zwn commented 4 years ago

@RealSenseCustomerSupport Can we have this issue open while waiting for a solution? The problem can be experienced on multiple platforms as already reported here by many people and elsewhere on the internet. We are currently experiencing the issue on APU2 board. The suggested workaround is of no help since we cannot control when 5V is introduced to different parts of the board. T265 is alone with this problem.

@rdinoff, this is a known hardware issue. We are trying to work with Movidius to find a workaround. Currently, if the Movidius processor gets voltage before the hub itself, then it fails to detect the USB speed correctly.

@rdinoff Is any solution to this on the horizon?

zwn commented 4 years ago

@rdinoff Is any solution to this on the horizon?

Err sorry, I meant to call out @radfordi.

skylouis commented 4 years ago

If you want I can share with you the hardware solution we have put in place to control the 5V alimentation using GPIO of the single board computer.

fnoop commented 4 years ago

@RealSenseCustomerSupport - Please, don't be stupid. This is a USB sensor most commonly connected to some embedded/robotic device, there is every reasonable expectation that it will be plugged in at power/boot time and expected to work. This is a fault in your product, pure and simple. This is a recall level fault, if you can't fix it in firmware.

rmackay9 commented 4 years ago

I can confirm that with an RPI4 at least, @patrickpoirier51's suggestion of using uhubctrl to power cycle the USB hub does work. I've commented on this issue as well: https://github.com/IntelRealSense/librealsense/issues/5527

radfordi commented 4 years ago

@fnoop, the T265 comes with a 1yr warranty. Please contact customer support if you'd like to return your camera.

@zwn, the only solution we've found is to run uhubctrl. We've considered doing the power cycle ourselves in librealsense before trying to boot the camera to avoid needing a separate program, but even then, you would still need to have power control of the USB port for this to work.

cowboygary commented 4 years ago

Hi all, what's actually the real solution?

dexterpengji commented 4 years ago

Same issue: T265 will not be detected if it was connected before booting the computer. I have to replug it to the computer after booting to let it work. Hope this issue could be solved soon.

ethanrublee commented 4 years ago

TL;DR; soft reboots of the nano cause enumeration to fail. It can reliably be fixed using the command uhubctl -l 1-2 -p 1 -a cycle if there is no hub plugged into the nano, and the t265 is plugged into ports 2-4, but not 1.

Untitled drawing (1)

For the jetson nano developer kit, i was having inconsistent results with @radfordi's suggestion of using uhubctrl.

It seems like uhubctrl only effectively turns off the power for all dev kit USB ports on the nano if its issued for the first port on the 2-1 bus with ./uhubctl -l 1-2 -p 1 -a cycle Also, I noticed that if I plugged the t265 into the 1st port, it would sometimes enumerate and sometimes not, indicating the race condition, with an error like:

$ rs-enumerate-devices 
 30/07 23:00:01,517 ERROR [547566735376] (tm-boot.h:39) Error booting T265
 30/07 23:00:04,571 ERROR [547566735376] (tm-boot.h:39) Error booting T265
No device detected. Is it plugged in?

I also get the above error if I soft reboot the nano with sudo reboot, regardless of the port i plug into.

However, plugging the t265 into any other port (2-4), and then cycling port 1 with uhubctl, i have repeatable behavior.

The error also occurs if the the t265 is plugged into another port, and that port is cycled with uhubctl. I assume this is because the port does not actually loose its power.

Listing hub and port state with uhubctl

$ ./uhubctl
Current status for hub 2-1 [0bda:0411 Generic 4-Port USB 3.1 Hub, USB 3.10, 4 ports]
  Port 1: 02a0 power 5gbps Rx.Detect
  Port 2: 02a0 power 5gbps Rx.Detect
  Port 3: 02a0 power 5gbps Rx.Detect
  Port 4: 02a0 power 5gbps Rx.Detect
Current status for hub 1-2 [0bda:5411 Generic 4-Port USB 2.1 Hub, USB 2.10, 4 ports]
  Port 1: 0100 power
  Port 2: 0100 power
  Port 3: 0503 power highspeed enable connect [03e7:2150 Movidius Ltd. Movidius MA2X5X 03e72150]
  Port 4: 0103 power enable connect [1d50:606f canable.io canable gs_usb 001D00385852430320363530]

Turn off port 1:

$ ./uhubctl -l 1-2 -p 1 -a off
Current status for hub 2-1 [0bda:0411 Generic 4-Port USB 3.1 Hub, USB 3.10, 4 ports]
  Port 1: 02a0 power 5gbps Rx.Detect
Sent power off request
New status for hub 2-1 [0bda:0411 Generic 4-Port USB 3.1 Hub, USB 3.10, 4 ports]
  Port 1: 00a0 off
Current status for hub 1-2 [0bda:5411 Generic 4-Port USB 2.1 Hub, USB 2.10, 4 ports]
  Port 1: 0100 power
Sent power off request
New status for hub 1-2 [0bda:5411 Generic 4-Port USB 2.1 Hub, USB 2.10, 4 ports]
  Port 1: 0000 off

List it again, notice the USB devices have disconnected.

$ ./uhubctl
Current status for hub 2-1 [0bda:0411 Generic 4-Port USB 3.1 Hub, USB 3.10, 4 ports]
  Port 1: 00a0 off
  Port 2: 02a0 power 5gbps Rx.Detect
  Port 3: 02a0 power 5gbps Rx.Detect
  Port 4: 02a0 power 5gbps Rx.Detect
Current status for hub 1-2 [0bda:5411 Generic 4-Port USB 2.1 Hub, USB 2.10, 4 ports]
  Port 1: 0000 off
  Port 2: 0100 power
  Port 3: 0100 power
  Port 4: 0100 power

Turn back on

$ # ./uhubctl -l 1-2 -p 1 -a on
Current status for hub 2-1 [0bda:0411 Generic 4-Port USB 3.1 Hub, USB 3.10, 4 ports]
  Port 1: 00a0 off
Sent power on request
New status for hub 2-1 [0bda:0411 Generic 4-Port USB 3.1 Hub, USB 3.10, 4 ports]
  Port 1: 02a0 power 5gbps Rx.Detect
Current status for hub 1-2 [0bda:5411 Generic 4-Port USB 2.1 Hub, USB 2.10, 4 ports]
  Port 1: 0000 off
Sent power on request
New status for hub 1-2 [0bda:5411 Generic 4-Port USB 2.1 Hub, USB 2.10, 4 ports]
  Port 1: 0100 power

List again, devices reconnect:

./uhubctl
Current status for hub 2-1 [0bda:0411 Generic 4-Port USB 3.1 Hub, USB 3.10, 4 ports]
  Port 1: 02a0 power 5gbps Rx.Detect
  Port 2: 02a0 power 5gbps Rx.Detect
  Port 3: 02a0 power 5gbps Rx.Detect
  Port 4: 02a0 power 5gbps Rx.Detect
Current status for hub 1-2 [0bda:5411 Generic 4-Port USB 2.1 Hub, USB 2.10, 4 ports]
  Port 1: 0100 power
  Port 2: 0100 power
  Port 3: 0503 power highspeed enable connect [03e7:2150 Movidius Ltd. Movidius MA2X5X 03e72150]
  Port 4: 0103 power enable connect [1d50:606f canable.io canable gs_usb 001D00385852430320363530]

Here is the output of dmesg -w while the cycle command occurs, notice that the t265 disconnects and reconnects along with another usb device on port 4:

[16528.508935] usb 2-1: usb_suspend_both: status 0
[16528.509519] usb usb2: usb_suspend_both: status 0
[16528.684791] usb 2-1: usb_suspend_both: status 0
[16528.686002] usb usb2: usb_suspend_both: status 0
[16528.704161] usb usb2: usb_suspend_both: status 0
[16528.861067] usb 2-1: usb_suspend_both: status 0
[16529.168760] usb 2-1: usb_suspend_both: status 0
[16529.169469] usb usb2: usb_suspend_both: status 0
[16529.313631] usb 1-2.3: USB disconnect, device number 86
[16529.461699] usb 1-2.4: USB disconnect, device number 87
[16529.462256] gs_usb 1-2.4:1.0 can0: Couldn't shutdown device (err=-19)
[16529.648749] tegra-xusb-padctl 7009f000.xusb_padctl: power down UTMI pad 1
[16529.668747] usb 1-2: usb_suspend_both: status 0
[16531.316800] usb 2-1: usb_suspend_both: status 0
[16531.468778] usb 2-1: usb_suspend_both: status 0
[16531.469056] tegra-xusb-padctl 7009f000.xusb_padctl: power on UTMI pads 1
[16531.469169] usb usb2: usb_suspend_both: status 0
[16531.608749] tegra-xusb-padctl 7009f000.xusb_padctl: power down UTMI pad 1
[16531.628701] usb 1-2: usb_suspend_both: status 0
[16531.825162] tegra-xusb-padctl 7009f000.xusb_padctl: power on UTMI pads 1
[16532.032728] usb 1-2.3: new high-speed USB device number 88 using tegra-xusb
[16532.054736] usb 1-2.3: New USB device found, idVendor=03e7, idProduct=2150
[16532.054753] usb 1-2.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[16532.054765] usb 1-2.3: Product: Movidius MA2X5X
[16532.054777] usb 1-2.3: Manufacturer: Movidius Ltd.
[16532.054787] usb 1-2.3: SerialNumber: 03e72150
[16532.352688] usb 1-2.4: new full-speed USB device number 89 using tegra-xusb
[16532.375323] usb 1-2.4: New USB device found, idVendor=1d50, idProduct=606f
[16532.375336] usb 1-2.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[16532.375346] usb 1-2.4: Product: canable gs_usb
[16532.375354] usb 1-2.4: Manufacturer: canable.io
[16532.375362] usb 1-2.4: SerialNumber: 001D00385852430320363530
[16532.377118] gs_usb 1-2.4:1.0: Configuring for 1 interfaces
[16533.116000] IPv6: ADDRCONF(NETDEV_CHANGE): can0: link becomes ready

Enumeration and disabling the power fails if there is a hub plugged into a port on the nano (haven't been able to test with one supported by uhubctl), see this ticket https://github.com/mvp/uhubctl/issues/258

AllenIsaacJose commented 11 months ago

SOLVED

sudo sh -c "echo 141a0000.pcie > /sys/bus/platform/drivers/tegra194-pcie/unbind"
sudo sh -c "echo 141a0000.pcie > /sys/bus/platform/drivers/tegra194-pcie/bind"

Find the PCIe card to which the USB is connected. In my case 141a0000.pcie. The above command will turn the power supply to the PCIe card off and then on thereby making my T265 tracker camera detectable.

IntelRealSense / librealsense

T265 not enumerating correctly after boot #4681

Issue Description