[69.056532] Initializing watchdogs
[69.056584]   /dev/watchdog0
[69.063716] [001/130] (960s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[69.122391] Starting subtest: cursorB-vs-flipA-varying-size
[69.124987] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[69.203666] [002/130] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[69.268062] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[69.269516] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[69.363600] [003/130] (960s left) gem_exec_reloc (basic-cpu-read-noreloc)
[69.420140] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[69.470436] [004/130] (960s left) gem_exec_reloc (basic-concurrent16)
[69.516190] Subtest basic-concurrent16: SKIP (0.000s)
[69.574930] [005/130] (960s left) dumb_buffer (create-valid-dumb)
[69.619803] Starting subtest: create-valid-dumb
[69.620601] Subtest create-valid-dumb: SUCCESS (0.000s)
[69.727919] [006/130] (959s left) gem_exec_fence (invalid-fence-array)
[70.089760] Starting subtest: invalid-fence-array
[70.091324] Subtest invalid-fence-array: SUCCESS (0.001s)
[70.457067] [007/130] (959s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[70.517853] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[70.518641] Starting dynamic subtest: pipe-A-eDP-1
[70.526646] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.535232] Starting dynamic subtest: pipe-B-eDP-1
[70.544486] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.550767] Starting dynamic subtest: pipe-C-eDP-1
[70.562377] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[70.566839] Starting dynamic subtest: pipe-D-eDP-1
[70.573512] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[70.574736] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.003s)
[72.865418] [008/130] (956s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[72.927237] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[72.928163] Starting dynamic subtest: pipe-A-eDP-1
[72.950058] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[72.954780] Starting dynamic subtest: pipe-B-eDP-1
[72.974993] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[72.979764] Starting dynamic subtest: pipe-C-eDP-1
[73.005516] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[73.017075] Starting dynamic subtest: pipe-D-eDP-1
[73.041312] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[73.043696] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.011s)
[75.322464] [009/130] (954s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[75.375079] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[75.429291] [010/130] (954s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[75.475603] Starting subtest: wait-all-for-submit-delayed-submit
[75.585193] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.106s)
[75.659315] [011/130] (954s left) core_auth (getclient-master-drop)
[75.709425] Starting subtest: getclient-master-drop
[75.711197] Subtest getclient-master-drop: SUCCESS (0.002s)
[75.769886] [012/130] (954s left) gem_ctx_param (get-priority-new-ctx)
[75.816906] Starting subtest: get-priority-new-ctx
[75.817942] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[75.888255] [013/130] (953s left) gem_exec_reloc (basic-gtt-cpu-active)
[75.934113] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[75.996237] [014/130] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[76.055272] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[76.056496] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[76.170043] [015/130] (953s left) gem_close_race (basic-threads)
[76.222064] Starting subtest: basic-threads
[77.529214] Subtest basic-threads: SUCCESS (1.309s)
[77.717049] [016/130] (952s left) kms_atomic (plane-cursor-legacy)
[77.771884] Starting subtest: plane-cursor-legacy
[77.772608] Starting dynamic subtest: pipe-A-eDP-1
[78.210679] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[78.211555] Subtest plane-cursor-legacy: SUCCESS (0.440s)
[79.026212] [017/130] (950s left) prime_mmap (test_aperture_limit)
[79.072487] Starting subtest: test_aperture_limit
[79.073423] Starting dynamic subtest: test_aperture_limit-smem
[79.081708] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.010s)
[79.082604] Subtest test_aperture_limit: SUCCESS (0.010s)
[79.174298] [018/130] (950s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[79.234087] Starting subtest: psr-rgb565-draw-blt
[79.235497] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[79.308893] [019/130] (950s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[79.370391] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[79.391571] [020/130] (950s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[79.439115] Starting subtest: cursorA-vs-flipB-varying-size
[79.440258] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[79.506306] [021/130] (950s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[79.551634] Starting subtest: etime-multi-wait-all-for-submit-submitted
[79.661837] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[79.724944] [022/130] (950s left) kms_flip (absolute-wf_vblank-interruptible)
[79.788682] Starting subtest: absolute-wf_vblank-interruptible
[79.790608] Starting dynamic subtest: A-eDP1
[88.587208] Dynamic subtest A-eDP1: SUCCESS (8.802s)
[88.599641] Starting dynamic subtest: B-eDP1
[97.473335] Dynamic subtest B-eDP1: SUCCESS (8.868s)
[97.479269] Starting dynamic subtest: C-eDP1
[106.299018] Dynamic subtest C-eDP1: SUCCESS (8.847s)
[106.305302] Starting dynamic subtest: D-eDP1
[115.087167] Dynamic subtest D-eDP1: SUCCESS (8.765s)
[115.088214] Subtest absolute-wf_vblank-interruptible: SUCCESS (35.286s)
[116.311659] [023/130] (913s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[116.374186] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[116.378520] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[117.602467] [024/130] (912s left) kms_pm_backlight (bad-brightness)
[117.667087] Starting subtest: bad-brightness
[117.694282] Starting dynamic subtest: eDP-1
[118.010962] Dynamic subtest eDP-1: SUCCESS (0.316s)
[118.011909] Subtest bad-brightness: SUCCESS (0.344s)
[118.889455] [025/130] (911s left) gem_mmap_gtt (medium-copy-xy)
[118.937951] Starting subtest: medium-copy-XY
[125.635870] Subtest medium-copy-XY: SUCCESS (6.698s)
[125.702143] [026/130] (904s left) api_intel_bb (blit-reloc-purge-cache)
[125.770622] Starting subtest: blit-reloc-purge-cache
[125.772446] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[125.885909] [027/130] (904s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[125.948989] Starting subtest: psr-2p-pri-indfb-multidraw
[125.950925] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[126.068880] [028/130] (904s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[126.133796] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[126.151345] [029/130] (903s left) gem_busy (semaphore)
[126.333780] Subtest semaphore: SKIP (0.000s)
[126.570813] [030/130] (903s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[126.620965] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[126.621784] Starting dynamic subtest: pipe-A-valid-mode
[129.476826] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.855s)
[129.477549] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.856s)
[130.332031] [031/130] (899s left) kms_invalid_mode (clock-too-high)
[130.397512] Starting subtest: clock-too-high
[130.398158] Starting dynamic subtest: pipe-A-eDP-1
[130.399585] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[130.405154] Starting dynamic subtest: pipe-B-eDP-1
[130.406726] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[130.411901] Starting dynamic subtest: pipe-C-eDP-1
[130.413585] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[130.418846] Starting dynamic subtest: pipe-D-eDP-1
[130.420559] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[130.422163] Subtest clock-too-high: SKIP (0.003s)
[130.458896] [032/130] (899s left) gem_mmap_gtt (basic-copy)
[130.496225] Starting subtest: basic-copy
[131.039168] Subtest basic-copy: SUCCESS (0.539s)
[131.135158] [033/130] (899s left) gem_exec_schedule (wide)
[131.313166] Starting subtest: wide
[131.314355] Starting dynamic subtest: rcs0
[148.249447] Dynamic subtest rcs0: SUCCESS (16.932s)
[148.256367] Starting dynamic subtest: bcs0
[156.536082] Dynamic subtest bcs0: SUCCESS (8.286s)
[156.546091] Starting dynamic subtest: vcs0
[164.210472] Dynamic subtest vcs0: SUCCESS (7.674s)
[164.220724] Starting dynamic subtest: vcs1
[171.796498] Dynamic subtest vcs1: SUCCESS (7.584s)
[171.807877] Starting dynamic subtest: vecs0
[179.141163] Dynamic subtest vecs0: SUCCESS (7.344s)
[179.142380] Subtest wide: SUCCESS (47.822s)
[180.650725] [034/130] (849s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[180.701350] Starting subtest: flip-vs-cursor-busy-crc-legacy
[181.712956] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (1.013s)
[182.549617] [035/130] (847s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[182.602637] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[182.672482] [036/130] (847s left) gem_pipe_control_store_loop (reused-buffer)
[182.713956] Starting subtest: reused-buffer
[184.903791] Subtest reused-buffer: SUCCESS (2.149s)
[184.975391] [037/130] (845s left) gem_tiled_swapping (non-threaded)
[191.083954] Starting subtest: non-threaded
[192.591377] Subtest non-threaded: FAIL (1.495s)
[193.595350] [038/130] (836s left) gem_exec_balancer (invalid-bonds)
[193.675086] Starting subtest: invalid-bonds
[193.676976] Subtest invalid-bonds: SKIP (0.000s)
[193.949866] [039/130] (836s left) gem_render_copy_redux (normal)
[193.989172] Starting subtest: normal
[194.339048] Subtest normal: SUCCESS (0.350s)
[194.465513] [040/130] (835s left) kms_psr (psr-sprite-mmap-gtt)
[194.522220] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[194.550915] [041/130] (835s left) gem_ctx_param (invalid-size-get)
[194.587422] Starting subtest: invalid-size-get
[194.588259] Subtest invalid-size-get: SUCCESS (0.000s)
[194.648891] [042/130] (835s left) gen9_exec_parse (allowed-single)
[194.698582] Subtest allowed-single: SKIP (0.000s)
[194.715243] [043/130] (835s left) gem_wait (wait)
[194.778592] Starting subtest: wait
[194.779339] Starting dynamic subtest: all-engines
[195.846374] Dynamic subtest all-engines: SUCCESS (1.067s)
[195.856967] Starting dynamic subtest: rcs0
[196.890105] Dynamic subtest rcs0: SUCCESS (1.043s)
[196.908910] Starting dynamic subtest: bcs0
[197.936252] Dynamic subtest bcs0: SUCCESS (1.046s)
[197.946700] Starting dynamic subtest: vcs0
[198.980625] Dynamic subtest vcs0: SUCCESS (1.044s)
[198.999088] Starting dynamic subtest: vcs1
[200.026540] Dynamic subtest vcs1: SUCCESS (1.045s)
[200.045468] Starting dynamic subtest: vecs0
[201.071699] Dynamic subtest vecs0: SUCCESS (1.044s)
[201.073171] Subtest wait: SUCCESS (6.293s)
[201.267979] [044/130] (829s left) drm_fdinfo (memory-info-active)
[201.310162] Starting subtest: memory-info-active
[201.310854] Starting dynamic subtest: smem0
[203.997787] Dynamic subtest smem0: SUCCESS (2.687s)
[203.999056] Subtest memory-info-active: SUCCESS (2.687s)
[204.081645] [045/130] (826s left) syncobj_wait (invalid-signal-illegal-handle)
[204.128199] Starting subtest: invalid-signal-illegal-handle
[204.129228] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[204.199261] [046/130] (826s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[204.268381] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[204.301457] [047/130] (826s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[204.358745] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[206.770054] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.412s)
[206.929557] [048/130] (823s left) gem_userptr_blits (unsync-unmap-cycles)
[206.980202] Subtest unsync-unmap-cycles: SKIP (0.000s)
[207.130819] [049/130] (823s left) gem_render_copy (y-tiled-to-vebox-linear)
[207.178232] Starting subtest: y-tiled-to-vebox-linear
[207.179295] Starting dynamic subtest: smem
[207.241298] Dynamic subtest smem: SUCCESS (0.063s)
[207.242344] Subtest y-tiled-to-vebox-linear: SUCCESS (0.063s)
[207.487244] [050/130] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[207.543797] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[207.545260] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[207.644867] [051/130] (822s left) kms_psr (psr2-primary-render)
[207.695683] Subtest psr2-primary-render: SKIP (0.000s)
[207.758683] [052/130] (822s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[207.818152] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[207.818768] Starting dynamic subtest: pipe-A-eDP-1
[208.423631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[208.431594] Starting dynamic subtest: pipe-B-eDP-1
[210.103141] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.679s)
[210.110839] Starting dynamic subtest: pipe-C-eDP-1
[211.827760] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.719s)
[211.840492] Starting dynamic subtest: pipe-D-eDP-1
[213.544262] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.720s)
[213.545182] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (5.722s)
[214.803028] [053/130] (815s left) gem_userptr_blits (relocations)
[214.856740] Starting subtest: relocations
[214.858560] Subtest relocations: SKIP (0.000s)
[214.995415] [054/130] (815s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[215.060796] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[215.062290] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[215.146415] [055/130] (815s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[215.200688] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[215.201876] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[215.297072] [056/130] (815s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[215.360489] Starting subtest: x-tiled-16bpp-rotate-270
[215.388128] Subtest x-tiled-16bpp-rotate-270: SKIP (0.026s)
[215.527675] [057/130] (815s left) gem_ctx_persistence (engines-hostile-preempt)
[215.565312] Starting subtest: engines-hostile-preempt
[215.566044] Starting dynamic subtest: rcs0
[215.632297] Dynamic subtest rcs0: SUCCESS (0.066s)
[215.650706] Starting dynamic subtest: bcs0
[215.679160] Dynamic subtest bcs0: SUCCESS (0.046s)
[215.698018] Starting dynamic subtest: vcs0
[215.731399] Dynamic subtest vcs0: SUCCESS (0.051s)
[215.748830] Starting dynamic subtest: vcs1
[215.798150] Dynamic subtest vcs1: SUCCESS (0.066s)
[215.817148] Starting dynamic subtest: vecs0
[215.866165] Dynamic subtest vecs0: SUCCESS (0.067s)
[215.867917] Subtest engines-hostile-preempt: SUCCESS (0.300s)
[215.949302] [058/130] (814s left) kms_psr (pr-cursor-mmap-gtt)
[216.012486] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[216.046579] [059/130] (814s left) gem_reg_read (bad-register)
[216.087437] Starting subtest: bad-register
[216.088197] Subtest bad-register: SUCCESS (0.000s)
[216.163077] [060/130] (814s left) gem_exec_schedule (semaphore-codependency)
[216.212393] Starting subtest: semaphore-codependency
[216.217825] Subtest semaphore-codependency: SUCCESS (0.006s)
[216.579408] [061/130] (814s left) gem_ctx_shared (q-independent)
[216.630813] Starting subtest: Q-independent
[216.631865] Starting dynamic subtest: rcs0
[216.649700] Dynamic subtest rcs0: SUCCESS (0.019s)
[216.657021] Starting dynamic subtest: bcs0
[216.664272] Dynamic subtest bcs0: SUCCESS (0.015s)
[216.671813] Starting dynamic subtest: vcs0
[216.679146] Dynamic subtest vcs0: SUCCESS (0.015s)
[216.686238] Starting dynamic subtest: vcs1
[216.694272] Dynamic subtest vcs1: SUCCESS (0.015s)
[216.701822] Starting dynamic subtest: vecs0
[216.710152] Dynamic subtest vecs0: SUCCESS (0.016s)
[216.710987] Subtest Q-independent: SUCCESS (0.080s)
[216.964089] [062/130] (813s left) gem_partial_pwrite_pread (write-snoop)
[217.001059] Subtest write-snoop: SKIP (0.000s)
[217.077250] [063/130] (813s left) kms_color (ctm-0-25)
[217.130367] Starting subtest: ctm-0-25
[217.131301] Starting dynamic subtest: pipe-A-eDP-1
[220.617544] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[220.625716] Starting dynamic subtest: pipe-B-eDP-1
[224.783143] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.165s)
[224.790995] Starting dynamic subtest: pipe-C-eDP-1
[228.960162] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.177s)
[228.967971] Starting dynamic subtest: pipe-D-eDP-1
[233.147301] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.187s)
[233.148294] Subtest ctm-0-25: SUCCESS (16.017s)
[234.043600] [064/130] (796s left) kms_cursor_crc (cursor-size-change)
[234.109728] Starting subtest: cursor-size-change
[234.110645] Starting dynamic subtest: pipe-A-eDP-1
[234.979809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.870s)
[234.988727] Starting dynamic subtest: pipe-D-eDP-1
[236.529943] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.549s)
[236.530829] Subtest cursor-size-change: SUCCESS (2.421s)
[237.350088] [065/130] (793s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[237.410090] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[237.412146] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[237.498362] [066/130] (793s left) kms_chamelium_frames (dp-crc-single)
[237.859541] Subtest dp-crc-single: SKIP (0.000s)
[238.708873] [067/130] (792s left) kms_cursor_crc (cursor-offscreen-256x85)
[238.767343] Starting subtest: cursor-offscreen-256x85
[238.770935] Starting dynamic subtest: pipe-A-eDP-1
[241.388829] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.617s)
[241.415253] Starting dynamic subtest: pipe-D-eDP-1
[244.669299] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.260s)
[244.670640] Subtest cursor-offscreen-256x85: SUCCESS (5.901s)
[245.538169] [068/130] (785s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[245.582739] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[245.583407] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[245.651174] [069/130] (785s left) kms_pm_rpm (universal-planes-dpms)
[246.854158] Starting subtest: universal-planes-dpms
[246.855912] Starting dynamic subtest: plane-32
[255.014065] Dynamic subtest plane-32: SUCCESS (8.157s)
[255.034692] Starting dynamic subtest: plane-41
[263.208054] Dynamic subtest plane-41: SUCCESS (8.191s)
[263.225584] Starting dynamic subtest: plane-50
[271.399147] Dynamic subtest plane-50: SUCCESS (8.190s)
[271.408651] Starting dynamic subtest: plane-59
[279.649116] Dynamic subtest plane-59: SUCCESS (8.248s)
[279.671356] Starting dynamic subtest: plane-68
[287.906352] Dynamic subtest plane-68: SUCCESS (8.255s)
[287.923162] Starting dynamic subtest: plane-77
[296.166173] Dynamic subtest plane-77: SUCCESS (8.257s)
[296.168050] Subtest universal-planes-dpms: SUCCESS (49.312s)
[296.531895] [070/130] (734s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[296.588119] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[296.588896] Starting dynamic subtest: pipe-A-eDP-1
[296.595955] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[296.603368] Starting dynamic subtest: pipe-B-eDP-1
[296.609508] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[296.616657] Starting dynamic subtest: pipe-C-eDP-1
[296.623290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[296.630158] Starting dynamic subtest: pipe-D-eDP-1
[296.637115] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[296.638523] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[299.002863] [071/130] (732s left) kms_feature_discovery (psr2)
[299.063254] Starting subtest: psr2
[299.064807] Subtest psr2: SKIP (0.000s)
[299.135433] [072/130] (731s left) i915_query (query-regions-sanity-check)
[299.174533] Starting subtest: query-regions-sanity-check
[299.187040] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[299.336574] [073/130] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[299.390642] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[299.392211] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[299.485086] [074/130] (731s left) kms_cursor_crc (cursor-random-64x64)
[299.545641] Starting subtest: cursor-random-64x64
[299.548880] Starting dynamic subtest: pipe-A-eDP-1
[303.479839] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.930s)
[303.507121] Starting dynamic subtest: pipe-D-eDP-1
[308.035838] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.535s)
[308.036704] Subtest cursor-random-64x64: SUCCESS (8.490s)
[308.950014] [075/130] (722s left) syncobj_wait (multi-wait-all-submitted-signaled)
[308.991750] Starting subtest: multi-wait-all-submitted-signaled
[309.102130] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[309.169110] [076/130] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[309.231683] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[311.206710] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.976s)
[311.367871] [077/130] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[311.424600] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[311.425983] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[311.515134] [078/130] (719s left) gem_pxp (reject-modify-context-protection-on)
[311.629389] Starting subtest: reject-modify-context-protection-on
[311.631037] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[311.765487] [079/130] (719s left) kms_vblank (query-forked-busy)
[311.813975] Starting subtest: query-forked-busy
[311.814711] Starting dynamic subtest: pipe-A-eDP-1
[314.774160] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.958s)
[314.789237] Starting dynamic subtest: pipe-D-eDP-1
[318.396895] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.617s)
[318.397708] Subtest query-forked-busy: SUCCESS (6.582s)
[319.235782] [080/130] (712s left) gem_softpin (evict-single-offset)
[319.280762] Starting subtest: evict-single-offset
[343.266861] Subtest evict-single-offset: SUCCESS (23.984s)
[343.350264] [081/130] (687s left) gem_exec_params (sol-reset-not-gen7)
[343.420158] Starting subtest: sol-reset-not-gen7
[343.421086] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[343.531412] [082/130] (687s left) gem_exec_flush (basic-uc-set-default)
[343.573797] Starting subtest: basic-uc-set-default
[349.040585] Subtest basic-uc-set-default: SUCCESS (5.466s)
[349.220297] [083/130] (682s left) kms_cursor_crc (cursor-sliding-128x128)
[349.287650] Starting subtest: cursor-sliding-128x128
[349.291509] Starting dynamic subtest: pipe-A-eDP-1
[353.107530] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.817s)
[353.133895] Starting dynamic subtest: pipe-D-eDP-1
[357.582774] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.454s)
[357.583838] Subtest cursor-sliding-128x128: SUCCESS (8.294s)
[358.431633] [084/130] (672s left) kms_vrr (lobf)
[358.485532] Starting subtest: lobf
[358.486710] Subtest lobf: SKIP (0.000s)
[358.561233] [085/130] (672s left) gem_lmem_swapping (parallel-random-engines)
[358.617661] Subtest parallel-random-engines: SKIP (0.000s)
[358.638157] [086/130] (672s left) perf (blocking-parameterized)
[358.844628] Starting subtest: blocking-parameterized
[378.900602] Subtest blocking-parameterized: SUCCESS (20.017s)
[378.923081] [087/130] (652s left) kms_big_fb (y-tiled-addfb)
[378.986819] Starting subtest: y-tiled-addfb
[378.987584] Subtest y-tiled-addfb: SUCCESS (0.001s)
[379.090361] [088/130] (652s left) kms_flip (plain-flip-ts-check-interruptible)
[379.148928] Starting subtest: plain-flip-ts-check-interruptible
[379.149842] Starting dynamic subtest: A-eDP1
[388.117733] Dynamic subtest A-eDP1: SUCCESS (8.956s)
[388.132610] Starting dynamic subtest: B-eDP1
[397.090609] Dynamic subtest B-eDP1: SUCCESS (8.957s)
[397.098795] Starting dynamic subtest: C-eDP1
[406.045613] Dynamic subtest C-eDP1: SUCCESS (8.980s)
[406.056715] Starting dynamic subtest: D-eDP1
[415.049166] Dynamic subtest D-eDP1: SUCCESS (8.974s)
[415.050748] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.878s)
[416.241202] [089/130] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[416.302977] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[416.304454] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[416.391168] [090/130] (615s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[416.451924] Starting subtest: psr-farfromfence-mmap-gtt
[416.453475] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[416.549069] [091/130] (615s left) kms_pm_backlight (fade-with-dpms)
[416.605223] Starting subtest: fade-with-dpms
[418.743806] Starting dynamic subtest: eDP-1
[421.430442] Dynamic subtest eDP-1: SUCCESS (2.688s)
[421.431995] Subtest fade-with-dpms: SUCCESS (4.825s)
[422.301605] [092/130] (609s left) kms_joiner (basic-force-big-joiner)
[422.358820] Starting subtest: basic-force-big-joiner
[422.359462] Starting dynamic subtest: single
[425.940298] Dynamic subtest single: SUCCESS (3.582s)
[425.941958] Subtest basic-force-big-joiner: SUCCESS (3.584s)
[427.167169] [093/130] (604s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[427.233233] Starting subtest: 4-tiled-32bpp-rotate-0
[427.234840] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[427.334879] [094/130] (604s left) gem_sync (basic-many-each)
[427.391675] Starting subtest: basic-many-each
[429.647291] Subtest basic-many-each: SUCCESS (2.255s)
[429.844583] [095/130] (601s left) kms_busy (extended-modeset-hang-oldfb)
[429.909634] Starting subtest: extended-modeset-hang-oldfb
[429.910578] Starting dynamic subtest: pipe-A
[441.807188] Dynamic subtest pipe-A: SUCCESS (11.896s)
[441.817875] Starting dynamic subtest: pipe-D
[454.576945] Dynamic subtest pipe-D: SUCCESS (12.765s)
[454.577749] Subtest extended-modeset-hang-oldfb: SUCCESS (24.668s)
[455.490189] [096/130] (576s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[455.559035] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[455.560917] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[455.654695] [097/130] (576s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[455.710612] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[455.711872] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[455.823869] [098/130] (575s left) kms_psr (fbc-pr-primary-blt)
[455.884874] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[455.918387] [099/130] (575s left) kms_addfb_basic (basic)
[455.955723] Starting subtest: basic
[455.956898] Subtest basic: SUCCESS (0.000s)
[456.055339] [100/130] (575s left) i915_pm_rpm (sysfs-read)
[457.548930] Starting subtest: sysfs-read
[458.695227] Subtest sysfs-read: SUCCESS (1.139s)
[459.045549] [101/130] (572s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[459.100899] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[459.123681] [102/130] (572s left) kms_plane_lowres (tiling-y)
[459.176138] Starting subtest: tiling-y
[459.176954] Starting dynamic subtest: pipe-A-eDP-1
[459.178439] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[459.488652] Starting dynamic subtest: pipe-B-eDP-1
[459.490445] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[459.497910] Starting dynamic subtest: pipe-C-eDP-1
[459.499633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[459.507090] Starting dynamic subtest: pipe-D-eDP-1
[459.508784] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[459.510336] Subtest tiling-y: SKIP (0.312s)
[460.341609] [103/130] (571s left) vgem_basic (dmabuf-export)
[460.392269] Starting subtest: dmabuf-export
[460.435998] Subtest dmabuf-export: SUCCESS (0.044s)
[460.526962] [104/130] (571s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[460.587186] Starting subtest: plane-all-modeset-transition-internal-panels
[460.589019] Starting dynamic subtest: pipe-A-eDP-1
[461.973733] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.381s)
[462.278762] Starting dynamic subtest: pipe-B-eDP-1
[463.361830] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.095s)
[463.637036] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (3.043s)
[464.518144] [105/130] (567s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[464.570386] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[464.675989] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[464.755740] [106/130] (567s left) api_intel_allocator (alloc-simple)
[464.806087] Starting subtest: alloc-simple
[464.806893] Subtest alloc-simple: SUCCESS (0.001s)
[464.938052] [107/130] (567s left) gem_exec_whisper (basic-queues-all)
[464.986729] Starting subtest: basic-queues-all
[469.221780] Subtest basic-queues-all: SUCCESS (4.233s)
[469.407342] [108/130] (562s left) kms_chamelium_frames (hdmi-crc-single)
[469.779225] Subtest hdmi-crc-single: SKIP (0.000s)
[470.612681] [109/130] (561s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[470.665115] Starting subtest: dsc-fractional-bpp-with-bpc
[470.666928] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[470.730100] [110/130] (561s left) gem_mmap_gtt (flink-race)
[470.781399] Starting subtest: flink-race
[490.973427] Subtest flink-race: SUCCESS (20.151s)
[491.051597] [111/130] (541s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[491.113629] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[491.703018] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.590s)
[491.869280] [112/130] (540s left) gem_mmap_offset (oob-read)
[491.905531] Starting subtest: oob-read
[491.906185] Subtest oob-read: SUCCESS (0.000s)
[492.017901] [113/130] (540s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[492.070885] Starting subtest: fbcpsr-stridechange
[492.072772] Subtest fbcpsr-stridechange: SKIP (0.000s)
[492.183864] [114/130] (539s left) syncobj_basic (bad-flags-handle-to-fd)
[492.232089] Starting subtest: bad-flags-handle-to-fd
[492.232883] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[492.298682] [115/130] (539s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[492.355336] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[492.356067] Starting dynamic subtest: pipe-A
[493.510366] Dynamic subtest pipe-A: SUCCESS (1.156s)
[493.525151] Starting dynamic subtest: pipe-B
[494.697053] Dynamic subtest pipe-B: SUCCESS (1.185s)
[494.723035] Starting dynamic subtest: pipe-C
[495.886629] Dynamic subtest pipe-C: SUCCESS (1.187s)
[495.911134] Starting dynamic subtest: pipe-D
[497.083671] Dynamic subtest pipe-D: SUCCESS (1.194s)
[497.085642] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (4.731s)
[498.278165] [116/130] (533s left) gem_exec_balancer (bonded-dual)
[498.332479] Starting subtest: bonded-dual
[498.334159] Subtest bonded-dual: SKIP (0.000s)
[498.621590] [117/130] (533s left) kms_pipe_crc_basic (nonblocking-crc)
[498.677959] Starting subtest: nonblocking-crc
[498.680573] Starting dynamic subtest: pipe-A-eDP-1
[499.507986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s)
[499.518487] Starting dynamic subtest: pipe-B-eDP-1
[501.040676] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.530s)
[501.051555] Starting dynamic subtest: pipe-C-eDP-1
[502.527306] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.484s)
[502.543851] Starting dynamic subtest: pipe-D-eDP-1
[504.043625] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.512s)
[504.044636] Subtest nonblocking-crc: SUCCESS (5.364s)
[504.910988] [118/130] (527s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[504.973852] Starting subtest: yf-tiled-64bpp-rotate-180
[504.975467] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[505.082282] [119/130] (527s left) gem_mmap_gtt (basic-wc)
[505.122537] Starting subtest: basic-wc
[505.756651] Subtest basic-wc: SUCCESS (0.630s)
[505.860785] [120/130] (526s left) kms_display_modes (mst-extended-mode-negative)
[505.918949] Starting subtest: mst-extended-mode-negative
[505.920847] Subtest mst-extended-mode-negative: SKIP (0.000s)
[505.937652] [121/130] (526s left) i915_pm_freq_api (freq-basic-api)
[505.976142] Starting subtest: freq-basic-api
[505.976883] Starting dynamic subtest: gt0
[505.980555] Dynamic subtest gt0: SUCCESS (0.004s)
[505.981258] Subtest freq-basic-api: SUCCESS (0.004s)
[506.060271] [122/130] (526s left) gem_fence_thrash (bo-write-verify-threaded-none)
[506.093401] Starting subtest: bo-write-verify-threaded-none
[510.287886] Subtest bo-write-verify-threaded-none: SUCCESS (4.191s)
[510.407999] [123/130] (521s left) gem_exec_fence (syncobj-unused-fence)
[510.742510] Starting subtest: syncobj-unused-fence
[510.744336] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[511.116530] [124/130] (521s left) sysfs_preempt_timeout (invalid)
[511.156336] Starting subtest: invalid
[511.157183] Starting dynamic subtest: vecs0
[511.158262] Dynamic subtest vecs0: SUCCESS (0.000s)
[511.173112] Starting dynamic subtest: vcs0
[511.174164] Dynamic subtest vcs0: SUCCESS (0.000s)
[511.183430] Starting dynamic subtest: bcs0
[511.184534] Dynamic subtest bcs0: SUCCESS (0.000s)
[511.198886] Starting dynamic subtest: rcs0
[511.199858] Dynamic subtest rcs0: SUCCESS (0.000s)
[511.208143] Starting dynamic subtest: vcs1
[511.209146] Dynamic subtest vcs1: SUCCESS (0.000s)
[511.210129] Subtest invalid: SUCCESS (0.005s)
[511.225464] [125/130] (521s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[511.262162] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[511.263179] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[511.330344] [126/130] (521s left) perf_pmu (event-wait)
[511.366375] Starting subtest: event-wait
[511.367210] Starting dynamic subtest: rcs0
[511.369162] Dynamic subtest rcs0: SKIP (0.000s)
[511.371175] Subtest event-wait: SKIP (0.001s)
[511.448484] [127/130] (520s left) gem_ctx_isolation (clean)
[511.494715] Starting subtest: clean
[511.495318] Starting dynamic subtest: rcs0
[511.514669] Dynamic subtest rcs0: SUCCESS (0.019s)
[511.523084] Starting dynamic subtest: bcs0
[511.607868] Dynamic subtest bcs0: SUCCESS (0.092s)
[511.616114] Starting dynamic subtest: vcs0
[511.691798] Dynamic subtest vcs0: SUCCESS (0.083s)
[511.700181] Starting dynamic subtest: vcs1
[511.774440] Dynamic subtest vcs1: SUCCESS (0.082s)
[511.782960] Starting dynamic subtest: vecs0
[511.860409] Dynamic subtest vecs0: SUCCESS (0.085s)
[511.861400] Subtest clean: SUCCESS (0.366s)
[512.115508] [128/130] (520s left) prime_vgem (wait)
[512.209116] Starting subtest: wait
[512.210286] Starting dynamic subtest: rcs0
[512.257823] Dynamic subtest rcs0: SUCCESS (0.048s)
[512.275830] Starting dynamic subtest: bcs0
[512.324947] Dynamic subtest bcs0: SUCCESS (0.065s)
[512.343253] Starting dynamic subtest: vcs0
[512.365945] Dynamic subtest vcs0: SUCCESS (0.039s)
[512.382272] Starting dynamic subtest: vcs1
[512.406997] Dynamic subtest vcs1: SUCCESS (0.039s)
[512.423219] Starting dynamic subtest: vecs0
[512.447884] Dynamic subtest vecs0: SUCCESS (0.039s)
[512.449382] Subtest wait: SUCCESS (0.240s)
[512.585072] [129/130] (519s left) gem_ppgtt (shrink-vs-evict-any)
[512.628680] Starting subtest: shrink-vs-evict-any
[517.873664] Subtest shrink-vs-evict-any: SUCCESS (5.240s)
[517.977567] [130/130] (514s left) gem_softpin (overlap)
[518.021782] Starting subtest: overlap
[518.703957] Subtest overlap: SUCCESS (0.678s)
[518.834791] Closing watchdogs
Done.