[43.725460] Initializing watchdogs
[43.725517]   /dev/watchdog0
[43.740587] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[43.745391] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.747883] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.749661] [001/130] (960s left) gem_ctx_param (root-set)
[43.876726] Starting subtest: root-set
[43.877535] Subtest root-set: SUCCESS (0.000s)
[43.931642] [002/130] (960s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[44.021932] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[44.023053] Starting dynamic subtest: pipe-A
[44.159476] Dynamic subtest pipe-A: SUCCESS (0.138s)
[44.165894] Starting dynamic subtest: pipe-B
[44.302978] Dynamic subtest pipe-B: SUCCESS (0.143s)
[44.307961] Starting dynamic subtest: pipe-C
[44.443982] Dynamic subtest pipe-C: SUCCESS (0.141s)
[44.449837] Starting dynamic subtest: pipe-D
[44.594598] Dynamic subtest pipe-D: SUCCESS (0.150s)
[44.595713] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.574s)
[44.765346] [003/130] (959s left) kms_psr (fbc-psr2-primary-blt)
[44.856476] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[44.892821] [004/130] (959s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[44.980636] Starting subtest: 2x-flip-vs-cursor-atomic
[44.983260] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[45.032147] [005/130] (959s left) kms_vblank (ts-continuation-idle)
[45.120554] Starting subtest: ts-continuation-idle
[45.121292] Starting dynamic subtest: pipe-A-HDMI-A-1
[45.289368] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.168s)
[45.297327] Starting dynamic subtest: pipe-D-HDMI-A-1
[45.428548] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.137s)
[45.429289] Subtest ts-continuation-idle: SUCCESS (0.309s)
[45.568608] [006/130] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[45.667938] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[45.669491] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[45.744717] [007/130] (958s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[45.835726] Starting subtest: fbc-2p-pri-indfb-multidraw
[45.837171] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[45.903300] [008/130] (958s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[45.991779] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[45.992544] Starting dynamic subtest: pipe-A-HDMI-A-1
[46.666080] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.669s)
[46.676729] Starting dynamic subtest: pipe-B-HDMI-A-1
[47.178875] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.506s)
[47.189376] Starting dynamic subtest: pipe-C-HDMI-A-1
[47.702579] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.515s)
[47.712978] Starting dynamic subtest: pipe-D-HDMI-A-1
[48.217041] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.506s)
[48.218382] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (2.206s)
[48.425580] [009/130] (956s left) drm_fdinfo (busy-hang)
[48.467686] Starting subtest: busy-hang
[48.468469] Starting dynamic subtest: rcs0
[49.502906] Dynamic subtest rcs0: SUCCESS (1.023s)
[49.508268] Starting dynamic subtest: bcs0
[50.536834] Dynamic subtest bcs0: SUCCESS (1.026s)
[50.543819] Starting dynamic subtest: vcs0
[51.574822] Dynamic subtest vcs0: SUCCESS (1.030s)
[51.581888] Starting dynamic subtest: vcs1
[52.611777] Dynamic subtest vcs1: SUCCESS (1.030s)
[52.618737] Starting dynamic subtest: vecs0
[53.641102] Dynamic subtest vecs0: SUCCESS (1.023s)
[53.642416] Subtest busy-hang: SUCCESS (5.135s)
[53.707302] [010/130] (950s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[53.743333] Starting subtest: multi-wait-available-submitted-signaled
[53.744043] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[53.806980] [011/130] (950s left) gem_madvise (dontneed-before-exec)
[53.842711] Starting subtest: dontneed-before-exec
[53.844277] Subtest dontneed-before-exec: SUCCESS (0.003s)
[53.962593] [012/130] (950s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[54.052809] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[54.053516] Starting dynamic subtest: pipe-A-HDMI-A-1
[54.060311] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[54.064992] Starting dynamic subtest: pipe-B-HDMI-A-1
[54.071860] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[54.076437] Starting dynamic subtest: pipe-C-HDMI-A-1
[54.083186] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[54.087642] Starting dynamic subtest: pipe-D-HDMI-A-1
[54.094464] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[54.095806] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[54.260335] [013/130] (950s left) gem_exec_balancer (invalid-bonds)
[54.309045] Starting subtest: invalid-bonds
[54.312068] Subtest invalid-bonds: SUCCESS (0.003s)
[54.497932] [014/130] (950s left) gem_userptr_blits (process-exit-busy)
[54.546689] Starting subtest: process-exit-busy
[54.563300] Subtest process-exit-busy: SUCCESS (0.017s)
[54.663150] [015/130] (950s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[54.755586] Starting subtest: fbcpsr-tiling-y
[54.756986] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[54.848128] [016/130] (949s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[54.939502] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[56.280597] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (1.336s)
[56.411325] [017/130] (948s left) kms_chamelium_audio (hdmi-audio)
[56.556715] Subtest hdmi-audio: SKIP (0.000s)
[56.640431] [018/130] (948s left) gem_pxp (reject-modify-context-protection-on)
[56.747032] Starting subtest: reject-modify-context-protection-on
[56.748211] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[56.819625] [019/130] (948s left) kms_busy (extended-modeset-hang-oldfb)
[56.910620] Starting subtest: extended-modeset-hang-oldfb
[56.911429] Starting dynamic subtest: pipe-A
[67.442485] Dynamic subtest pipe-A: SUCCESS (10.512s)
[67.451966] Starting dynamic subtest: pipe-D
[78.161906] Dynamic subtest pipe-D: SUCCESS (10.711s)
[78.162834] Subtest extended-modeset-hang-oldfb: SUCCESS (21.229s)
[78.281654] [020/130] (926s left) gem_ctx_isolation (preservation-s3)
[78.329601] Starting subtest: preservation-S3
[78.330443] Starting dynamic subtest: rcs0
[94.782902] Dynamic subtest rcs0: SUCCESS (1.565s)
[94.788533] Starting dynamic subtest: bcs0
[111.746704] Dynamic subtest bcs0: SUCCESS (1.537s)
[111.753600] Starting dynamic subtest: vcs0
[128.738573] Dynamic subtest vcs0: SUCCESS (1.548s)
[128.744208] Starting dynamic subtest: vcs1
[145.715693] Dynamic subtest vcs1: SUCCESS (1.564s)
[145.721262] Starting dynamic subtest: vecs0
[162.736219] Dynamic subtest vecs0: SUCCESS (1.531s)
[162.737011] Subtest preservation-S3: SUCCESS (7.746s)
[170.983463] [021/130] (918s left) gem_ctx_shared (q-in-order)
[171.037888] Starting subtest: Q-in-order
[171.038706] Starting dynamic subtest: rcs0
[171.113639] Dynamic subtest rcs0: SUCCESS (0.074s)
[171.124059] Starting dynamic subtest: bcs0
[171.162730] Dynamic subtest bcs0: SUCCESS (0.048s)
[171.173992] Starting dynamic subtest: vcs0
[171.209648] Dynamic subtest vcs0: SUCCESS (0.045s)
[171.221969] Starting dynamic subtest: vcs1
[171.259855] Dynamic subtest vcs1: SUCCESS (0.049s)
[171.271084] Starting dynamic subtest: vecs0
[171.307719] Dynamic subtest vecs0: SUCCESS (0.046s)
[171.309120] Subtest Q-in-order: SUCCESS (0.267s)
[171.487548] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[171.492076] [022/130] (918s left) perf_pmu (most-busy-check-all)
[171.530049] Starting subtest: most-busy-check-all
[171.530776] Starting dynamic subtest: rcs0
[172.054122] Dynamic subtest rcs0: SUCCESS (0.518s)
[172.063036] Starting dynamic subtest: bcs0
[172.579137] Dynamic subtest bcs0: SUCCESS (0.519s)
[172.588968] Starting dynamic subtest: vcs0
[173.108132] Dynamic subtest vcs0: SUCCESS (0.523s)
[173.117837] Starting dynamic subtest: vcs1
[173.634075] Dynamic subtest vcs1: SUCCESS (0.520s)
[173.643341] Starting dynamic subtest: vecs0
[174.164423] Dynamic subtest vecs0: SUCCESS (0.525s)
[174.165631] Subtest most-busy-check-all: SUCCESS (2.608s)
[174.234132] [023/130] (915s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[174.331960] Starting subtest: addfb25-x-tiled-mismatch-legacy
[174.332725] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[174.397370] [024/130] (915s left) kms_cursor_crc (cursor-onscreen-64x21)
[174.486441] Starting subtest: cursor-onscreen-64x21
[174.491775] Starting dynamic subtest: pipe-A-HDMI-A-1
[175.691487] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.190s)
[175.722952] Starting dynamic subtest: pipe-D-HDMI-A-1
[176.860584] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.138s)
[176.861329] Subtest cursor-onscreen-64x21: SUCCESS (2.358s)
[176.995122] [025/130] (912s left) gem_mmap_wc (coherency)
[177.033384] Starting subtest: coherency
[177.107317] Subtest coherency: SUCCESS (0.073s)
[177.204416] [026/130] (912s left) gem_exec_parallel (engines)
[177.249298] Starting subtest: engines
[177.250053] Starting dynamic subtest: basic
[178.766051] Dynamic subtest basic: SUCCESS (1.509s)
[178.776262] Starting dynamic subtest: contexts
[181.379867] Dynamic subtest contexts: SUCCESS (2.594s)
[181.386087] Starting dynamic subtest: fds
[185.760124] Dynamic subtest fds: SUCCESS (4.376s)
[185.777372] Starting dynamic subtest: userptr
[187.381824] Dynamic subtest userptr: SUCCESS (1.618s)
[187.382630] Subtest engines: SUCCESS (10.099s)
[187.564624] [027/130] (902s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[187.604566] Starting subtest: invalid-bsd2-flag-on-vebox
[187.605393] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[187.728674] [028/130] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[187.821801] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[187.823265] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[187.917481] [029/130] (902s left) gem_exec_fence (submit-chain)
[188.091953] Starting subtest: submit-chain
[188.102115] Subtest submit-chain: SUCCESS (0.010s)
[188.581051] [030/130] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[188.674628] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[188.676037] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[188.768805] [031/130] (901s left) gem_exec_params (no-bsd)
[188.808298] Starting subtest: no-bsd
[188.809076] Subtest no-bsd: SUCCESS (0.001s)
[188.912094] [032/130] (901s left) kms_psr (psr2-sprite-mmap-cpu)
[189.000412] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[189.036592] [033/130] (901s left) gem_exec_whisper (basic-contexts-priority-all)
[189.081720] Starting subtest: basic-contexts-priority-all
[192.323142] Subtest basic-contexts-priority-all: SUCCESS (3.227s)
[192.487292] [034/130] (897s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[192.575699] Starting subtest: primary-yf-tiled-reflect-x-270
[192.624064] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.048s)
[192.709529] [035/130] (897s left) gem_wait (wait)
[192.761093] Starting subtest: wait
[192.761907] Starting dynamic subtest: all-engines
[193.786296] Dynamic subtest all-engines: SUCCESS (1.023s)
[193.796392] Starting dynamic subtest: rcs0
[194.819495] Dynamic subtest rcs0: SUCCESS (1.031s)
[194.829112] Starting dynamic subtest: bcs0
[195.848575] Dynamic subtest bcs0: SUCCESS (1.027s)
[195.858218] Starting dynamic subtest: vcs0
[196.879559] Dynamic subtest vcs0: SUCCESS (1.029s)
[196.888841] Starting dynamic subtest: vcs1
[197.904190] Dynamic subtest vcs1: SUCCESS (1.023s)
[197.913464] Starting dynamic subtest: vecs0
[198.931009] Dynamic subtest vecs0: SUCCESS (1.023s)
[198.932203] Subtest wait: SUCCESS (6.163s)
[199.123012] [036/130] (891s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[199.221908] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[199.873169] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.650s)
[199.996505] [037/130] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[200.096711] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[200.098169] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[200.188072] [038/130] (890s left) gem_exec_reloc (basic-cpu-noreloc)
[200.228356] Starting subtest: basic-cpu-noreloc
[200.230788] Subtest basic-cpu-noreloc: SUCCESS (0.002s)
[200.340008] [039/130] (890s left) kms_sequence (get-busy)
[200.428672] Starting subtest: get-busy
[200.429382] Starting dynamic subtest: pipe-A-HDMI-A-1
[201.714365] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.283s)
[201.720956] Starting dynamic subtest: pipe-B-HDMI-A-1
[202.989712] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.273s)
[202.998211] Starting dynamic subtest: pipe-C-HDMI-A-1
[204.267653] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.276s)
[204.277511] Starting dynamic subtest: pipe-D-HDMI-A-1
[205.530932] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.261s)
[205.531764] Subtest get-busy: SUCCESS (5.098s)
[205.639502] [040/130] (884s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[205.736790] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[205.778812] [041/130] (884s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[205.878604] Starting subtest: cursor-rapid-movement-max-size
[205.880694] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[205.957905] [042/130] (884s left) kms_prop_blob (blob-multiple)
[205.993407] Starting subtest: blob-multiple
[205.994131] Subtest blob-multiple: SUCCESS (0.001s)
[206.060880] [043/130] (884s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[206.095977] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[206.096734] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[206.158694] [044/130] (884s left) kms_atomic_transition (plane-all-transition-fencing)
[206.246964] Starting subtest: plane-all-transition-fencing
[206.248849] Starting dynamic subtest: pipe-A-HDMI-A-1
[208.176025] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.917s)
[208.213016] Starting dynamic subtest: pipe-B-HDMI-A-1
[210.149443] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.935s)
[210.168844] Subtest plane-all-transition-fencing: SUCCESS (3.919s)
[210.291261] [045/130] (880s left) gem_mmap_wc (bad-object)
[210.333706] Starting subtest: bad-object
[210.334399] Subtest bad-object: SUCCESS (0.000s)
[210.444946] [046/130] (880s left) kms_addfb_basic (unused-handle)
[210.481358] Starting subtest: unused-handle
[210.482114] Subtest unused-handle: SUCCESS (0.000s)
[210.626987] [047/130] (880s left) gem_lmem_swapping (parallel-multi)
[210.666819] Subtest parallel-multi: SKIP (0.000s)
[210.716513] [048/130] (880s left) kms_feature_discovery (dp-mst)
[210.802262] Starting subtest: dp-mst
[210.803685] Subtest dp-mst: SKIP (0.000s)
[210.858561] [049/130] (879s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[210.895421] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[210.997757] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[211.071702] [050/130] (879s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[211.110394] Starting subtest: writes-after-reads
[212.000656] Subtest writes-after-reads: SUCCESS (0.890s)
[212.121659] [051/130] (878s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[212.261208] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[212.344520] [052/130] (878s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[212.435948] Starting subtest: flip-vs-cursor-varying-size
[219.630577] Subtest flip-vs-cursor-varying-size: SUCCESS (7.156s)
[219.743696] [053/130] (871s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[219.841541] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[219.842950] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[219.937493] [054/130] (871s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[220.029458] Starting subtest: fbc-rgb565-draw-pwrite
[221.344652] Subtest fbc-rgb565-draw-pwrite: SUCCESS (1.314s)
[221.452249] [055/130] (869s left) kms_flip (2x-blocking-wf_vblank)
[221.544617] Starting subtest: 2x-blocking-wf_vblank
[221.553827] Subtest 2x-blocking-wf_vblank: SKIP (0.009s)
[221.622163] [056/130] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[221.715621] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[221.717067] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[221.801764] [057/130] (869s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[221.888756] Starting subtest: cursorB-vs-flipB-atomic-transitions
[221.890204] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[221.945691] [058/130] (869s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[222.035622] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[222.036305] Starting dynamic subtest: pipe-A
[222.662279] Dynamic subtest pipe-A: SUCCESS (0.627s)
[222.669118] Starting dynamic subtest: pipe-B
[223.279491] Dynamic subtest pipe-B: SUCCESS (0.616s)
[223.288672] Starting dynamic subtest: pipe-C
[223.889131] Dynamic subtest pipe-C: SUCCESS (0.609s)
[223.898317] Starting dynamic subtest: pipe-D
[224.516616] Dynamic subtest pipe-D: SUCCESS (0.625s)
[224.517640] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.480s)
[224.698883] [059/130] (866s left) i915_pm_rps (thresholds)
[224.743271] Starting subtest: thresholds
[224.744053] Starting dynamic subtest: gt0
[234.820045] Dynamic subtest gt0: SUCCESS (10.070s)
[234.821458] Subtest thresholds: SUCCESS (10.071s)
[234.893759] [060/130] (856s left) kms_psr (psr-cursor-plane-move)
[234.984537] Subtest psr-cursor-plane-move: SKIP (0.000s)
[235.025507] [061/130] (856s left) gem_pread (uncached)
[235.061338] Starting subtest: uncached
[235.837765] Subtest uncached: SUCCESS (0.767s)
[235.939642] [062/130] (855s left) syncobj_eventfd (invalid-bad-pad)
[235.975256] Starting subtest: invalid-bad-pad
[235.976068] Subtest invalid-bad-pad: SUCCESS (0.000s)
[236.039283] [063/130] (855s left) kms_pipe_crc_basic (nonblocking-crc)
[236.130973] Starting subtest: nonblocking-crc
[236.132752] Starting dynamic subtest: pipe-A-HDMI-A-1
[236.498270] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.365s)
[236.506274] Starting dynamic subtest: pipe-B-HDMI-A-1
[236.833791] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.334s)
[236.841931] Starting dynamic subtest: pipe-C-HDMI-A-1
[237.186638] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.349s)
[237.193546] Starting dynamic subtest: pipe-D-HDMI-A-1
[237.523636] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.335s)
[237.524407] Subtest nonblocking-crc: SUCCESS (1.391s)
[237.632861] [064/130] (853s left) syncobj_basic (bad-destroy)
[237.673402] Starting subtest: bad-destroy
[237.674171] Subtest bad-destroy: SUCCESS (0.000s)
[237.736022] [065/130] (853s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[237.773802] Starting subtest: invalid-bsd1-flag-on-blt
[237.774602] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[237.868971] [066/130] (853s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[237.963033] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[237.964778] Starting dynamic subtest: pipe-A-valid-mode
[238.016665] Dynamic subtest pipe-A-valid-mode: SKIP (0.051s)
[238.018150] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.052s)
[238.113039] [067/130] (853s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[238.209068] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[238.210552] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[238.307528] [068/130] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[238.403093] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[238.404490] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[238.499281] [069/130] (853s left) kms_invalid_mode (zero-clock)
[238.587676] Starting subtest: zero-clock
[238.588410] Starting dynamic subtest: pipe-A-HDMI-A-1
[238.636925] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.048s)
[238.645971] Starting dynamic subtest: pipe-B-HDMI-A-1
[238.646734] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[238.655402] Starting dynamic subtest: pipe-C-HDMI-A-1
[238.656177] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[238.665565] Starting dynamic subtest: pipe-D-HDMI-A-1
[238.666309] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[238.667022] Subtest zero-clock: SUCCESS (0.056s)
[238.794121] [070/130] (852s left) vgem_basic (debugfs)
[238.843050] Starting subtest: debugfs
[238.843859] Subtest debugfs: SUCCESS (0.000s)
[238.893213] [071/130] (852s left) api_intel_allocator (simple-allocator)
[238.928973] Starting subtest: simple-allocator
[238.929730] Starting dynamic subtest: basic
[238.931768] Dynamic subtest basic: SUCCESS (0.002s)
[238.939745] Starting dynamic subtest: parallel-one
[239.118675] Dynamic subtest parallel-one: SUCCESS (0.177s)
[239.125602] Starting dynamic subtest: print
[239.126358] Dynamic subtest print: SUCCESS (0.000s)
[239.133104] Starting dynamic subtest: reuse
[239.133823] Dynamic subtest reuse: SUCCESS (0.000s)
[239.140457] Starting dynamic subtest: reserve
[239.141171] Dynamic subtest reserve: SUCCESS (0.000s)
[239.147434] Starting dynamic subtest: fork-reopen-allocator
[239.148127] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[239.148824] Subtest simple-allocator: SUCCESS (0.200s)
[239.184387] [072/130] (852s left) gem_exec_reloc (basic-write-wc-active)
[239.225644] Starting subtest: basic-write-wc-active
[239.357813] Subtest basic-write-wc-active: SUCCESS (0.119s)
[239.468013] [073/130] (852s left) i915_hangman (gt-engine-error)
[239.511773] Starting subtest: gt-engine-error
[239.512574] Starting dynamic subtest: rcs0
[239.592868] Dynamic subtest rcs0: SUCCESS (0.081s)
[239.610369] Starting dynamic subtest: bcs0
[239.675793] Dynamic subtest bcs0: SUCCESS (0.081s)
[239.693224] Starting dynamic subtest: vcs0
[239.746675] Dynamic subtest vcs0: SUCCESS (0.069s)
[239.764328] Starting dynamic subtest: vcs1
[239.827117] Dynamic subtest vcs1: SUCCESS (0.078s)
[239.844367] Starting dynamic subtest: vecs0
[239.918793] Dynamic subtest vecs0: SUCCESS (0.090s)
[239.920219] Subtest gt-engine-error: SUCCESS (0.408s)
[239.987033] [074/130] (851s left) gem_pxp (hw-rejects-pxp-context)
[240.083292] Starting subtest: hw-rejects-pxp-context
[240.085326] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[240.153803] [075/130] (851s left) kms_vblank (wait-busy-hang)
[240.244390] Starting subtest: wait-busy-hang
[240.246623] Starting dynamic subtest: pipe-A-HDMI-A-1
[254.511200] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.257s)
[254.522823] Starting dynamic subtest: pipe-D-HDMI-A-1
[268.314509] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.793s)
[268.315348] Subtest wait-busy-hang: SUCCESS (28.060s)
[268.462469] [076/130] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[268.560906] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[268.562401] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[268.643969] [077/130] (823s left) gem_eio (kms)
[268.740442] Starting subtest: kms
[282.662266] Subtest kms: SUCCESS (13.927s)
[282.856176] [078/130] (809s left) sysfs_heartbeat_interval (idempotent)
[282.910867] Starting subtest: idempotent
[282.912730] Starting dynamic subtest: vecs0
[282.913429] Dynamic subtest vecs0: SUCCESS (0.001s)
[282.920641] Starting dynamic subtest: vcs0
[282.921442] Dynamic subtest vcs0: SUCCESS (0.001s)
[282.928486] Starting dynamic subtest: bcs0
[282.929187] Dynamic subtest bcs0: SUCCESS (0.001s)
[282.936207] Starting dynamic subtest: rcs0
[282.936918] Dynamic subtest rcs0: SUCCESS (0.001s)
[282.943772] Starting dynamic subtest: vcs1
[282.944479] Dynamic subtest vcs1: SUCCESS (0.001s)
[282.945171] Subtest idempotent: SUCCESS (0.010s)
[282.983382] [079/130] (809s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[283.081422] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[283.090936] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.009s)
[283.149602] [080/130] (808s left) gem_spin_batch (legacy)
[283.195354] Starting subtest: legacy
[283.196126] Starting dynamic subtest: default
[286.547661] Dynamic subtest default: SUCCESS (3.317s)
[286.557820] Starting dynamic subtest: render
[289.865845] Dynamic subtest render: SUCCESS (3.317s)
[289.876104] Starting dynamic subtest: bsd
[293.186914] Dynamic subtest bsd: SUCCESS (3.319s)
[293.202477] Starting dynamic subtest: bsd1
[296.508658] Dynamic subtest bsd1: SUCCESS (3.319s)
[296.518768] Starting dynamic subtest: bsd2
[299.826435] Dynamic subtest bsd2: SUCCESS (3.317s)
[299.836850] Starting dynamic subtest: blt
[303.146280] Dynamic subtest blt: SUCCESS (3.317s)
[303.156989] Starting dynamic subtest: vebox
[306.466548] Dynamic subtest vebox: SUCCESS (3.317s)
[306.467558] Subtest legacy: SUCCESS (23.238s)
[306.607643] [081/130] (785s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[306.704248] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[306.705652] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[306.812706] [082/130] (785s left) kms_flip (dpms-vs-vblank-race)
[306.904536] Starting subtest: dpms-vs-vblank-race
[306.907218] Starting dynamic subtest: A-HDMI-A1
[309.750720] Dynamic subtest A-HDMI-A1: SUCCESS (2.842s)
[309.757915] Starting dynamic subtest: B-HDMI-A1
[312.569349] Dynamic subtest B-HDMI-A1: SUCCESS (2.817s)
[312.578873] Starting dynamic subtest: C-HDMI-A1
[315.355645] Dynamic subtest C-HDMI-A1: SUCCESS (2.785s)
[315.364051] Starting dynamic subtest: D-HDMI-A1
[318.172338] Dynamic subtest D-HDMI-A1: SUCCESS (2.814s)
[318.175416] Subtest dpms-vs-vblank-race: SUCCESS (11.269s)
[318.333589] [083/130] (773s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[318.445695] Starting subtest: y-tiled-16bpp-rotate-270
[319.716239] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.269s)
[319.849674] [084/130] (772s left) drm_fdinfo (virtual-busy-hang)
[319.889882] Starting subtest: virtual-busy-hang
[325.122847] Subtest virtual-busy-hang: SUCCESS (5.231s)
[325.191748] [085/130] (767s left) gem_softpin (evict-prime-sanity-check)
[325.233107] Starting subtest: evict-prime-sanity-check
[325.233890] Starting dynamic subtest: rcs0
[326.357748] Dynamic subtest rcs0: SUCCESS (1.123s)
[326.376459] Starting dynamic subtest: bcs0
[327.484730] Dynamic subtest bcs0: SUCCESS (1.124s)
[327.504283] Starting dynamic subtest: vcs0
[328.610859] Dynamic subtest vcs0: SUCCESS (1.123s)
[328.630523] Starting dynamic subtest: vcs1
[329.743811] Dynamic subtest vcs1: SUCCESS (1.129s)
[329.761226] Starting dynamic subtest: vecs0
[330.870777] Dynamic subtest vecs0: SUCCESS (1.124s)
[330.890028] Starting dynamic subtest: all
[332.013706] Dynamic subtest all: SUCCESS (1.140s)
[332.014849] Subtest evict-prime-sanity-check: SUCCESS (6.780s)
[332.089793] [086/130] (760s left) gem_partial_pwrite_pread (write-display)
[332.128921] Starting subtest: write-display
[342.171985] Subtest write-display: SUCCESS (10.040s)
[342.281610] [087/130] (750s left) syncobj_wait (invalid-signal-zero-handles)
[342.318776] Starting subtest: invalid-signal-zero-handles
[342.319488] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[342.386055] [088/130] (749s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[342.482914] Starting subtest: fbc-farfromfence-mmap-gtt
[343.933857] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (1.451s)
[344.038216] [089/130] (748s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[344.130348] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[344.131092] Starting dynamic subtest: pipe-A-HDMI-A-1
[344.138223] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[344.146992] Starting dynamic subtest: pipe-B-HDMI-A-1
[344.153812] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[344.160966] Starting dynamic subtest: pipe-C-HDMI-A-1
[344.167777] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[344.174617] Starting dynamic subtest: pipe-D-HDMI-A-1
[344.181551] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[344.182931] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[344.392174] [090/130] (748s left) gem_exec_store (pages)
[344.437319] Starting subtest: pages
[344.438111] Starting dynamic subtest: rcs0
[344.513950] Dynamic subtest rcs0: SUCCESS (0.075s)
[344.533951] Starting dynamic subtest: bcs0
[344.566014] Dynamic subtest bcs0: SUCCESS (0.050s)
[344.577555] Starting dynamic subtest: vcs0
[344.619608] Dynamic subtest vcs0: SUCCESS (0.052s)
[344.634364] Starting dynamic subtest: vcs1
[344.699875] Dynamic subtest vcs1: SUCCESS (0.078s)
[344.719539] Starting dynamic subtest: vecs0
[344.780189] Dynamic subtest vecs0: SUCCESS (0.077s)
[344.781382] Subtest pages: SUCCESS (0.343s)
[344.971861] [091/130] (747s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[345.065478] Starting subtest: fbcpsr-shrfb-scaledprimary
[345.066944] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[345.154530] [092/130] (747s left) perf_pmu (busy-accuracy-98)
[345.193754] Starting subtest: busy-accuracy-98
[345.194578] Starting dynamic subtest: rcs0
[348.223202] Dynamic subtest rcs0: SUCCESS (3.026s)
[348.232212] Starting dynamic subtest: bcs0
[351.250267] Dynamic subtest bcs0: SUCCESS (3.025s)
[351.258922] Starting dynamic subtest: vcs0
[354.279417] Dynamic subtest vcs0: SUCCESS (3.027s)
[354.288044] Starting dynamic subtest: vcs1
[357.307995] Dynamic subtest vcs1: SUCCESS (3.027s)
[357.317046] Starting dynamic subtest: vecs0
[360.337270] Dynamic subtest vecs0: SUCCESS (3.027s)
[360.338209] Subtest busy-accuracy-98: SUCCESS (15.137s)
[360.442525] [093/130] (732s left) kms_big_fb (linear-16bpp-rotate-0)
[360.541840] Starting subtest: linear-16bpp-rotate-0
[362.241193] Subtest linear-16bpp-rotate-0: SUCCESS (1.698s)
[362.409903] [094/130] (730s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[362.511550] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[363.149978] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.637s)
[363.303358] [095/130] (729s left) gem_exec_reloc (basic-write-read-active)
[363.343032] Starting subtest: basic-write-read-active
[363.471520] Subtest basic-write-read-active: SUCCESS (0.119s)
[363.586180] [096/130] (729s left) sw_sync (alloc_fence)
[363.621459] Starting subtest: alloc_fence
[363.622230] Subtest alloc_fence: SUCCESS (0.000s)
[363.668766] [097/130] (729s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[363.761271] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[364.844806] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (1.083s)
[364.978279] [098/130] (727s left) perf (buffer-fill)
[365.059732] Starting subtest: buffer-fill
[365.060463] Starting dynamic subtest: 0-rcs0
[367.321779] Dynamic subtest 0-rcs0: SUCCESS (2.252s)
[367.322535] Subtest buffer-fill: SUCCESS (2.253s)
[367.354083] [099/130] (725s left) gem_exec_schedule (preempt-engines)
[367.416494] Starting subtest: preempt-engines
[367.417461] Starting dynamic subtest: rcs0
[367.488542] Dynamic subtest rcs0: SUCCESS (0.071s)
[367.497226] Starting dynamic subtest: bcs0
[367.562633] Dynamic subtest bcs0: SUCCESS (0.073s)
[367.570666] Starting dynamic subtest: vcs0
[367.632860] Dynamic subtest vcs0: SUCCESS (0.069s)
[367.640680] Starting dynamic subtest: vcs1
[367.703101] Dynamic subtest vcs1: SUCCESS (0.069s)
[367.711251] Starting dynamic subtest: vecs0
[367.775379] Dynamic subtest vecs0: SUCCESS (0.071s)
[367.776167] Subtest preempt-engines: SUCCESS (0.359s)
[368.084835] [100/130] (724s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[368.180326] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[368.223225] [101/130] (724s left) perf_pmu (interrupts)
[368.262892] Starting subtest: interrupts
[369.379849] Subtest interrupts: SUCCESS (1.108s)
[369.470538] [102/130] (723s left) core_getversion (all-cards)
[369.508039] Starting subtest: all-cards
[371.895516] Subtest all-cards: SUCCESS (2.388s)
[371.934009] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.amdgpu: true
[371.934737] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.xe: true
[371.939606] [103/130] (720s left) debugfs_test (read_all_entries)
[371.980390] Starting subtest: read_all_entries
[372.123849] Subtest read_all_entries: SUCCESS (0.143s)
[372.239469] [104/130] (720s left) syncobj_wait (invalid-single-wait-unsubmitted)
[372.275988] Starting subtest: invalid-single-wait-unsubmitted
[372.276723] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[372.329673] [105/130] (720s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[372.419919] Starting subtest: drrs-dirtyfb-ioctl
[372.423936] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[372.525422] [106/130] (720s left) kms_color (legacy-gamma)
[372.613768] Starting subtest: legacy-gamma
[372.614479] Starting dynamic subtest: pipe-A-HDMI-A-1
[372.970370] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.355s)
[372.977788] Starting dynamic subtest: pipe-B-HDMI-A-1
[373.269482] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.299s)
[373.279104] Starting dynamic subtest: pipe-C-HDMI-A-1
[373.572644] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.303s)
[373.580777] Starting dynamic subtest: pipe-D-HDMI-A-1
[373.853651] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.280s)
[373.854447] Subtest legacy-gamma: SUCCESS (1.240s)
[373.992093] [107/130] (719s left) gem_exec_params (dr4-dirt)
[374.033843] Starting subtest: DR4-dirt
[374.034662] Subtest DR4-dirt: SUCCESS (0.000s)
[374.124797] [108/130] (718s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[374.163470] Starting subtest: etime-single-wait-all-for-submit-submitted
[374.269758] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[374.343327] [109/130] (718s left) gem_ccs (ctrl-surf-copy)
[374.381721] Starting subtest: ctrl-surf-copy
[374.383240] Subtest ctrl-surf-copy: SKIP (0.000s)
[374.445046] [110/130] (718s left) kms_async_flips (crc-atomic)
[374.537050] Starting subtest: crc-atomic
[374.662688] Starting dynamic subtest: pipe-A-HDMI-A-1
[376.818783] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.147s)
[376.957701] Starting dynamic subtest: pipe-B-HDMI-A-1
[379.091088] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.134s)
[379.199805] Starting dynamic subtest: pipe-C-HDMI-A-1
[381.317067] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.114s)
[381.429769] Starting dynamic subtest: pipe-D-HDMI-A-1
[383.547308] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.115s)
[383.548033] Subtest crc-atomic: SUCCESS (8.999s)
[383.777305] [111/130] (709s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[383.875940] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[383.876635] Starting dynamic subtest: pipe-A
[384.016432] Dynamic subtest pipe-A: SUCCESS (0.140s)
[384.027904] Starting dynamic subtest: pipe-B
[384.158000] Dynamic subtest pipe-B: SUCCESS (0.140s)
[384.168733] Starting dynamic subtest: pipe-C
[384.316526] Dynamic subtest pipe-C: SUCCESS (0.158s)
[384.324898] Starting dynamic subtest: pipe-D
[384.477368] Dynamic subtest pipe-D: SUCCESS (0.160s)
[384.478360] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.602s)
[384.678067] [112/130] (708s left) kms_lease (empty-lease)
[384.767935] Starting subtest: empty-lease
[384.769803] Starting dynamic subtest: pipe-A-HDMI-A-1
[384.770604] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[384.779819] Starting dynamic subtest: pipe-B-HDMI-A-1
[384.780587] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[384.788724] Starting dynamic subtest: pipe-C-HDMI-A-1
[384.789454] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[384.797073] Starting dynamic subtest: pipe-D-HDMI-A-1
[384.797789] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[384.798479] Subtest empty-lease: SUCCESS (0.009s)
[384.836709] [113/130] (708s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[384.935414] Starting subtest: 4-tiled-64bpp-rotate-0
[384.936802] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[385.039601] [114/130] (708s left) gem_mmap_gtt (basic-short)
[385.074272] Starting subtest: basic-short
[385.103092] Subtest basic-short: SUCCESS (0.029s)
[385.204548] [115/130] (708s left) kms_content_protection (mei-interface)
[385.303778] Starting subtest: mei-interface
[385.625429] Subtest mei-interface: SKIP (0.319s)
[385.787849] [116/130] (707s left) sysfs_preempt_timeout (timeout)
[385.827453] Starting subtest: timeout
[385.828198] Starting dynamic subtest: vecs0
[386.751394] Dynamic subtest vecs0: SUCCESS (0.923s)
[386.765326] Starting dynamic subtest: vcs0
[387.695824] Dynamic subtest vcs0: SUCCESS (0.941s)
[387.709069] Starting dynamic subtest: bcs0
[388.629637] Dynamic subtest bcs0: SUCCESS (0.931s)
[388.640006] Starting dynamic subtest: rcs0
[389.574711] Dynamic subtest rcs0: SUCCESS (0.943s)
[389.585195] Starting dynamic subtest: vcs1
[390.518637] Dynamic subtest vcs1: SUCCESS (0.941s)
[390.519707] Subtest timeout: SUCCESS (4.690s)
[390.588296] [117/130] (702s left) kms_pm_rpm (basic-pci-d3-state)
[392.010181] Starting subtest: basic-pci-d3-state
[393.327847] Subtest basic-pci-d3-state: SUCCESS (1.317s)
[393.434169] [118/130] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[393.527329] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[393.528707] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[393.638745] [119/130] (699s left) gem_cs_tlb (engines)
[393.678011] Starting subtest: engines
[393.678773] Starting dynamic subtest: rcs0
[395.838637] Dynamic subtest rcs0: SUCCESS (2.152s)
[395.846215] Starting dynamic subtest: bcs0
[397.990071] Dynamic subtest bcs0: SUCCESS (2.151s)
[397.998926] Starting dynamic subtest: vcs0
[400.142080] Dynamic subtest vcs0: SUCCESS (2.151s)
[400.149477] Starting dynamic subtest: vcs1
[402.293010] Dynamic subtest vcs1: SUCCESS (2.151s)
[402.300481] Starting dynamic subtest: vecs0
[404.444073] Dynamic subtest vecs0: SUCCESS (2.151s)
[404.444794] Subtest engines: SUCCESS (10.762s)
[404.548417] [120/130] (689s left) gen9_exec_parse (batch-without-end)
[404.587570] Subtest batch-without-end: SKIP (0.000s)
[404.626309] [121/130] (688s left) kms_dp_linktrain_fallback (dp-fallback)
[404.722550] Starting subtest: dp-fallback
[404.724764] Subtest dp-fallback: SKIP (0.000s)
[404.780644] [122/130] (688s left) gem_exec_fence (basic-await)
[404.956054] Starting subtest: basic-await
[404.956964] Starting dynamic subtest: rcs0
[405.039475] Dynamic subtest rcs0: SUCCESS (0.082s)
[405.056448] Starting dynamic subtest: bcs0
[405.131321] Dynamic subtest bcs0: SUCCESS (0.089s)
[405.148262] Starting dynamic subtest: vcs0
[405.222129] Dynamic subtest vcs0: SUCCESS (0.089s)
[405.242009] Starting dynamic subtest: vcs1
[405.317259] Dynamic subtest vcs1: SUCCESS (0.092s)
[405.337122] Starting dynamic subtest: vecs0
[405.412226] Dynamic subtest vecs0: SUCCESS (0.092s)
[405.413438] Subtest basic-await: SUCCESS (0.457s)
[405.888405] [123/130] (687s left) kms_chamelium_color (ctm-max)
[405.979629] Subtest ctm-max: SKIP (0.000s)
[406.024959] [124/130] (687s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[406.118237] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[406.158086] [125/130] (687s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[406.195331] Starting subtest: cpuset-basic-small-copy-XY
[412.769166] Subtest cpuset-basic-small-copy-XY: SUCCESS (6.575s)
[412.835524] [126/130] (680s left) kms_psr (fbc-psr-primary-page-flip)
[412.971653] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[413.015507] [127/130] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[413.112026] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[414.320276] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (1.209s)
[414.429881] [128/130] (679s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[414.523407] Starting subtest: psr-rgb565-draw-mmap-gtt
[414.524829] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[414.628710] [129/130] (679s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[414.726018] Starting subtest: yf-tiled-16bpp-rotate-90
[414.727439] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[414.823557] [130/130] (679s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[414.913811] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[414.915311] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[415.074164] Closing watchdogs
Done.