GStreamer pipeline hangs after hours due to errors

streakflash · April 5, 2021, 8:32am

Hello,

I’ve designed this pipelien that uses two different cameras to compose output in my Python/Qt based application. Everything works fine but the app hangs after couple of hours or minutes,

Running gstreamer with debug level 3 exposes following warnings (Removed many sequencial duplicated lines)

0:00:01.016107283 14314   0x559bdfe590 WARN          v4l2bufferpool gstv4l2bufferpool.c:790:gst_v4l2_buffer_pool_start:<source_2:pool:src> Uncertain or not enough buffers, enabling copy threshold
0:00:01.923523511 14314   0x559bdfe590 WARN          v4l2bufferpool gstv4l2bufferpool.c:1952:gst_v4l2_buffer_pool_process:<source_2:pool:src> Dropping truncated buffer, this is likely a driver bug.
0:00:01.939974401 14314   0x559bdfe590 WARN                 v4l2src gstv4l2src.c:976:gst_v4l2src_create:<source_2> lost frames detected: count = 230 - ts: 0:00:00.919337027
0:00:02.990022327 14314   0x559bdfe590 WARN          v4l2bufferpool gstv4l2bufferpool.c:1952:gst_v4l2_buffer_pool_process:<source_2:pool:src> Dropping truncated buffer, this is likely a driver bug.
0:00:03.006565985 14314   0x559bdfe590 WARN                 v4l2src gstv4l2src.c:976:gst_v4l2src_create:<source_2> lost frames detected: count = 136 - ts: 0:00:01.985947187
0:00:04.289911178 14314   0x559bdfe590 WARN          v4l2bufferpool gstv4l2bufferpool.c:1952:gst_v4l2_buffer_pool_process:<source_2:pool:src> Dropping truncated buffer, this is likely a driver bug.
0:00:04.306536499 14314   0x559bdfe590 WARN                 v4l2src gstv4l2src.c:976:gst_v4l2src_create:<source_2> lost frames detected: count = 205 - ts: 0:00:03.285886027
0:00:14.463057820 14314   0x559bdfe590 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue2> error: Internal data stream error.
0:00:14.463200958 14314   0x559bdfe590 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue2> error: streaming stopped, reason not-linked (-1)
0:00:14.463468224 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue0> error: Internal data stream error.
0:00:14.463529633 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue0> error: streaming stopped, reason not-linked (-1)
0:00:14.607746627 14314   0x559bdfe540 WARN          v4l2bufferpool gstv4l2bufferpool.c:790:gst_v4l2_buffer_pool_start:<source_1:pool:src> Uncertain or not enough buffers, enabling copy threshold
0:00:15.610458006 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue4> error: Internal data stream error.
0:00:15.610592792 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue4> error: streaming stopped, reason not-linked (-1)
0:00:15.610765401 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue5> error: Internal data stream error.
0:00:15.610828698 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue5> error: streaming stopped, reason not-linked (-1)
0:00:15.703272958 14314   0x559bdfe540 WARN          v4l2bufferpool gstv4l2bufferpool.c:790:gst_v4l2_buffer_pool_start:<source_1:pool:src> Uncertain or not enough buffers, enabling copy threshold
0:00:17.365679776 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue8> error: Internal data stream error.
0:00:17.366101444 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue8> error: streaming stopped, reason not-linked (-1)
0:00:17.366437031 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue9> error: Internal data stream error.
0:00:17.366741162 14314   0x559bdfe540 WARN                   queue gstqueue.c:988:gst_queue_handle_sink_event:<queue9> error: streaming stopped, reason not-linked (-1)
0:00:17.466034826 14314   0x559bdfe590 WARN          v4l2bufferpool gstv4l2bufferpool.c:790:gst_v4l2_buffer_pool_start:<source_2:pool:src> Uncertain or not enough buffers, enabling copy threshold
0:01:07.267125833 14314   0x559bdfe540 WARN          v4l2bufferpool gstv4l2bufferpool.c:1952:gst_v4l2_buffer_pool_process:<source_1:pool:src> Dropping truncated buffer, this is likely a driver bug.
0:01:07.320018089 14314   0x559bdfe540 WARN                 v4l2src gstv4l2src.c:976:gst_v4l2src_create:<source_1> lost frames detected: count = 11 - ts: 0:00:49.825705798
0:01:18.469308144 14314   0x559bdfe590 WARN          v4l2bufferpool gstv4l2bufferpool.c:1952:gst_v4l2_buffer_pool_process:<source_2:pool:src> Dropping truncated buffer, this is likely a driver bug.
0:01:18.486142300 14314   0x559bdfe590 WARN                 v4l2src gstv4l2src.c:976:gst_v4l2src_create:<source_2> lost frames detected: count = 255 - ts: 0:01:01.014083542
0:02:35.649454180 14314   0x559bdfe590 WARN          v4l2bufferpool gstv4l2bufferpool.c:1952:gst_v4l2_buffer_pool_process:<source_2:pool:src> Dropping truncated buffer, this is likely a driver bug.
0:02:35.666158884 14314   0x559bdfe590 WARN                 v4l2src gstv4l2src.c:976:gst_v4l2src_create:<source_2> lost frames detected: count = 168 - ts: 0:02:18.194158446
0:02:40.715948578 14314   0x559bdfe590 WARN          v4l2bufferpool gstv4l2bufferpool.c:1952:gst_v4l2_buffer_pool_process:<source_2:pool:src> Dropping truncated buffer, this is likely a driver bug.
0:02:40.732665022 14314   0x559bdfe590 WARN                 v4l2src gstv4l2src.c:976:gst_v4l2src_create:<source_2> lost frames detected: count = 71 - ts: 0:02:23.260606902
0:03:03.117321379 14314   0x559bdfe540 WARN          v4l2bufferpool gstv4l2bufferpool.c:1952:gst_v4l2_buffer_pool_process:<source_1:pool:src> Dropping truncated buffer, this is likely a driver bug.
0:03:03.157331221 14314   0x559bdfe540 WARN                 v4l2src gstv4l2src.c:976:gst_v4l2src_create:<source_1> lost frames detected: count = 1 - ts: 0:02:45.663025742
0:03:32.122298850 14314   0x559bdfe540 WARN          v4l2bufferpool gstv4l2bufferpool.c:1952:gst_v4l2_buffer_pool_process:<source_1:pool:src> Dropping truncated buffer, this is likely a driver bug.
0:03:32.122536421 14314   0x559bdfe540 WARN           v4l2allocator gstv4l2allocator.c:1349:gst_v4l2_allocator_dqbuf:<source_1:pool:src:allocator> V4L2 provided buffer has bytesused 0 which is too small to include data_offset 0

The gstreamer pipeline looks like this

gst-launch-1.0 -e \
	v4l2src io-mode=2 device=/dev/video0 name=source_1 \
	v4l2src io-mode=2 device=/dev/video0 name=source_2 \
	nvcompositor name=comp sink_0::width=1920 sink_0::height=1080 sink_1::xpos=1280 sink_1::width=640 sink_1::height=360 \
	source_1. ! video/x-raw,format=YUY2,width=1920,height=1080,framerate=30/1 ! nvvidconv ! 'video/x-raw(memory:NVMM)' ! tee name=tee_source_1 \
	tee_source_1. ! queue ! comp. \
	tee_source_1. ! queue max-size-buffers=2 leaky=downstream ! nvvidconv ! video/x-raw,format=BGRx ! appsink max-buffers=10 drop=true emit-signals=true sync=false name=sink_primary \
	source_2. ! video/x-raw,format=YUY2,width=1920,height=1080,framerate=30/1 ! nvvidconv ! 'video/x-raw(memory:NVMM),width=640,height=360' ! tee name=tee_source_2 \
	tee_source_2. ! queue ! comp. \
	tee_source_2. ! queue max-size-buffers=2 leaky=downstream ! nvvidconv ! video/x-raw,format=BGRx,width=640,height=360 ! appsink max-buffers=10 drop=true emit-signals=true sync=false name=sink_secondary \
	comp. ! 'video/x-raw(memory:NVMM)' ! nvvidconv ! omxh265enc ! tee name=recording_tee \
	recording_tee. ! queue ! rtph265pay config-interval=10 pt=96 ! udpsink host=127.0.0.1 port=5000 \
	recording_tee. ! queue ! splitmuxsink location=cam-recording-%03d.mp4 max-size-time=9000000000000 max-files=96

I think the issue is that the appsink takes long to process and eventually something gets blocked in the pipeline but im not sure about it, experts please advice

DaneLLL · April 6, 2021, 5:35am

Hi,
We have deprecated omx plugins. Please try with nvv4l2h265enc.

And we suggest try nvv4l2camerasrc. You can rebuild it to support YUY2 format. Please refer to this patch:
Macrosilicon USB - #5 by DaneLLL

streakflash · April 6, 2021, 9:25pm

Hi DaneLLL,

Thank you for your reply, I have compiled the source with the YUY2 patches, the problem im facing with it now is that one or both of the cameras are showing green disorded image, it occures randomly thought, after reconnecting the usb cable it might fix or might remain greenish, with v4l2src I face no such issue

gst-launch-1.0 -e nvv4l2camerasrc device=/dev/video1 ! 'video/x-raw(memory:NVMM),format=YUY2,width=1920,height=1080,framerate=30/1' ! nvvidconv ! 'video/x-raw(memory:NVMM)' ! nv3dsink

Screenshot

about the nvv4l2h265enc plugin, i’ve been using it before flashing to the latest jetson image, unfortunately it is problematic for me now, my application has feature to swap the video sources on the go, when such event is requested, I send EOS to the pipelien and wait it to finish properly, then I start a completly new pipeline with swapped sources, but then, gstreamer crashes with the following output after setting newly created pipeline state to READY. I’d like to mention that this same method was used on previously flashed image without failures

    0:00:03.877650773 19473      0xaf02cf0 WARN                    v4l2 gstv4l2object.c:2375:gst_v4l2_object_add_interlace_mode:0xabc1400 Failed to determine interlace mode
    0:00:03.877743286 19473      0xaf02cf0 WARN                    v4l2 gstv4l2object.c:2375:gst_v4l2_object_add_interlace_mode:0xabc1400 Failed to determine interlace mode
    0:00:03.877803766 19473      0xaf02cf0 WARN                    v4l2 gstv4l2object.c:2375:gst_v4l2_object_add_interlace_mode:0xabc1400 Failed to determine interlace mode
    0:00:03.877909238 19473      0xaf02cf0 WARN                    v4l2 gstv4l2object.c:4434:gst_v4l2_object_probe_caps:<nvv4l2h265enc1:src> Failed to probe pixel aspect ratio with VIDIOC_CROPCAP: Unknown error -1

I think the problem root is in nvcompositor since I tried to run the pipeline without

recording_tee. ! queue ! rtph265pay config-interval=10 pt=96 ! udpsink host=127.0.01 port=5000

and then without the second part

recording_tee. ! queue ! splitmuxsink location=/mnt/storage/%02d.mp4 max-size-time=9000000000000 max-files=96 async-finalize=true

yet it fails every time when I try to change re-run the pipeline, only excluding the entire comp. (the last 3 lines) definition helps

beside that when I run the pipeline with nvv4l2h265enc I constantly see the following message

0:00:03.209421132 20591 0x7f38003850 FIXME h265parse gsth265parse.c:1798:gst_h265_parse_parse_frame: Implement timestamp/duration interpolation based on SEI message

Here is my final pipeline

v4l2src io-mode=2 device=/dev/video0 name=source_1 ! video/x-raw,format=YUY2,width=1920,height=1080,framerate=30/1 ! nvvidconv ! video/x-raw(memory:NVMM) ! tee name=tee_source_1 
v4l2src io-mode=2 device=/dev/video1 name=source_2 ! video/x-raw,format=YUY2,width=1920,height=1080,framerate=30/1 ! nvvidconv ! video/x-raw(memory:NVMM),width=640,height=360 ! tee name=tee_source_2 
nvcompositor name=comp sink_0::width=1920 sink_0::height=1080 sink_1::xpos=1280 sink_1::width=640 sink_1::height=360 
tee_source_1. ! queue ! comp. 
tee_source_2. ! queue ! comp. 
tee_source_1. ! queue ! nvvidconv ! video/x-raw,format=BGRx ! appsink drop=true emit-signals=true sync=false name=sink_primary 
tee_source_2. ! queue ! nvvidconv ! video/x-raw,format=BGRx ! appsink drop=true emit-signals=true sync=false name=sink_secondary 
comp. ! video/x-raw(memory:NVMM) ! nvvidconv ! video/x-raw(memory:NVMM),format=NV12 ! nvv4l2h265enc bitrate=8000000 ! h265parse ! tee name=recording_tee 
recording_tee. ! queue ! rtph265pay config-interval=10 pt=96 ! udpsink host=127.0.0.1 port=5000 
recording_tee. ! queue ! splitmuxsink location=/mnt/storage/2021-04-07/021642561645/%02d.mp4 max-size-time=9000000000000 max-files=96

DaneLLL · April 7, 2021, 3:22am

Hi,
From the screenshot, the color looks not right. Is your camera source in YUY2 format? Seems like it is in UYVY or other format. Do you use USB cameras or YUV sensors?

And for hitting error in swapping buffers, the case is a bit complicated and we would need a test sample to reproduce the issue. Please help on this.

And if you are on JP4.5(r32.5), we have nvvidconv and nvcompositor open source. You may download the package and debug further:
https://developer.nvidia.com/embedded/l4t/r32_release_v5.1/r32_release_v5.1/sources/t186/public_sources.tbz2

streakflash · April 7, 2021, 9:11am

I use a DFG/HDSDI - SDI-to-USB 3.0 converter
for both cameras

$ v4l2-ctl -d /dev/video0 --list-formats-ext
	Index       : 1
	Type        : Video Capture
	Pixel Format: 'YUYV'
	Name        : YUYV 4:2:2
		Size: Discrete 1920x1080
			Interval: Discrete 0.033s (30.000 fps)
			Interval: Discrete 0.033s (29.970 fps)
			Interval: Discrete 0.040s (25.000 fps)
			Interval: Discrete 0.042s (24.000 fps)
			Interval: Discrete 0.042s (23.940 fps)
		Size: Discrete 1920x540
			Interval: Discrete 0.017s (60.000 fps)
			Interval: Discrete 0.017s (59.940 fps)
			Interval: Discrete 0.020s (50.000 fps)
		Size: Discrete 1280x720
			Interval: Discrete 0.017s (60.000 fps)
			Interval: Discrete 0.017s (59.940 fps)
			Interval: Discrete 0.020s (50.000 fps)
			Interval: Discrete 0.033s (30.000 fps)
			Interval: Discrete 0.033s (29.970 fps)
			Interval: Discrete 0.040s (25.000 fps)
			Interval: Discrete 0.042s (24.000 fps)
			Interval: Discrete 0.042s (23.940 fps)

streakflash · April 9, 2021, 9:00am

After further debugging im sure the nvv4l2h265enc component is at fault. I have prepared a simple python application that emits the pipeline swapping process which is used in my main application: test_app.py (3.2 KB)

On gst debug level 3, this is the only message i get before the crash happens

0:00:07.098242672 14323 0x7fa0008690 WARN v4l2 gstv4l2object.c:4434:gst_v4l2_object_probe_caps:nvv4l2h265enc1:src Failed to probe pixel aspect ratio with VIDIOC_CROPCAP: Unknown error -1

When nvv4l2h265enc maxperf-enable=1 bitrate=8000000 definition is not used the application works as intended.
I have also tried to use nvv4l2vp9enc and nvv4l2h264enc, all of them behave the same

streakflash · April 11, 2021, 7:34pm

Beside nvv4l2h265enc, camera hangs on the simpliest pipelien after 5 minutes to 1 hour, the device becomes unavailable and I have to reconnect the USB cable, I have checked the USB cables they are not malfunction. There is no problem when running pipelien only with 1 camera source

gst-launch-1.0 -e \
	v4l2src device=/dev/video0 name=source_1 ! 'video/x-raw,format=YUY2,width=1920,height=1080,framerate=30/1' ! nvvidconv ! 'video/x-raw(memory:NVMM),width=640,height=380' ! tee name=tee_source_1 \
	v4l2src device=/dev/video1 name=source_2 ! 'video/x-raw,format=YUY2,width=1920,height=1080,framerate=30/1' ! nvvidconv ! 'video/x-raw(memory:NVMM),width=640,height=380' ! tee name=tee_source_2 \
	tee_source_1. ! queue ! nv3dsink sync=false name=sink_primary \
	tee_source_2. ! queue ! nv3dsink sync=false name=sink_secondary

Can this be USB bandwidth issue ?

Kernel message is

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 4.9.201-tegra (buildbrain@mobile-u64-5296-d7000) (gcc version 7.3.1 20180425 [linaro-7.3-2018.05 revision d29120a424ecfbc167ef90065c0eeb7f91977701] (Linaro GCC 7.3-2018.05) ) #1 SMP PREEMPT Tue Mar 2 19:53:23 PST 2021
[    0.000000] Boot CPU: AArch64 Processor [4e0f0040]
[    0.000000] OF: fdt:memory scan node memory, reg size 48,
[    0.000000] OF: fdt: - 80000000 ,  2c000000
[    0.000000] OF: fdt: - ac200000 ,  44800000
[    0.000000] OF: fdt: - 100000000 ,  180000000
[    0.000000] earlycon: tegra_comb_uart0 at MMIO32 0x000000000c168000 (options '')
[    0.000000] bootconsole [tegra_comb_uart0] enabled
[    0.000000] Found tegra_fbmem: 00800000@a06a0000
[    0.000000] Found lut_mem: 00002008@a069a000
[    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 vpr-carveout, compatible id nvidia,vpr-carveout
[    0.000000] OF: reserved mem: initialized node grid-of-semaphores, compatible id nvidia,gosmem
[    0.000000] cma: Reserved 64 MiB at 0x00000000c2000000
[    0.000000] On node 0 totalpages: 2031101
[    0.000000]   DMA zone: 7160 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 458237 pages, LIFO batch:31
[    0.000000]   Normal zone: 24576 pages used for memmap
[    0.000000]   Normal zone: 1572864 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 24 pages/cpu s57560 r8192 d32552 u98304
[    0.000000] pcpu-alloc: s57560 r8192 d32552 u98304 alloc=24*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [0] 4 [0] 5 
[    0.000000] Speculative Store Bypass Disable mitigation not required
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 1999365
[    0.000000] Kernel command line: console=ttyTCU0,115200 video=tegrafb no_console_suspend=1 earlycon=tegra_comb_uart,mmio32,0x0c168000 gpt rootfs.slot_suffix= tegra_fbmem=0x800000@0xa06a0000 lut_mem=0x2008@0xa069a000 usbcore.old_scheme_first=1 tegraid=19.1.2.0.0 maxcpus=6 boot.slot_suffix= boot.ratchetvalues=0.4.2 vpr_resize sdhci_tegra.en_boot_part_access=1    quiet root=/dev/mmcblk0p1 rw rootwait rootfstype=ext4 console=ttyTCU0,115200n8 console=tty0 fbcon=map:0 net.ifnames=0 usb_port_owner_info=2 usbcore.usbfs_memory_mb=1024 usbcore.autosuspend=-1
[    0.000000] log_buf_len individual max cpu contribution: 32768 bytes
[    0.000000] log_buf_len total cpu_extra contributions: 163840 bytes
[    0.000000] log_buf_len min size: 32768 bytes
[    0.000000] log_buf_len: 262144 bytes
[    0.000000] early log buf free: 29104(88%)
[    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[    0.000000] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
[    0.000000] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
[    0.000000] Memory: 7182604K/8124404K available (15294K kernel code, 2942K rwdata, 6664K rodata, 8576K init, 609K bss, 188136K reserved, 753664K 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 - 0xffffff8008f70000   ( 15296 KB)
[    0.000000]     .rodata : 0xffffff8008f70000 - 0xffffff8009600000   (  6720 KB)
[    0.000000]       .init : 0xffffff8009600000 - 0xffffff8009e60000   (  8576 KB)
[    0.000000]       .data : 0xffffff8009e60000 - 0xffffff800a13f808   (  2943 KB)
[    0.000000]        .bss : 0xffffff800a13f808 - 0xffffff800a1d7cbc   (   610 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 - 0xffffffbf08000000   (   128 MB actual)
[    0.000000]     memory  : 0xffffffc000000000 - 0xffffffc200000000   (  8192 MB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, 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=6.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=6
[    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.000005] sched_clock: 56 bits at 31MHz, resolution 32ns, wraps every 4398046511088ns
[    0.000671] Console: colour dummy device 80x25
[    0.000683] console [tty0] enabled
[    0.000690] bootconsole [tegra_comb_uart0] disabled
[    0.000703] kmemleak: Kernel memory leak detector disabled
[    0.000721] Calibrating delay loop (skipped), value calculated using timer frequency.. 62.50 BogoMIPS (lpj=125000)
[    0.000736] pid_max: default: 32768 minimum: 301
[    0.001868] Security Framework initialized
[    0.002473] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes)
[    0.002484] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes)
[    0.004154] ftrace: allocating 47208 entries in 185 pages
[    0.399853] sched-energy: Sched-energy-costs installed from DT
[    0.399872] ASID allocator initialised with 65536 entries
[    0.434868] tegra-id: chipid=21917.
[    0.434880] tegra-id: opt_subrevision=1.
[    0.434906] Tegra Revision: A02p SKU: 0xde CPU Process: 0 SoC Process: 0
[    0.434939] DTS File Name: /dvs/git/dirty/git-master_linux/kernel/kernel-4.9/arch/arm64/boot/dts/../../../../../../hardware/nvidia/platform/t19x/jakku/kernel-dts/tegra194-p3668-all-p3509-0000.dts
[    0.434951] DTB Build time: Mar  2 2021 19:56:08
[    0.483062] CPU1: Booted secondary processor [4e0f0040]
[    0.515119] CPU2: Booted secondary processor [4e0f0040]
[    0.547243] CPU3: Booted secondary processor [4e0f0040]
[    0.579481] CPU4: Booted secondary processor [4e0f0040]
[    0.611616] CPU5: Booted secondary processor [4e0f0040]
[    0.611850] Brought up 6 CPUs
[    0.611860] SMP: Total of 6 processors activated.
[    0.611869] CPU features: detected feature: Privileged Access Never
[    0.611876] CPU features: detected feature: LSE atomic instructions
[    0.611882] CPU features: detected feature: User Access Override
[    0.611889] CPU features: detected feature: 32-bit EL0 Support
[    0.613419] CPU: All CPU(s) started at EL2
[    0.613474] alternatives: patching kernel code
[    0.619959] devtmpfs: initialized
[    0.660803] Initilizing CustomIPI irq domain
[    0.661116] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.661130] futex hash table entries: 2048 (order: 5, 131072 bytes)
[    0.685127] pinctrl core: initialized pinctrl subsystem
[    0.685344] OS set in device tree is not L4T.
[    0.685695] regulator-dummy: no parameters
[    0.685945] Initializing plugin-manager
[    0.685990] Plugin module not found
[    0.686038] Plugin-manager status disabled
[    0.687398] NET: Registered protocol family 16
[    0.689532] pstore: using zlib compression
[    0.689552] console [pstore-1] enabled
[    0.689558] pstore: Registered ramoops as persistent store backend
[    0.689565] ramoops: attached 0x200000@0xf0800000, ecc: 0/0
[    0.706964] cpuidle: using governor menu
[    0.708050] bpmp: waiting for handshake
[    0.708057] bpmp: handshake completed
[    0.708074] bpmp: synchronizing channels
[    0.708083] bpmp: channels synchronized
[    0.708089] bpmp: mail init ok
[    0.710838] t19x-arm-smmu 12000000.iommu: found 3 SMMUs and ISO SMMU id is 2
[    0.711044] t19x-arm-smmu 12000000.iommu: probing hardware configuration...
[    0.711051] t19x-arm-smmu 12000000.iommu: SMMUv2 with:
[    0.711058] t19x-arm-smmu 12000000.iommu: 	stage 1 translation
[    0.711064] t19x-arm-smmu 12000000.iommu: 	stage 2 translation
[    0.711070] t19x-arm-smmu 12000000.iommu: 	nested translation
[    0.711079] t19x-arm-smmu 12000000.iommu: 	stream matching with 128 register groups, mask 0x7f80
[    0.711087] t19x-arm-smmu 12000000.iommu: SMMU address space size (0x800000) differs from mapped region size (0x1000000)!
[    0.711099] t19x-arm-smmu 12000000.iommu: 	64 context banks (0 stage-2 only)
[    0.711109] t19x-arm-smmu 12000000.iommu: 	Stage-1: 39-bit VA -> 48-bit IPA
[    0.711139] t19x-arm-smmu 12000000.iommu: 	Stage-2: 39-bit IPA -> 48-bit PA
[    0.715131] vdso: 2 pages (1 code @ ffffff8008f77000, 1 data @ ffffff8009e64000)
[    0.715162] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.717567] atomic_pool_init():622: DMA: preallocated 1024 KiB pool for atomic allocations
[    0.718814] tegra_aon_clk_init: ok
[    0.718828] Registering BPMP clocks...
[    0.718926] tegra_bpmp_clk_init: clock init ok (400 clks)
[    0.719491] Serial: AMBA PL011 UART driver
[    0.719656] tegra_powergate_init: DONE
[    0.719801] DTS File Name: /dvs/git/dirty/git-master_linux/kernel/kernel-4.9/arch/arm64/boot/dts/../../../../../../hardware/nvidia/platform/t19x/jakku/kernel-dts/tegra194-p3668-all-p3509-0000.dts
[    0.719842] DTB Build time: Mar  2 2021 19:56:08
[    0.722668] Tegra reboot handler registered.
[    0.730803] iommu: Adding device 14160000.pcie to group 0
[    0.731520] iommu: Adding device 141a0000.pcie to group 1
[    0.733048] iommu: Adding device 2490000.ether_qos to group 2
[    0.733550] iommu: Adding device 3100000.serial to group 3
[    0.734018] iommu: Adding device 3110000.serial to group 4
[    0.734440] iommu: Adding device 3140000.serial to group 5
[    0.735066] tegra-pmc c360000.pmc: scratch reg offset dts data not present
[    0.735352] tegra-pmc: get_secure_pmc_setting: done secure_pmc=0
[    0.735388] tegra-pmc: ### PMC reset source: TEGRA_POWER_ON_RESET
[    0.735394] tegra-pmc: ### PMC reset level: TEGRA_RESET_LEVEL_L0
[    0.735399] tegra-pmc: ### PMC reset status reg: 0x0
[    0.735459] tegra-pmc: PMC Prod config success
[    0.735678] padctrl padctrl.0: Pad control driver tegra-pmc-padctrl registered
[    0.735693] tegra-pmc c360000.pmc: IO padctrl driver initialized
[    0.736020] iommu: Adding device 3400000.sdhci to group 6
[    0.736519] iommu: Adding device 3210000.spi to group 7
[    0.736924] iommu: Adding device 3230000.spi to group 8
[    0.737327] iommu: Adding device 3270000.spi to group 9
[    0.738642] iommu: Adding device 3160000.i2c to group 10
[    0.739117] iommu: Adding device c240000.i2c to group 11
[    0.739626] iommu: Adding device 3180000.i2c to group 12
[    0.740062] iommu: Adding device 3190000.i2c to group 13
[    0.740708] iommu: Adding device 31b0000.i2c to group 14
[    0.741117] iommu: Adding device 31c0000.i2c to group 15
[    0.741548] iommu: Adding device c250000.i2c to group 16
[    0.741962] iommu: Adding device 31e0000.i2c to group 17
[    0.742580] iommu: Adding device sound to group 18
[    0.743150] iommu: Adding device 3510000.hda to group 19
[    0.744078] iommu: Adding device bc00000.rtcpu to group 20
[    0.745839] iommu: Adding device 13e10000.host1x to group 21
[    0.746290] iommu: Adding device 13e10000.host1x:ctx0 to group 22
[    0.746644] iommu: Adding device 13e10000.host1x:ctx1 to group 23
[    0.746992] iommu: Adding device 13e10000.host1x:ctx2 to group 24
[    0.747371] iommu: Adding device 13e10000.host1x:ctx3 to group 25
[    0.747785] iommu: Adding device 13e10000.host1x:ctx4 to group 26
[    0.748183] iommu: Adding device 13e10000.host1x:ctx5 to group 27
[    0.748536] iommu: Adding device 13e10000.host1x:ctx6 to group 28
[    0.748924] iommu: Adding device 13e10000.host1x:ctx7 to group 29
[    0.749698] iommu: Adding device 15340000.vic to group 30
[    0.750098] iommu: Adding device 15380000.nvjpg to group 31
[    0.750410] iommu: Adding device 15500000.tsec to group 32
[    0.750691] iommu: Adding device 15100000.tsecb to group 33
[    0.750982] iommu: Adding device 15480000.nvdec to group 34
[    0.751260] iommu: Adding device 15140000.nvdec1 to group 35
[    0.751574] iommu: Adding device 154c0000.nvenc to group 36
[    0.751855] iommu: Adding device 15a80000.nvenc1 to group 37
[    0.752284] iommu: Adding device 15880000.nvdla0 to group 38
[    0.752760] iommu: Adding device 158c0000.nvdla1 to group 39
[    0.753465] iommu: Adding device 15200000.nvdisplay to group 40
[    0.753648] platform 15200000.nvdisplay: IOVA linear map 0x00000000a06a0000(800000)
[    0.753660] platform 15200000.nvdisplay: IOVA linear map 0x00000000a069a000(3000)
[    0.757631] platform 15200000.nvdisplay: IOVA linear map 0x00000000c6000000(2a000000)
[    0.757729] t19x-arm-smmu: Adding 15200000.nvdisplay to ISO SMMU client
[    0.758415] iommu: Adding device 15210000.nvdisplay to group 41
[    0.758491] t19x-arm-smmu: Adding 15210000.nvdisplay to ISO SMMU client
[    0.760375] iommu: Adding device 15c10000.vi to group 42
[    0.760590] t19x-arm-smmu: Adding 15c10000.vi to ISO SMMU client
[    0.761071] iommu: Adding device 14800000.isp to group 43
[    0.761996] iommu: Adding device 16000000.pva0 to group 44
[    0.762539] iommu: Adding device 16800000.pva1 to group 45
[    0.763036] iommu: Adding device 15810000.se to group 46
[    0.763424] iommu: Adding device 15820000.se to group 47
[    0.763726] iommu: Adding device 15830000.se to group 48
[    0.764033] iommu: Adding device 15840000.se to group 49
[    0.764310] iommu: Adding device c1a0000.aon to group 50
[    0.766145] iommu: Adding device d000000.bpmp to group 51
[    0.766489] bpmp: ping status is 0
[    0.766629] bpmp d000000.bpmp: firmware tag is e73a758761f0c6d24a1e69a2ac6b5035
[    0.769787] bpmp d000000.bpmp: probe ok
[    0.771550] tegra-reset 0.bpmp_reset: registered 190 resets.
[    0.772289] iommu: Adding device smmu_test to group 52
[    0.773530] mc: mapped MMIO address: 0xffffff800a590000 -> 0x2c10000
[    0.773564] mc: mapped MMIO address: 0xffffff800a5b0000 -> 0x2c20000
[    0.773597] mc: mapped MMIO address: 0xffffff800a5d0000 -> 0x2c30000
[    0.773627] mc: mapped MMIO address: 0xffffff800a7b0000 -> 0x2c40000
[    0.773656] mc: mapped MMIO address: 0xffffff800a7d0000 -> 0x2c50000
[    0.773689] mc: mapped MMIO address: 0xffffff800b010000 -> 0x2b80000
[    0.773717] mc: mapped MMIO address: 0xffffff800b030000 -> 0x2b90000
[    0.773745] mc: mapped MMIO address: 0xffffff800b050000 -> 0x2ba0000
[    0.773792] mc: mapped MMIO address: 0xffffff800b070000 -> 0x2bb0000
[    0.773833] mc: mapped MMIO address: 0xffffff800b090000 -> 0x1700000
[    0.773855] mc: mapped MMIO address: 0xffffff800b0b0000 -> 0x1710000
[    0.773877] mc: mapped MMIO address: 0xffffff800b0d0000 -> 0x1720000
[    0.773895] mc: mapped MMIO address: 0xffffff800b0f0000 -> 0x1730000
[    0.773913] mc: mapped MMIO address: 0xffffff800b110000 -> 0x1740000
[    0.773929] mc: mapped MMIO address: 0xffffff800b130000 -> 0x1750000
[    0.773946] mc: mapped MMIO address: 0xffffff800b150000 -> 0x1760000
[    0.773962] mc: mapped MMIO address: 0xffffff800b170000 -> 0x1770000
[    0.774059] mc-err: mcerr ops are set to t19x
[    0.779784] iommu: Adding device 2600000.dma to group 53
[    0.784600] gpio gpiochip0: gpio-line-names specifies 240 line names but there are 224 lines on the chip
[    0.785778] GPIO line 339 (wifi-enable) hogged as output/high
[    0.785825] GPIO line 412 (camera-control-output-low) hogged as output/low
[    0.785864] GPIO line 413 (camera-control-output-low) hogged as output/low
[    0.786211] gpiochip_setup_dev: registered GPIOs 288 to 511 on device: gpiochip0 (tegra-gpio)
[    0.794840] gpio gpiochip1: gpio-line-names specifies 21 line names but there are 40 lines on the chip
[    0.794936] GPIO line 253 (pex-refclk-sel-low) hogged as output/low
[    0.794977] GPIO line 266 (w-disable1) hogged as output/high
[    0.795013] GPIO line 264 (w-disable2) hogged as output/high
[    0.795049] GPIO line 265 (suspend-led-gpio) hogged as output/high
[    0.795376] gpiochip_setup_dev: registered GPIOs 248 to 287 on device: gpiochip1 (tegra-gpio-aon)
[    0.797996] tegra186-aowake c370000.pmc: WAKE_AOWAKE_CNTRL_83 = 0x10a
[    0.798007] tegra186-aowake c370000.pmc: WAKE_AOWAKE_CTRL_0 = 3
[    0.798018] tegra186-aowake c370000.pmc: WAKE_AOWAKE_CNTRL_24(PMU_INT) = 256
[    0.798867] iommu: Adding device 3550000.xudc to group 54
[    0.799573] iommu: Adding device 3610000.xhci to group 55
[    0.801708] arm64_ras arm64_ras: probed
[    0.802117] ras_fhi_enable: FHI 469 enabled on CPU0
[    0.802169] ras_fhi_enable: FHI 470 enabled on CPU1
[    0.802253] ras_fhi_enable: FHI 471 enabled on CPU2
[    0.802339] ras_fhi_enable: FHI 472 enabled on CPU3
[    0.802426] ras_fhi_enable: FHI 473 enabled on CPU4
[    0.802526] ras_fhi_enable: FHI 474 enabled on CPU5
[    0.802717] carmel_ras_enable: RAS enabled on cpu0
[    0.802896] carmel_ras_enable: RAS enabled on cpu1
[    0.803113] carmel_ras_enable: RAS enabled on cpu2
[    0.803322] carmel_ras_enable: RAS enabled on cpu3
[    0.803537] carmel_ras_enable: RAS enabled on cpu4
[    0.803736] carmel_ras_enable: RAS enabled on cpu5
[    0.803815] carmel_ras carmel_ras: probed
[    0.804968] tegra-cbb 2300000.cbb-noc: noc_secure_irq = 478, noc_nonsecure_irq = 477>
[    0.805487] tegra-cbb c600000.aon-noc: noc_secure_irq = 480, noc_nonsecure_irq = 479>
[    0.806397] tegra-cbb d600000.bpmp-noc: noc_secure_irq = 482, noc_nonsecure_irq = 481>
[    0.807281] tegra-cbb be00000.rce-noc: noc_secure_irq = 484, noc_nonsecure_irq = 483>
[    0.808119] tegra-cbb b600000.sce-noc: noc_secure_irq = 486, noc_nonsecure_irq = 485>
[    0.808468] tegra-cbb 14040000.cv-noc: defer probe as CV-NOC not probed yet
[    0.809886] vdd-ac-bat: 5000 mV 
[    0.810356] vdd-sdmmc1-sw: 3300 mV 
[    0.810726] vdd-1v8-sd: 1800 mV 
[    0.811088] vdd-3v3-cvb: 3300 mV 
[    0.811429] vdd-1v8-cvb: 1800 mV 
[    0.811807] vdd-epb-1v0: supplied by vdd-3v3-cvb
[    0.811858] vdd-epb-1v0: 1000 mV 
[    0.812335] avdd-cam-2v8: 2800 mV 
[    0.812683] vdd-fan: 5000 mV 
[    0.813051] vdd-hdmi-5v0: 5000 mV 
[    0.813401] vdd_sys_en: 1200 mV 
[    0.850251] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[    0.854976] eventlib_kernel: keventlib is initialized, test id: 0
[    0.855301] SCSI subsystem initialized
[    0.855560] libata version 3.00 loaded.
[    0.855821] usbcore: registered new interface driver usbfs
[    0.855877] usbcore: registered new interface driver hub
[    0.856002] usbcore: registered new device driver usb
[    0.867581] tegra-i2c 31e0000.i2c: could not find pctldev for node /host1x/dpaux@155F0000/pinmux@0, deferring probe
[    0.870805] max77620 4-003c: PMIC Version OTP:0x51 and ES:0x1
[    0.877678] vdd-1v0: at 1000 mV 
[    0.881687] vdd-1v8-hs: at 1800 mV 
[    0.885740] vdd-1v8-ls: at 1800 mV 
[    0.889742] vdd-1v8-ao: at 1800 mV 
[    0.893770] vddio-ddr-1v1: at 1100 mV 
[    0.897544] vdd-rtc: at 800 mV 
[    0.898917] spmic-ldo1: at 2375 mV 
[    0.905607] vdd-ao-3v3: at 3300 mV 
[    0.913634] vddio-emmc-3v3: at 3300 mV 
[    0.914964] spmic-ldo4: at 1587 mV 
[    0.921701] vdd-usb-3v3: at 3300 mV 
[    0.929751] vddio-sdmmc1-3v3: at 3300 mV 
[    0.933763] vdd-csi-1v2: at 1200 mV 
[    0.935308] spmic-ldo8: at 1800 mV 
[    0.940289] GPIO line 246 (gpio_default) hogged as output/high
[    0.941681] GPIO line 247 (gpio_default) hogged as output/high
[    0.942031] gpiochip_setup_dev: registered GPIOs 240 to 247 on device: gpiochip2 (max77620-gpio)
[    0.942387] max77620 4-003c: max77620 probe successful
[    0.943252] media: Linux media interface: v0.10
[    0.943355] Linux video capture interface: v2.00
[    0.944815] pps_core: LinuxPPS API ver. 1 registered
[    0.944822] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.944839] PTP clock support registered
[    0.945116] tegra_wdt_t18x 30c0000.watchdog: Expiry count is deprecated
[    0.945405] tegra_wdt_t18x 30c0000.watchdog: Tegra WDT init timeout = 120 sec
[    0.945451] tegra_wdt_t18x 30c0000.watchdog: Registered successfully
[    0.948288] trusty trusty: trusty version: Built: 19:52:48 Mar  2 2021 
[    0.948351] trusty trusty: selected api version: 3 (requested 3)
[    0.949499] Advanced Linux Sound Architecture Driver Initialized.
[    0.950082] Bluetooth: Core ver 2.22
[    0.950136] NET: Registered protocol family 31
[    0.950142] Bluetooth: HCI device and connection manager initialized
[    0.950153] Bluetooth: HCI socket layer initialized
[    0.950161] Bluetooth: L2CAP socket layer initialized
[    0.950188] Bluetooth: SCO socket layer initialized
[    0.953135] camchar: rtcpu character device driver loaded
[    0.953644] gpio tegra-gpio wake61 for gpio=201(Z:1)
[    0.953748] extcon-gpio-states external-connection:extcon@1: Cable state:0, cable id:0
[    0.954772] clocksource: Switched to clocksource arch_sys_counter
[    1.004788] VFS: Disk quotas dquot_6.6.0
[    1.004872] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    1.005234] nvmap_heap_init: nvmap_heap_init: created heap block cache
[    1.006548] tegra-carveouts tegra-carveouts: assigned reserved memory node grid-of-semaphores
[    1.006598] dma_declare_coherent_resizable_cma_memory:324: resizable heap=vpr, base=0x00000000c6000000, size=0x2a000000
[    1.006918] cma: enabled page replacement for spfn=c6000, epfn=f0000
[    1.006927] dma_declare_coherent_resizable_cma_memory:373: resizable cma heap=vpr create successful
[    1.006940] nvmap: nvmap_select_cache_ops() nvmap cache ops set to scf
[    1.006948] nvmap_page_pool_init: Total RAM pages: 1984067
[    1.006955] nvmap_page_pool_init: nvmap page pool size: 248008 pages (968 MB)
[    1.007158] nvmap_background_zero_thread: PP zeroing thread starting.
[    1.007654] misc nvmap: created heap vpr base 0x00000000c6000000 size (688128KiB)
[    1.009939] tegra-gpcdma 2600000.dma: GPC DMA driver register 31 channels
[    1.022720] thermal thermal_zone0: Registering thermal zone thermal_zone0 for type CPU-therm
[    1.023012] thermal thermal_zone1: Registering thermal zone thermal_zone1 for type GPU-therm
[    1.023217] thermal thermal_zone2: Registering thermal zone thermal_zone2 for type AUX-therm
[    1.023390] thermal thermal_zone3: Registering thermal zone thermal_zone3 for type AO-therm
[    1.023555] thermal thermal_zone4: Registering thermal zone thermal_zone4 for type PMIC-Die
[    1.024699] la/ptsa driver initialized.
[    1.024973] NET: Registered protocol family 2
[    1.025697] TCP established hash table entries: 65536 (order: 7, 524288 bytes)
[    1.026031] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[    1.026644] TCP: Hash tables configured (established 65536 bind 65536)
[    1.026690] UDP hash table entries: 4096 (order: 5, 131072 bytes)
[    1.026851] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes)
[    1.027264] NET: Registered protocol family 1
[    1.027966] RPC: Registered named UNIX socket transport module.
[    1.027972] RPC: Registered udp transport module.
[    1.027978] RPC: Registered tcp transport module.
[    1.027983] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    1.027993] PCI: CLS 0 bytes, default 64
[    1.028222] Trying to unpack rootfs image as initramfs...
[    1.253654] Freeing initrd memory: 7064K
[    1.270954] random: fast init done
[    1.275077] host1x 13e10000.host1x: initialized
[    1.276811] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available
[    1.281503] audit: initializing netlink subsys (disabled)
[    1.281540] audit: type=2000 audit(0.900:1): initialized
[    1.282395] workingset: timestamp_bits=46 max_order=21 bucket_order=0
[    1.291152] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    1.292410] ntfs: driver 2.1.32 [Flags: R/W].
[    1.293057] 9p: Installing v9fs 9p2000 file system support
[    1.298062] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 240)
[    1.298258] io scheduler noop registered
[    1.298515] io scheduler cfq registered (default)
[    1.301966] gic 2a41000.agic-controller: GIC IRQ controller registered
[    1.305639] iommu: Adding device 2993000.adsp to group 56
[    1.317718] iommu: Adding device aconnect@2a41000:adsp_audio to group 57
[    1.317903] tegra-aconnect aconnect@2a41000: Tegra ACONNECT bus registered
[    1.330258] tegra-pwm 3280000.pwm: PWM clk can sleep in ops
[    1.330721] tegra-pwm c340000.pwm: PWM clk can sleep in ops
[    1.331348] tegra-pwm 32c0000.pwm: PWM clk can sleep in ops
[    1.331734] tegra-pwm 32d0000.pwm: PWM clk can sleep in ops
[    1.332176] tegra-pwm 32f0000.pwm: PWM clk can sleep in ops
[    1.335525] tegra_camera_platform tegra-camera-platform: tegra_camera_probe:camera_platform_driver probe
[    1.335739] misc tegra_camera_ctrl: tegra_camera_isomgr_register isp_iso_bw=1500000, vi_iso_bw=1500000, max_bw=1500000
[    1.339087] tsec 15500000.tsec: initialized
[    1.340958] tsec 15100000.tsecb: initialized
[    1.345290] nvdec 15480000.nvdec: initialized
[    1.347903] nvdec 15140000.nvdec1: initialized
[    1.354255] falcon 15340000.vic: initialized
[    1.356358] falcon 15380000.nvjpg: initialized
[    1.358162] falcon 154c0000.nvenc: initialized
[    1.360058] falcon 15a80000.nvenc1: initialized
[    1.363497] iommu_context_dev 13e10000.host1x:ctx0: initialized (streamid=56)
[    1.365338] iommu_context_dev 13e10000.host1x:ctx1: initialized (streamid=57)
[    1.366991] iommu_context_dev 13e10000.host1x:ctx2: initialized (streamid=58)
[    1.368596] iommu_context_dev 13e10000.host1x:ctx3: initialized (streamid=59)
[    1.370258] iommu_context_dev 13e10000.host1x:ctx4: initialized (streamid=60)
[    1.371912] iommu_context_dev 13e10000.host1x:ctx5: initialized (streamid=61)
[    1.373408] iommu_context_dev 13e10000.host1x:ctx6: initialized (streamid=62)
[    1.375032] iommu_context_dev 13e10000.host1x:ctx7: initialized (streamid=63)
[    1.378337] t194-nvcsi 15a00000.nvcsi: initialized
[    1.383707] scare-pigeon 13e10000.host1x:vi-thi@15f00000: initialized
[    1.384083] scare-pigeon 14b00000.isp-thi: initialized
[    1.389362] pva 16000000.pva0: initialized
[    1.394953] pva 16800000.pva1: initialized
[    1.399529] nvdla 15880000.nvdla0: initialized
[    1.403893] nvdla 158c0000.nvdla1: initialized
[    1.405189] tegradccommon 15200000.dc_common: host1x channel mapped
[    1.405202] tegradccommon 15200000.dc_common: dc_common syncpt # 1 allocated
[    1.405228] tegradccommon 15200000.dc_common: dma mapping done
[    1.406248] tegradc 15200000.nvdisplay: disp0 connected to head0->/host1x/sor1
[    1.406277] generic_infoframe_type: 0x87
[    1.406339] tegradc 15200000.nvdisplay: DT parsed successfully
[    1.406374] tegradc 15200000.nvdisplay: Display dc.ffffff800bd10000 registered with id=0
[    1.409826] tegra_nvdisp_bandwidth_register_max_config: max config iso bw = 7088400 KB/s
[    1.409834] tegra_nvdisp_bandwidth_register_max_config: max config EMC floor = 800000000 Hz
[    1.409840] tegra_nvdisp_bandwidth_register_max_config: max config hubclk = 300000000 Hz
[    1.410056] tegradc 15200000.nvdisplay: vblank syncpt # 8 for dc 0
[    1.410066] tegradc 15200000.nvdisplay: vpulse3 syncpt # 9 for dc 0
[    1.410744] tegradc 15200000.nvdisplay: Bootloader disp_param detected. Detected mode: 1920x1080 (on 0x0mm) pclk=148350937
[    1.413197] tegradc 15200000.nvdisplay: hdmi: invalid prod list prod_list_hdmi_board
[    1.413206] tegradc 15200000.nvdisplay: hdmi: tegra_hdmi_tmds_range_read(bd) failed
[    1.416224] tegradc 15200000.nvdisplay: probed
[    1.452776] Console: switching to colour frame buffer device 240x67
[    1.452914] tegradc 15200000.nvdisplay: fb registered
[    1.453242] gpio tegra-gpio wake63 for gpio=97(M:1)
[    1.453764] tegra_nvdisp_handle_pd_enable: Unpowergated Head0 pd
[    1.453853] tegra_nvdisp_handle_pd_enable: Unpowergated Head1 pd
[    1.456059] Parent Clock set for DC plld2
[    1.516302] tegradc 15200000.nvdisplay: hdmi: tmds rate:148351K prod-setting:prod_c_hdmi_111m_223m
[    1.517093] tegradc 15200000.nvdisplay: hdmi: get RGB quant from REG programmed by BL.
[    1.517108] tegradc 15200000.nvdisplay: hdmi: get YCC quant from REG programmed by BL.
[    1.542851] extcon-disp-state external-connection:disp-state: cable 47 state 1
[    1.542859] Extcon AUX1(HDMI) enable
[    1.543328] tegradc 15210000.nvdisplay: disp1 connected to head1->/host1x/sor
[    1.543357] tegradc 15210000.nvdisplay: parse_dp_settings: No dp-lt-settings node
[    1.543428] tegradc 15210000.nvdisplay: DT parsed successfully
[    1.543503] tegradc 15210000.nvdisplay: Display dc.ffffff800be10000 registered with id=1
[    1.543745] tegradc 15210000.nvdisplay: vblank syncpt # 11 for dc 1
[    1.543756] tegradc 15210000.nvdisplay: vpulse3 syncpt # 12 for dc 1
[    1.552105] tegradc 15210000.nvdisplay: probed
[    1.552409] tegradc 15210000.nvdisplay: fb registered
[    1.555673] hpd: state 7 (Takeover from bootloader), hpd 0, pending_hpd_evt 1
[    1.555682] hpd: switching from state 7 (Takeover from bootloader) to state 0 (Reset)
[    1.555696] hpd: state 0 (Reset), hpd 0, pending_hpd_evt 0
[    1.555708] tegradc 15210000.nvdisplay: blank - powerdown
[    1.555723] extcon-disp-state external-connection:disp-state: cable 44 state 0 already set.
[    1.555729] Extcon DP: HPD disabled
[    1.555734] hpd: hpd_switch 0
[    1.555740] hpd: switching from state 0 (Reset) to state 1 (Check Plug)
[    1.555751] hpd: state 1 (Check Plug), hpd 0, pending_hpd_evt 0
[    1.555761] hpd: switching from state 1 (Check Plug) to state 3 (Disabled)
[    1.556016] tegra_cec 3960000.tegra_cec: dt=1 start=0x03960000 end=0x03960FFF irq=77
[    1.556025] tegra_cec 3960000.tegra_cec: Unpowergate DISP: 0.
[    1.556239] tegra_cec 3960000.tegra_cec: Enable clock result: 0.
[    1.556346] tegra_cec 3960000.tegra_cec: tegra_cec_init started
[    1.556453] tegra_cec 3960000.tegra_cec: cec_add_sysfs ret=0
[    1.556460] tegra_cec 3960000.tegra_cec: probed
[    1.565834] tegra-adma 2930000.adma: Tegra210 ADMA driver registered 32 channels
[    1.566633] tegra-fuse-burn 3820000.efuse:efuse-burn: shutdown limit check disabled
[    1.566642] tegra-fuse-burn 3820000.efuse:efuse-burn: Fuse burn driver initialized
[    1.567032] kfuse 3830000.kfuse: initialized
[    1.572760] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    1.575615] 3100000.serial: ttyTHS0 at MMIO 0x3100000 (irq = 47, base_baud = 0) is a TEGRA_UART
[    1.576660] 3110000.serial: ttyTHS1 at MMIO 0x3110000 (irq = 48, base_baud = 0) is a TEGRA_UART
[    1.577373] 3140000.serial: ttyTHS4 at MMIO 0x3140000 (irq = 49, base_baud = 0) is a TEGRA_UART
[    1.578675] console [ttyTCU0] enabled
[    1.579035] [drm] Initialized
[    1.590493] brd: module loaded
[    1.595556] loop: module loaded
[    1.595641] tegra_profiler: version: 1.143, samples/io: 48/28
[    1.595779] tegra_profiler: auth: init
[    1.596450] THERMAL EST: found 3 subdevs
[    1.596458] THERMAL EST num_resources: 0
[    1.596465] [THERMAL EST subdev 0]
[    1.596471] [THERMAL EST subdev 1]
[    1.596477] [THERMAL EST subdev 2]
[    1.596490] THERMAL EST: Found 2 profiles, default profile is quiet
[    1.596856] thermal thermal_zone5: Registering thermal zone thermal_zone5 for type thermal-fan-est
[    1.596862] THERMAL EST: thz register success.
[    1.597042] THERMAL EST: end of probe, return err: 0
[    1.597786] sd: No Scsi addr parsed to reserve index
[    1.597817] hisi_sas: driver version v1.6
[    1.608212] qspi_mtd spi6.0: s25fs256s SSG 8 0 1000 2000000
[    1.608222] qspi_mtd spi6.0: s25fs256s (32768 Kbytes)
[    1.608233] qspi_mtd spi6.0: mtd .name = spi6.0, .size = 0x2000000 (32MiB) .erasesize = 0x00010000 (64KiB) .numeraseregions = 0
[    1.608457] 1 ofpart partitions found on MTD device spi6.0
[    1.608463] Creating 1 MTD partitions on "spi6.0":
[    1.608472] 0x000000000000-0x000002000000 : "Whole_flash0"
[    1.610929] libphy: Fixed MDIO Bus: probed
[    1.611535] tun: Universal TUN/TAP device driver, 1.6
[    1.611540] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[    1.612295] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k
[    1.612300] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    1.612349] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k
[    1.612354] igb: Copyright (c) 2007-2014 Intel Corporation.
[    1.612392] igbvf: Intel(R) Gigabit Virtual Function Network Driver - version 2.4.0-k
[    1.612397] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[    1.612429] Intel(R) 10GbE PCI Express Linux Network Driver - version 4.6.4
[    1.612434] Copyright(c) 1999 - 2017 Intel Corporation.
[    1.677950] tegradc 15200000.nvdisplay: blank - powerdown
[    1.716659] extcon-disp-state external-connection:disp-state: cable 47 state 0
[    1.716663] Extcon AUX1(HDMI) disable
[    1.742743] tegra_nvdisp_handle_pd_disable: Powergated Head1 pd
[    1.743954] tegra_nvdisp_handle_pd_disable: Powergated Head0 pd
[    1.802403] tegradc 15200000.nvdisplay: unblank
[    1.804180] tegra_nvdisp_handle_pd_enable: Unpowergated Head0 pd
[    1.804464] tegra_nvdisp_handle_pd_enable: Unpowergated Head1 pd
[    1.813130] Parent Clock set for DC plld2
[    1.821352] tegradc 15200000.nvdisplay: hdmi: tmds rate:410500K prod-setting:prod_c_hdmi_300m_600m
[    1.823048] tegradc 15200000.nvdisplay: hdmi: get YCC quant from EDID.
[    1.857745] eqos 2490000.ether_qos: failed to read eqos_auto_cal_config_0_reg
[    1.858267] eqos 2490000.ether_qos: Setting local MAC: 48 b0 2d 15 ec e4
[    1.858446] libphy: dwc_phy: probed
[    1.861353] PPP generic driver version 2.4.2
[    1.861572] PPP BSD Compression module registered
[    1.861577] PPP Deflate Compression module registered
[    1.861593] PPP MPPE Compression module registered
[    1.861597] NET: Registered protocol family 24
[    1.861718] usbcore: registered new interface driver r8152
[    1.861826] usbcore: registered new interface driver asix
[    1.861896] usbcore: registered new interface driver ax88179_178a
[    1.861935] usbcore: registered new interface driver cdc_ether
[    1.861986] usbcore: registered new interface driver net1080
[    1.862012] usbcore: registered new interface driver cdc_subset
[    1.862038] usbcore: registered new interface driver zaurus
[    1.862075] usbcore: registered new interface driver cdc_ncm
[    1.862282] VFIO - User Level meta-driver version: 0.3
[    1.863479] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.863505] ehci-pci: EHCI PCI platform driver
[    1.863548] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    1.863559] ohci-pci: OHCI PCI platform driver
[    1.863590] ohci-platform: OHCI generic platform driver
[    1.868466] tegra-xusb 3610000.xhci: USB2 port 0 has OTG_CAP
[    1.870369] tegra-xusb 3610000.xhci: extcon 0: ffffffc1f5126400 id
[    1.870654] usbcore: registered new interface driver uas
[    1.870692] usbcore: registered new interface driver usb-storage
[    1.870800] usbcore: registered new interface driver usbserial
[    1.874239] tegra-xudc-new 3550000.xudc: PMQOS CPU boost enabled
[    1.874314] tegra-xudc-new 3550000.xudc: device count: 1
[    1.875173] tegra-xudc-new 3550000.xudc: vbus state: 0
[    1.875182] tegra-xudc-new 3550000.xudc: Initialize boost_cpufreq work
[    1.875282] tegra-xudc-new 3550000.xudc: entering ELPG
[    1.875584] tegra-xudc-new 3550000.xudc: entering ELPG done
[    1.875927] tegra-xusb 3610000.xhci: Firmware timestamp: 2019-07-24 05:47:34 UTC, Version: 60.06 release
[    1.875958] tegra-xusb 3610000.xhci: xHCI Host Controller
[    1.876004] tegra-xusb 3610000.xhci: new USB bus registered, assigned bus number 1
[    1.876696] tegra-xusb 3610000.xhci: hcc params 0x0184ff25 hci version 0x110 quirks 0x00050810
[    1.876739] tegra-xusb 3610000.xhci: irq 464, io mem 0x03610000
[    1.876938] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    1.876945] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.876950] usb usb1: Product: xHCI Host Controller
[    1.876956] usb usb1: Manufacturer: Linux 4.9.201-tegra xhci-hcd
[    1.876960] usb usb1: SerialNumber: 3610000.xhci
[    1.877135] mousedev: PS/2 mouse device common for all mice
[    1.877191] usbcore: registered new interface driver xpad
[    1.877403] hub 1-0:1.0: USB hub found
[    1.877460] hub 1-0:1.0: 4 ports detected
[    1.877966] tegra-xusb 3610000.xhci: xHCI Host Controller
[    1.877977] tegra-xusb 3610000.xhci: new USB bus registered, assigned bus number 2
[    1.877986] tegra-xusb 3610000.xhci: Host supports USB 3.1 Enhanced SuperSpeed
[    1.878215] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003
[    1.878222] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.878227] usb usb2: Product: xHCI Host Controller
[    1.878232] usb usb2: Manufacturer: Linux 4.9.201-tegra xhci-hcd
[    1.878237] usb usb2: SerialNumber: 3610000.xhci
[    1.878675] hub 2-0:1.0: USB hub found
[    1.878712] hub 2-0:1.0: 4 ports detected
[    1.879740] Wake76 for irq=199
[    1.879743] Wake77 for irq=199
[    1.879746] Wake78 for irq=199
[    1.879748] Wake79 for irq=199
[    1.879751] Wake80 for irq=199
[    1.879753] Wake81 for irq=199
[    1.879756] Wake82 for irq=199
[    1.879796] tegra-xusb 3610000.xhci: Upgrade port 0 to USB3.0
[    1.879803] tegra-xusb 3610000.xhci: Upgrade port 1 to USB3.0
[    1.891178] extcon-disp-state external-connection:disp-state: cable 47 state 1
[    1.891182] Extcon AUX1(HDMI) enable
[    1.893218] tegradc 15200000.nvdisplay: sync windows ret = 250
[    1.919036] extcon-disp-state external-connection:disp-state: cable 51 state 1
[    1.919043] Extcon HDMI: HPD enabled
[    1.919071] tegradc 15200000.nvdisplay: hdmi: plugged
[    2.010069] max77686-rtc max77620-rtc: rtc core: registered max77620-rtc as rtc0
[    2.011737] Wake73 for irq=42
[    2.013064] rtc rtc1: alarm rtc device
[    2.013084] tegra_rtc c2a0000.rtc: rtc core: registered c2a0000.rtc as rtc1
[    2.013116] tegra_rtc c2a0000.rtc: Tegra internal Real Time Clock
[    2.013351] i2c /dev entries driver
[    2.015525] i2c i2c-2: Added multiplexed i2c bus 9
[    2.015923] i2c i2c-2: Added multiplexed i2c bus 10
[    2.015932] i2c-mux-gpio cam_i2cmux: 2 port mux on 3180000.i2c adapter
[    2.016360] imx219 9-0010: tegracam sensor driver:imx219_v2.0.6
[    2.039811] tegra-i2c 3180000.i2c: no acknowledge from address 0x10
[    2.039866] imx219 9-0010: imx219_board_setup: error during i2c read probe (-121)
[    2.040216] imx219 9-0010: board setup failed
[    2.040433] imx219: probe of 9-0010 failed with error -121
[    2.040835] imx219 10-0010: tegracam sensor driver:imx219_v2.0.6
[    2.064085] tegra-i2c 3180000.i2c: no acknowledge from address 0x10
[    2.064135] imx219 10-0010: imx219_board_setup: error during i2c read probe (-121)
[    2.064437] imx219 10-0010: board setup failed
[    2.064637] imx219: probe of 10-0010 failed with error -121
[    2.065857] max77620-power max20024-power: Event recorder REG_NVERC : 0x44
[    2.072693] tegra-thermal-throttle bthrot_cdev: cpufreq policy is not ready defer
[    2.073070] FAN dev name: pwm-fan
[    2.073119] FAN:gpio request success.
[    2.073129] FAN: can't find tach_gpio
[    2.073139] pwm_fan_driver pwm-fan: Found 2 profiles, default profile is quiet
[    2.073168] pwm_fan_driver pwm-fan: cap state:4, cap pwm:255
[    2.073360] pwm_fan_driver pwm-fan: got pwm for fan. polarity is normal
[    2.073367] pwm_fan_driver pwm-fan: tach period: 1000
[    2.073956] pwm_fan_driver pwm-fan: index 0: pwm=0, rpm=0, rru=40, rrd=40, state:2
[    2.073964] pwm_fan_driver pwm-fan: index 1: pwm=130, rpm=1000, rru=2, rrd=2, state:2
[    2.073971] pwm_fan_driver pwm-fan: index 2: pwm=160, rpm=2000, rru=1, rrd=1, state:2
[    2.073977] pwm_fan_driver pwm-fan: index 3: pwm=200, rpm=3000, rru=1, rrd=1, state:2
[    2.073984] pwm_fan_driver pwm-fan: index 4: pwm=255, rpm=4000, rru=1, rrd=1, state:3
[    2.073990] pwm_fan_driver pwm-fan: index 5: pwm=255, rpm=5000, rru=1, rrd=1, state:3
[    2.073997] pwm_fan_driver pwm-fan: index 6: pwm=255, rpm=6000, rru=1, rrd=1, state:3
[    2.074003] pwm_fan_driver pwm-fan: index 7: pwm=255, rpm=7000, rru=1, rrd=1, state:4
[    2.074010] pwm_fan_driver pwm-fan: index 8: pwm=255, rpm=10000, rru=1, rrd=1, state:4
[    2.074018] pwm_fan_driver pwm-fan: index 9: pwm=255, rpm=11000, rru=1, rrd=1, state:4
[    2.074699] tegra-oc-event d280000.soctherm-oc-event: OC driver initialized
[    2.075590] device-mapper: uevent: version 1.0.3
[    2.075964] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com
[    2.079678] tegra194_cpufreq_probe: platform driver Initialization: pass
[    2.080649] cpuidle: Initializing cpuidle driver
[    2.081312] sdhci: Secure Digital Host Controller Interface driver
[    2.081315] sdhci: Copyright(c) Pierre Ossman
[    2.081319] sdhci-pltfm: SDHCI platform and OF driver helper
[    2.081590] sdhci-tegra 3400000.sdhci: Got CD GPIO
[    2.082371] sdhci-tegra 3400000.sdhci: Client registration for eMC Successful
[    2.084572] sdhci-tegra 3400000.sdhci: wakeup init done, cdirq 246
[    2.088831] tegra-se-elp 3ad0000.se_elp: tegra_se_elp_probe: complete
[    2.089824] tegra-se-nvhost 15810000.se: initialized
[    2.090735] tegra-se-nvhost 15810000.se: tegra_se_probe: complete
[    2.092074] tegra-se-nvhost 15820000.se: initialized
[    2.093168] tegra-se-nvhost 15820000.se: tegra_se_probe: complete
[    2.094292] tegra-se-nvhost 15830000.se: initialized
[    2.094999] tegra-se-nvhost 15830000.se: tegra_se_probe: complete
[    2.095778] tegra-se-nvhost 15840000.se: initialized
[    2.096741] tegra-se-nvhost 15840000.se: tegra_se_probe: complete
[    2.097016] hidraw: raw HID events driver (C) Jiri Kosina
[    2.098084] usbcore: registered new interface driver usbhid
[    2.098088] usbhid: USB HID core driver
[    2.102531] tegra186-cam-rtcpu bc00000.rtcpu: deferring, 14800000.isp is not probed
[    2.103737] tegra_aon c1a0000.aon: tegra aon driver probe OK
[    2.104116] tegra186-aondbg aondbg: aondbg driver probe() OK
[    2.104621] denver_knobs_init:MTS_VERSION:51035886
[    2.104799] tegra19x_actmon d230000.actmon: in actmon_register()...
[    2.105743] tegra19x_actmon d230000.actmon: initialization Completed for the device mc_all
[    2.106103] t19x_cache tegra-cache: probed
[    2.108920] misc nvmap: cvsram :dma coherent mem declare 0x0000000050000000,4194304
[    2.108928] misc nvmap: created heap cvsram base 0x0000000050000000 size (4096KiB)
[    2.109489] carmel-pmu-drv carmel-pmu: Registered Carmel PMU
[    2.109948] PLL_AON clock registered
[    2.112320] Clocks initialized successfully
[    2.113947] nvpmodel: initialized successfully
[    2.115103] trusty-virtio trusty:virtio: initializing
[    2.115318] trusty_ipc virtio0: vring0: va(pa)  ffffffc1e2656000(0) qsz 32 notifyid 1
[    2.115353] trusty_ipc virtio0: vring1: va(pa)  ffffffc1e2748000(0) qsz 32 notifyid 2
[    2.115488] trusty-virtio trusty:virtio: initializing done
[    2.115748] trusty_ipc virtio0: is online
[    2.116149] tegra-hda 3510000.hda: Override SDO lines to 4
[    2.116708] usbcore: registered new interface driver snd-usb-audio
[    2.131022] gpio tegra-gpio wake8 for gpio=55(G:7)
[    2.131090] mmc0: SDHCI controller on 3400000.sdhci [3400000.sdhci] using ADMA 64-bit with 64 bit addr
[    2.136292] input: tegra-hda-xnx HDMI/DP,pcm=3 as /devices/3510000.hda/sound/card0/input0
[    2.136454] input: tegra-hda-xnx HDMI/DP,pcm=7 as /devices/3510000.hda/sound/card0/input1
[    2.136635] input: tegra-hda-xnx HDMI/DP,pcm=8 as /devices/3510000.hda/sound/card0/input2
[    2.136797] input: tegra-hda-xnx HDMI/DP,pcm=9 as /devices/3510000.hda/sound/card0/input3
[    2.206823] usb 1-2: new high-speed USB device number 2 using tegra-xusb
[    2.230074] OPE platform probe
[    2.230186] OPE platform probe successful
[    2.247462] usb 1-2: New USB device found, idVendor=0bda, idProduct=5489
[    2.247470] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    2.247474] usb 1-2: Product: 4-Port USB 2.0 Hub
[    2.247478] usb 1-2: Manufacturer: Generic
[    2.248937] hub 1-2:1.0: USB hub found
[    2.249959] hub 1-2:1.0: 4 ports detected
[    2.290676] mmc0: host does not support reading read-only switch, assuming write-enable
[    2.323427] tegra-asoc: sound: ADMAIF1 <-> ADMAIF1 mapping ok
[    2.323556] tegra-asoc: sound: ADMAIF2 <-> ADMAIF2 mapping ok
[    2.323677] tegra-asoc: sound: ADMAIF3 <-> ADMAIF3 mapping ok
[    2.323805] tegra-asoc: sound: ADMAIF4 <-> ADMAIF4 mapping ok
[    2.323936] tegra-asoc: sound: ADMAIF5 <-> ADMAIF5 mapping ok
[    2.324075] tegra-asoc: sound: ADMAIF6 <-> ADMAIF6 mapping ok
[    2.324216] tegra-asoc: sound: ADMAIF7 <-> ADMAIF7 mapping ok
[    2.324339] tegra-asoc: sound: ADMAIF8 <-> ADMAIF8 mapping ok
[    2.324474] tegra-asoc: sound: ADMAIF9 <-> ADMAIF9 mapping ok
[    2.324593] tegra-asoc: sound: ADMAIF10 <-> ADMAIF10 mapping ok
[    2.324721] tegra-asoc: sound: ADMAIF11 <-> ADMAIF11 mapping ok
[    2.324824] tegra-asoc: sound: ADMAIF12 <-> ADMAIF12 mapping ok
[    2.324929] tegra-asoc: sound: ADMAIF13 <-> ADMAIF13 mapping ok
[    2.325037] tegra-asoc: sound: ADMAIF14 <-> ADMAIF14 mapping ok
[    2.325138] tegra-asoc: sound: ADMAIF15 <-> ADMAIF15 mapping ok
[    2.325243] tegra-asoc: sound: ADMAIF16 <-> ADMAIF16 mapping ok
[    2.325347] tegra-asoc: sound: ADMAIF17 <-> ADMAIF17 mapping ok
[    2.325428] tegra-asoc: sound: ADMAIF18 <-> ADMAIF18 mapping ok
[    2.325517] tegra-asoc: sound: ADMAIF19 <-> ADMAIF19 mapping ok
[    2.325609] tegra-asoc: sound: ADMAIF20 <-> ADMAIF20 mapping ok
[    2.353518] u32 classifier
[    2.353524]     Actions configured
[    2.353593] Initializing XFRM netlink socket
[    2.354161] NET: Registered protocol family 10
[    2.354962] NET: Registered protocol family 17
[    2.354979] NET: Registered protocol family 15
[    2.355035] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
[    2.355141] Bluetooth: RFCOMM socket layer initialized
[    2.355157] Bluetooth: RFCOMM ver 1.11
[    2.355166] Bluetooth: HIDP (Human Interface Emulation) ver 1.2
[    2.355173] Bluetooth: HIDP socket layer initialized
[    2.355191] 9pnet: Installing 9P2000 support
[    2.355229] Key type dns_resolver registered
[    2.356490] Registered cp15_barrier emulation handler
[    2.356508] Registered setend emulation handler
[    2.356525] usb 2-3: new SuperSpeedPlus USB device number 2 using tegra-xusb
[    2.358161] registered taskstats version 1
[    2.359161] tegra-pcie-dw 14160000.pcie: Setting init speed to max speed
[    2.363102] OF: PCI: host bridge /pcie@14160000 ranges:
[    2.363134] OF: PCI:    IO 0x36100000..0x361fffff -> 0x36100000
[    2.363152] OF: PCI:   MEM 0x1740000000..0x17ffffffff -> 0x40000000
[    2.363169] OF: PCI:   MEM 0x1400000000..0x173fffffff -> 0x1400000000
[    2.396445] usb 2-3: New USB device found, idVendor=0bda, idProduct=0489
[    2.396456] usb 2-3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    2.396472] usb 2-3: Product: 4-Port USB 3.0 Hub
[    2.396476] usb 2-3: Manufacturer: Generic
[    2.412194] hub 2-3:1.0: USB hub found
[    2.414866] hub 2-3:1.0: 4 ports detected
[    2.458490] mmc0: hw tuning done ...
[    2.458525] mmc0: new ultra high speed SDR104 SDXC card at address 0001
[    2.458974] mmcblk0: mmc0:0001 SD128 116 GiB 
[    2.463556]  mmcblk0: p1 p2 p3 p4 p5 p6 p7 p8 p9 p10 p11
[    2.474791] tegra-pcie-dw 14160000.pcie: link is up
[    2.474979] tegra-pcie-dw 14160000.pcie: PCI host bridge to bus 0004:00
[    2.475007] pci_bus 0004:00: root bus resource [bus 00-ff]
[    2.475027] pci_bus 0004:00: root bus resource [io  0x0000-0xfffff] (bus address [0x36100000-0x361fffff])
[    2.475043] pci_bus 0004:00: root bus resource [mem 0x1740000000-0x17ffffffff] (bus address [0x40000000-0xffffffff])
[    2.475047] pci_bus 0004:00: root bus resource [mem 0x1400000000-0x173fffffff pref]
[    2.475075] pci 0004:00:00.0: [10de:1ad1] type 01 class 0x060400
[    2.475233] pci 0004:00:00.0: PME# supported from D0 D3hot D3cold
[    2.475432] iommu: Adding device 0004:00:00.0 to group 58
[    2.475761] pci 0004:01:00.0: [10ec:c822] type 00 class 0x028000
[    2.475882] pci 0004:01:00.0: reg 0x10: initial BAR value 0x00000000 invalid
[    2.475887] pci 0004:01:00.0: reg 0x10: [io  size 0x0100]
[    2.476044] pci 0004:01:00.0: reg 0x18: [mem 0x00000000-0x0000ffff 64bit]
[    2.476766] pci 0004:01:00.0: supports D1 D2
[    2.476770] pci 0004:01:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[    2.477076] iommu: Adding device 0004:01:00.0 to group 59
[    2.488318] pci 0004:00:00.0: BAR 14: assigned [mem 0x1740000000-0x17400fffff]
[    2.488349] pci 0004:00:00.0: BAR 13: assigned [io  0x1000-0x1fff]
[    2.488358] pci 0004:01:00.0: BAR 2: assigned [mem 0x1740000000-0x174000ffff 64bit]
[    2.488445] pci 0004:01:00.0: BAR 0: assigned [io  0x1000-0x10ff]
[    2.488472] pci 0004:00:00.0: PCI bridge to [bus 01-ff]
[    2.488477] pci 0004:00:00.0:   bridge window [io  0x1000-0x1fff]
[    2.488484] pci 0004:00:00.0:   bridge window [mem 0x1740000000-0x17400fffff]
[    2.488519] pci 0004:00:00.0: Max Payload Size set to  128/ 256 (was  256), Max Read Rq  512
[    2.488584] pci 0004:01:00.0: Max Payload Size set to  128/ 128 (was  128), Max Read Rq  512
[    2.488887] pcieport 0004:00:00.0: Signaling PME through PCIe PME interrupt
[    2.488910] pci 0004:01:00.0: Signaling PME through PCIe PME interrupt
[    2.488922] pcie_pme 0004:00:00.0:pcie001: service driver pcie_pme loaded
[    2.488997] aer 0004:00:00.0:pcie002: service driver aer loaded
[    2.489655] tegra-pcie-dw 141a0000.pcie: Setting init speed to max speed
[    2.491265] OF: PCI: host bridge /pcie@141a0000 ranges:
[    2.491300] OF: PCI:    IO 0x3a100000..0x3a1fffff -> 0x3a100000
[    2.491318] OF: PCI:   MEM 0x1f40000000..0x1fffffffff -> 0x40000000
[    2.491334] OF: PCI:   MEM 0x1c00000000..0x1f3fffffff -> 0x1c00000000
[    2.582840] tegra_cec 3960000.tegra_cec: physical address: 20:00.
[    2.598822] tegra-pcie-dw 141a0000.pcie: link is up
[    2.599149] tegra-pcie-dw 141a0000.pcie: PCI host bridge to bus 0005:00
[    2.599159] pci_bus 0005:00: root bus resource [bus 00-ff]
[    2.599179] pci_bus 0005:00: root bus resource [io  0x100000-0x1fffff] (bus address [0x3a100000-0x3a1fffff])
[    2.599212] pci_bus 0005:00: root bus resource [mem 0x1f40000000-0x1fffffffff] (bus address [0x40000000-0xffffffff])
[    2.599216] pci_bus 0005:00: root bus resource [mem 0x1c00000000-0x1f3fffffff pref]
[    2.599242] pci 0005:00:00.0: [10de:1ad0] type 01 class 0x060400
[    2.599372] pci 0005:00:00.0: PME# supported from D0 D3hot D3cold
[    2.599641] iommu: Adding device 0005:00:00.0 to group 60
[    2.600035] pci 0005:01:00.0: [144d:a808] type 00 class 0x010802
[    2.600151] pci 0005:01:00.0: reg 0x10: [mem 0x00000000-0x00003fff 64bit]
[    2.601063] iommu: Adding device 0005:01:00.0 to group 61
[    2.611645] pci 0005:00:00.0: BAR 14: assigned [mem 0x1f40000000-0x1f400fffff]
[    2.611654] pci 0005:01:00.0: BAR 0: assigned [mem 0x1f40000000-0x1f40003fff 64bit]
[    2.611712] pci 0005:00:00.0: PCI bridge to [bus 01-ff]
[    2.611719] pci 0005:00:00.0:   bridge window [mem 0x1f40000000-0x1f400fffff]
[    2.611748] pci 0005:00:00.0: Max Payload Size set to  256/ 256 (was  256), Max Read Rq  512
[    2.611796] pci 0005:01:00.0: Max Payload Size set to  256/ 256 (was  128), Max Read Rq  512
[    2.612043] pcieport 0005:00:00.0: Signaling PME through PCIe PME interrupt
[    2.612047] pci 0005:01:00.0: Signaling PME through PCIe PME interrupt
[    2.612058] pcie_pme 0005:00:00.0:pcie001: service driver pcie_pme loaded
[    2.612154] aer 0005:00:00.0:pcie002: service driver aer loaded
[    2.612605] nvme nvme0: pci function 0005:01:00.0
[    2.612734] nvme 0005:01:00.0: enabling device (0000 -> 0002)
[    2.623153] tegra-cbb 14040000.cv-noc: noc_secure_irq = 90, noc_nonsecure_irq = 89>
[    2.628519] tegra194-isp5 14800000.isp: initialized
[    2.635301] tegra194-vi5 15c10000.vi: using default number of vi channels, 36
[    2.638091] tegra194-vi5 15c10000.vi: initialized
[    2.638811] usb 1-3: new full-speed USB device number 3 using tegra-xusb
[    2.642881] tegra194-vi5 15c10000.vi: subdev 15a00000.nvcsi--2 bound
[    2.642954] tegra194-vi5 15c10000.vi: subdev 15a00000.nvcsi--1 bound
[    2.643166] tegra-thermal-throttle bthrot_cdev: clk:cpu max:1907200000, min:115200000 steps:24
[    2.647365] tegra_cec 3960000.tegra_cec: Sent <Text View On> res: -113.
[    2.647370] tegra_cec 3960000.tegra_cec: tegra_cec_init Done.
[    2.647536] tegra-thermal-throttle bthrot_cdev: clk:gpu max:1109250000, min:114750000 steps:10
[    2.647551] tegra-thermal-throttle bthrot_cdev: cdev:skin-balanced clk:0:cpu off:0 slope-adj:200
[    2.647555] tegra-thermal-throttle bthrot_cdev: cdev:skin-balanced clk:1:gpu off:0 slope-adj:400
[    2.647628] tegra-thermal-throttle bthrot_cdev: cdev:skin-balanced max_state:48 cutoff:0
[    2.647662] tegra-thermal-throttle bthrot_cdev: cdev:gpu-balanced clk:0:cpu off:0 slope-adj:400
[    2.647666] tegra-thermal-throttle bthrot_cdev: cdev:gpu-balanced clk:1:gpu off:0 slope-adj:400
[    2.651814] tegra-thermal-throttle bthrot_cdev: cdev:gpu-balanced max_state:40 cutoff:1
[    2.651863] tegra-thermal-throttle bthrot_cdev: cdev:cpu-balanced clk:0:cpu off:0 slope-adj:200
[    2.651870] tegra-thermal-throttle bthrot_cdev: cdev:cpu-balanced clk:1:gpu off:365500000 slope-adj:300
[    2.652227] tegra-thermal-throttle bthrot_cdev: cdev:cpu-balanced max_state:48 cutoff:0
[    2.652277] tegra-thermal-throttle bthrot_cdev: cdev:emergency-balanced clk:0:cpu off:38400000 slope-adj:10
[    2.652301] tegra-thermal-throttle bthrot_cdev: cdev:emergency-balanced clk:1:gpu off:25500000 slope-adj:10
[    2.652645] tegra-thermal-throttle bthrot_cdev: cdev:emergency-balanced max_state:2 cutoff:0
[    2.652707] tegra-thermal-throttle bthrot_cdev: cdev:aux-balanced clk:0:cpu off:0 slope-adj:400
[    2.652712] tegra-thermal-throttle bthrot_cdev: cdev:aux-balanced clk:1:gpu off:0 slope-adj:400
[    2.652965] tegra-thermal-throttle bthrot_cdev: cdev:aux-balanced max_state:40 cutoff:1
[    2.653761] tegra186-cam-rtcpu bc00000.rtcpu: Trace buffer configured at IOVA=0xbff00000
[    2.659922] usb 1-3: New USB device found, idVendor=13d3, idProduct=3549
[    2.659928] usb 1-3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    2.659932] usb 1-3: Product: Bluetooth Radio
[    2.659936] usb 1-3: Manufacturer: Realtek
[    2.659939] usb 1-3: SerialNumber: 00e04c000001
[    2.728370]  nvme0n1: p1
[    2.737752] tegra-ivc ivc-bc00000.rtcpu: region 0: iova=0xbfee0000-0xbfefffff size=131072
[    2.738086] tegra-ivc ivc-bc00000.rtcpu:echo@0: echo: ver=0 grp=1 RX[16x64]=0x1000-0x1480 TX[16x64]=0x1480-0x1900
[    2.738280] tegra-ivc ivc-bc00000.rtcpu:dbg@1: dbg: ver=0 grp=1 RX[1x384]=0x1900-0x1b00 TX[1x384]=0x1b00-0x1d00
[    2.738440] tegra-ivc ivc-bc00000.rtcpu:dbg@2: dbg: ver=0 grp=1 RX[1x8192]=0x1d00-0x3d80 TX[1x8192]=0x3d80-0x5e00
[    2.738825] tegra-ivc ivc-bc00000.rtcpu:ivccontrol@3: ivccontrol: ver=0 grp=1 RX[64x320]=0x5e00-0xae80 TX[64x320]=0xae80-0xff00
[    2.738879] tegra-ivc ivc-bc00000.rtcpu:ivccapture@4: ivccapture: ver=0 grp=1 RX[512x64]=0xff00-0x17f80 TX[512x64]=0x17f80-0x20000
[    2.739136] tegra186-cam-rtcpu bc00000.rtcpu: using cam RTCPU IRQ (65)
[    2.739141] tegra186-cam-rtcpu bc00000.rtcpu: tegra_camrtc_mon_create is successful
[    2.739986] tegra186-cam-rtcpu bc00000.rtcpu: firmware version cpu=rce cmd=5 sha1=cf2bef3ad10e437272857b76308abef8ffb80bda
[    2.740408] Wake83 for irq=211
[    2.740474] gpio tegra-gpio wake67 for gpio=48(G:0)
[    2.740547] gpio tegra-gpio-aon wake29 for gpio=36(EE:4)
[    2.740697] input: gpio-keys as /devices/gpio-keys/input/input4
[    2.771876] tegra_rtc c2a0000.rtc: setting system clock to 2021-04-12 07:14:28 UTC (1618211668)
[    2.772319] mmcblk mmc0:0001: Card claimed for testing.
[    2.813381] bpmp: mounted debugfs mirror
[    2.819235] ALSA device list:
[    2.819242]   #0: tegra-hda-xnx at 0x3518000 irq 64
[    2.819245]   #1: jetson-xaviernx-ape
[    2.821027] Freeing unused kernel memory: 8576K
[    2.859970] Root device found: mmcblk0p1
[    2.861837] Found dev node: /dev/mmcblk0p1
[    2.958840] usb 1-2.2: new low-speed USB device number 4 using tegra-xusb
[    2.987980] usb 1-2.2: New USB device found, idVendor=040b, idProduct=2000
[    2.987986] usb 1-2.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    2.987990] usb 1-2.2: Product: USB Keyboard
[    2.988014] usb 1-2.2: Manufacturer: Generic
[    2.993384] input: Generic USB Keyboard as /devices/3610000.xhci/usb1/1-2/1-2.2/1-2.2:1.0/0003:040B:2000.0001/input/input5
[    3.051380] hid-generic 0003:040B:2000.0001: input,hidraw0: USB HID v1.10 Keyboard [Generic USB Keyboard] on usb-3610000.xhci-2.2/input0
[    3.060370] input: Generic USB Keyboard as /devices/3610000.xhci/usb1/1-2/1-2.2/1-2.2:1.1/0003:040B:2000.0002/input/input6
[    3.119248] hid-generic 0003:040B:2000.0002: input,hidraw1: USB HID v1.10 Mouse [Generic USB Keyboard] on usb-3610000.xhci-2.2/input1
[    3.490383] EXT4-fs (mmcblk0p1): 25 orphan inodes deleted
[    3.490388] EXT4-fs (mmcblk0p1): recovery complete
[    3.528490] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
[    3.531844] Rootfs mounted over mmcblk0p1
[    3.553072] Switching from initrd to actual rootfs
[    3.891239] ip_tables: (C) 2000-2006 Netfilter Core Team
[    3.895110] cgroup: cgroup2: unknown option "nsdelegate"
[    3.915339] 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)
[    3.915937] systemd[1]: Detected architecture arm64.
[    3.925012] systemd[1]: Set hostname to <aragats-jetson>.
[    4.053147] 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.
[    4.053159] systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.)
[    4.324062] random: systemd: uninitialized urandom read (16 bytes read)
[    4.327169] systemd[1]: Created slice User and Session Slice.
[    4.327444] random: systemd: uninitialized urandom read (16 bytes read)
[    4.328560] systemd[1]: Created slice System Slice.
[    4.328623] random: systemd: uninitialized urandom read (16 bytes read)
[    4.328979] systemd[1]: Listening on Journal Socket (/dev/log).
[    4.330153] systemd[1]: Created slice system-serial\x2dgetty.slice.
[    4.330199] systemd[1]: Reached target Slices.
[    4.428878] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null)
[    4.507192] nvgpu: 17000000.gv11b          nvgpu_nvhost_syncpt_init:291  [INFO]  syncpt_unit_base 60000000 syncpt_unit_size 400000 size 1000

[    4.533237] cpu-throttle-alert cooling device registered.
[    4.533549] gpu-throttle-alert cooling device registered.
[    4.533824] aux-throttle-alert cooling device registered.
[    4.665742] systemd-journald[2351]: Received request to flush runtime journal from PID 1
[    4.935075] usb 2-3.3: new SuperSpeed USB device number 3 using tegra-xusb
[    4.955374] usb 2-3.3: LPM exit latency is zeroed, disabling LPM.
[    4.956149] usb 2-3.3: New USB device found, idVendor=199e, idProduct=8800
[    4.956156] usb 2-3.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    4.956160] usb 2-3.3: Product: DFG/HDSDI
[    4.956165] usb 2-3.3: Manufacturer: The Imaging Source Europe GmbH
[    4.956169] usb 2-3.3: SerialNumber: 41020544
[    5.183038] usb 2-3.1: new SuperSpeed USB device number 4 using tegra-xusb
[    5.203416] usb 2-3.1: LPM exit latency is zeroed, disabling LPM.
[    5.204189] usb 2-3.1: New USB device found, idVendor=199e, idProduct=8800
[    5.204196] usb 2-3.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    5.204201] usb 2-3.1: Product: DFG/HDSDI
[    5.204205] usb 2-3.1: Manufacturer: The Imaging Source Europe GmbH
[    5.204209] usb 2-3.1: SerialNumber: 46020317
[    5.396998] rtl88x2ce 0004:01:00.0: enabling device (0000 -> 0003)
[    5.614133] usbcore: registered new interface driver btusb
[    5.664534] rtk_btusb: Realtek Bluetooth USB driver ver 3.1
[    5.664541] rtk_btcoex: rtk_btcoex_init: version: 1.2
[    5.664544] rtk_btcoex: create workqueue
[    5.664696] rtk_btcoex: alloc buffers 1792, 2432 for ev and l2
[    5.664757] rtk_btusb: btusb_probe intf->cur_altsetting->desc.bInterfaceNumber 0
[    5.664762] rtk_btusb: btusb_probe can_wakeup 1, may wakeup 0
[    5.664765] rtk_btusb: patch_add
[    5.664768] rtk_btusb: auto suspend is disabled
[    5.664773] rtk_btusb: pid = 0x3549
[    5.664787] rtk_btusb: patch_add: Reset gEVersion to 0xff
[    5.664797] rtk_btusb: set_bit(HCI_QUIRK_RESET_ON_CLOSE, &hdev->quirks);
[    5.666872] rtk_btusb: btusb_probe: done
[    5.666879] rtk_btusb: btusb_open start
[    5.666885] rtk_btusb: btusb_open hdev->promisc ==0
[    5.666888] rtk_btusb: download_patch start
[    5.666896] rtk_btusb: chip type value: 0x73
[    5.666900] rtk_btusb: HCI reset.
[    5.666955] usbcore: registered new interface driver rtk_btusb
[    5.678342] rtk_btusb: read_ver_rsp->lmp_subver = 0x8822
[    5.678347] rtk_btusb: read_ver_rsp->hci_rev = 0xc
[    5.678352] rtk_btusb: patch_entry->lmp_sub = 0x8822
[    5.678355] rtk_btusb: load_firmware start
[    5.678359] rtk_btusb: lmp_version = 0x8822
[    5.678362] rtk_btusb: config filename rtl8822cu_config
[    5.680072] rtk_btusb: no bdaddr file /opt/bdaddr
[    5.680078] rtk_btusb: 55 ab 23 87 00 00
[    5.680088] rtk_btusb: Config file length 6, new length 6
[    5.680090] rtk_btusb: fw name is  rtl8822cu_fw
[    5.692364] rtk_btusb: This is not 8723a, use new patch style!
[    5.692374] rtk_btusb: rtk_get_eversion: gEVersion 255
[    5.693330] rtk_btusb: eversion->status = 0x0, eversion->version = 0x3
[    5.693335] rtk_btusb: load_firmware: New gEVersion 3
[    5.693339] rtk_btusb: rtk_get_fw_project_id: opcode 0, len 1, data 13
[    5.693344] rtk_btusb: lmp_version is 8822, project_id is 8822, match!
[    5.693347] rtk_btusb: fw_version = 0x98a42f7
[    5.693350] rtk_btusb: number_of_total_patch = 3
[    5.693352] rtk_btusb: chipID 4
[    5.693357] rtk_btusb: patch_length 0x55f0
[    5.693360] rtk_btusb: start_offset 0x00005d00
[    5.693364] rtk_btusb: Svn version:    21761
[    5.693368] rtk_btusb: Coexistence: BTCOEX_20190509-0d0d
[    5.693371] rtk_btusb: buf_len = 0x55f6
[    5.693382] rtk_btusb: fw: exists, config file: exists
[    5.693385] rtk_btusb: load_firmware done
[    5.693405] rtk_btusb: download_data start
[    5.697884] uvcvideo: Found UVC 1.10 device DFG/HDSDI (199e:8800)
[    5.699204] uvcvideo 2-3.3:1.0: Entity type for entity Extension 3 was not initialized!
[    5.699448] uvcvideo 2-3.3:1.0: Entity type for entity Processing 2 was not initialized!
[    5.699633] uvcvideo 2-3.3:1.0: Entity type for entity Camera 1 was not initialized!
[    5.700078] uvcvideo: Found UVC 1.10 device DFG/HDSDI (199e:8800)
[    5.701324] uvcvideo 2-3.1:1.0: Entity type for entity Extension 3 was not initialized!
[    5.701560] uvcvideo 2-3.1:1.0: Entity type for entity Processing 2 was not initialized!
[    5.701744] uvcvideo 2-3.1:1.0: Entity type for entity Camera 1 was not initialized!
[    5.702174] usbcore: registered new interface driver uvcvideo
[    5.702178] USB Video Class driver (1.1.1)
[    5.807354] rtk_btusb: download_data done
[    5.807361] rtk_btusb: HCI reset.
[    5.818347] rtk_btusb: read_ver_rsp->lmp_subver = 0x42f7
[    5.818353] rtk_btusb: read_ver_rsp->hci_rev = 0x98a
[    5.818357] rtk_btusb: patch_entry->lmp_sub = 0x8822
[    5.818368] rtk_btusb: Rtk patch end 0
[    5.818374] rtk_btusb: btusb_open set HCI_RUNNING
[    5.818404] rtk_btcoex: Open BTCOEX
[    5.818408] rtk_btusb: btusb_open end
[    5.820428] rtk_btcoex: BTCOEX hci_rev 0x098a
[    5.820434] rtk_btcoex: BTCOEX lmp_subver 0x42f7
[    5.840360] rtk_btusb: btusb_notify: hci0 evt 3
[    6.080104] EXT4-fs (nvme0n1p1): mounted filesystem with ordered data mode. Opts: (null)
[    6.860225] using random self ethernet address
[    6.860395] using random host ethernet address
[    6.977517] random: crng init done
[    6.977652] random: 7 urandom warning(s) missed due to ratelimiting
[    7.326911] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[    7.326930] Bluetooth: BNEP socket layer initialized
[    7.781977] Mass Storage Function, version: 2009/09/11
[    7.781987] LUN: removable file: (no medium)
[    7.791622] using random self ethernet address
[    7.791784] using random host ethernet address
[    7.842987] rndis0: HOST MAC ea:72:0b:c7:7d:78
[    7.843141] rndis0: MAC ea:72:0b:c7:7d:79
[    7.844021] usb0: HOST MAC ea:72:0b:c7:7d:7a
[    7.844198] usb0: MAC ea:72:0b:c7:7d:7b
[    7.844221] tegra-xudc-new 3550000.xudc: exiting ELPG
[    7.844855] tegra-xudc-new 3550000.xudc: exiting ELPG done
[    7.844870] tegra-xudc-new 3550000.xudc: ep 0 (type: 0, dir: out) enabled
[    7.844905] tegra-xudc-new 3550000.xudc: entering ELPG
[    7.845144] tegra-xudc-new 3550000.xudc: entering ELPG done
[    7.845155] tegra-xudc-new 3550000.xudc: exiting ELPG
[    7.845582] tegra-xudc-new 3550000.xudc: exiting ELPG done
[    7.845592] tegra-xudc-new 3550000.xudc: entering ELPG
[    7.845766] tegra-xudc-new 3550000.xudc: entering ELPG done
[    7.852173] l4tbr0: port 1(rndis0) entered blocking state
[    7.852181] l4tbr0: port 1(rndis0) entered disabled state
[    7.855114] device rndis0 entered promiscuous mode
[    7.861788] IPv6: ADDRCONF(NETDEV_UP): rndis0: link is not ready
[    7.868197] l4tbr0: port 2(usb0) entered blocking state
[    7.868204] l4tbr0: port 2(usb0) entered disabled state
[    7.868406] device usb0 entered promiscuous mode
[    7.874601] IPv6: ADDRCONF(NETDEV_UP): usb0: link is not ready
[    8.530821] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[    8.810924] nvgpu: 17000000.gv11b                 tpc_pg_mask_store:843  [INFO]  no value change, same mask already set
[    8.843720] gpio tegra-gpio wake20 for gpio=52(G:4)
[    8.847859] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[    8.862555] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[    9.044994] zram: Added device: zram0
[    9.045989] zram: Added device: zram1
[    9.048147] zram: Added device: zram2
[    9.050932] zram: Added device: zram3
[    9.055014] zram: Added device: zram4
[    9.059535] zram: Added device: zram5
[    9.092102] zram0: detected capacity change from 0 to 678563840
[    9.168304] Adding 662656k swap on /dev/zram0.  Priority:5 extents:1 across:662656k SS
[    9.179577] zram1: detected capacity change from 0 to 678563840
[    9.179686] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[    9.214561] Adding 662656k swap on /dev/zram1.  Priority:5 extents:1 across:662656k SS
[    9.226476] zram2: detected capacity change from 0 to 678563840
[    9.264652] Adding 662656k swap on /dev/zram2.  Priority:5 extents:1 across:662656k SS
[    9.269136] zram3: detected capacity change from 0 to 678563840
[    9.315561] Adding 662656k swap on /dev/zram3.  Priority:5 extents:1 across:662656k SS
[    9.319072] zram4: detected capacity change from 0 to 678563840
[    9.335064] Adding 662656k swap on /dev/zram4.  Priority:5 extents:1 across:662656k SS
[    9.344348] zram5: detected capacity change from 0 to 678563840
[    9.358543] Adding 662656k swap on /dev/zram5.  Priority:5 extents:1 across:662656k SS
[    9.442279] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   10.895464] tegradc 15200000.nvdisplay: blank - powerdown
[   10.928264] extcon-disp-state external-connection:disp-state: cable 47 state 0
[   10.928269] Extcon AUX1(HDMI) disable
[   10.945165] tegra_nvdisp_handle_pd_disable: Powergated Head1 pd
[   10.945692] tegra_nvdisp_handle_pd_disable: Powergated Head0 pd
[   10.945943] tegradc 15200000.nvdisplay: unblank
[   10.947015] tegra_nvdisp_handle_pd_enable: Unpowergated Head0 pd
[   10.947132] tegra_nvdisp_handle_pd_enable: Unpowergated Head1 pd
[   10.949061] Parent Clock set for DC plld2
[   10.960059] tegradc 15200000.nvdisplay: hdmi: tmds rate:297000K prod-setting:prod_c_hdmi_223m_300m
[   10.961553] tegradc 15200000.nvdisplay: hdmi: get YCC quant from EDID.
[   10.998937] extcon-disp-state external-connection:disp-state: cable 47 state 1
[   10.998941] Extcon AUX1(HDMI) enable
[   10.999327] tegradc 15200000.nvdisplay: unblank
[   10.999344] tegradc 15210000.nvdisplay: blank - powerdown
[   11.981416] eqos 2490000.ether_qos eth0: Link is Up - 1Gbps/Full - flow control rx/tx
[   11.982080] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   16.558568] fuse init (API version 7.26)
[   17.875518] tegradc 15200000.nvdisplay: unblank
[   17.875533] tegradc 15210000.nvdisplay: blank - powerdown
[   34.134993] vdd-1v8-sd: disabling
[   34.135002] vdd-1v8-cvb: disabling
[   34.135008] vdd-epb-1v0: disabling
[   34.135012] avdd-cam-2v8: disabling
[   34.135017] vdd-fan: disabling
[   34.135022] vdd_sys_en: disabling
[   58.711132] FAN rising trip_level:1 cur_temp:46050 trip_temps[2]:60000
[   79.954496] uvcvideo: Non-zero status (-71) in video completion handler.
[   79.955917] uvcvideo: Non-zero status (-71) in video completion handler.

DaneLLL · April 12, 2021, 9:37am

Hi,
We have run the command on r32.5/XNX + 2E-Con USB cameras:

$ gst-launch-1.0 -e \
> v4l2src device=/dev/video0 name=source_1 ! 'video/x-raw,format=UYVY,width=1920,height=1080,framerate=60/1' ! nvvidconv ! 'video/x-raw(memory:NVMM),width=640,height=480' ! tee name=tee_source_1 \
> v4l2src device=/dev/video1 name=source_2 ! 'video/x-raw,format=UYVY,width=1920,height=1080,framerate=60/1' ! nvvidconv ! 'video/x-raw(memory:NVMM),width=640,height=480' ! tee name=tee_source_2 \
> tee_source_1. ! queue ! nv3dsink sync=false name=sink_primary \
> tee_source_2. ! queue ! nv3dsink sync=false name=sink_secondary

Don’t hit the issues in 2+ hour run. Probably the instability is specific to your USB cameras. Are you able to share brand and model ID for reference?

And we would like to try test_app.pybut it is dependent to PyQt. Would need your help to share a script without the dependency, so that we can test it on default system image.

streakflash · April 12, 2021, 12:51pm

Thanks for the reply @DaneLLL
Here is a script running on GTK ui instead, should work with the default system image
test_app_gtk.py (3.6 KB)

As I menthioned above, I use DFG/HDSDI - SDI-to-USB 3.0 converter as the camera source. My cameras are attached to 2 of these converters.

DaneLLL · April 15, 2021, 6:41am

Hi,
We run the script and it hangs and cannot exit through Ctrl+C:

nvidia@nvidia-desktop:~$ python3 test_app_gtk.py


^C^C^C^C

^C^C

Please help check and see if you have any idea.

streakflash · April 15, 2021, 9:45am

@DaneLLL The script is working fine I have validated it on a fresh image. It pops up a tiny window with 3 buttons maybe you missed that. Please use the UI to start and stop the pipeline.

In a sequence of
Push button: /dev/video0
Push button: Stop pipeline
Push button: /dev/video1 the error occures

I would also like to state that this bug doesnt exist in
Jetpack 4.4 (32.4.3). I have used this same script to validate my statement.

Screenshot

Screenshot 2021-04-15 134347

DaneLLL · April 15, 2021, 11:08am

Hi,
We ran the script remotely so did not see the buttons. Will try when we can physically access the device.

So need to press the buttons until the issue happens? Or it is hit in first trial?

streakflash · April 15, 2021, 12:04pm

The crash occures right after pipeline restarts so first attempt is sufficient

DaneLLL · April 16, 2021, 9:33am

Hi,
For segment fault, please apply this prebuilt lib and try again:
Libv4l2_nvargus.so source code - #19 by JerryChang

streakflash · April 16, 2021, 10:38am

Hi,
I confirm that the patch has resolved the issue with the nvv4l2h265enc encoder. Thank you for that.

Now since first issue has gone, can you give advice on the camera’s failure ?
I have tested both cameras simultaneously using gstreamer pipeline shown below on a regular laptop running Ubuntu 20.04 and no faulty detected so far, but cameras are guaranteed to fail on short period of time while using the same pipeline on Jetson Xavier NX.

gst-launch-1.0 -e \
    v4l2src device=/dev/video0 name=source_1 ! 'video/x-raw,format=YUY2,width=1920,height=1080,framerate=30/1' ! videoconvert ! xvimagesink sync=false name=sink_primary \
    v4l2src device=/dev/video1 name=source_2 ! 'video/x-raw,format=YUY2,width=1920,height=1080,framerate=30/1' ! videoconvert ! xvimagesink sync=false name=sink_secondary

I’ve tried tricks from the these topics, still couldnt resolve the issue

DaneLLL · April 19, 2021, 3:11am

Hi,
Please check if you can supply external power to the cameras for a try. On Jetson Nano devkit, there is embedded hub, you may connect to one hub with external power, and connect to the USB cameras.
We run with two E-Con CU135 and it looks OK to output in 1080p60 steadily. Each camera has different power requirement and it probably help improve stability with external power supply.

streakflash · May 5, 2021, 8:49am

I want to share our final solution to this problem. Jetson Xavier might have insufficient USB bandwidth issue, the power consumption of both converters were not exceeding 1A , yet we tried to use the converters by connecting them to an externally powered USB hub - No luck, same behaviour.

We went with a different converter that is using PCI bus to transfer the data, so we had to sacrifise our SSD installed in the m.2 slot to use this new SDI converter. Eventually this worked out and we decided to use external HDD/SSD to store our data.

Thank you

Topic		Replies	Views
Gstreamer Pipeline issue : PosixMemMap:84 mmap failed Jetson Orin Nano gstreamer	15	661	April 25, 2024
Help with gstreamer speed improvement via using userptr buffer allocations Jetson TX2	10	4435	May 17, 2018
DeepStream, Python USB cam sample hangs DeepStream SDK	38	1352	October 12, 2021
gstreamer pipeline is very slow to start Jetson TX1	19	7094	April 6, 2017
Low camera frame rate DeepStream SDK camera , nvbugs	30	6175	October 12, 2021
Gst_nvds_buffer_pool_alloc_buffer: assertion 'mem' failed DeepStream SDK	16	2172	October 12, 2021
Simple Gstream USB Camera Live View Jetson AGX Orin gstreamer	12	2324	July 25, 2023
Gstreamer UDP sink using python Jetson Xavier NX gstreamer	15	4492	October 18, 2021
RTSP Gstreamer pipeline with nvv4l2h264 Jetson AGX Orin camera , gstreamer	5	1985	January 11, 2023
Jetson Xavier yuv422 camera driver [one camera] no reply from camera processor Jetson AGX Xavier camera	35	3495	October 17, 2021

GStreamer pipeline hangs after hours due to errors

Related topics