[43.725823] Initializing watchdogs
[43.725885]   /dev/watchdog0
[43.741368] [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.746923] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.749607] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.751679] [001/133] (960s left) gem_exec_fence (basic-await)
[43.922717] Starting subtest: basic-await
[43.923697] Starting dynamic subtest: rcs0
[44.004676] Dynamic subtest rcs0: SUCCESS (0.082s)
[44.016089] Starting dynamic subtest: bcs0
[44.089429] Dynamic subtest bcs0: SUCCESS (0.084s)
[44.100603] Starting dynamic subtest: vcs0
[44.173885] Dynamic subtest vcs0: SUCCESS (0.084s)
[44.187910] Starting dynamic subtest: vcs1
[44.263783] Dynamic subtest vcs1: SUCCESS (0.089s)
[44.275840] Starting dynamic subtest: vecs0
[44.349529] Dynamic subtest vecs0: SUCCESS (0.085s)
[44.350502] Subtest basic-await: SUCCESS (0.427s)
[44.825474] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[44.827422] [002/133] (959s left) kms_big_fb (linear-8bpp-rotate-0)
[44.924996] Starting subtest: linear-8bpp-rotate-0
[45.953693] Subtest linear-8bpp-rotate-0: SUCCESS (1.028s)
[46.085936] [003/133] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[46.180693] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[46.182068] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[46.254917] [004/133] (958s left) gem_exec_params (rel-constants-invalid)
[46.292695] Starting subtest: rel-constants-invalid
[46.293400] Subtest rel-constants-invalid: SUCCESS (0.000s)
[46.393638] [005/133] (958s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[46.488796] Starting subtest: 4-tiled-addfb-size-offset-overflow
[46.490149] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[46.577870] [006/133] (957s left) gem_sync (basic-store-all)
[46.620190] Starting subtest: basic-store-all
[49.030617] Subtest basic-store-all: SUCCESS (2.410s)
[49.208612] [007/133] (955s left) gem_mmap_gtt (fault-concurrent-x)
[49.240978] Starting subtest: fault-concurrent-X
[53.274504] Subtest fault-concurrent-X: SUCCESS (3.999s)
[53.377081] [008/133] (951s left) kms_chamelium_color (ctm-blue-to-red)
[53.465148] Subtest ctm-blue-to-red: SKIP (0.000s)
[53.508259] [009/133] (951s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[53.592366] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[53.593055] Starting dynamic subtest: pipe-A-valid-mode
[54.467508] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.874s)
[54.468824] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.875s)
[54.614974] [010/133] (950s left) kms_hdr (static-toggle)
[54.708240] Starting subtest: static-toggle
[54.710377] Subtest static-toggle: SKIP (0.000s)
[54.768797] [011/133] (949s left) prime_vgem (fence-wait)
[54.831809] Starting subtest: fence-wait
[54.832572] Starting dynamic subtest: rcs0
[55.872335] Dynamic subtest rcs0: SUCCESS (1.041s)
[55.881768] Starting dynamic subtest: bcs0
[56.904992] Dynamic subtest bcs0: SUCCESS (1.023s)
[56.913892] Starting dynamic subtest: vcs0
[57.926700] Dynamic subtest vcs0: SUCCESS (1.021s)
[57.936033] Starting dynamic subtest: vcs1
[58.948120] Dynamic subtest vcs1: SUCCESS (1.020s)
[58.957835] Starting dynamic subtest: vecs0
[59.971208] Dynamic subtest vecs0: SUCCESS (1.022s)
[59.972307] Subtest fence-wait: SUCCESS (5.132s)
[60.072439] [012/133] (944s left) gen7_exec_parse (cmd-crossing-page)
[60.108882] Subtest cmd-crossing-page: SKIP (0.000s)
[60.148141] [013/133] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[60.238373] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[60.239830] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[60.329372] [014/133] (944s left) kms_chamelium_hpd (dp-hpd-storm)
[60.462308] Subtest dp-hpd-storm: SKIP (0.000s)
[60.550074] [015/133] (944s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[60.638408] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[60.639113] Starting dynamic subtest: pipe-A-HDMI-A-1
[60.645686] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[60.651331] Starting dynamic subtest: pipe-B-HDMI-A-1
[60.657861] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[60.663442] Starting dynamic subtest: pipe-C-HDMI-A-1
[60.669980] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[60.675659] Starting dynamic subtest: pipe-D-HDMI-A-1
[60.682441] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[60.683742] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[60.873946] [016/133] (943s left) kms_content_protection (legacy-hdcp14)
[60.963553] Starting subtest: legacy-hdcp14
[60.977115] Subtest legacy-hdcp14: SKIP (0.012s)
[61.071758] [017/133] (943s left) kms_plane_multiple (tiling-yf)
[61.155605] Starting subtest: tiling-yf
[61.156943] Subtest tiling-yf: SKIP (0.000s)
[61.249428] [018/133] (943s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[61.337282] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[61.338653] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[61.501410] [019/133] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[61.594770] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[61.596112] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[61.674875] [020/133] (943s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[61.707960] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[61.760065] [021/133] (943s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[61.853067] Starting subtest: y-tiled-32bpp-rotate-180
[62.930077] Subtest y-tiled-32bpp-rotate-180: SUCCESS (1.077s)
[63.076847] [022/133] (942s left) kms_lease (atomic-implicit-crtc)
[63.163318] Starting subtest: atomic-implicit-crtc
[63.164073] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.167633] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[63.173361] Starting dynamic subtest: pipe-B-HDMI-A-1
[63.176920] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.008s)
[63.184844] Starting dynamic subtest: pipe-C-HDMI-A-1
[63.188448] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.011s)
[63.196272] Starting dynamic subtest: pipe-D-HDMI-A-1
[63.199782] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.011s)
[63.200473] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[63.282011] [023/133] (941s left) kms_cursor_crc (cursor-dpms)
[63.368291] Starting subtest: cursor-dpms
[63.368976] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.975633] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.606s)
[63.983895] Starting dynamic subtest: pipe-D-HDMI-A-1
[64.556396] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.579s)
[64.557176] Subtest cursor-dpms: SUCCESS (1.188s)
[64.719114] [024/133] (940s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[64.757520] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[64.758214] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[64.827905] [025/133] (940s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[64.923166] Starting subtest: x-tiled-32bpp-rotate-270
[65.000245] Subtest x-tiled-32bpp-rotate-270: SKIP (0.076s)
[65.125542] [026/133] (940s left) kms_cursor_crc (cursor-tearing-position-change)
[65.210437] Starting subtest: cursor-tearing-position-change
[65.211901] Starting dynamic subtest: pipe-A-HDMI-A-1
[65.468053] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.256s)
[65.476261] Starting dynamic subtest: pipe-D-HDMI-A-1
[65.690961] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.221s)
[65.691703] Subtest cursor-tearing-position-change: SUCCESS (0.480s)
[65.841053] [027/133] (939s left) api_intel_allocator (execbuf-with-allocator)
[65.875483] Starting subtest: execbuf-with-allocator
[65.878686] Subtest execbuf-with-allocator: SUCCESS (0.003s)
[65.984371] [028/133] (939s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[66.067815] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[66.069294] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[66.126418] [029/133] (939s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[66.213538] Starting subtest: cursorB-vs-flipA-varying-size
[66.216255] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[66.272750] [030/133] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[66.361551] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[66.362936] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[66.462235] [031/133] (938s left) gem_exec_reloc (basic-gtt-read-active)
[66.499161] Starting subtest: basic-gtt-read-active
[66.630014] Subtest basic-gtt-read-active: SUCCESS (0.121s)
[66.740834] [032/133] (938s left) kms_async_flips (crc-atomic)
[66.878973] Starting subtest: crc-atomic
[67.054358] Starting dynamic subtest: pipe-A-HDMI-A-1
[69.213722] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.151s)
[69.342273] Starting dynamic subtest: pipe-B-HDMI-A-1
[71.453251] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.109s)
[71.565054] Starting dynamic subtest: pipe-C-HDMI-A-1
[73.696367] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.128s)
[73.811837] Starting dynamic subtest: pipe-D-HDMI-A-1
[75.934380] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.120s)
[75.935172] Subtest crc-atomic: SUCCESS (9.047s)
[76.157785] [033/133] (929s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[76.249488] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[76.250197] Starting dynamic subtest: pipe-A-valid-mode
[77.263631] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.014s)
[77.264418] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.015s)
[77.446391] [034/133] (928s left) api_intel_bb (object-noreloc-purge-cache-simple)
[77.494944] Starting subtest: object-noreloc-purge-cache-simple
[77.499266] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[77.606923] [035/133] (928s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[77.705298] Starting subtest: cursor-rapid-movement-256x85
[77.710153] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.936141] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.226s)
[77.973363] Starting dynamic subtest: pipe-D-HDMI-A-1
[78.208552] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.242s)
[78.209311] Subtest cursor-rapid-movement-256x85: SUCCESS (0.504s)
[78.377716] [036/133] (927s left) syncobj_wait (wait-all-snapshot)
[78.412976] Starting subtest: wait-all-snapshot
[78.495900] Subtest wait-all-snapshot: SUCCESS (0.082s)
[78.559029] [037/133] (927s left) gem_eio (kms)
[78.654353] Starting subtest: kms
[101.951520] Subtest kms: SUCCESS (23.297s)
[102.097306] [038/133] (903s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[102.194537] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[102.456381] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.262s)
[102.575069] [039/133] (903s left) gem_render_copy_redux (interruptible)
[102.612494] Starting subtest: interruptible
[102.954623] Subtest interruptible: SUCCESS (0.334s)
[103.042290] [040/133] (902s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[103.133023] Starting subtest: fbcpsr-slowdraw
[103.134433] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[103.225410] [041/133] (902s left) syncobj_basic (bad-handle-to-fd)
[103.258431] Starting subtest: bad-handle-to-fd
[103.259131] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[103.338243] [042/133] (902s left) gem_exec_reloc (basic-gtt-read)
[103.375268] Starting subtest: basic-gtt-read
[103.382697] Subtest basic-gtt-read: SUCCESS (0.007s)
[103.491872] [043/133] (902s left) kms_atomic_transition (plane-all-modeset-transition)
[103.578301] Starting subtest: plane-all-modeset-transition
[103.580135] Starting dynamic subtest: pipe-A-HDMI-A-1
[114.813902] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (11.234s)
[114.857829] Starting dynamic subtest: pipe-B-HDMI-A-1
[124.350758] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (9.500s)
[124.376640] Subtest plane-all-modeset-transition: SUCCESS (20.799s)
[124.500817] [044/133] (881s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[124.593331] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[124.594684] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[124.694910] [045/133] (881s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[124.727840] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[124.830627] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[124.904859] [046/133] (881s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[124.989812] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[133.900562] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.911s)
[134.041183] [047/133] (872s left) kms_chamelium_frames (hdmi-crc-multiple)
[134.190337] Subtest hdmi-crc-multiple: SKIP (0.000s)
[134.287084] [048/133] (871s left) kms_sequence (get-idle)
[134.374997] Starting subtest: get-idle
[134.376785] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.592307] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.216s)
[135.599509] Starting dynamic subtest: pipe-B-HDMI-A-1
[136.767170] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.173s)
[136.775165] Starting dynamic subtest: pipe-C-HDMI-A-1
[137.948128] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.179s)
[137.957803] Starting dynamic subtest: pipe-D-HDMI-A-1
[139.124079] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.173s)
[139.124804] Subtest get-idle: SUCCESS (4.749s)
[139.232906] [049/133] (866s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[139.324872] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[139.326661] Starting dynamic subtest: pipe-A-HDMI-A-1
[139.333650] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[139.342256] Starting dynamic subtest: pipe-B-HDMI-A-1
[139.349167] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[139.357441] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.364338] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[139.370276] Starting dynamic subtest: pipe-D-HDMI-A-1
[139.377052] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[139.378362] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[139.560985] [050/133] (866s left) kms_feature_discovery (display-4x)
[139.652484] Starting subtest: display-4x
[139.653818] Subtest display-4x: SKIP (0.000s)
[139.711258] [051/133] (866s left) kms_cursor_legacy (single-move)
[139.796006] Starting subtest: single-move
[139.796668] Starting dynamic subtest: pipe-A
[145.210111] Dynamic subtest pipe-A: SUCCESS (5.379s)
[145.215757] Starting dynamic subtest: pipe-B
[150.589568] Dynamic subtest pipe-B: SUCCESS (5.378s)
[150.595364] Starting dynamic subtest: pipe-C
[155.969203] Dynamic subtest pipe-C: SUCCESS (5.379s)
[155.975163] Starting dynamic subtest: pipe-D
[161.350362] Dynamic subtest pipe-D: SUCCESS (5.379s)
[161.356943] Starting dynamic subtest: all-pipes
[166.729124] Dynamic subtest all-pipes: SUCCESS (5.379s)
[166.729816] Subtest single-move: SUCCESS (26.900s)
[166.768509] [052/133] (839s left) kms_plane_scaling (planes-scaler-unity-scaling)
[166.854841] Starting subtest: planes-scaler-unity-scaling
[166.855527] Starting dynamic subtest: pipe-A
[166.920202] Dynamic subtest pipe-A: SUCCESS (0.065s)
[166.927355] Starting dynamic subtest: pipe-B
[167.057422] Dynamic subtest pipe-B: SUCCESS (0.136s)
[167.064848] Starting dynamic subtest: pipe-C
[167.210268] Dynamic subtest pipe-C: SUCCESS (0.152s)
[167.217513] Starting dynamic subtest: pipe-D
[167.353318] Dynamic subtest pipe-D: SUCCESS (0.142s)
[167.354016] Subtest planes-scaler-unity-scaling: SUCCESS (0.499s)
[167.524127] [053/133] (838s left) gem_pxp (fail-invalid-protected-context)
[167.629225] Starting subtest: fail-invalid-protected-context
[167.630213] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[167.699944] [054/133] (838s left) sw_sync (timeline_closed_signaled)
[167.731847] Starting subtest: timeline_closed_signaled
[167.732538] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[167.781808] [055/133] (838s left) kms_addfb_basic (bad-pitch-32)
[167.815866] Starting subtest: bad-pitch-32
[167.816561] Subtest bad-pitch-32: SUCCESS (0.000s)
[167.976474] [056/133] (838s left) kms_psr2_su (page_flip-nv12)
[168.009490] Subtest page_flip-NV12: SKIP (0.000s)
[168.052306] [057/133] (838s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[168.141070] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[168.142487] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[168.243453] [058/133] (838s left) kms_pm_rpm (modeset-non-lpsp)
[169.636933] Starting subtest: modeset-non-lpsp
[170.840344] Subtest modeset-non-lpsp: SKIP (1.202s)
[171.010542] [059/133] (835s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[171.046848] Starting subtest: multi-wait-all-for-submit-available-submitted
[171.047567] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[171.111533] [060/133] (835s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[171.196699] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[171.198931] Starting dynamic subtest: A-HDMI-A1
[171.928729] Dynamic subtest A-HDMI-A1: SUCCESS (0.730s)
[171.938565] Starting dynamic subtest: B-HDMI-A1
[172.610299] Dynamic subtest B-HDMI-A1: SUCCESS (0.680s)
[172.619686] Starting dynamic subtest: C-HDMI-A1
[173.218190] Dynamic subtest C-HDMI-A1: SUCCESS (0.606s)
[173.224996] Starting dynamic subtest: D-HDMI-A1
[173.858417] Dynamic subtest D-HDMI-A1: SUCCESS (0.639s)
[173.859551] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.663s)
[174.012127] [061/133] (832s left) gem_workarounds (basic-read)
[174.064400] Starting subtest: basic-read
[174.072269] Subtest basic-read: SUCCESS (0.008s)
[174.189124] [062/133] (832s left) i915_drm_fdinfo (virtual-idle)
[174.224497] Starting subtest: virtual-idle
[176.752075] Subtest virtual-idle: SUCCESS (2.518s)
[176.829320] [063/133] (829s left) kms_vrr (negative-basic)
[176.916029] Starting subtest: negative-basic
[176.918129] Subtest negative-basic: SKIP (0.000s)
[176.974668] [064/133] (829s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[177.068727] Starting subtest: yf-tiled-8bpp-rotate-0
[177.070097] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[177.146462] [065/133] (829s left) kms_psr (fbc-psr-primary-blt)
[177.231549] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[177.270507] [066/133] (829s left) gem_exec_schedule (manyslice)
[177.312721] Starting subtest: manyslice
[177.313397] Starting dynamic subtest: rcs0
[177.838790] Dynamic subtest rcs0: SUCCESS (0.517s)
[177.845215] Starting dynamic subtest: bcs0
[178.180384] Dynamic subtest bcs0: SUCCESS (0.340s)
[178.187085] Starting dynamic subtest: vcs0
[178.506796] Dynamic subtest vcs0: SUCCESS (0.325s)
[178.513108] Starting dynamic subtest: vcs1
[178.907377] Dynamic subtest vcs1: SUCCESS (0.399s)
[178.913883] Starting dynamic subtest: vecs0
[179.286526] Dynamic subtest vecs0: SUCCESS (0.378s)
[179.287271] Subtest manyslice: SUCCESS (1.966s)
[179.570351] [067/133] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[179.660725] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[179.662153] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[179.748771] [068/133] (827s left) kms_fbcon_fbt (fbc)
[179.784850] Starting subtest: fbc
[183.192934] Subtest fbc: SUCCESS (3.407s)
[183.278359] [069/133] (823s left) gem_create (create-ext-cpu-access-big)
[183.423948] Starting subtest: create-ext-cpu-access-big
[183.425354] Subtest create-ext-cpu-access-big: SKIP (0.000s)
[183.497598] [070/133] (823s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[183.583912] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[183.585687] Starting dynamic subtest: pipe-A-HDMI-A-1
[183.602740] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[183.609351] Starting dynamic subtest: pipe-B-HDMI-A-1
[183.626689] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[183.633035] Starting dynamic subtest: pipe-C-HDMI-A-1
[183.650179] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[183.656970] Starting dynamic subtest: pipe-D-HDMI-A-1
[183.675911] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[183.677310] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.014s)
[183.822739] [071/133] (823s left) gem_ctx_isolation (clean)
[183.867040] Starting subtest: clean
[183.867865] Starting dynamic subtest: rcs0
[183.890869] Dynamic subtest rcs0: SUCCESS (0.023s)
[183.898837] Starting dynamic subtest: bcs0
[183.950065] Dynamic subtest bcs0: SUCCESS (0.058s)
[183.957712] Starting dynamic subtest: vcs0
[184.012302] Dynamic subtest vcs0: SUCCESS (0.061s)
[184.020018] Starting dynamic subtest: vcs1
[184.082223] Dynamic subtest vcs1: SUCCESS (0.069s)
[184.089792] Starting dynamic subtest: vecs0
[184.149412] Dynamic subtest vecs0: SUCCESS (0.066s)
[184.150132] Subtest clean: SUCCESS (0.283s)
[184.331011] [072/133] (822s left) kms_rotation_crc (sprite-rotation-180)
[184.416304] Starting subtest: sprite-rotation-180
[187.897405] Subtest sprite-rotation-180: SUCCESS (3.481s)
[188.088751] [073/133] (819s left) gem_exec_whisper (basic-sync-all)
[188.133167] Starting subtest: basic-sync-all
[189.469138] Subtest basic-sync-all: SUCCESS (1.337s)
[189.649662] [074/133] (817s left) i915_pm_rpm (sysfs-read)
[191.048053] Starting subtest: sysfs-read
[192.243784] Subtest sysfs-read: SUCCESS (1.197s)
[192.429257] [075/133] (814s left) kms_plane (plane-panning-bottom-right-suspend)
[192.513901] Starting subtest: plane-panning-bottom-right-suspend
[192.515678] Starting dynamic subtest: pipe-A
[208.977255] Dynamic subtest pipe-A: SUCCESS (1.580s)
[208.986214] Starting dynamic subtest: pipe-B
[225.955055] Dynamic subtest pipe-B: SUCCESS (1.517s)
[225.955749] Subtest plane-panning-bottom-right-suspend: SUCCESS (3.101s)
[235.132072] [076/133] (781s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[235.234199] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[235.235569] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[235.335208] [077/133] (780s left) kms_vblank (wait-busy-hang)
[235.419916] Starting subtest: wait-busy-hang
[235.422088] Starting dynamic subtest: pipe-A-HDMI-A-1
[249.105320] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.679s)
[249.116028] Starting dynamic subtest: pipe-D-HDMI-A-1
[262.920923] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.810s)
[262.921726] Subtest wait-busy-hang: SUCCESS (27.495s)
[263.079013] [078/133] (753s left) i915_selftest (mock)
[264.002750] Starting subtest: mock
[264.003515] Starting dynamic subtest: sanitycheck
[264.665718] Dynamic subtest sanitycheck: SUCCESS (0.670s)
[264.686342] Starting dynamic subtest: shmem
[265.363068] Dynamic subtest shmem: SUCCESS (0.685s)
[265.377104] Starting dynamic subtest: fence
[273.313893] Dynamic subtest fence: SUCCESS (7.948s)
[273.319895] Starting dynamic subtest: scatterlist
[275.165462] Dynamic subtest scatterlist: SUCCESS (1.858s)
[275.176292] Starting dynamic subtest: syncmap
[277.994162] Dynamic subtest syncmap: SUCCESS (2.817s)
[278.002661] Starting dynamic subtest: uncore
[278.681642] Dynamic subtest uncore: SUCCESS (0.693s)
[278.694160] Starting dynamic subtest: ring
[279.352129] Dynamic subtest ring: SUCCESS (0.669s)
[279.365950] Starting dynamic subtest: engine
[280.059049] Dynamic subtest engine: SUCCESS (0.697s)
[280.068653] Starting dynamic subtest: timelines
[284.493234] Dynamic subtest timelines: SUCCESS (4.432s)
[284.500516] Starting dynamic subtest: requests
[287.220215] Dynamic subtest requests: SUCCESS (2.724s)
[287.226914] Starting dynamic subtest: objects
[288.037197] Dynamic subtest objects: SUCCESS (0.815s)
[288.044794] Starting dynamic subtest: phys
[288.849146] Dynamic subtest phys: SUCCESS (0.810s)
[288.856847] Starting dynamic subtest: dmabuf
[289.616118] Dynamic subtest dmabuf: SUCCESS (0.765s)
[289.628870] Starting dynamic subtest: vma
[297.101979] Dynamic subtest vma: SUCCESS (7.483s)
[297.109229] Starting dynamic subtest: evict
[298.707079] Dynamic subtest evict: SUCCESS (1.603s)
[298.714557] Starting dynamic subtest: gtt
[302.445174] Dynamic subtest gtt: SUCCESS (3.735s)
[302.457670] Starting dynamic subtest: hugepages
[303.382160] Dynamic subtest hugepages: SUCCESS (0.935s)
[303.397036] Starting dynamic subtest: memory_region
[306.644300] Dynamic subtest memory_region: SUCCESS (3.259s)
[306.645419] Subtest mock: SUCCESS (42.640s)
[306.672956] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[306.673802] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[306.677262] [079/133] (709s left) gem_readwrite (write-bad-handle)
[307.712126] Starting subtest: write-bad-handle
[307.713510] Subtest write-bad-handle: SUCCESS (0.000s)
[307.802066] [FACT gem_readwrite (write-bad-handle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[307.803687] [FACT gem_readwrite (write-bad-handle)] new: kernel.kmod_is_loaded.i915: true
[307.806731] [080/133] (708s left) syncobj_timeline (reset-during-wait-for-submit)
[307.848193] Starting subtest: reset-during-wait-for-submit
[307.951096] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[308.026911] [081/133] (708s left) fbdev (write)
[308.068280] Starting subtest: write
[308.526926] Subtest write: SUCCESS (0.450s)
[308.570516] [082/133] (707s left) gem_eio (in-flight-1us)
[308.617133] Starting subtest: in-flight-1us
[310.876855] Subtest in-flight-1us: SUCCESS (2.258s)
[311.003748] [083/133] (705s left) syncobj_wait (invalid-wait-bad-flags)
[311.039372] Starting subtest: invalid-wait-bad-flags
[311.040092] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[311.096957] [084/133] (705s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[311.181446] Starting subtest: primary-x-tiled-reflect-x-180
[314.748637] Subtest primary-x-tiled-reflect-x-180: SUCCESS (3.567s)
[314.929191] [085/133] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[315.022489] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[315.023905] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[315.115772] [086/133] (701s left) perf_pmu (enable-race)
[315.154262] Starting subtest: enable-race
[315.154981] Starting dynamic subtest: rcs0
[327.747661] Dynamic subtest rcs0: SUCCESS (12.572s)
[327.763194] Starting dynamic subtest: bcs0
[340.326347] Dynamic subtest bcs0: SUCCESS (12.575s)
[340.341406] Starting dynamic subtest: vcs0
[352.897112] Dynamic subtest vcs0: SUCCESS (12.570s)
[352.913458] Starting dynamic subtest: vcs1
[365.466431] Dynamic subtest vcs1: SUCCESS (12.572s)
[365.482886] Starting dynamic subtest: vecs0
[378.016004] Dynamic subtest vecs0: SUCCESS (12.570s)
[378.016722] Subtest enable-race: SUCCESS (62.864s)
[378.092659] [087/133] (638s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[378.190783] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[378.192244] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[378.280995] [088/133] (638s left) gem_exec_schedule (implicit-boths)
[378.323700] Starting subtest: implicit-boths
[378.324404] Starting dynamic subtest: rcs0
[378.388344] Dynamic subtest rcs0: SUCCESS (0.064s)
[378.404334] Starting dynamic subtest: bcs0
[378.457028] Dynamic subtest bcs0: SUCCESS (0.065s)
[378.472497] Starting dynamic subtest: vcs0
[378.529243] Dynamic subtest vcs0: SUCCESS (0.069s)
[378.544379] Starting dynamic subtest: vcs1
[378.599395] Dynamic subtest vcs1: SUCCESS (0.067s)
[378.617341] Starting dynamic subtest: vecs0
[378.670305] Dynamic subtest vecs0: SUCCESS (0.068s)
[378.673465] Subtest implicit-boths: SUCCESS (0.347s)
[378.998073] [089/133] (637s left) gem_exec_schedule (u-fairslice)
[379.044284] Starting subtest: u-fairslice
[379.045018] Starting dynamic subtest: rcs0
[381.066148] Dynamic subtest rcs0: SUCCESS (2.013s)
[381.076054] Starting dynamic subtest: bcs0
[383.078652] Dynamic subtest bcs0: SUCCESS (2.011s)
[383.089099] Starting dynamic subtest: vcs0
[385.090849] Dynamic subtest vcs0: SUCCESS (2.011s)
[385.101105] Starting dynamic subtest: vcs1
[387.102736] Dynamic subtest vcs1: SUCCESS (2.011s)
[387.113372] Starting dynamic subtest: vecs0
[389.114884] Dynamic subtest vecs0: SUCCESS (2.011s)
[389.115769] Subtest u-fairslice: SUCCESS (10.062s)
[389.400302] [090/133] (627s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[389.495636] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[389.813403] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.317s)
[389.956147] [091/133] (626s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[390.040577] Starting subtest: compare-crc-sanitycheck-xr24
[390.042383] Starting dynamic subtest: pipe-A-HDMI-A-1
[390.314096] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.271s)
[390.324471] Starting dynamic subtest: pipe-B-HDMI-A-1
[390.564232] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.248s)
[390.574235] Starting dynamic subtest: pipe-C-HDMI-A-1
[390.805477] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.239s)
[390.816677] Starting dynamic subtest: pipe-D-HDMI-A-1
[391.060993] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.252s)
[391.061705] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.021s)
[391.232231] [092/133] (625s left) kms_properties (plane-properties-atomic)
[391.322454] Starting subtest: plane-properties-atomic
[391.324390] Starting dynamic subtest: pipe-A-HDMI-A-1
[391.567371] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.243s)
[391.576091] Starting dynamic subtest: pipe-B-HDMI-A-1
[391.850363] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.280s)
[391.860363] Starting dynamic subtest: pipe-C-HDMI-A-1
[392.135483] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.283s)
[392.143065] Starting dynamic subtest: pipe-D-HDMI-A-1
[392.432314] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.296s)
[392.433021] Subtest plane-properties-atomic: SUCCESS (1.110s)
[392.576199] [093/133] (624s left) gem_ringfill (legacy-basic)
[392.805129] Starting subtest: legacy-basic
[392.808016] Starting dynamic subtest: default
[392.840196] Dynamic subtest default: SUCCESS (0.034s)
[392.858945] Starting dynamic subtest: render
[392.861471] Dynamic subtest render: SUCCESS (0.019s)
[392.870890] Starting dynamic subtest: bsd
[392.879362] Dynamic subtest bsd: SUCCESS (0.017s)
[392.888741] Starting dynamic subtest: bsd1
[392.896382] Dynamic subtest bsd1: SUCCESS (0.016s)
[392.905476] Starting dynamic subtest: bsd2
[392.910380] Dynamic subtest bsd2: SUCCESS (0.013s)
[392.919411] Starting dynamic subtest: blt
[392.926484] Dynamic subtest blt: SUCCESS (0.015s)
[392.935250] Starting dynamic subtest: vebox
[392.940517] Dynamic subtest vebox: SUCCESS (0.013s)
[392.941281] Subtest legacy-basic: SUCCESS (0.136s)
[393.017456] [094/133] (624s left) gem_mmap_wc (read)
[393.051373] Starting subtest: read
[393.059500] Subtest read: SUCCESS (0.008s)
[393.158252] [095/133] (623s left) kms_psr (psr2-cursor-mmap-gtt)
[393.244941] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[393.286356] [096/133] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[393.375217] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[393.376578] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[393.470063] [097/133] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[393.557949] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[393.559387] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[393.659193] [098/133] (623s left) gem_exec_balancer (full-pulse)
[393.700625] Starting subtest: full-pulse
[395.309790] Subtest full-pulse: SUCCESS (1.609s)
[395.501041] [099/133] (621s left) gem_exec_whisper (basic-fds-priority-all)
[395.543765] Starting subtest: basic-fds-priority-all
[399.788732] Subtest basic-fds-priority-all: SUCCESS (4.237s)
[399.970327] [100/133] (617s left) kms_pm_backlight (basic-brightness)
[400.057160] Subtest basic-brightness: SKIP (0.000s)
[400.104075] [101/133] (617s left) gem_ctx_persistence (legacy-engines-mixed-process)
[400.140843] Starting subtest: legacy-engines-mixed-process
[400.141557] Starting dynamic subtest: render
[400.516459] Dynamic subtest render: SUCCESS (0.374s)
[400.530471] Starting dynamic subtest: bsd1
[400.873345] Dynamic subtest bsd1: SUCCESS (0.354s)
[400.889915] Starting dynamic subtest: bsd2
[401.238311] Dynamic subtest bsd2: SUCCESS (0.362s)
[401.256758] Starting dynamic subtest: blt
[401.614125] Dynamic subtest blt: SUCCESS (0.373s)
[401.627327] Starting dynamic subtest: vebox
[401.967304] Dynamic subtest vebox: SUCCESS (0.350s)
[401.970472] Subtest legacy-engines-mixed-process: SUCCESS (1.828s)
[402.066090] [102/133] (615s left) gem_exec_reloc (basic-wc-gtt-active)
[402.107374] Starting subtest: basic-wc-gtt-active
[402.238201] Subtest basic-wc-gtt-active: SUCCESS (0.123s)
[402.349932] [103/133] (615s left) gem_wait (await)
[402.396109] Starting subtest: await
[402.396849] Starting dynamic subtest: all-engines
[403.452597] Dynamic subtest all-engines: SUCCESS (1.056s)
[403.464482] Starting dynamic subtest: rcs0
[404.485775] Dynamic subtest rcs0: SUCCESS (1.031s)
[404.497328] Starting dynamic subtest: bcs0
[405.526135] Dynamic subtest bcs0: SUCCESS (1.038s)
[405.537449] Starting dynamic subtest: vcs0
[406.560341] Dynamic subtest vcs0: SUCCESS (1.032s)
[406.571967] Starting dynamic subtest: vcs1
[407.590196] Dynamic subtest vcs1: SUCCESS (1.027s)
[407.604841] Starting dynamic subtest: vecs0
[408.618905] Dynamic subtest vecs0: SUCCESS (1.027s)
[408.621865] Subtest await: SUCCESS (6.224s)
[408.815172] [104/133] (608s left) kms_psr (fbc-psr2-sprite-blt)
[408.902190] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[408.947907] [105/133] (608s left) i915_drm_fdinfo (virtual-busy-hang)
[408.983738] Starting subtest: virtual-busy-hang
[414.193382] Subtest virtual-busy-hang: SUCCESS (5.209s)
[414.267444] [106/133] (603s left) gem_exec_create (madvise)
[414.309631] Starting subtest: madvise
[414.310389] Starting dynamic subtest: smem
[434.444165] Dynamic subtest smem: SUCCESS (20.133s)
[434.444903] Subtest madvise: SUCCESS (20.135s)
[435.838340] [107/133] (581s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[435.930273] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[435.931643] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[436.023207] [108/133] (581s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[436.109907] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[436.151489] [109/133] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[436.243791] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[436.245245] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[436.313003] [110/133] (581s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[436.401187] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[436.402572] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[436.500731] [111/133] (581s left) gem_exec_fence (syncobj-timeline-repeat)
[436.953633] Starting subtest: syncobj-timeline-repeat
[437.307166] Subtest syncobj-timeline-repeat: SUCCESS (0.353s)
[437.481631] [112/133] (580s left) gem_mmap_gtt (basic-write-read)
[437.515472] Starting subtest: basic-write-read
[437.519715] Subtest basic-write-read: SUCCESS (0.005s)
[437.617132] [113/133] (580s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[437.711872] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[437.713330] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[437.808210] [114/133] (580s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[437.843406] Starting subtest: single-wait-all-for-submit-signaled
[437.844144] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[437.908394] [115/133] (579s left) kms_async_flips (async-flip-suspend-resume)
[437.993673] Starting subtest: async-flip-suspend-resume
[438.123211] Starting dynamic subtest: pipe-A-HDMI-A-1
[455.880487] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.324s)
[456.009178] Starting dynamic subtest: pipe-B-HDMI-A-1
[473.869314] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.291s)
[473.984107] Starting dynamic subtest: pipe-C-HDMI-A-1
[491.871254] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.310s)
[491.991848] Starting dynamic subtest: pipe-D-HDMI-A-1
[509.889697] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.301s)
[509.890543] Subtest async-flip-suspend-resume: SUCCESS (9.697s)
[518.173304] [116/133] (507s left) kms_flip (2x-flip-vs-dpms-on-nop)
[518.270750] Starting subtest: 2x-flip-vs-dpms-on-nop
[518.279326] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.009s)
[518.360156] [117/133] (507s left) prime_vgem (basic-fence-read)
[518.406920] Starting subtest: basic-fence-read
[518.452488] Subtest basic-fence-read: SUCCESS (0.045s)
[518.560059] [118/133] (507s left) gem_unref_active_buffers
[518.729787] [119/133] (507s left) kms_psr (pr-primary-mmap-gtt)
[518.814969] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[518.859346] [120/133] (507s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[518.893818] Starting subtest: etime-single-wait-available-unsubmitted
[518.995535] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[519.074892] [121/133] (507s left) syncobj_wait (single-wait-for-submit-signaled)
[519.109943] Starting subtest: single-wait-for-submit-signaled
[519.110692] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[519.171971] [122/133] (507s left) gem_ctx_bad_destroy (invalid-ctx)
[519.204837] Starting subtest: invalid-ctx
[519.205583] Subtest invalid-ctx: SUCCESS (0.000s)
[519.261782] [123/133] (507s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[519.358739] Starting subtest: protected-encrypted-src-copy-not-readible
[519.439682] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.083s)
[519.548520] [124/133] (506s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[519.637715] Starting subtest: 2x-absolute-wf_vblank-interruptible
[519.647353] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.009s)
[519.716560] [125/133] (506s left) gem_userptr_blits (relocations)
[519.754710] Starting subtest: relocations
[519.755604] Subtest relocations: SUCCESS (0.002s)
[519.867011] [126/133] (506s left) kms_properties (colorop-properties-legacy)
[519.951855] Starting subtest: colorop-properties-legacy
[519.952552] Starting dynamic subtest: pipe-A-HDMI-A-1
[520.033302] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.080s)
[520.043675] Starting dynamic subtest: pipe-B-HDMI-A-1
[520.147350] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.112s)
[520.156743] Starting dynamic subtest: pipe-C-HDMI-A-1
[520.270481] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.120s)
[520.280986] Starting dynamic subtest: pipe-D-HDMI-A-1
[520.389472] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.117s)
[520.390154] Subtest colorop-properties-legacy: SUCCESS (0.438s)
[520.520088] [127/133] (505s left) gem_mmap_gtt (hang-user)
[520.557957] Starting subtest: hang-user
[556.540432] Subtest hang-user: SUCCESS (35.980s)
[556.638910] [128/133] (469s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[556.729545] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[558.074112] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.345s)
[558.203169] [129/133] (468s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[558.294982] Starting subtest: plane-lut1d-ctm3x4
[558.382898] Starting dynamic subtest: pipe-A-plane-0
[558.482212] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[558.500277] Starting dynamic subtest: pipe-A-plane-1
[558.573659] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s)
[558.589169] Starting dynamic subtest: pipe-A-plane-2
[558.673747] Dynamic subtest pipe-A-plane-2: SUCCESS (0.098s)
[558.897010] Starting dynamic subtest: pipe-B-plane-0
[558.982714] Dynamic subtest pipe-B-plane-0: SUCCESS (0.099s)
[558.995198] Starting dynamic subtest: pipe-B-plane-1
[559.082832] Dynamic subtest pipe-B-plane-1: SUCCESS (0.098s)
[559.095085] Starting dynamic subtest: pipe-B-plane-2
[559.174411] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[559.384029] Starting dynamic subtest: pipe-C-plane-0
[559.459382] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[559.473710] Starting dynamic subtest: pipe-C-plane-1
[559.559460] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[559.574228] Starting dynamic subtest: pipe-C-plane-2
[559.659653] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s)
[559.883932] Starting dynamic subtest: pipe-D-plane-0
[559.958018] Dynamic subtest pipe-D-plane-0: SUCCESS (0.083s)
[559.970456] Starting dynamic subtest: pipe-D-plane-1
[560.057232] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[560.073039] Starting dynamic subtest: pipe-D-plane-2
[560.157236] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[560.206247] Subtest plane-lut1d-ctm3x4: SUCCESS (1.912s)
[560.311716] [130/133] (466s left) sysfs_timeslice_duration (duration)
[560.349386] Starting subtest: duration
[560.351439] Starting dynamic subtest: vecs0
[560.409605] Dynamic subtest vecs0: SUCCESS (0.059s)
[560.426237] Starting dynamic subtest: vcs0
[560.469444] Dynamic subtest vcs0: SUCCESS (0.057s)
[560.484237] Starting dynamic subtest: bcs0
[560.533660] Dynamic subtest bcs0: SUCCESS (0.062s)
[560.551195] Starting dynamic subtest: rcs0
[560.601731] Dynamic subtest rcs0: SUCCESS (0.065s)
[560.619325] Starting dynamic subtest: vcs1
[560.671591] Dynamic subtest vcs1: SUCCESS (0.067s)
[560.672949] Subtest duration: SUCCESS (0.323s)
[560.745034] [131/133] (465s left) gem_spin_batch (resubmit-new)
[560.786120] Starting subtest: resubmit-new
[560.786882] Starting dynamic subtest: rcs0
[560.789971] Dynamic subtest rcs0: SUCCESS (0.003s)
[560.800026] Starting dynamic subtest: bcs0
[560.800758] Dynamic subtest bcs0: SUCCESS (0.003s)
[560.809412] Starting dynamic subtest: vcs0
[560.810126] Dynamic subtest vcs0: SUCCESS (0.002s)
[560.818118] Starting dynamic subtest: vcs1
[560.818812] Dynamic subtest vcs1: SUCCESS (0.003s)
[560.826385] Starting dynamic subtest: vecs0
[560.827139] Dynamic subtest vecs0: SUCCESS (0.003s)
[560.827835] Subtest resubmit-new: SUCCESS (0.020s)
[560.990575] [132/133] (465s left) gem_userptr_blits (create-destroy-sync)
[561.035653] Starting subtest: create-destroy-sync
[566.084432] Subtest create-destroy-sync: SUCCESS (5.014s)
[566.156213] [133/133] (460s left) dmabuf_sync_file (export-multiwait)
[566.193110] Starting subtest: export-multiwait
[566.193793] Subtest export-multiwait: SUCCESS (0.001s)
[566.244712] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_sync
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_chamelium_color
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_hdr
results: parsing output: 10/ for test: prime_vgem
results: parsing output: 11/ for test: gen7_exec_parse
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_plane_multiple
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr_stress_test
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_async_flips
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_render_copy_redux
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_basic
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_chamelium_frames
results: parsing output: 47/ for test: kms_sequence
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_pxp
results: parsing output: 53/ for test: sw_sync
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_psr2_su
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_workarounds
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_fbcon_fbt
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_ctx_isolation
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: i915_selftest
results: parsing output: 78/ for test: gem_readwrite
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: gem_ringfill
results: parsing output: 93/ for test: gem_mmap_wc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: kms_pm_backlight
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: gem_wait
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_create
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_async_flips
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: prime_vgem
results: parsing output: 117/ for test: gem_unref_active_buffers
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: gem_ctx_bad_destroy
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_color_pipeline
results: parsing output: 129/ for test: sysfs_timeslice_duration
results: parsing output: 130/ for test: gem_spin_batch
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: dmabuf_sync_file
Done.