# tracer: nop # # entries-in-buffer/entries-written: 210/210 #P:12 # # _-----=> irqs-off # / _----=> need-resched # | / _---=> hardirq/softirq # || / _--=> preempt-depth # ||| / delay # TASK-PID CPU# |||| TIMESTAMP FUNCTION # | | | |||| | | v4l2-ctl-2608 [007] .... 391.123232: tegra_channel_open: vi-output, imx390 2-001e v4l2-ctl-2608 [007] .... 391.128382: tegra_channel_set_power: imx390 2-001e : 0x1 v4l2-ctl-2608 [007] .... 391.128393: camera_common_s_power: status : 0x1 v4l2-ctl-2608 [007] .... 391.128401: tegra_channel_set_power: 13e40000.host1x:nvcsi@15a00000- : 0x1 v4l2-ctl-2608 [007] .... 391.128403: csi_s_power: enable : 0x1 v4l2-ctl-2608 [007] .... 391.129466: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13 v4l2-ctl-2608 [002] .... 391.148559: tegra_channel_set_stream: enable : 0x1 v4l2-ctl-2608 [002] .... 391.163571: tegra_channel_set_stream: 13e40000.host1x:nvcsi@15a00000- : 0x1 v4l2-ctl-2608 [002] .... 391.163573: csi_s_stream: enable : 0x1 v4l2-ctl-2608 [002] .... 391.164006: tegra_channel_set_stream: imx390 2-001e : 0x1 kworker/7:3-141 [007] .... 391.170981: rtcpu_string: tstamp:12670737705 id:0x04010000 str:"VM0 activating." kworker/7:3-141 [007] .... 391.170982: rtcpu_string: tstamp:12671071898 id:0x04010000 str:"NVCSILP clock rate = 408000000 Hz. " kworker/7:3-141 [007] .... 391.171119: rtcpu_string: tstamp:12671182855 id:0x04010000 str:"VI5: tegra_vi_channel_alloc() " kworker/7:3-141 [007] .... 391.171122: rtcpu_string: tstamp:12671187864 id:0x04010000 str:"VI5: unit 0 stream ID table: " kworker/7:3-141 [007] .... 391.171125: rtcpu_string: tstamp:12671188183 id:0x04010000 str:"VI5: unit 0 stream ID table from THI: " kworker/7:3-141 [007] .... 391.171128: rtcpu_string: tstamp:12671188537 id:0x04010000 str:"VI5: FALCON_CSB_AFBIF_STREAMID_CTL = 0x00 " kworker/7:3-141 [007] .... 391.171131: rtcpu_string: tstamp:12671198087 id:0x04010000 str:"VI5: vi5_trace_enable: configuring trace buffer " kworker/7:3-141 [007] .... 391.171132: rtcpu_string: tstamp:12671198252 id:0x04010000 str:"at iova=0xc55dda00 size=32768 " kworker/7:3-141 [007] .... 391.171135: rtcpu_string: tstamp:12671199516 id:0x04010000 str:"VI5: tegra_vi_channel_alloc: ch=35 " kworker/7:3-141 [007] .... 391.171138: rtcpu_string: tstamp:12671212182 id:0x04010000 str:"VI5: PFSD enabled for channel: NO, expected_coun" kworker/7:3-141 [007] .... 391.171138: rtcpu_string: tstamp:12671212347 id:0x04010000 str:"t. 0 " kworker/7:3-141 [007] .... 391.171141: rtcpu_string: tstamp:12671212649 id:0x04010000 str:"VI5: channel_submit(35, bfebf000) " kworker/7:3-141 [007] .... 391.171144: rtcpu_string: tstamp:12671213222 id:0x04010000 str:"VI5: completion_actions[8] size = 30, next offse" kworker/7:3-141 [007] .... 391.171144: rtcpu_string: tstamp:12671213389 id:0x04010000 str:"t = 314 " kworker/7:3-141 [007] .... 391.171147: rtcpu_string: tstamp:12671213759 id:0x04010000 str:"VI5: completion_actions[0] size = 31, next offse" kworker/7:3-141 [007] .... 391.171148: rtcpu_string: tstamp:12671213926 id:0x04010000 str:"t = 345 " kworker/7:3-141 [007] .... 391.171151: rtcpu_string: tstamp:12671214288 id:0x04010000 str:"VI5: completion_actions[2] size = 14, next offse" kworker/7:3-141 [007] .... 391.171151: rtcpu_string: tstamp:12671214454 id:0x04010000 str:"t = 359 " kworker/7:3-141 [007] .... 391.171154: rtcpu_string: tstamp:12671214817 id:0x04010000 str:"VI5: completion_actions[1] size = 30, next offse" kworker/7:3-141 [007] .... 391.171154: rtcpu_string: tstamp:12671214983 id:0x04010000 str:"t = 389 " kworker/7:3-141 [007] .... 391.171157: rtcpu_string: tstamp:12671215342 id:0x04010000 str:"VI5: completion_actions[4] size = 14, next offse" kworker/7:3-141 [007] .... 391.171158: rtcpu_string: tstamp:12671215507 id:0x04010000 str:"t = 403 " kworker/7:3-141 [007] .... 391.171160: rtcpu_string: tstamp:12671215867 id:0x04010000 str:"VI5: completion_actions[3] size = 14, next offse" kworker/7:3-141 [007] .... 391.171161: rtcpu_string: tstamp:12671216032 id:0x04010000 str:"t = 417 " kworker/7:3-141 [007] .... 391.171164: rtcpu_string: tstamp:12671216389 id:0x04010000 str:"VI5: completion_actions[5] size = 2, next offset" kworker/7:3-141 [007] .... 391.171164: rtcpu_string: tstamp:12671216555 id:0x04010000 str:" = 419 " kworker/7:3-141 [007] .... 391.171167: rtcpu_string: tstamp:12671217072 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x02 " kworker/7:3-141 [007] .... 391.171170: rtcpu_string: tstamp:12671217330 id:0x04010000 str:"VI5: enabling stream 1 " kworker/7:3-141 [007] .... 391.171172: rtcpu_string: tstamp:12671219624 id:0x04010000 str:"VI5: PFSD enabled for channel: NO, expected_coun" kworker/7:3-141 [007] .... 391.171173: rtcpu_string: tstamp:12671219787 id:0x04010000 str:"t. 0 " kworker/7:3-141 [007] .... 391.171176: rtcpu_string: tstamp:12671220082 id:0x04010000 str:"VI5: channel_submit(35, bfebf180) " kworker/7:3-141 [007] .... 391.171179: rtcpu_string: tstamp:12671220554 id:0x04010000 str:"VI5: completion_actions[8] size = 30, next offse" kworker/7:3-141 [007] .... 391.171179: rtcpu_string: tstamp:12671220717 id:0x04010000 str:"t = 314 " kworker/7:3-141 [007] .... 391.171182: rtcpu_string: tstamp:12671221081 id:0x04010000 str:"VI5: completion_actions[0] size = 31, next offse" kworker/7:3-141 [007] .... 391.171183: rtcpu_string: tstamp:12671221245 id:0x04010000 str:"t = 345 " kworker/7:3-141 [007] .... 391.171185: rtcpu_string: tstamp:12671221603 id:0x04010000 str:"VI5: completion_actions[2] size = 14, next offse" kworker/7:3-141 [007] .... 391.171186: rtcpu_string: tstamp:12671221766 id:0x04010000 str:"t = 359 " kworker/7:3-141 [007] .... 391.171188: rtcpu_string: tstamp:12671222124 id:0x04010000 str:"VI5: completion_actions[1] size = 30, next offse" kworker/7:3-141 [007] .... 391.171189: rtcpu_string: tstamp:12671222291 id:0x04010000 str:"t = 389 " kworker/7:3-141 [007] .... 391.171192: rtcpu_string: tstamp:12671222649 id:0x04010000 str:"VI5: completion_actions[4] size = 14, next offse" kworker/7:3-141 [007] .... 391.171192: rtcpu_string: tstamp:12671222811 id:0x04010000 str:"t = 403 " kworker/7:3-141 [007] .... 391.171195: rtcpu_string: tstamp:12671223166 id:0x04010000 str:"VI5: completion_actions[3] size = 14, next offse" kworker/7:3-141 [007] .... 391.171196: rtcpu_string: tstamp:12671223330 id:0x04010000 str:"t = 417 " kworker/7:3-141 [007] .... 391.171198: rtcpu_string: tstamp:12671223689 id:0x04010000 str:"VI5: completion_actions[5] size = 2, next offset" kworker/7:3-141 [007] .... 391.171199: rtcpu_string: tstamp:12671223860 id:0x04010000 str:" = 419 " kworker/7:3-141 [007] .... 391.171201: rtcpu_string: tstamp:12671224376 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x02 " kworker/7:3-141 [007] .... 391.171206: rtcpu_vinotify_event: tstamp:12671635105 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:405478980128 data:0xc55cff0010000000 kworker/7:3-141 [007] .... 391.171207: rtcpu_vinotify_event: tstamp:12671635277 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:405478986720 data:0x0000000031000001 kworker/7:3-141 [007] .... 391.171207: rtcpu_vinotify_event: tstamp:12671635472 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:405479206848 data:0xc55cfc0010000000 kworker/7:3-141 [007] .... 391.171208: rtcpu_vinotify_event: tstamp:12671635639 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:405479213504 data:0x0000000031000002 kworker/7:3-141 [007] .... 391.171208: rtcpu_string: tstamp:12671694095 id:0x04010000 str:"tegra_nvcsi_stream_set_config(vm0, stream=1, csi" kworker/7:3-141 [007] .... 391.171209: rtcpu_string: tstamp:12671694197 id:0x04010000 str:"=1) " kworker/7:3-141 [007] .... 391.171213: rtcpu_string: tstamp:12671700967 id:0x04010000 str:"tegra_nvcsi_stream_open(vm0, stream=1, csi=1) " vi-output, imx3-2610 [007] .... 393.697126: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13 kworker/7:3-141 [007] .... 393.746980: rtcpu_string: tstamp:12750819227 id:0x04010000 str:"VI5: tegra_vi_channel_release(35) " kworker/7:3-141 [007] .... 393.746994: rtcpu_string: tstamp:12750819505 id:0x04010000 str:"VI5: vi5_channel_disable(35) " kworker/7:3-141 [007] .... 393.746998: rtcpu_string: tstamp:12750829738 id:0x04010000 str:"VI5: vi5 reset completed in 1 retries " kworker/7:3-141 [007] .... 393.747001: rtcpu_string: tstamp:12750830038 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x00 " kworker/7:3-141 [007] .... 393.747005: rtcpu_string: tstamp:12750830258 id:0x04010000 str:"VI5: disabling stream 1 " kworker/7:3-141 [007] .... 393.747008: rtcpu_string: tstamp:12750868750 id:0x04010000 str:"VI5: tegra_vi_channel_alloc() " kworker/7:3-141 [007] .... 393.747011: rtcpu_string: tstamp:12750869310 id:0x04010000 str:"VI5: tegra_vi_channel_alloc: ch=35 " kworker/7:3-141 [007] .... 393.747014: rtcpu_string: tstamp:12750878478 id:0x04010000 str:"VI5: PFSD enabled for channel: NO, expected_coun" kworker/7:3-141 [007] .... 393.747015: rtcpu_string: tstamp:12750878581 id:0x04010000 str:"t. 0 " kworker/7:3-141 [007] .... 393.747018: rtcpu_string: tstamp:12750878820 id:0x04010000 str:"VI5: channel_submit(35, bfebe000) " kworker/7:3-141 [007] .... 393.747022: rtcpu_string: tstamp:12750879313 id:0x04010000 str:"VI5: completion_actions[8] size = 30, next offse" kworker/7:3-141 [007] .... 393.747022: rtcpu_string: tstamp:12750879415 id:0x04010000 str:"t = 314 " kworker/7:3-141 [007] .... 393.747026: rtcpu_string: tstamp:12750879721 id:0x04010000 str:"VI5: completion_actions[0] size = 31, next offse" kworker/7:3-141 [007] .... 393.747027: rtcpu_string: tstamp:12750879824 id:0x04010000 str:"t = 345 " kworker/7:3-141 [007] .... 393.747030: rtcpu_string: tstamp:12750880124 id:0x04010000 str:"VI5: completion_actions[2] size = 14, next offse" kworker/7:3-141 [007] .... 393.747031: rtcpu_string: tstamp:12750880228 id:0x04010000 str:"t = 359 " kworker/7:3-141 [007] .... 393.747034: rtcpu_string: tstamp:12750880529 id:0x04010000 str:"VI5: completion_actions[1] size = 30, next offse" kworker/7:3-141 [007] .... 393.747035: rtcpu_string: tstamp:12750880630 id:0x04010000 str:"t = 389 " kworker/7:3-141 [007] .... 393.747038: rtcpu_string: tstamp:12750880929 id:0x04010000 str:"VI5: completion_actions[4] size = 14, next offse" kworker/7:3-141 [007] .... 393.747039: rtcpu_string: tstamp:12750881032 id:0x04010000 str:"t = 403 " kworker/7:3-141 [007] .... 393.747042: rtcpu_string: tstamp:12750881329 id:0x04010000 str:"VI5: completion_actions[3] size = 14, next offse" kworker/7:3-141 [007] .... 393.747042: rtcpu_string: tstamp:12750881430 id:0x04010000 str:"t = 417 " kworker/7:3-141 [007] .... 393.747046: rtcpu_string: tstamp:12750881727 id:0x04010000 str:"VI5: completion_actions[5] size = 2, next offset" kworker/7:3-141 [007] .... 393.747046: rtcpu_string: tstamp:12750881827 id:0x04010000 str:" = 419 " kworker/7:3-141 [007] .... 393.747050: rtcpu_string: tstamp:12750882199 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x02 " kworker/7:3-141 [007] .... 393.747053: rtcpu_string: tstamp:12750882392 id:0x04010000 str:"VI5: enabling stream 1 " kworker/7:3-141 [007] .... 393.747056: rtcpu_string: tstamp:12750883987 id:0x04010000 str:"VI5: PFSD enabled for channel: NO, expected_coun" kworker/7:3-141 [007] .... 393.747057: rtcpu_string: tstamp:12750884091 id:0x04010000 str:"t. 0 " kworker/7:3-141 [007] .... 393.747060: rtcpu_string: tstamp:12750884323 id:0x04010000 str:"VI5: channel_submit(35, bfebe180) " kworker/7:3-141 [007] .... 393.747063: rtcpu_string: tstamp:12750884717 id:0x04010000 str:"VI5: completion_actions[8] size = 30, next offse" kworker/7:3-141 [007] .... 393.747064: rtcpu_string: tstamp:12750884817 id:0x04010000 str:"t = 314 " kworker/7:3-141 [007] .... 393.747067: rtcpu_string: tstamp:12750885122 id:0x04010000 str:"VI5: completion_actions[0] size = 31, next offse" kworker/7:3-141 [007] .... 393.747068: rtcpu_string: tstamp:12750885224 id:0x04010000 str:"t = 345 " kworker/7:3-141 [007] .... 393.747071: rtcpu_string: tstamp:12750885522 id:0x04010000 str:"VI5: completion_actions[2] size = 14, next offse" kworker/7:3-141 [007] .... 393.747072: rtcpu_string: tstamp:12750885624 id:0x04010000 str:"t = 359 " kworker/7:3-141 [007] .... 393.747075: rtcpu_string: tstamp:12750885923 id:0x04010000 str:"VI5: completion_actions[1] size = 30, next offse" kworker/7:3-141 [007] .... 393.747076: rtcpu_string: tstamp:12750886024 id:0x04010000 str:"t = 389 " kworker/7:3-141 [007] .... 393.747079: rtcpu_string: tstamp:12750886321 id:0x04010000 str:"VI5: completion_actions[4] size = 14, next offse" kworker/7:3-141 [007] .... 393.747080: rtcpu_string: tstamp:12750886425 id:0x04010000 str:"t = 403 " kworker/7:3-141 [007] .... 393.747083: rtcpu_string: tstamp:12750886722 id:0x04010000 str:"VI5: completion_actions[3] size = 14, next offse" kworker/7:3-141 [007] .... 393.747083: rtcpu_string: tstamp:12750886823 id:0x04010000 str:"t = 417 " kworker/7:3-141 [007] .... 393.747086: rtcpu_string: tstamp:12750887116 id:0x04010000 str:"VI5: completion_actions[5] size = 2, next offset" kworker/7:3-141 [007] .... 393.747087: rtcpu_string: tstamp:12750887217 id:0x04010000 str:" = 419 " kworker/7:3-141 [007] .... 393.747091: rtcpu_string: tstamp:12750887589 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x02 " kworker/7:3-141 [007] .... 393.747096: rtcpu_vinotify_event: tstamp:12751388895 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:408028369024 data:0xc55cff0010000000 kworker/7:3-141 [007] .... 393.747096: rtcpu_vinotify_event: tstamp:12751389033 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:408028436480 data:0x0000000031000001 kworker/7:3-141 [007] .... 393.747097: rtcpu_vinotify_event: tstamp:12751389187 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:408028529728 data:0xc55cfc0010000000 kworker/7:3-141 [007] .... 393.747097: rtcpu_vinotify_event: tstamp:12751389319 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:408028574144 data:0x0000000031000002 vi-output, imx3-2610 [002] .... 396.257227: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13 kworker/7:3-141 [007] .... 396.270997: rtcpu_string: tstamp:12830824573 id:0x04010000 str:"VI5: tegra_vi_channel_release(35) " kworker/7:3-141 [007] .... 396.271008: rtcpu_string: tstamp:12830824850 id:0x04010000 str:"VI5: vi5_channel_disable(35) " kworker/7:3-141 [007] .... 396.271011: rtcpu_string: tstamp:12830829738 id:0x04010000 str:"VI5: vi5 reset completed in 1 retries " kworker/7:3-141 [007] .... 396.271014: rtcpu_string: tstamp:12830830039 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x00 " kworker/7:3-141 [007] .... 396.271016: rtcpu_string: tstamp:12830830258 id:0x04010000 str:"VI5: disabling stream 1 " kworker/7:3-141 [007] .... 396.271020: rtcpu_string: tstamp:12830871875 id:0x04010000 str:"VI5: tegra_vi_channel_alloc() " kworker/7:3-141 [007] .... 396.271022: rtcpu_string: tstamp:12830872425 id:0x04010000 str:"VI5: tegra_vi_channel_alloc: ch=35 " kworker/7:3-141 [007] .... 396.271025: rtcpu_string: tstamp:12830874812 id:0x04010000 str:"VI5: PFSD enabled for channel: NO, expected_coun" kworker/7:3-141 [007] .... 396.271026: rtcpu_string: tstamp:12830874916 id:0x04010000 str:"t. 0 " kworker/7:3-141 [007] .... 396.271028: rtcpu_string: tstamp:12830875153 id:0x04010000 str:"VI5: channel_submit(35, bfebd000) " kworker/7:3-141 [007] .... 396.271031: rtcpu_string: tstamp:12830875644 id:0x04010000 str:"VI5: completion_actions[8] size = 30, next offse" kworker/7:3-141 [007] .... 396.271031: rtcpu_string: tstamp:12830875747 id:0x04010000 str:"t = 314 " kworker/7:3-141 [007] .... 396.271034: rtcpu_string: tstamp:12830876052 id:0x04010000 str:"VI5: completion_actions[0] size = 31, next offse" kworker/7:3-141 [007] .... 396.271035: rtcpu_string: tstamp:12830876154 id:0x04010000 str:"t = 345 " kworker/7:3-141 [007] .... 396.271037: rtcpu_string: tstamp:12830876459 id:0x04010000 str:"VI5: completion_actions[2] size = 14, next offse" kworker/7:3-141 [007] .... 396.271038: rtcpu_string: tstamp:12830876560 id:0x04010000 str:"t = 359 " kworker/7:3-141 [007] .... 396.271040: rtcpu_string: tstamp:12830876858 id:0x04010000 str:"VI5: completion_actions[1] size = 30, next offse" kworker/7:3-141 [007] .... 396.271041: rtcpu_string: tstamp:12830876958 id:0x04010000 str:"t = 389 " kworker/7:3-141 [007] .... 396.271043: rtcpu_string: tstamp:12830877255 id:0x04010000 str:"VI5: completion_actions[4] size = 14, next offse" kworker/7:3-141 [007] .... 396.271044: rtcpu_string: tstamp:12830877356 id:0x04010000 str:"t = 403 " kworker/7:3-141 [007] .... 396.271046: rtcpu_string: tstamp:12830877652 id:0x04010000 str:"VI5: completion_actions[3] size = 14, next offse" kworker/7:3-141 [007] .... 396.271046: rtcpu_string: tstamp:12830877753 id:0x04010000 str:"t = 417 " kworker/7:3-141 [007] .... 396.271049: rtcpu_string: tstamp:12830878058 id:0x04010000 str:"VI5: completion_actions[5] size = 2, next offset" kworker/7:3-141 [007] .... 396.271050: rtcpu_string: tstamp:12830878160 id:0x04010000 str:" = 419 " kworker/7:3-141 [007] .... 396.271052: rtcpu_string: tstamp:12830878545 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x02 " kworker/7:3-141 [007] .... 396.271054: rtcpu_string: tstamp:12830878737 id:0x04010000 str:"VI5: enabling stream 1 " kworker/7:3-141 [007] .... 396.271057: rtcpu_string: tstamp:12830880311 id:0x04010000 str:"VI5: PFSD enabled for channel: NO, expected_coun" kworker/7:3-141 [007] .... 396.271057: rtcpu_string: tstamp:12830880412 id:0x04010000 str:"t. 0 " kworker/7:3-141 [007] .... 396.271059: rtcpu_string: tstamp:12830880644 id:0x04010000 str:"VI5: channel_submit(35, bfebd180) " kworker/7:3-141 [007] .... 396.271062: rtcpu_string: tstamp:12830881040 id:0x04010000 str:"VI5: completion_actions[8] size = 30, next offse" kworker/7:3-141 [007] .... 396.271062: rtcpu_string: tstamp:12830881141 id:0x04010000 str:"t = 314 " kworker/7:3-141 [007] .... 396.271064: rtcpu_string: tstamp:12830881446 id:0x04010000 str:"VI5: completion_actions[0] size = 31, next offse" kworker/7:3-141 [007] .... 396.271065: rtcpu_string: tstamp:12830881547 id:0x04010000 str:"t = 345 " kworker/7:3-141 [007] .... 396.271067: rtcpu_string: tstamp:12830881844 id:0x04010000 str:"VI5: completion_actions[2] size = 14, next offse" kworker/7:3-141 [007] .... 396.271067: rtcpu_string: tstamp:12830881944 id:0x04010000 str:"t = 359 " kworker/7:3-141 [007] .... 396.271070: rtcpu_string: tstamp:12830882243 id:0x04010000 str:"VI5: completion_actions[1] size = 30, next offse" kworker/7:3-141 [007] .... 396.271070: rtcpu_string: tstamp:12830882343 id:0x04010000 str:"t = 389 " kworker/7:3-141 [007] .... 396.271072: rtcpu_string: tstamp:12830882639 id:0x04010000 str:"VI5: completion_actions[4] size = 14, next offse" kworker/7:3-141 [007] .... 396.271073: rtcpu_string: tstamp:12830882741 id:0x04010000 str:"t = 403 " kworker/7:3-141 [007] .... 396.271075: rtcpu_string: tstamp:12830883037 id:0x04010000 str:"VI5: completion_actions[3] size = 14, next offse" kworker/7:3-141 [007] .... 396.271075: rtcpu_string: tstamp:12830883135 id:0x04010000 str:"t = 417 " kworker/7:3-141 [007] .... 396.271078: rtcpu_string: tstamp:12830883428 id:0x04010000 str:"VI5: completion_actions[5] size = 2, next offset" kworker/7:3-141 [007] .... 396.271078: rtcpu_string: tstamp:12830883528 id:0x04010000 str:" = 419 " kworker/7:3-141 [007] .... 396.271080: rtcpu_string: tstamp:12830883899 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x02 " kworker/7:3-141 [007] .... 396.271084: rtcpu_vinotify_event: tstamp:12831142804 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:410588228384 data:0xc55cff0010000000 kworker/7:3-141 [007] .... 396.271085: rtcpu_vinotify_event: tstamp:12831142938 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:410588272096 data:0x0000000031000001 kworker/7:3-141 [007] .... 396.271085: rtcpu_vinotify_event: tstamp:12831143089 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:410588389120 data:0xc55cfc0010000000 kworker/7:3-141 [007] .... 396.271085: rtcpu_vinotify_event: tstamp:12831143218 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:410588433504 data:0x0000000031000002 vi-output, imx3-2610 [003] .... 398.817404: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13 kworker/7:3-141 [007] .... 398.846991: rtcpu_string: tstamp:12910822799 id:0x04010000 str:"VI5: tegra_vi_channel_release(35) " kworker/7:3-141 [007] .... 398.847003: rtcpu_string: tstamp:12910823073 id:0x04010000 str:"VI5: vi5_channel_disable(35) " kworker/7:3-141 [007] .... 398.847007: rtcpu_string: tstamp:12910829735 id:0x04010000 str:"VI5: vi5 reset completed in 1 retries " kworker/7:3-141 [007] .... 398.847011: rtcpu_string: tstamp:12910830034 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x00 " kworker/7:3-141 [007] .... 398.847015: rtcpu_string: tstamp:12910830254 id:0x04010000 str:"VI5: disabling stream 1 " kworker/7:3-141 [007] .... 398.847018: rtcpu_string: tstamp:12910877475 id:0x04010000 str:"VI5: tegra_vi_channel_alloc() " kworker/7:3-141 [007] .... 398.847022: rtcpu_string: tstamp:12910878025 id:0x04010000 str:"VI5: tegra_vi_channel_alloc: ch=35 " kworker/7:3-141 [007] .... 398.847026: rtcpu_string: tstamp:12910880316 id:0x04010000 str:"VI5: PFSD enabled for channel: NO, expected_coun" kworker/7:3-141 [007] .... 398.847027: rtcpu_string: tstamp:12910880420 id:0x04010000 str:"t. 0 " kworker/7:3-141 [007] .... 398.847030: rtcpu_string: tstamp:12910880656 id:0x04010000 str:"VI5: channel_submit(35, bfebc000) " kworker/7:3-141 [007] .... 398.847033: rtcpu_string: tstamp:12910881166 id:0x04010000 str:"VI5: completion_actions[8] size = 30, next offse" kworker/7:3-141 [007] .... 398.847036: rtcpu_string: tstamp:12910881268 id:0x04010000 str:"t = 314 " kworker/7:3-141 [007] .... 398.847039: rtcpu_string: tstamp:12910881573 id:0x04010000 str:"VI5: completion_actions[0] size = 31, next offse" kworker/7:3-141 [007] .... 398.847040: rtcpu_string: tstamp:12910881674 id:0x04010000 str:"t = 345 " kworker/7:3-141 [007] .... 398.847044: rtcpu_string: tstamp:12910881971 id:0x04010000 str:"VI5: completion_actions[2] size = 14, next offse" kworker/7:3-141 [007] .... 398.847045: rtcpu_string: tstamp:12910882071 id:0x04010000 str:"t = 359 " kworker/7:3-141 [007] .... 398.847049: rtcpu_string: tstamp:12910882369 id:0x04010000 str:"VI5: completion_actions[1] size = 30, next offse" kworker/7:3-141 [007] .... 398.847050: rtcpu_string: tstamp:12910882469 id:0x04010000 str:"t = 389 " kworker/7:3-141 [007] .... 398.847053: rtcpu_string: tstamp:12910882764 id:0x04010000 str:"VI5: completion_actions[4] size = 14, next offse" kworker/7:3-141 [007] .... 398.847054: rtcpu_string: tstamp:12910882865 id:0x04010000 str:"t = 403 " kworker/7:3-141 [007] .... 398.847058: rtcpu_string: tstamp:12910883161 id:0x04010000 str:"VI5: completion_actions[3] size = 14, next offse" kworker/7:3-141 [007] .... 398.847059: rtcpu_string: tstamp:12910883261 id:0x04010000 str:"t = 417 " kworker/7:3-141 [007] .... 398.847062: rtcpu_string: tstamp:12910883555 id:0x04010000 str:"VI5: completion_actions[5] size = 2, next offset" kworker/7:3-141 [007] .... 398.847063: rtcpu_string: tstamp:12910883655 id:0x04010000 str:" = 419 " kworker/7:3-141 [007] .... 398.847066: rtcpu_string: tstamp:12910884029 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x02 " kworker/7:3-141 [007] .... 398.847070: rtcpu_string: tstamp:12910884219 id:0x04010000 str:"VI5: enabling stream 1 " kworker/7:3-141 [007] .... 398.847073: rtcpu_string: tstamp:12910885779 id:0x04010000 str:"VI5: PFSD enabled for channel: NO, expected_coun" kworker/7:3-141 [007] .... 398.847074: rtcpu_string: tstamp:12910885879 id:0x04010000 str:"t. 0 " kworker/7:3-141 [007] .... 398.847077: rtcpu_string: tstamp:12910886110 id:0x04010000 str:"VI5: channel_submit(35, bfebc180) " kworker/7:3-141 [007] .... 398.847081: rtcpu_string: tstamp:12910886502 id:0x04010000 str:"VI5: completion_actions[8] size = 30, next offse" kworker/7:3-141 [007] .... 398.847082: rtcpu_string: tstamp:12910886604 id:0x04010000 str:"t = 314 " kworker/7:3-141 [007] .... 398.847085: rtcpu_string: tstamp:12910886907 id:0x04010000 str:"VI5: completion_actions[0] size = 31, next offse" kworker/7:3-141 [007] .... 398.847086: rtcpu_string: tstamp:12910887007 id:0x04010000 str:"t = 345 " kworker/7:3-141 [007] .... 398.847089: rtcpu_string: tstamp:12910887304 id:0x04010000 str:"VI5: completion_actions[2] size = 14, next offse" kworker/7:3-141 [007] .... 398.847090: rtcpu_string: tstamp:12910887404 id:0x04010000 str:"t = 359 " kworker/7:3-141 [007] .... 398.847093: rtcpu_string: tstamp:12910887701 id:0x04010000 str:"VI5: completion_actions[1] size = 30, next offse" kworker/7:3-141 [007] .... 398.847094: rtcpu_string: tstamp:12910887799 id:0x04010000 str:"t = 389 " kworker/7:3-141 [007] .... 398.847098: rtcpu_string: tstamp:12910888095 id:0x04010000 str:"VI5: completion_actions[4] size = 14, next offse" kworker/7:3-141 [007] .... 398.847098: rtcpu_string: tstamp:12910888208 id:0x04010000 str:"t = 403 " kworker/7:3-141 [007] .... 398.847102: rtcpu_string: tstamp:12910888504 id:0x04010000 str:"VI5: completion_actions[3] size = 14, next offse" kworker/7:3-141 [007] .... 398.847102: rtcpu_string: tstamp:12910888606 id:0x04010000 str:"t = 417 " kworker/7:3-141 [007] .... 398.847106: rtcpu_string: tstamp:12910888899 id:0x04010000 str:"VI5: completion_actions[5] size = 2, next offset" kworker/7:3-141 [007] .... 398.847106: rtcpu_string: tstamp:12910888999 id:0x04010000 str:" = 419 " kworker/7:3-141 [007] .... 398.847110: rtcpu_string: tstamp:12910889372 id:0x04010000 str:"VI5: vi5_update_streams: ch=35 stream_mask=0x02 " kworker/7:3-141 [007] .... 398.847115: rtcpu_vinotify_event: tstamp:12910895224 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:413148414560 data:0xc55cff0010000000 kworker/7:3-141 [007] .... 398.847115: rtcpu_vinotify_event: tstamp:12910895359 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:413148458272 data:0x0000000031000001 kworker/7:3-141 [007] .... 398.847116: rtcpu_vinotify_event: tstamp:12910900660 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:413148692832 data:0xc55cfc0010000000 kworker/7:3-141 [007] .... 398.847116: rtcpu_vinotify_event: tstamp:12910900791 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:413148737248 data:0x0000000031000002