[51.790942] Initializing watchdogs
[51.791478]   /dev/watchdog0
[51.807805] [001/141] (960s left) gem_exec_whisper (basic-normal)
[52.072750] Starting subtest: basic-normal
[58.265269] Subtest basic-normal: SUCCESS (6.192s)
[58.459997] [002/141] (953s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[59.346157] Starting subtest: syncobj-timeline-invalid-wait
[59.348530] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[59.576883] [003/141] (952s left) gem_exec_params (invalid-flag)
[59.792990] Starting subtest: invalid-flag
[59.795205] Subtest invalid-flag: SUCCESS (0.001s)
[59.891590] [004/141] (952s left) gem_workarounds (suspend-resume)
[60.129855] Starting subtest: suspend-resume
[76.726816] Subtest suspend-resume: SUCCESS (1.561s)
[82.914896] [005/141] (950s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[83.319858] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[83.606828] [006/141] (949s left) kms_busy (extended-pageflip-hang-oldfb)
[83.940307] Starting subtest: extended-pageflip-hang-oldfb
[83.946429] Starting dynamic subtest: pipe-A
[84.550713] Dynamic subtest pipe-A: SUCCESS (0.605s)
[84.583940] Starting dynamic subtest: pipe-C
[85.212578] Dynamic subtest pipe-C: SUCCESS (0.617s)
[85.215237] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.249s)
[85.603013] [007/141] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[85.925547] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[88.144880] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.226s)
[88.284362] [008/141] (945s left) gem_ctx_param (invalid-get-no-zeromap)
[88.494504] Starting subtest: invalid-get-no-zeromap
[88.496574] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[88.583815] [009/141] (945s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[88.880015] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[88.882426] Starting dynamic subtest: pipe-A-valid-mode
[88.980248] Dynamic subtest pipe-A-valid-mode: SKIP (0.097s)
[88.985493] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.099s)
[89.271332] [010/141] (944s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[89.535902] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[89.605300] [011/141] (944s left) gem_exec_reloc (basic-write-cpu-active)
[89.818890] Starting subtest: basic-write-cpu-active
[89.962457] Subtest basic-write-cpu-active: SUCCESS (0.142s)
[90.155071] [012/141] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[90.467705] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[90.471751] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[90.555046] [013/141] (943s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[90.775518] Starting subtest: y-tiled-ccs-to-yf-tiled
[90.777627] Starting dynamic subtest: smem
[91.165868] Dynamic subtest smem: SUCCESS (0.390s)
[91.167859] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.391s)
[91.373944] [014/141] (942s left) kms_vrr (flip-suspend)
[91.677241] Starting subtest: flip-suspend
[91.681013] Subtest flip-suspend: SKIP (0.000s)
[91.720748] [015/141] (942s left) kms_frontbuffer_tracking (basic)
[92.027801] Starting subtest: basic
[94.848768] Subtest basic: SUCCESS (2.826s)
[94.955090] [016/141] (938s left) gem_mmap_offset (clear)
[95.161643] Starting subtest: clear
[95.164407] Starting dynamic subtest: smem0
[119.214212] Dynamic subtest smem0: SUCCESS (24.048s)
[119.216500] Subtest clear: SUCCESS (24.048s)
[119.573360] [017/141] (914s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[119.879430] Starting subtest: fbc-rgb565-draw-mmap-cpu
[122.049734] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.176s)
[122.173509] [018/141] (911s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[122.487693] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[122.491536] Subtest psr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[122.590225] [019/141] (911s left) kms_color (ctm-negative)
[122.890056] Starting subtest: ctm-negative
[122.892166] Starting dynamic subtest: pipe-A
[123.403998] Dynamic subtest pipe-A: SUCCESS (0.508s)
[123.440240] Starting dynamic subtest: pipe-B
[124.194623] Dynamic subtest pipe-B: SUCCESS (0.797s)
[124.218566] Starting dynamic subtest: pipe-C
[125.117478] Dynamic subtest pipe-C: SUCCESS (0.922s)
[125.119494] Subtest ctm-negative: SUCCESS (2.228s)
[125.455658] [020/141] (908s left) kms_psr (psr2_basic)
[125.663900] Subtest psr2_basic: SKIP (0.000s)
[125.719648] [021/141] (908s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[126.023546] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[126.027503] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[126.120299] [022/141] (908s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs)
[126.743526] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs
[126.747400] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.001s)
[127.139845] [023/141] (907s left) i915_query (query-regions-unallocated)
[127.346299] Starting subtest: query-regions-unallocated
[127.348259] Subtest query-regions-unallocated: SUCCESS (0.000s)
[127.437784] [024/141] (906s left) kms_content_protection (uevent)
[127.766282] Starting subtest: uevent
[127.800136] Starting dynamic subtest: pipe-A-DP-1
[162.280020] Dynamic subtest pipe-A-DP-1: FAIL (34.334s)
[162.282114] Subtest uevent: FAIL (34.497s)
[162.601062] [025/141] (871s left) kms_flip (flip-vs-panning-interruptible)
[162.900622] Starting subtest: flip-vs-panning-interruptible
[162.905256] Starting dynamic subtest: A-DP1
[173.491567] Dynamic subtest A-DP1: SUCCESS (10.586s)
[173.517345] Starting dynamic subtest: B-DP1
[183.990483] Dynamic subtest B-DP1: SUCCESS (10.498s)
[184.012932] Starting dynamic subtest: C-DP1
[194.508185] Dynamic subtest C-DP1: SUCCESS (10.507s)
[194.511784] Subtest flip-vs-panning-interruptible: SUCCESS (31.600s)
[194.946804] [026/141] (839s left) kms_plane_multiple (tiling-x)
[195.253467] Starting subtest: tiling-x
[195.255620] Starting dynamic subtest: pipe-A-DP-1
[196.711904] Dynamic subtest pipe-A-DP-1: SUCCESS (1.459s)
[196.733687] Starting dynamic subtest: pipe-B-DP-1
[198.372627] Dynamic subtest pipe-B-DP-1: SUCCESS (1.656s)
[198.395162] Starting dynamic subtest: pipe-C-DP-1
[200.063223] Dynamic subtest pipe-C-DP-1: SUCCESS (1.686s)
[200.065202] Subtest tiling-x: SUCCESS (4.814s)
[200.419613] [027/141] (833s left) prime_self_import (basic-with_one_bo)
[200.635075] Starting subtest: basic-with_one_bo
[200.642941] Subtest basic-with_one_bo: SUCCESS (0.007s)
[200.728682] [028/141] (833s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[200.933518] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[200.935624] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[201.029661] [029/141] (833s left) gem_exec_reloc (basic-concurrent16)
[201.242900] Starting subtest: basic-concurrent16
[206.732908] Subtest basic-concurrent16: SUCCESS (5.486s)
[206.947430] [030/141] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[207.260886] Starting subtest: psr-1p-primscrn-spr-indfb-move
[207.264836] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[207.362891] [031/141] (827s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[207.684283] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[207.692088] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[207.796644] [032/141] (826s left) gem_exec_reloc (basic-write-wc-noreloc)
[208.013574] Starting subtest: basic-write-wc-noreloc
[208.019189] Subtest basic-write-wc-noreloc: SUCCESS (0.008s)
[208.213332] [033/141] (826s left) prime_busy (hang)
[208.425404] Starting subtest: hang
[208.427728] Starting dynamic subtest: rcs0
[214.931213] Dynamic subtest rcs0: SUCCESS (6.503s)
[214.953544] Starting dynamic subtest: bcs0
[221.906495] Dynamic subtest bcs0: SUCCESS (6.971s)
[221.927733] Starting dynamic subtest: vcs0
[228.945055] Dynamic subtest vcs0: SUCCESS (7.039s)
[228.965809] Starting dynamic subtest: vecs0
[235.920767] Dynamic subtest vecs0: SUCCESS (6.975s)
[235.922776] Subtest hang: SUCCESS (27.493s)
[236.029453] [034/141] (798s left) v3d/v3d_get_bo_offset (get-bad-handle)
[236.291073] Subtest get-bad-handle: SKIP (0.000s)
[236.363333] [035/141] (798s left) kms_addfb_basic (invalid-set-prop)
[236.568098] Starting subtest: invalid-set-prop
[236.570273] Subtest invalid-set-prop: SUCCESS (0.000s)
[236.763778] [036/141] (797s left) gem_ctx_shared (exec-single-timeline)
[236.992492] Starting subtest: exec-single-timeline
[236.994544] Starting dynamic subtest: rcs0
[238.031149] Dynamic subtest rcs0: SUCCESS (1.035s)
[238.058054] Starting dynamic subtest: bcs0
[239.117259] Dynamic subtest bcs0: SUCCESS (1.086s)
[239.142974] Starting dynamic subtest: vcs0
[240.205896] Dynamic subtest vcs0: SUCCESS (1.088s)
[240.232151] Starting dynamic subtest: vecs0
[241.294001] Dynamic subtest vecs0: SUCCESS (1.087s)
[241.296298] Subtest exec-single-timeline: SUCCESS (4.301s)
[241.530962] [037/141] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[241.845238] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[241.849317] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[241.947367] [038/141] (792s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[242.382835] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[242.386946] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[243.028247] [039/141] (791s left) kms_ccs (pipe-b-crc-primary-rotation-180-yf_tiled_ccs)
[243.554772] Starting subtest: pipe-B-crc-primary-rotation-180-yf_tiled_ccs
[244.209961] Subtest pipe-B-crc-primary-rotation-180-yf_tiled_ccs: SUCCESS (0.655s)
[244.836220] [040/141] (790s left) kms_big_fb (linear-16bpp-rotate-90)
[245.157769] Starting subtest: linear-16bpp-rotate-90
[245.241238] Subtest linear-16bpp-rotate-90: SKIP (0.080s)
[245.351701] [041/141] (789s left) kms_dsc (dsc-basic)
[245.650593] Subtest dsc-basic: SKIP (0.000s)
[245.701250] [042/141] (789s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[246.014454] Starting subtest: fbc-rgb565-draw-blt
[248.274656] Subtest fbc-rgb565-draw-blt: SUCCESS (2.264s)
[248.419645] [043/141] (786s left) gem_tiled_blits (interruptible)
[250.105928] Starting subtest: interruptible
[302.096963] Subtest interruptible: SUCCESS (51.991s)
[302.208685] [044/141] (732s left) kms_atomic (plane-cursor-legacy)
[302.930862] Starting subtest: plane-cursor-legacy
[302.987179] Subtest plane-cursor-legacy: SUCCESS (0.056s)
[303.450308] [045/141] (731s left) gem_exec_balancer (individual)
[303.680232] Starting subtest: individual
[307.498992] Subtest individual: SUCCESS (3.818s)
[311.383749] [046/141] (723s left) kms_lease (lease_again)
[311.694620] Starting subtest: lease_again
[311.699175] Starting dynamic subtest: pipe-A-DP-1
[311.702512] Dynamic subtest pipe-A-DP-1: SUCCESS (0.006s)
[311.729685] Starting dynamic subtest: pipe-B-DP-1
[311.731742] Dynamic subtest pipe-B-DP-1: SUCCESS (0.004s)
[311.755226] Starting dynamic subtest: pipe-C-DP-1
[311.757240] Dynamic subtest pipe-C-DP-1: SUCCESS (0.003s)
[311.759181] Subtest lease_again: SUCCESS (0.023s)
[311.815366] [047/141] (723s left) kms_plane_scaling (2x-scaler-multi-pipe)
[312.115539] Starting subtest: 2x-scaler-multi-pipe
[312.119613] Subtest 2x-scaler-multi-pipe: SKIP (0.005s)
[312.215747] [048/141] (723s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[312.514073] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[312.516211] Starting dynamic subtest: pipe-A-valid-mode
[312.606259] Dynamic subtest pipe-A-valid-mode: SKIP (0.087s)
[312.610463] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.091s)
[312.916522] [049/141] (722s left) kms_pipe_crc_basic (hang-read-crc)
[313.231055] Starting subtest: hang-read-crc
[313.233245] Starting dynamic subtest: pipe-A-DP-1
[314.535576] Dynamic subtest pipe-A-DP-1: SUCCESS (1.305s)
[314.560961] Starting dynamic subtest: pipe-B-DP-1
[316.216377] Dynamic subtest pipe-B-DP-1: SUCCESS (1.673s)
[316.241187] Starting dynamic subtest: pipe-C-DP-1
[318.153576] Dynamic subtest pipe-C-DP-1: SUCCESS (1.932s)
[318.157742] Subtest hang-read-crc: SUCCESS (4.926s)
[318.455041] [050/141] (716s left) api_intel_bb (render)
[318.683568] Starting subtest: render
[318.685835] Starting dynamic subtest: render-none-512
[318.770959] Dynamic subtest render-none-512: SUCCESS (0.107s)
[318.794967] Starting dynamic subtest: render-none-reloc-512
[318.877383] Dynamic subtest render-none-reloc-512: SUCCESS (0.104s)
[318.904180] Starting dynamic subtest: render-none-1024
[319.239057] Dynamic subtest render-none-1024: SUCCESS (0.361s)
[319.262297] Starting dynamic subtest: render-none-reloc-1024
[319.598040] Dynamic subtest render-none-reloc-1024: SUCCESS (0.357s)
[319.623469] Starting dynamic subtest: render-x-512
[319.699470] Dynamic subtest render-x-512: SUCCESS (0.101s)
[319.724497] Starting dynamic subtest: render-x-reloc-512
[319.790401] Dynamic subtest render-x-reloc-512: SUCCESS (0.089s)
[319.815096] Starting dynamic subtest: render-x-1024
[320.103680] Dynamic subtest render-x-1024: SUCCESS (0.312s)
[320.127395] Starting dynamic subtest: render-x-reloc-1024
[320.429312] Dynamic subtest render-x-reloc-1024: SUCCESS (0.324s)
[320.453445] Starting dynamic subtest: render-y-512
[320.533475] Dynamic subtest render-y-512: SUCCESS (0.102s)
[320.560518] Starting dynamic subtest: render-y-reloc-512
[320.623654] Dynamic subtest render-y-reloc-512: SUCCESS (0.089s)
[320.649863] Starting dynamic subtest: render-y-1024
[320.934999] Dynamic subtest render-y-1024: SUCCESS (0.310s)
[320.961308] Starting dynamic subtest: render-y-reloc-1024
[321.263815] Dynamic subtest render-y-reloc-1024: SUCCESS (0.327s)
[321.265913] Subtest render: SUCCESS (2.602s)
[321.369845] [051/141] (714s left) v3d/v3d_submit_cl (job-perfmon)
[321.645217] Subtest job-perfmon: SKIP (0.000s)
[321.720886] [052/141] (713s left) kms_cdclk (plane-scaling)
[321.926349] Subtest plane-scaling: SKIP (0.000s)
[321.985946] [053/141] (713s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[322.306914] Starting subtest: 4-tiled-32bpp-rotate-90
[322.311445] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[322.421563] [054/141] (713s left) kms_big_fb (linear-32bpp-rotate-90)
[322.745884] Starting subtest: linear-32bpp-rotate-90
[322.830736] Subtest linear-32bpp-rotate-90: SKIP (0.082s)
[322.954334] [055/141] (712s left) kms_vblank (pipe-d-query-busy-hang)
[323.265099] Subtest pipe-D-query-busy-hang: SKIP (0.000s)
[323.354043] [056/141] (712s left) kms_flip (nonexisting-fb)
[323.641097] Starting subtest: nonexisting-fb
[323.643216] Starting dynamic subtest: A-DP1
[324.171384] Dynamic subtest A-DP1: SUCCESS (0.529s)
[324.194361] Starting dynamic subtest: B-DP1
[324.642325] Dynamic subtest B-DP1: SUCCESS (0.468s)
[324.665135] Starting dynamic subtest: C-DP1
[325.097413] Dynamic subtest C-DP1: SUCCESS (0.455s)
[325.099540] Subtest nonexisting-fb: SUCCESS (1.462s)
[325.500294] [057/141] (710s left) kms_cursor_crc (cursor-sliding-64x21)
[325.801323] Starting subtest: cursor-sliding-64x21
[325.814180] Starting dynamic subtest: pipe-A-DP-1
[329.499687] Dynamic subtest pipe-A-DP-1: SUCCESS (3.684s)
[329.586818] Starting dynamic subtest: pipe-C-DP-1
[333.539208] Dynamic subtest pipe-C-DP-1: SUCCESS (3.981s)
[333.541298] Subtest cursor-sliding-64x21: SUCCESS (7.737s)
[333.901997] [058/141] (701s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[334.230916] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[334.239771] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.004s)
[334.331765] [059/141] (701s left) kms_vblank (pipe-b-wait-forked-busy)
[334.635810] Starting subtest: pipe-B-wait-forked-busy
[337.479876] Subtest pipe-B-wait-forked-busy: SUCCESS (2.843s)
[337.816173] [060/141] (697s left) syncobj_timeline (single-wait-all-available-signaled)
[338.022533] Starting subtest: single-wait-all-available-signaled
[338.024846] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[338.114980] [061/141] (697s left) vc4/vc4_tiling (get-bad-modifier)
[338.373145] Subtest get-bad-modifier: SKIP (0.000s)
[338.448712] [062/141] (697s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[338.764779] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[338.768856] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[338.882300] [063/141] (697s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[340.686903] Starting subtest: dpms-mode-unset-non-lpsp
[342.147857] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.461s)
[344.836551] [064/141] (691s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_mc_ccs)
[345.539789] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs
[345.544687] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[345.875544] [065/141] (690s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_mc_ccs)
[346.402907] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs
[346.407958] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[346.928270] [066/141] (689s left) gem_basic (bad-close)
[347.134931] Starting subtest: bad-close
[347.139025] Subtest bad-close: SUCCESS (0.000s)
[347.229521] [067/141] (688s left) perf_pmu (gt-awake)
[347.437377] Starting subtest: gt-awake
[349.985988] Subtest gt-awake: SUCCESS (2.548s)
[350.095800] [068/141] (686s left) sysfs_heartbeat_interval (invalid)
[350.308548] Starting subtest: invalid
[350.310916] Starting dynamic subtest: vecs0
[350.313196] Dynamic subtest vecs0: SUCCESS (0.001s)
[350.337511] Starting dynamic subtest: vcs0
[350.339471] Dynamic subtest vcs0: SUCCESS (0.001s)
[350.362661] Starting dynamic subtest: bcs0
[350.364644] Dynamic subtest bcs0: SUCCESS (0.001s)
[350.387734] Starting dynamic subtest: rcs0
[350.389912] Dynamic subtest rcs0: SUCCESS (0.001s)
[350.392036] Subtest invalid: SUCCESS (0.010s)
[350.427647] [069/141] (685s left) gem_exec_fair (basic-none)
[350.656759] Starting subtest: basic-none
[350.659094] Starting dynamic subtest: rcs0
[356.320243] Dynamic subtest rcs0: SUCCESS (5.661s)
[356.345900] Starting dynamic subtest: bcs0
[356.349995] Dynamic subtest bcs0: SKIP (0.008s)
[356.379026] Starting dynamic subtest: vcs0
[362.445357] Dynamic subtest vcs0: SUCCESS (6.114s)
[362.469488] Starting dynamic subtest: vecs0
[368.553316] Dynamic subtest vecs0: SUCCESS (6.106s)
[368.555596] Subtest basic-none: SUCCESS (17.896s)
[368.763999] [070/141] (667s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[369.063181] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[369.065484] Starting dynamic subtest: pipe-A-DP-1
[370.066195] Dynamic subtest pipe-A-DP-1: SUCCESS (1.003s)
[370.093977] Starting dynamic subtest: pipe-B-DP-1
[371.324838] Dynamic subtest pipe-B-DP-1: SUCCESS (1.254s)
[371.354233] Starting dynamic subtest: pipe-C-DP-1
[372.266093] Dynamic subtest pipe-C-DP-1: SUCCESS (0.937s)
[372.268672] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.208s)
[372.683988] [071/141] (663s left) gem_ctx_persistence (legacy-engines-mixed-process)
[372.903878] Starting subtest: legacy-engines-mixed-process
[372.912253] Starting dynamic subtest: render
[373.300749] Dynamic subtest render: SUCCESS (0.391s)
[373.325355] Starting dynamic subtest: bsd
[373.653953] Dynamic subtest bsd: SUCCESS (0.351s)
[373.684650] Starting dynamic subtest: blt
[374.027013] Dynamic subtest blt: SUCCESS (0.368s)
[374.052881] Starting dynamic subtest: vebox
[374.374236] Dynamic subtest vebox: SUCCESS (0.347s)
[374.376501] Subtest legacy-engines-mixed-process: SUCCESS (1.472s)
[374.469033] [072/141] (661s left) kms_properties (connector-properties-legacy)
[374.789220] Starting subtest: connector-properties-legacy
[377.072150] Subtest connector-properties-legacy: SUCCESS (2.293s)
[377.380812] [073/141] (658s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[377.713970] Starting subtest: y-tiled-64bpp-rotate-0
[386.717688] Subtest y-tiled-64bpp-rotate-0: SUCCESS (9.001s)
[387.631353] [074/141] (648s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[387.961987] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[387.966580] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[388.105747] [075/141] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[388.438768] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[388.442691] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[388.551393] [076/141] (647s left) gem_close_race (multigpu-basic-process)
[388.793272] Starting subtest: multigpu-basic-process
[388.797849] Subtest multigpu-basic-process: SKIP (0.000s)
[388.997579] [077/141] (647s left) api_intel_bb (full-batch)
[389.200892] Starting subtest: full-batch
[389.206258] Subtest full-batch: SUCCESS (0.006s)
[389.395659] [078/141] (647s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[389.688491] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[389.690569] Starting dynamic subtest: pipe-A-DP-1
[389.783853] Dynamic subtest pipe-A-DP-1: SUCCESS (0.094s)
[389.820739] Starting dynamic subtest: pipe-B-DP-1
[390.150450] Dynamic subtest pipe-B-DP-1: SUCCESS (0.361s)
[390.186170] Starting dynamic subtest: pipe-C-DP-1
[390.244460] Dynamic subtest pipe-C-DP-1: SKIP (0.085s)
[390.246632] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.556s)
[390.658605] [079/141] (645s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[391.375581] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[391.688889] [080/141] (645s left) gem_wait (wait)
[391.930279] Starting subtest: wait
[391.932496] Starting dynamic subtest: all-engines
[392.959655] Dynamic subtest all-engines: SUCCESS (1.027s)
[392.987020] Starting dynamic subtest: rcs0
[393.981625] Dynamic subtest rcs0: SUCCESS (1.021s)
[394.005942] Starting dynamic subtest: bcs0
[395.008634] Dynamic subtest bcs0: SUCCESS (1.026s)
[395.033168] Starting dynamic subtest: vcs0
[396.033676] Dynamic subtest vcs0: SUCCESS (1.023s)
[396.058628] Starting dynamic subtest: vecs0
[397.059294] Dynamic subtest vecs0: SUCCESS (1.024s)
[397.061442] Subtest wait: SUCCESS (5.128s)
[397.309390] [081/141] (639s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb)
[397.511751] Subtest primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[397.574775] [082/141] (639s left) fbdev (write)
[397.795229] Starting subtest: write
[398.528895] Subtest write: SUCCESS (0.733s)
[398.605059] [083/141] (638s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[398.904469] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[398.912345] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.003s)
[399.024194] [084/141] (637s left) i915_hangman (gt-engine-error)
[399.248164] Starting subtest: gt-engine-error
[399.250319] Starting dynamic subtest: rcs0
[399.334706] Dynamic subtest rcs0: SUCCESS (0.087s)
[399.365996] Starting dynamic subtest: bcs0
[399.370679] Dynamic subtest bcs0: SKIP (0.003s)
[399.398623] Starting dynamic subtest: vcs0
[399.418611] Dynamic subtest vcs0: SUCCESS (0.079s)
[399.454080] Starting dynamic subtest: vecs0
[399.506340] Dynamic subtest vecs0: SUCCESS (0.086s)
[399.508440] Subtest gt-engine-error: SUCCESS (0.260s)
[399.605871] [085/141] (637s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[399.915220] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[410.993671] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.080s)
[411.334894] [086/141] (625s left) kms_chamelium_color (ctm-0-50)
[411.649771] Subtest ctm-0-50: SKIP (0.000s)
[411.698284] [087/141] (625s left) kms_vblank (pipe-a-wait-forked)
[411.995675] Starting subtest: pipe-A-wait-forked
[414.338352] Subtest pipe-A-wait-forked: SUCCESS (2.343s)
[414.670886] [088/141] (622s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[414.985184] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[414.989074] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[415.086179] [089/141] (622s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[415.388863] Starting subtest: cursor-vs-flip-toggle
[457.190420] Subtest cursor-vs-flip-toggle: SUCCESS (41.803s)
[457.527923] [090/141] (579s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[457.833715] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[457.838017] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[457.925427] [091/141] (579s left) gem_ctx_param (set-priority-not-supported)
[458.130801] Starting subtest: set-priority-not-supported
[458.134736] Subtest set-priority-not-supported: SKIP (0.000s)
[458.225301] [092/141] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[458.529011] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[460.712827] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.171s)
[460.914345] [093/141] (576s left) kms_sequence (get-idle)
[461.274702] Starting subtest: get-idle
[461.276860] Starting dynamic subtest: DP-1-pipe-A
[463.613249] Dynamic subtest DP-1-pipe-A: SUCCESS (2.336s)
[463.637249] Starting dynamic subtest: DP-1-pipe-B
[466.224137] Dynamic subtest DP-1-pipe-B: SUCCESS (2.608s)
[466.254628] Starting dynamic subtest: DP-1-pipe-C
[468.935281] Dynamic subtest DP-1-pipe-C: SUCCESS (2.705s)
[468.937307] Subtest get-idle: SUCCESS (7.663s)
[469.242758] [094/141] (568s left) gem_exec_schedule (u-semaphore-resolve)
[469.479219] Starting subtest: u-semaphore-resolve
[469.530279] Subtest u-semaphore-resolve: SUCCESS (0.051s)
[469.877366] [095/141] (567s left) gem_exec_reloc (basic-write-read)
[470.091677] Starting subtest: basic-write-read
[470.108295] Subtest basic-write-read: SUCCESS (0.016s)
[470.309515] [096/141] (567s left) i915_pm_rpm (modeset-stress-extra-wait)
[472.113373] Starting subtest: modeset-stress-extra-wait
[525.205141] Subtest modeset-stress-extra-wait: SUCCESS (53.090s)
[525.378848] [097/141] (512s left) i915_pm_backlight (fade-with-dpms)
[525.678175] Subtest fade-with-dpms: SKIP (0.000s)
[525.741465] [098/141] (511s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs)
[526.041633] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs
[526.045571] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[526.754281] [099/141] (510s left) v3d/v3d_wait_bo (unused-bo-0ns)
[527.010586] Subtest unused-bo-0ns: SKIP (0.000s)
[527.087904] [100/141] (510s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[527.395588] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[527.399821] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[527.487529] [101/141] (510s left) prime_mmap (test_refcounting)
[527.691322] Starting subtest: test_refcounting
[527.693409] Starting dynamic subtest: test_refcounting-smem
[527.699348] Dynamic subtest test_refcounting-smem: SUCCESS (0.007s)
[527.701570] Subtest test_refcounting: SUCCESS (0.009s)
[527.804158] [102/141] (509s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[528.113785] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[528.117778] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[528.204673] [103/141] (509s left) gem_userptr_blits (coherency-sync)
[528.447547] Starting subtest: coherency-sync
[529.007223] Subtest coherency-sync: SKIP (0.540s)
[529.168656] [104/141] (508s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[529.776817] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[529.784236] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.005s)
[530.333402] [105/141] (507s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[530.662472] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[532.169495] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.507s)
[532.351590] [106/141] (505s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[532.675620] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[532.679525] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[532.784038] [107/141] (505s left) gem_exec_schedule (pi-ringfull)
[533.163955] Starting subtest: pi-ringfull
[533.166229] Starting dynamic subtest: rcs0
[533.265964] Dynamic subtest rcs0: SUCCESS (0.101s)
[533.293452] Starting dynamic subtest: bcs0
[533.357557] Dynamic subtest bcs0: SUCCESS (0.090s)
[533.384127] Starting dynamic subtest: vcs0
[533.449167] Dynamic subtest vcs0: SUCCESS (0.090s)
[533.475222] Starting dynamic subtest: vecs0
[533.544495] Dynamic subtest vecs0: SUCCESS (0.094s)
[533.546513] Subtest pi-ringfull: SUCCESS (0.381s)
[533.750042] [108/141] (504s left) gem_lmem_swapping (massive)
[533.962238] Subtest massive: SKIP (0.000s)
[534.014913] [109/141] (504s left) kms_cursor_crc (cursor-random-32x32)
[534.316646] Starting subtest: cursor-random-32x32
[534.426296] Subtest cursor-random-32x32: SKIP (0.106s)
[534.549996] [110/141] (503s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[534.859210] Starting subtest: psr-rgb565-draw-mmap-gtt
[534.863168] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[534.949892] [111/141] (503s left) gem_exec_flush (basic-uc-ro-default)
[535.178244] Starting subtest: basic-uc-ro-default
[540.664161] Subtest basic-uc-ro-default: SUCCESS (5.486s)
[540.884520] [112/141] (497s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[541.088624] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[541.091093] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[541.183258] [113/141] (497s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[541.493845] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[541.497758] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[541.600522] [114/141] (496s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[541.806575] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[541.808774] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[541.900364] [115/141] (496s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[542.626305] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[542.936487] [116/141] (495s left) drm_fdinfo (virtual-busy-all)
[543.145841] Starting subtest: virtual-busy-all
[543.148210] Subtest virtual-busy-all: SUCCESS (0.001s)
[543.233725] [117/141] (495s left) gem_pxp (reject-modify-context-protection-on)
[545.956375] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[546.051822] [118/141] (492s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_rc_ccs)
[546.672906] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs
[546.677533] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[547.148493] [119/141] (491s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[547.528907] Starting subtest: short-flip-before-cursor-atomic-transitions
[548.616702] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.112s)
[548.956826] [120/141] (489s left) kms_psr (sprite_plane_onoff)
[549.159495] Subtest sprite_plane_onoff: SKIP (0.000s)
[549.220012] [121/141] (489s left) prime_mmap (test_errors)
[549.418894] Starting subtest: test_errors
[549.421092] Starting dynamic subtest: test_errors-smem
[549.439507] Dynamic subtest test_errors-smem: SUCCESS (0.020s)
[549.441855] Subtest test_errors: SUCCESS (0.021s)
[549.554786] [122/141] (489s left) syncobj_timeline (multi-wait-all-available-submitted)
[549.758564] Starting subtest: multi-wait-all-available-submitted
[549.760837] Subtest multi-wait-all-available-submitted: SUCCESS (0.002s)
[549.854559] [123/141] (488s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[550.159339] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[550.163205] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[550.255230] [124/141] (488s left) gem_ringfill (basic-all)
[550.725522] Starting subtest: basic-all
[551.923268] Subtest basic-all: SUCCESS (1.197s)
[552.055986] [125/141] (486s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[552.357630] Starting subtest: universal-plane-pipe-B-sanity
[553.187960] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.832s)
[553.508668] [126/141] (485s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[553.714959] Starting subtest: etime-multi-wait-all-for-submit-submitted
[553.821244] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[553.908744] [127/141] (485s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[554.619185] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[554.626902] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.004s)
[554.955008] [128/141] (484s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs)
[555.467498] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs
[555.473415] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[556.042639] [129/141] (482s left) gem_gtt_cpu_tlb
[556.376031] [130/141] (482s left) kms_universal_plane (disable-primary-vs-flip-pipe-d)
[556.671465] Subtest disable-primary-vs-flip-pipe-D: SKIP (0.000s)
[556.759014] [131/141] (482s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[557.486613] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[557.788724] [132/141] (481s left) gem_flink_basic (double-flink)
[557.993225] Starting subtest: double-flink
[557.995362] Subtest double-flink: SUCCESS (0.000s)
[558.104828] [133/141] (481s left) gem_lmem_swapping (verify-random)
[558.311790] Subtest verify-random: SKIP (0.000s)
[558.370590] [134/141] (480s left) kms_flip (flip-vs-expired-vblank)
[558.658290] Starting subtest: flip-vs-expired-vblank
[558.660334] Starting dynamic subtest: A-DP1
[569.184491] Dynamic subtest A-DP1: SUCCESS (10.528s)
[569.210276] Starting dynamic subtest: B-DP1
[579.663233] Dynamic subtest B-DP1: SUCCESS (10.477s)
[579.689132] Starting dynamic subtest: C-DP1
[590.123654] Dynamic subtest C-DP1: SUCCESS (10.459s)
[590.125842] Subtest flip-vs-expired-vblank: SUCCESS (31.474s)
[590.540687] [135/141] (448s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[590.847827] Starting subtest: fbcpsr-tiling-linear
[590.851661] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[590.957894] [136/141] (448s left) kms_properties (crtc-properties-atomic)
[591.261564] Starting subtest: crtc-properties-atomic
[592.239433] Subtest crtc-properties-atomic: SUCCESS (0.979s)
[592.581032] [137/141] (446s left) gem_exec_balancer (persistence)
[596.594378] Starting subtest: persistence
[600.261034] Subtest persistence: SUCCESS (3.666s)
[600.347004] [138/141] (439s left) perf (gen8-unprivileged-single-ctx-counters)
[600.690474] Starting subtest: gen8-unprivileged-single-ctx-counters
[600.904917] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.214s)
[600.967016] [139/141] (438s left) gem_spin_batch (spin-all)
[601.193860] Starting subtest: spin-all
[601.219865] Subtest spin-all: SUCCESS (0.026s)
[601.463786] [140/141] (438s left) perf (oa-exponents)
[601.769778] Starting subtest: oa-exponents
[601.772078] Starting dynamic subtest: 0-rcs0
[605.788640] Dynamic subtest 0-rcs0: SUCCESS (4.017s)
[605.790770] Subtest oa-exponents: SUCCESS (4.019s)
[605.859296] [141/141] (433s left) template (a)
[606.063856] Starting subtest: A
[606.066243] Subtest A: SUCCESS (0.000s)
[606.157993] Closing watchdogs
Done.