[33.575810] Initializing watchdogs
[33.576088]   /dev/watchdog0
[33.611274] [001/142] (960s left) gem_gtt_cpu_tlb
[34.068859] [002/142] (960s left) fbdev (unaligned-write)
[34.347693] Starting subtest: unaligned-write
[34.530197] Subtest unaligned-write: SUCCESS (0.186s)
[34.628445] [003/142] (959s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[34.944902] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[35.028254] [004/142] (959s left) gem_flink_basic (bad-flink)
[35.313989] Starting subtest: bad-flink
[35.335144] Subtest bad-flink: SUCCESS (0.000s)
[35.414730] [005/142] (958s left) sysfs_timeslice_duration (idempotent)
[35.712203] Starting subtest: idempotent
[35.732443] Starting dynamic subtest: vecs0
[35.750727] Dynamic subtest vecs0: SUCCESS (0.001s)
[35.780127] Starting dynamic subtest: vcs0
[35.798544] Dynamic subtest vcs0: SUCCESS (0.001s)
[35.830410] Starting dynamic subtest: bcs0
[35.852132] Dynamic subtest bcs0: SUCCESS (0.001s)
[35.886543] Starting dynamic subtest: rcs0
[35.907276] Dynamic subtest rcs0: SUCCESS (0.001s)
[35.927347] Subtest idempotent: SUCCESS (0.008s)
[36.006111] [006/142] (958s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[36.432757] Starting subtest: extended-modeset-hang-newfb-with-reset
[36.453259] Starting dynamic subtest: pipe-A
[39.970687] Dynamic subtest pipe-A: SUCCESS (3.529s)
[40.001135] Starting dynamic subtest: pipe-C
[43.402570] Dynamic subtest pipe-C: SUCCESS (3.427s)
[43.421098] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (6.966s)
[43.788499] [007/142] (950s left) gem_ctx_shared (q-out-order)
[44.115652] Starting subtest: Q-out-order
[44.134208] Starting dynamic subtest: rcs0
[44.349493] Dynamic subtest rcs0: SUCCESS (0.242s)
[44.385041] Starting dynamic subtest: bcs0
[44.460336] Dynamic subtest bcs0: SUCCESS (0.111s)
[44.493349] Starting dynamic subtest: vcs0
[44.553802] Dynamic subtest vcs0: SUCCESS (0.091s)
[44.589477] Starting dynamic subtest: vecs0
[44.647135] Dynamic subtest vecs0: SUCCESS (0.093s)
[44.665951] Subtest Q-out-order: SUCCESS (0.540s)
[44.923240] [008/142] (949s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[45.351078] Starting subtest: x-tiled-64bpp-rotate-90
[45.433684] Subtest x-tiled-64bpp-rotate-90: SKIP (0.074s)
[45.542381] [009/142] (949s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[45.987218] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[46.023684] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[46.133155] [010/142] (948s left) syncobj_timeline (invalid-wait-zero-handles)
[46.426050] Starting subtest: invalid-wait-zero-handles
[46.447068] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[46.547045] [011/142] (948s left) kms_vblank (pipe-b-query-forked-hang)
[46.904180] Starting subtest: pipe-B-query-forked-hang
[54.194644] Subtest pipe-B-query-forked-hang: SUCCESS (7.161s)
[54.437268] [012/142] (940s left) vgem_basic (sysfs)
[54.761101] Starting subtest: sysfs
[54.781265] Subtest sysfs: SUCCESS (0.001s)
[54.879821] [013/142] (940s left) kms_hdr (static-toggle)
[55.235296] Starting subtest: static-toggle
[55.278065] Subtest static-toggle: SKIP (0.000s)
[55.382720] [014/142] (939s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[55.822730] Starting subtest: yf-tiled-16bpp-rotate-0
[59.391083] Subtest yf-tiled-16bpp-rotate-0: SUCCESS (3.607s)
[59.747247] [015/142] (935s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[60.042662] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[60.079394] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[60.249741] [016/142] (935s left) kms_ccs (pipe-b-bad-rotation-90-yf_tiled_ccs)
[60.782102] Starting subtest: pipe-B-bad-rotation-90-yf_tiled_ccs
[61.228146] Subtest pipe-B-bad-rotation-90-yf_tiled_ccs: SUCCESS (0.432s)
[61.871832] [017/142] (933s left) perf_pmu (interrupts-sync)
[62.231655] Starting subtest: interrupts-sync
[63.319929] Subtest interrupts-sync: SUCCESS (1.124s)
[63.470182] [018/142] (932s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[63.929504] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[63.983187] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[64.107293] [019/142] (931s left) drm_read (short-buffer-nonblock)
[64.616308] Starting subtest: short-buffer-nonblock
[64.639058] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[64.791545] [020/142] (931s left) perf (gen12-group-concurrent-oa-buffer-read)
[65.291534] Starting subtest: gen12-group-concurrent-oa-buffer-read
[75.593100] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.140s)
[75.678814] [021/142] (920s left) kms_chamelium_audio (hdmi-audio-edid)
[76.141176] Subtest hdmi-audio-edid: SKIP (0.000s)
[76.472057] [022/142] (919s left) kms_universal_plane (universal-plane-pipe-a-functional)
[76.829077] Starting subtest: universal-plane-pipe-A-functional
[79.304098] Subtest universal-plane-pipe-A-functional: SUCCESS (2.464s)
[79.630666] [023/142] (916s left) gem_exec_fence (syncobj-repeat)
[80.377233] Starting subtest: syncobj-repeat
[81.268582] Subtest syncobj-repeat: SUCCESS (0.892s)
[81.648114] [024/142] (914s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[82.083844] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[82.120257] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[82.227365] [025/142] (914s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs)
[82.708367] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs
[82.768434] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[83.277245] [026/142] (913s left) gem_mmap_offset (basic-uaf)
[83.574492] Starting subtest: basic-uaf
[83.595599] Subtest basic-uaf: SUCCESS (0.005s)
[83.697163] [027/142] (912s left) gem_close_race (multigpu-basic-threads)
[83.993935] Starting subtest: multigpu-basic-threads
[84.030504] Subtest multigpu-basic-threads: SKIP (0.000s)
[84.245872] [028/142] (912s left) kms_psr2_sf (cursor-plane-update-sf)
[84.560378] Subtest cursor-plane-update-sf: SKIP (0.000s)
[84.659432] [029/142] (912s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[84.945728] Starting subtest: invalid-multi-wait-unsubmitted
[84.964403] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[85.052098] [030/142] (911s left) kms_big_fb (4-tiled-addfb)
[85.463043] Starting subtest: 4-tiled-addfb
[85.501466] Subtest 4-tiled-addfb: SKIP (0.000s)
[85.607029] [031/142] (911s left) vc4/vc4_perfmon (destroy-valid-perfmon)
[85.953874] Subtest destroy-valid-perfmon: SKIP (0.000s)
[86.035853] [032/142] (910s left) kms_plane_multiple (tiling-y)
[86.392751] Starting subtest: tiling-y
[86.412738] Starting dynamic subtest: pipe-A-DP-1
[88.213815] Dynamic subtest pipe-A-DP-1: SUCCESS (1.808s)
[88.251418] Starting dynamic subtest: pipe-B-DP-1
[90.351090] Dynamic subtest pipe-B-DP-1: SUCCESS (2.113s)
[90.394639] Starting dynamic subtest: pipe-C-DP-1
[92.338809] Dynamic subtest pipe-C-DP-1: SUCCESS (2.000s)
[92.361081] Subtest tiling-y: SUCCESS (5.928s)
[92.734811] [033/142] (904s left) gem_ctx_persistence (engines-hang)
[93.092301] Starting subtest: engines-hang
[93.112862] Starting dynamic subtest: rcs0
[93.133178] Dynamic subtest rcs0: SUCCESS (0.039s)
[93.167940] Starting dynamic subtest: bcs0
[93.205099] Dynamic subtest bcs0: SKIP (0.005s)
[93.239090] Starting dynamic subtest: vcs0
[93.260166] Dynamic subtest vcs0: SUCCESS (0.044s)
[93.298571] Starting dynamic subtest: vecs0
[93.319181] Dynamic subtest vecs0: SUCCESS (0.037s)
[93.339718] Subtest engines-hang: SUCCESS (0.129s)
[93.443661] [034/142] (903s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[93.906317] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[93.943352] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[94.052526] [035/142] (903s left) kms_flip (flip-vs-fences)
[94.460189] Starting subtest: flip-vs-fences
[94.478195] Starting dynamic subtest: A-DP1
[105.355899] Dynamic subtest A-DP1: SUCCESS (10.883s)
[105.391904] Starting dynamic subtest: B-DP1
[116.306652] Dynamic subtest B-DP1: SUCCESS (10.969s)
[116.339279] Starting dynamic subtest: C-DP1
[127.028895] Dynamic subtest C-DP1: SUCCESS (10.723s)
[127.047847] Subtest flip-vs-fences: SUCCESS (32.585s)
[127.518762] [036/142] (869s left) gem_exec_fence (invalid-fence-array)
[128.246960] Starting subtest: invalid-fence-array
[128.268218] Subtest invalid-fence-array: SUCCESS (0.005s)
[128.630335] [037/142] (868s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[129.153867] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[129.196587] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[129.704618] [038/142] (867s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs)
[130.362488] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs
[130.405669] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[130.787724] [039/142] (866s left) gem_exec_schedule (preempt)
[131.241759] Starting subtest: preempt
[131.264131] Starting dynamic subtest: rcs0
[131.285482] Dynamic subtest rcs0: SUCCESS (0.065s)
[131.325250] Starting dynamic subtest: bcs0
[131.345658] Dynamic subtest bcs0: SUCCESS (0.088s)
[131.381386] Starting dynamic subtest: vcs0
[131.400092] Dynamic subtest vcs0: SUCCESS (0.061s)
[131.433223] Starting dynamic subtest: vecs0
[131.451719] Dynamic subtest vecs0: SUCCESS (0.063s)
[131.473317] Subtest preempt: SUCCESS (0.282s)
[131.748782] [040/142] (866s left) dmabuf_sync_file (import-multiple-read-write)
[132.045810] Starting subtest: import-multiple-read-write
[132.064364] Subtest import-multiple-read-write: SUCCESS (0.013s)
[132.168623] [041/142] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[132.598216] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[132.637850] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[132.743669] [042/142] (865s left) gem_mmap_gtt (fault-concurrent-y)
[133.038575] Starting subtest: fault-concurrent-Y
[136.609218] Subtest fault-concurrent-Y: SUCCESS (3.432s)
[136.852270] [043/142] (861s left) gem_spin_batch (spin-all)
[137.145569] Starting subtest: spin-all
[137.189094] Subtest spin-all: SUCCESS (0.028s)
[137.414611] [044/142] (860s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[137.938637] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[137.981138] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[138.477729] [045/142] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[138.914696] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[141.269635] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.426s)
[141.471216] [046/142] (856s left) gem_exec_balancer (busy)
[141.779286] Starting subtest: busy
[143.699691] Subtest busy: SUCCESS (1.918s)
[147.802712] [047/142] (850s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[148.191897] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[148.213183] Starting dynamic subtest: pipe-A-DP-1
[148.503524] Dynamic subtest pipe-A-DP-1: SUCCESS (0.317s)
[148.543830] Starting dynamic subtest: pipe-B-DP-1
[148.882221] Dynamic subtest pipe-B-DP-1: SUCCESS (0.373s)
[148.922923] Starting dynamic subtest: pipe-C-DP-1
[148.993137] Dynamic subtest pipe-C-DP-1: SKIP (0.092s)
[149.014657] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.795s)
[149.383209] [048/142] (849s left) kms_cursor_edge_walk (128x128-right-edge)
[149.770041] Starting subtest: 128x128-right-edge
[149.788741] Starting dynamic subtest: pipe-A-DP-1
[153.409097] Dynamic subtest pipe-A-DP-1: SUCCESS (3.652s)
[153.443093] Starting dynamic subtest: pipe-C-DP-1
[156.912733] Dynamic subtest pipe-C-DP-1: SUCCESS (3.503s)
[156.931541] Subtest 128x128-right-edge: SUCCESS (7.162s)
[157.268668] [049/142] (841s left) perf_pmu (invalid-init)
[157.560192] Starting subtest: invalid-init
[157.579724] Subtest invalid-init: SUCCESS (0.001s)
[157.703630] [050/142] (841s left) gem_exec_params (dr1-dirt)
[157.999195] Starting subtest: DR1-dirt
[158.019052] Subtest DR1-dirt: SUCCESS (0.000s)
[158.114345] [051/142] (840s left) sw_sync (alloc_timeline)
[158.388521] Starting subtest: alloc_timeline
[158.410381] Subtest alloc_timeline: SUCCESS (0.000s)
[158.498368] [052/142] (840s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[158.936289] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[158.977705] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[159.079056] [053/142] (839s left) gem_basic (create-close)
[159.362179] Starting subtest: create-close
[159.399447] Subtest create-close: SUCCESS (0.000s)
[159.487952] [054/142] (839s left) i915_pm_rpm (gem-idle)
[161.353445] Starting subtest: gem-idle
[166.987325] Subtest gem-idle: SUCCESS (5.458s)
[167.256974] [055/142] (831s left) kms_ccs (pipe-c-bad-aux-stride-yf_tiled_ccs)
[167.979459] Starting subtest: pipe-C-bad-aux-stride-yf_tiled_ccs
[168.023136] Subtest pipe-C-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[168.329172] [056/142] (830s left) kms_flip (2x-flip-vs-suspend-interruptible)
[168.706246] Starting subtest: 2x-flip-vs-suspend-interruptible
[168.747451] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.003s)
[168.851426] [057/142] (830s left) gen9_exec_parse (batch-zero-length)
[169.149759] Starting subtest: batch-zero-length
[169.168080] Subtest batch-zero-length: SUCCESS (0.002s)
[169.418291] [058/142] (830s left) gem_lmem_swapping (heavy-verify-multi)
[169.732830] Subtest heavy-verify-multi: SKIP (0.000s)
[169.834632] [059/142] (829s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[170.254681] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[170.291437] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[170.397919] [060/142] (829s left) kms_hdr (bpc-switch-dpms)
[170.752071] Starting subtest: bpc-switch-dpms
[172.955970] Starting dynamic subtest: pipe-A-DP-1
[174.407493] Dynamic subtest pipe-A-DP-1: SUCCESS (1.434s)
[174.432684] Subtest bpc-switch-dpms: SUCCESS (3.642s)
[174.827932] [061/142] (825s left) v3d/v3d_wait_bo (bad-bo)
[175.208781] Subtest bad-bo: SKIP (0.000s)
[175.339532] [062/142] (824s left) syncobj_wait (wait-any-complex)
[175.642801] Starting subtest: wait-any-complex
[175.681760] Subtest wait-any-complex: SUCCESS (0.063s)
[175.818860] [063/142] (824s left) kms_rotation_crc (primary-rotation-270)
[176.161333] Starting subtest: primary-rotation-270
[182.253224] Subtest primary-rotation-270: SUCCESS (6.099s)
[182.701651] [064/142] (817s left) kms_content_protection (atomic)
[183.101857] Starting subtest: atomic
[183.122783] Starting dynamic subtest: pipe-A-DP-1
[303.323303] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[310.740919] Closing watchdogs
[310.747300] Initializing watchdogs
[310.747493]   /dev/watchdog0
[310.804788] [065/142] (689s left) kms_flip (flip-vs-expired-vblank)
[311.190894] Starting subtest: flip-vs-expired-vblank
[311.209863] Starting dynamic subtest: A-DP1
[338.166224] Dynamic subtest A-DP1: SUCCESS (26.830s)
[338.212665] Starting dynamic subtest: B-DP1
[364.727171] Dynamic subtest B-DP1: SUCCESS (26.736s)
[364.765105] Starting dynamic subtest: C-DP1
[391.523678] Dynamic subtest C-DP1: SUCCESS (26.795s)
[391.544231] Subtest flip-vs-expired-vblank: SUCCESS (80.375s)
[408.283830] [066/142] (592s left) kms_flip (flip-vs-wf_vblank-interruptible)
[408.640283] Starting subtest: flip-vs-wf_vblank-interruptible
[408.658928] Starting dynamic subtest: A-DP1
[426.366341] Dynamic subtest A-DP1: SUCCESS (17.721s)
[426.401063] Starting dynamic subtest: B-DP1
[444.032334] Dynamic subtest B-DP1: SUCCESS (17.661s)
[444.067863] Starting dynamic subtest: C-DP1
[461.630383] Dynamic subtest C-DP1: SUCCESS (17.594s)
[461.651458] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (52.989s)
[478.561657] [067/142] (521s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[478.914049] Subtest bad-multisync-out-sync: SKIP (0.000s)
[479.004307] [068/142] (521s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[479.493908] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[479.798669] [069/142] (520s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[480.458400] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[480.519925] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[480.855697] [070/142] (519s left) gem_exec_params (mmapped)
[481.170186] Starting subtest: mmapped
[481.196136] Subtest mmapped: SUCCESS (0.005s)
[481.333376] [071/142] (519s left) gem_render_copy (y-tiled)
[481.647858] Starting subtest: y-tiled
[481.670866] Starting dynamic subtest: smem
[481.907099] Dynamic subtest smem: SUCCESS (0.284s)
[481.929556] Subtest y-tiled: SUCCESS (0.286s)
[482.158133] [072/142] (518s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-a)
[482.505198] Starting subtest: universal-plane-pageflip-windowed-pipe-A
[482.915083] Subtest universal-plane-pageflip-windowed-pipe-A: SUCCESS (0.410s)
[483.270590] [073/142] (517s left) perf_pmu (multi-client)
[483.584400] Starting subtest: multi-client
[483.608502] Starting dynamic subtest: rcs0
[484.556121] Dynamic subtest rcs0: SUCCESS (1.030s)
[484.597983] Starting dynamic subtest: bcs0
[485.589105] Dynamic subtest bcs0: SUCCESS (1.032s)
[485.629533] Starting dynamic subtest: vcs0
[486.626033] Dynamic subtest vcs0: SUCCESS (1.029s)
[486.667484] Starting dynamic subtest: vecs0
[487.659707] Dynamic subtest vecs0: SUCCESS (1.028s)
[487.684260] Subtest multi-client: SUCCESS (4.135s)
[487.820598] [074/142] (513s left) vgem_basic (dmabuf-fence-before)
[488.107188] Starting subtest: dmabuf-fence-before
[488.127733] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[488.215542] [075/142] (513s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[488.612785] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[490.004208] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.416s)
[490.194298] [076/142] (511s left) gem_exec_params (invalid-flag)
[490.484877] Starting subtest: invalid-flag
[490.505252] Subtest invalid-flag: SUCCESS (0.001s)
[490.598906] [077/142] (510s left) gem_exec_reloc (basic-gtt)
[490.896928] Starting subtest: basic-gtt
[490.915967] Subtest basic-gtt: SUCCESS (0.022s)
[491.120363] [078/142] (510s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[491.558876] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[491.597938] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[491.706611] [079/142] (510s left) kms_universal_plane (disable-primary-vs-flip-pipe-b)
[492.042351] Starting subtest: disable-primary-vs-flip-pipe-B
[493.126819] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (1.073s)
[493.495765] [080/142] (508s left) gem_ctx_engines (execute-oneforall)
[493.790740] Starting subtest: execute-oneforall
[494.498415] Subtest execute-oneforall: SUCCESS (0.713s)
[494.759514] [081/142] (507s left) kms_vblank (pipe-c-wait-forked-busy)
[495.113290] Starting subtest: pipe-C-wait-forked-busy
[498.061982] Subtest pipe-C-wait-forked-busy: SUCCESS (2.935s)
[498.419704] [082/142] (503s left) kms_cursor_crc (cursor-random-512x512)
[498.803740] Starting subtest: cursor-random-512x512
[498.843434] Subtest cursor-random-512x512: SKIP (0.003s)
[498.953371] [083/142] (503s left) gem_exec_balancer (nohangcheck)
[503.283766] Starting subtest: nohangcheck
[507.011827] Subtest nohangcheck: SUCCESS (3.734s)
[507.103440] [084/142] (495s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[507.412422] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[507.499104] [085/142] (494s left) syncobj_timeline (etime-single-wait-all-submitted)
[507.781074] Starting subtest: etime-single-wait-all-submitted
[507.856850] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[507.967089] [086/142] (494s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[508.386683] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[508.423191] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[508.534576] [087/142] (493s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[509.040976] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[509.081511] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[509.620278] [088/142] (493s left) vgem_basic (bad-flag)
[509.906531] Starting subtest: bad-flag
[509.928095] Subtest bad-flag: SUCCESS (0.000s)
[510.035275] [089/142] (492s left) gem_ctx_param (set-priority-not-supported)
[510.333533] Starting subtest: set-priority-not-supported
[510.370827] Subtest set-priority-not-supported: SKIP (0.000s)
[510.479562] [090/142] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[510.896403] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[510.933407] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[511.047051] [091/142] (491s left) perf (non-system-wide-paranoid)
[511.425674] Starting subtest: non-system-wide-paranoid
[511.513540] Subtest non-system-wide-paranoid: SUCCESS (0.113s)
[511.623677] [092/142] (491s left) i915_pm_rc6_residency (rc6-fence)
[511.916415] Starting subtest: rc6-fence
[527.320431] Subtest rc6-fence: SUCCESS (15.247s)
[527.412590] [093/142] (475s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[528.097165] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[528.156901] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[528.508238] [094/142] (474s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs)
[529.251769] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[529.608199] [095/142] (473s left) kms_psr2_sf (overlay-plane-move-continuous-sf)
[529.946872] Subtest overlay-plane-move-continuous-sf: SKIP (0.000s)
[530.073624] [096/142] (473s left) gem_softpin (evict-active-interruptible)
[530.381378] Starting subtest: evict-active-interruptible
[530.399902] Subtest evict-active-interruptible: SUCCESS (0.015s)
[530.533132] [097/142] (473s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[530.967309] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[533.846832] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (2.951s)
[534.011919] [098/142] (469s left) gem_exec_nop (basic-series)
[534.464200] Starting subtest: basic-series
[537.386086] Subtest basic-series: SUCCESS (3.058s)
[537.612291] [099/142] (466s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs)
[538.239771] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs
[538.281561] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[538.672147] [100/142] (465s left) kms_chamelium_frames (dp-crc-single)
[539.153132] Subtest dp-crc-single: SKIP (0.000s)
[539.479841] [101/142] (464s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[539.922653] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[539.960341] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[540.068381] [102/142] (464s left) kms_vblank (pipe-d-wait-busy-hang)
[540.470876] Subtest pipe-D-wait-busy-hang: SKIP (0.000s)
[540.656775] [103/142] (463s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_mc_ccs)
[541.392753] Subtest pipe-D-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[541.724471] [104/142] (462s left) kms_plane_scaling (intel-max-src-size)
[542.079221] Starting subtest: intel-max-src-size
[542.097597] Starting dynamic subtest: pipe-A-DP-1
[542.144059] Dynamic subtest pipe-A-DP-1: SUCCESS (0.051s)
[542.164937] Subtest intel-max-src-size: SUCCESS (0.053s)
[542.275094] [105/142] (462s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[542.566249] Starting subtest: single-wait-all-for-submit-available-signaled
[542.586599] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[542.691307] [106/142] (461s left) kms_vblank (pipe-b-query-idle-hang)
[543.044973] Starting subtest: pipe-B-query-idle-hang
[550.185822] Subtest pipe-B-query-idle-hang: SUCCESS (7.016s)
[550.444709] [107/142] (454s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[550.884033] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[550.920426] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[551.030701] [108/142] (453s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[551.463229] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[551.505587] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[551.612530] [109/142] (453s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[551.967832] Starting subtest: primary-yf-tiled-reflect-x-0
[552.007214] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.003s)
[552.120784] [110/142] (452s left) v3d/v3d_get_param (get-bad-flags)
[552.453953] Subtest get-bad-flags: SKIP (0.000s)
[552.559832] [111/142] (452s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[552.829590] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[552.868464] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[553.043205] [112/142] (452s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[553.435832] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[555.449805] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.067s)
[555.628762] [113/142] (449s left) kms_vblank (pipe-c-wait-forked-hang)
[556.020843] Starting subtest: pipe-C-wait-forked-hang
[563.209652] Subtest pipe-C-wait-forked-hang: SUCCESS (7.062s)
[563.481832] [114/142] (441s left) gem_exec_schedule (submit-late-slice)
[563.998326] Starting subtest: submit-late-slice
[564.021862] Starting dynamic subtest: rcs0
[564.045380] Dynamic subtest rcs0: SUCCESS (0.062s)
[564.086550] Starting dynamic subtest: bcs0
[564.111660] Dynamic subtest bcs0: SUCCESS (0.055s)
[564.151216] Starting dynamic subtest: vcs0
[564.175592] Dynamic subtest vcs0: SUCCESS (0.051s)
[564.215417] Starting dynamic subtest: vecs0
[564.242074] Dynamic subtest vecs0: SUCCESS (0.050s)
[564.265159] Subtest submit-late-slice: SUCCESS (0.231s)
[564.404194] [115/142] (441s left) syncobj_basic (bad-flags-handle-to-fd)
[564.733404] Starting subtest: bad-flags-handle-to-fd
[564.758236] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[564.865286] [116/142] (440s left) api_intel_bb (blit-reloc-keep-cache)
[565.165474] Starting subtest: blit-reloc-keep-cache
[565.186033] Subtest blit-reloc-keep-cache: SUCCESS (0.020s)
[565.287106] [117/142] (440s left) i915_pm_dc (dc5-dpms)
[566.667744] Starting subtest: dc5-dpms
[568.084274] Subtest dc5-dpms: SUCCESS (1.431s)
[568.313465] [118/142] (437s left) gem_pxp (reject-modify-context-protection-on)
[571.297698] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[571.440192] [119/142] (434s left) gem_exec_reloc (basic-write-gtt-active)
[571.730370] Starting subtest: basic-write-gtt-active
[571.850230] Subtest basic-write-gtt-active: SUCCESS (0.139s)
[572.079735] [120/142] (433s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[572.496158] Starting subtest: 4-tiled-32bpp-rotate-0
[572.532556] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[572.643153] [121/142] (433s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[573.273809] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[573.316485] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.005s)
[573.749251] [122/142] (432s left) kms_cursor_crc (cursor-random-128x42)
[574.129035] Starting subtest: cursor-random-128x42
[574.147258] Starting dynamic subtest: pipe-A-DP-1
[577.941668] Dynamic subtest pipe-A-DP-1: SUCCESS (3.803s)
[578.028891] Starting dynamic subtest: pipe-C-DP-1
[582.141623] Dynamic subtest pipe-C-DP-1: SUCCESS (4.131s)
[582.159844] Subtest cursor-random-128x42: SUCCESS (8.012s)
[582.533334] [123/142] (423s left) syncobj_basic (create-signaled)
[582.823400] Starting subtest: create-signaled
[582.843738] Subtest create-signaled: SUCCESS (0.000s)
[582.946710] [124/142] (423s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[583.384119] Starting subtest: fbc-rgb101010-draw-mmap-wc
[586.076649] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.647s)
[586.165781] [125/142] (420s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[586.576402] Starting subtest: fbcpsr-badstride
[586.617326] Subtest fbcpsr-badstride: SKIP (0.000s)
[586.725535] [126/142] (419s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[587.472495] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[587.830781] [127/142] (418s left) gem_exec_store (dword)
[588.206068] Starting subtest: dword
[588.229979] Starting dynamic subtest: rcs0
[588.251534] Dynamic subtest rcs0: SUCCESS (0.038s)
[588.290063] Starting dynamic subtest: bcs0
[588.311082] Dynamic subtest bcs0: SUCCESS (0.020s)
[588.348768] Starting dynamic subtest: vcs0
[588.369443] Dynamic subtest vcs0: SUCCESS (0.014s)
[588.406188] Starting dynamic subtest: vecs0
[588.429090] Dynamic subtest vecs0: SUCCESS (0.019s)
[588.452304] Subtest dword: SUCCESS (0.103s)
[588.572335] [128/142] (418s left) i915_pm_rpm (universal-planes-dpms)
[590.421616] Starting subtest: universal-planes-dpms
[590.442899] Starting dynamic subtest: plane-31
[593.141968] Dynamic subtest plane-31: SUCCESS (2.719s)
[593.184206] Starting dynamic subtest: plane-39
[596.075723] Dynamic subtest plane-39: SUCCESS (2.928s)
[596.116518] Starting dynamic subtest: plane-47
[598.921520] Dynamic subtest plane-47: SUCCESS (2.842s)
[598.967639] Starting dynamic subtest: plane-55
[601.728276] Dynamic subtest plane-55: SUCCESS (2.806s)
[601.749035] Subtest universal-planes-dpms: SUCCESS (11.307s)
[602.172753] [129/142] (404s left) kms_lease (master-vs-lease)
[602.542020] Starting subtest: master-vs-lease
[602.562137] Subtest master-vs-lease: SUCCESS (0.003s)
[602.677187] [130/142] (404s left) core_setmaster (master-drop-set-shared-fd)
[604.759348] Starting subtest: master-drop-set-shared-fd
[604.817202] Subtest master-drop-set-shared-fd: SUCCESS (0.044s)
[604.926067] [131/142] (402s left) kms_atomic_transition (plane-all-modeset-transition)
[605.287211] Starting subtest: plane-all-modeset-transition
[605.307095] Starting dynamic subtest: pipe-A-DP-1
[662.739945] Dynamic subtest pipe-A-DP-1: SUCCESS (57.452s)
[662.883358] Starting dynamic subtest: pipe-B-DP-1
[720.416695] Dynamic subtest pipe-B-DP-1: SUCCESS (57.572s)
[720.538090] Subtest plane-all-modeset-transition: SUCCESS (115.234s)
[720.906243] [132/142] (286s left) kms_psr (psr2_sprite_mmap_gtt)
[721.260202] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[721.369953] [133/142] (285s left) gem_tiled_partial_pwrite_pread (writes)
[721.670294] Starting subtest: writes
[723.837376] Subtest writes: SUCCESS (2.178s)
[723.998182] [134/142] (283s left) kms_vblank (pipe-c-accuracy-idle)
[724.371919] Starting subtest: pipe-C-accuracy-idle
[727.156353] Subtest pipe-C-accuracy-idle: SUCCESS (2.763s)
[727.523203] [135/142] (280s left) kms_async_flips (crc)
[727.898699] Starting subtest: crc
[728.334219] Starting dynamic subtest: pipe-A-DP-1
[736.887183] Dynamic subtest pipe-A-DP-1: FAIL (7.228s)
[736.945914] Starting dynamic subtest: pipe-B-DP-1
[744.614499] Dynamic subtest pipe-B-DP-1: FAIL (6.687s)
[744.683570] Starting dynamic subtest: pipe-C-DP-1
[750.972416] Dynamic subtest pipe-C-DP-1: FAIL (6.464s)
[750.991129] Subtest crc: FAIL (21.620s)
[751.135835] [136/142] (256s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[751.432995] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[751.513893] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[751.651105] [137/142] (256s left) gem_wait (await)
[751.968953] Starting subtest: await
[751.988892] Starting dynamic subtest: all-engines
[753.009450] Dynamic subtest all-engines: SUCCESS (1.039s)
[753.045958] Starting dynamic subtest: rcs0
[754.040411] Dynamic subtest rcs0: SUCCESS (1.026s)
[754.079643] Starting dynamic subtest: bcs0
[755.072285] Dynamic subtest bcs0: SUCCESS (1.030s)
[755.111843] Starting dynamic subtest: vcs0
[756.109768] Dynamic subtest vcs0: SUCCESS (1.032s)
[756.150978] Starting dynamic subtest: vecs0
[757.137094] Dynamic subtest vecs0: SUCCESS (1.026s)
[757.155803] Subtest await: SUCCESS (5.167s)
[757.424370] [138/142] (250s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[757.835488] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[757.877996] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[757.990351] [139/142] (250s left) syncobj_wait (wait-all-delayed-signal)
[758.281580] Starting subtest: wait-all-delayed-signal
[758.351822] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[758.491475] [140/142] (249s left) kms_big_fb (linear-8bpp-rotate-180)
[758.886325] Starting subtest: linear-8bpp-rotate-180
[762.790711] Subtest linear-8bpp-rotate-180: SUCCESS (3.920s)
[763.063159] [141/142] (245s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[763.459686] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[763.480781] Starting dynamic subtest: pipe-A-valid-mode
[764.207326] Dynamic subtest pipe-A-valid-mode: SKIP (0.722s)
[764.249669] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.727s)
[764.643680] [142/142] (243s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[765.081276] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[765.120861] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[765.191717] Closing watchdogs
Done.