[60.687306] Initializing watchdogs
[60.687354]   /dev/watchdog0
[60.702907] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.707861] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.710278] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.714098] [001/133] (960s left) gem_exec_fence (basic-await)
[60.912571] Starting subtest: basic-await
[60.915061] Starting dynamic subtest: rcs0
[60.994326] Dynamic subtest rcs0: SUCCESS (0.082s)
[61.003309] Starting dynamic subtest: bcs0
[61.072574] Dynamic subtest bcs0: SUCCESS (0.078s)
[61.081547] Starting dynamic subtest: vcs0
[61.146501] Dynamic subtest vcs0: SUCCESS (0.074s)
[61.156705] Starting dynamic subtest: vcs1
[61.221175] Dynamic subtest vcs1: SUCCESS (0.074s)
[61.231718] Starting dynamic subtest: vecs0
[61.297333] Dynamic subtest vecs0: SUCCESS (0.075s)
[61.307499] Starting dynamic subtest: ccs0
[61.374283] Dynamic subtest ccs0: SUCCESS (0.077s)
[61.376923] Subtest basic-await: SUCCESS (0.464s)
[63.012578] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[63.015750] [002/133] (958s left) kms_big_fb (linear-8bpp-rotate-0)
[63.119193] Starting subtest: linear-8bpp-rotate-0
[64.397527] Subtest linear-8bpp-rotate-0: SUCCESS (1.281s)
[64.520467] [003/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[64.615803] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[64.619139] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[64.714524] [004/133] (956s left) gem_exec_params (rel-constants-invalid)
[64.769513] Starting subtest: rel-constants-invalid
[64.771523] Subtest rel-constants-invalid: SUCCESS (0.000s)
[64.873989] [005/133] (956s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[64.982936] Starting subtest: 4-tiled-addfb-size-offset-overflow
[64.984552] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[65.084485] [006/133] (956s left) gem_sync (basic-store-all)
[65.151257] Starting subtest: basic-store-all
[68.106328] Subtest basic-store-all: SUCCESS (2.967s)
[68.299633] [007/133] (953s left) gem_mmap_gtt (fault-concurrent-x)
[68.362026] Subtest fault-concurrent-X: SKIP (0.000s)
[68.421819] [008/133] (953s left) kms_chamelium_color (ctm-blue-to-red)
[68.512865] Subtest ctm-blue-to-red: SKIP (0.000s)
[68.557626] [009/133] (952s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[68.654047] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[68.656392] Starting dynamic subtest: pipe-A-default-mode
[71.404084] Dynamic subtest pipe-A-default-mode: SUCCESS (2.753s)
[71.406500] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.754s)
[72.240511] [010/133] (949s left) kms_hdr (static-toggle)
[72.347161] Starting subtest: static-toggle
[72.353887] Subtest static-toggle: SKIP (0.000s)
[72.417269] [011/133] (949s left) prime_vgem (fence-wait)
[72.494396] Starting subtest: fence-wait
[72.496303] Starting dynamic subtest: rcs0
[73.545123] Dynamic subtest rcs0: SUCCESS (1.050s)
[73.555289] Starting dynamic subtest: bcs0
[74.609724] Dynamic subtest bcs0: SUCCESS (1.065s)
[74.620033] Starting dynamic subtest: vcs0
[75.654828] Dynamic subtest vcs0: SUCCESS (1.044s)
[75.665035] Starting dynamic subtest: vcs1
[76.695783] Dynamic subtest vcs1: SUCCESS (1.040s)
[76.706648] Starting dynamic subtest: vecs0
[77.741491] Dynamic subtest vecs0: SUCCESS (1.045s)
[77.751975] Starting dynamic subtest: ccs0
[78.786089] Dynamic subtest ccs0: SUCCESS (1.043s)
[78.788539] Subtest fence-wait: SUCCESS (6.294s)
[78.923151] [012/133] (942s left) gen7_exec_parse (cmd-crossing-page)
[78.989413] Subtest cmd-crossing-page: SKIP (0.000s)
[79.045193] [013/133] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[79.154448] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[79.158584] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[79.272072] [014/133] (942s left) kms_chamelium_hpd (dp-hpd-storm)
[79.647609] Subtest dp-hpd-storm: SKIP (0.000s)
[80.446206] [015/133] (941s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[80.538263] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[80.540624] Starting dynamic subtest: pipe-A-eDP-1
[81.409659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.864s)
[81.418502] Starting dynamic subtest: pipe-B-eDP-1
[83.131533] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.718s)
[83.141142] Starting dynamic subtest: pipe-C-eDP-1
[84.677614] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.547s)
[84.686012] Starting dynamic subtest: pipe-D-eDP-1
[86.204951] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[86.206837] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.658s)
[87.393674] [016/133] (934s left) kms_content_protection (legacy-hdcp14)
[87.552992] Starting subtest: legacy-hdcp14
[87.557457] Subtest legacy-hdcp14: SKIP (0.000s)
[87.679569] [017/133] (934s left) kms_plane_multiple (tiling-yf)
[87.776100] Starting subtest: tiling-yf
[87.780237] Subtest tiling-yf: SKIP (0.000s)
[87.849559] [018/133] (934s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[87.935798] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[87.940938] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[89.044445] [019/133] (932s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[89.157722] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[96.086860] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.930s)
[96.224266] [020/133] (925s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[96.332599] Starting subtest: invalidate-primary-flip-overlay
[107.053944] Subtest invalidate-primary-flip-overlay: SUCCESS (10.723s)
[107.169353] [021/133] (914s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[107.284090] Starting subtest: y-tiled-32bpp-rotate-180
[107.287638] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[107.373097] [022/133] (914s left) kms_lease (atomic-implicit-crtc)
[107.481812] Starting subtest: atomic-implicit-crtc
[107.484197] Starting dynamic subtest: pipe-A-eDP-1
[107.494348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[107.503963] Starting dynamic subtest: pipe-B-eDP-1
[107.513560] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[107.521362] Starting dynamic subtest: pipe-C-eDP-1
[107.530301] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[107.537338] Starting dynamic subtest: pipe-D-eDP-1
[107.546405] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[107.548045] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[107.615785] [023/133] (914s left) kms_cursor_crc (cursor-dpms)
[107.750722] Starting subtest: cursor-dpms
[107.752693] Starting dynamic subtest: pipe-A-eDP-1
[110.830717] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.077s)
[110.839893] Starting dynamic subtest: pipe-D-eDP-1
[114.419535] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.590s)
[114.421946] Subtest cursor-dpms: SUCCESS (6.669s)
[115.278040] [024/133] (906s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[115.343307] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[115.345524] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[115.441324] [025/133] (906s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[115.549637] Starting subtest: x-tiled-32bpp-rotate-270
[115.568886] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[115.680843] [026/133] (906s left) kms_cursor_crc (cursor-tearing-position-change)
[115.795218] Starting subtest: cursor-tearing-position-change
[115.797477] Starting dynamic subtest: pipe-A-eDP-1
[116.374146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[116.383225] Starting dynamic subtest: pipe-D-eDP-1
[117.606076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[117.608639] Subtest cursor-tearing-position-change: SUCCESS (1.808s)
[118.452800] [027/133] (903s left) api_intel_allocator (execbuf-with-allocator)
[118.516027] Starting subtest: execbuf-with-allocator
[118.520643] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[118.651341] [028/133] (903s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[118.743069] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[118.769699] Starting dynamic subtest: pipe-A-plane-0
[119.057773] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[119.066072] Starting dynamic subtest: pipe-A-plane-3
[119.291110] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[119.299965] Starting dynamic subtest: pipe-A-plane-5
[119.304234] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[120.421235] Starting dynamic subtest: pipe-B-plane-0
[120.714596] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[120.723656] Starting dynamic subtest: pipe-B-plane-3
[120.958795] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[120.970574] Starting dynamic subtest: pipe-B-plane-5
[120.975170] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[121.282193] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.539s)
[122.087534] [029/133] (900s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[122.212440] Starting subtest: cursorB-vs-flipA-varying-size
[122.217058] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[122.355584] [030/133] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[122.458762] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[122.463201] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[122.551967] [031/133] (899s left) gem_exec_reloc (basic-gtt-read-active)
[122.608556] Subtest basic-gtt-read-active: SKIP (0.000s)
[122.673617] [032/133] (899s left) kms_async_flips (crc-atomic)
[122.760294] Starting subtest: crc-atomic
[123.147512] Starting dynamic subtest: pipe-A-eDP-1
[126.013378] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.864s)
[126.396665] Starting dynamic subtest: pipe-B-eDP-1
[129.330589] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.949s)
[129.715443] Starting dynamic subtest: pipe-C-eDP-1
[132.633912] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.925s)
[132.996762] Starting dynamic subtest: pipe-D-eDP-1
[135.880903] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.893s)
[135.883287] Subtest crc-atomic: SUCCESS (13.123s)
[137.039726] [033/133] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[137.141304] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[137.146563] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[137.214197] [034/133] (885s left) api_intel_bb (object-noreloc-purge-cache-simple)
[137.262903] Starting subtest: object-noreloc-purge-cache-simple
[137.267682] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[137.394492] [035/133] (885s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[137.642578] Starting subtest: cursor-rapid-movement-256x85
[137.696138] Subtest cursor-rapid-movement-256x85: SKIP (0.048s)
[137.853979] [036/133] (884s left) syncobj_wait (wait-all-snapshot)
[137.918974] Starting subtest: wait-all-snapshot
[137.999661] Subtest wait-all-snapshot: SUCCESS (0.081s)
[138.088093] [037/133] (884s left) gem_eio (kms)
[138.352472] Starting subtest: kms
[158.107026] Subtest kms: SUCCESS (19.752s)
[159.289848] [038/133] (863s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[159.403436] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[159.407767] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[159.487202] [039/133] (863s left) gem_render_copy_redux (interruptible)
[159.544638] Starting subtest: interruptible
[159.940200] Subtest interruptible: SUCCESS (0.396s)
[160.060089] [040/133] (862s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[160.160107] Starting subtest: fbcpsr-slowdraw
[185.489305] Subtest fbcpsr-slowdraw: SUCCESS (25.331s)
[185.634358] [041/133] (837s left) syncobj_basic (bad-handle-to-fd)
[185.689972] Starting subtest: bad-handle-to-fd
[185.691966] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[185.797409] [042/133] (837s left) gem_exec_reloc (basic-gtt-read)
[185.857182] Subtest basic-gtt-read: SKIP (0.000s)
[185.922818] [043/133] (836s left) kms_atomic_transition (plane-all-modeset-transition)
[186.022960] Starting subtest: plane-all-modeset-transition
[186.027434] Subtest plane-all-modeset-transition: SKIP (0.000s)
[186.112895] [044/133] (836s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[186.207253] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[186.211344] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[186.299812] [045/133] (836s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[186.364770] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[186.467110] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[186.543311] [046/133] (836s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[186.661292] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[195.960502] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.297s)
[196.802896] [047/133] (826s left) kms_chamelium_frames (hdmi-crc-multiple)
[197.205565] Subtest hdmi-crc-multiple: SKIP (0.000s)
[198.024254] [048/133] (825s left) kms_sequence (get-idle)
[198.115058] Starting subtest: get-idle
[198.117330] Starting dynamic subtest: pipe-A-eDP-1
[199.917502] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.801s)
[199.926888] Starting dynamic subtest: pipe-B-eDP-1
[202.421728] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.504s)
[202.433298] Starting dynamic subtest: pipe-C-eDP-1
[204.866453] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.443s)
[204.875095] Starting dynamic subtest: pipe-D-eDP-1
[207.293533] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.424s)
[207.295893] Subtest get-idle: SUCCESS (9.179s)
[208.091449] [049/133] (815s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[208.192728] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[208.194979] Starting dynamic subtest: pipe-A-eDP-1
[208.215102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[208.231380] Starting dynamic subtest: pipe-B-eDP-1
[208.251342] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[208.260699] Starting dynamic subtest: pipe-C-eDP-1
[208.281251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[208.290550] Starting dynamic subtest: pipe-D-eDP-1
[208.312985] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[208.317487] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[210.445220] [050/133] (812s left) kms_feature_discovery (display-4x)
[210.549229] Starting subtest: display-4x
[210.553606] Subtest display-4x: SKIP (0.000s)
[210.639897] [051/133] (812s left) kms_cursor_legacy (single-move)
[210.753569] Starting subtest: single-move
[210.755799] Starting dynamic subtest: pipe-A
[216.135789] Dynamic subtest pipe-A: SUCCESS (5.378s)
[216.146827] Starting dynamic subtest: pipe-B
[221.519072] Dynamic subtest pipe-B: SUCCESS (5.380s)
[221.529863] Starting dynamic subtest: pipe-C
[226.902940] Dynamic subtest pipe-C: SUCCESS (5.381s)
[226.913080] Starting dynamic subtest: pipe-D
[232.285552] Dynamic subtest pipe-D: SUCCESS (5.379s)
[232.296888] Starting dynamic subtest: all-pipes
[237.675895] Dynamic subtest all-pipes: SUCCESS (5.387s)
[237.678377] Subtest single-move: SUCCESS (26.920s)
[237.819906] [052/133] (785s left) kms_plane_scaling (planes-scaler-unity-scaling)
[237.913769] Starting subtest: planes-scaler-unity-scaling
[237.915986] Starting dynamic subtest: pipe-A
[237.983601] Dynamic subtest pipe-A: SUCCESS (0.070s)
[237.992625] Starting dynamic subtest: pipe-B
[239.157979] Dynamic subtest pipe-B: SUCCESS (1.172s)
[239.167063] Starting dynamic subtest: pipe-C
[240.285366] Dynamic subtest pipe-C: SUCCESS (1.126s)
[240.295825] Starting dynamic subtest: pipe-D
[241.396862] Dynamic subtest pipe-D: SUCCESS (1.111s)
[241.399054] Subtest planes-scaler-unity-scaling: SUCCESS (3.484s)
[242.553247] [053/133] (780s left) gem_pxp (fail-invalid-protected-context)
[242.682719] Starting subtest: fail-invalid-protected-context
[242.685384] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[242.790443] [054/133] (780s left) sw_sync (timeline_closed_signaled)
[242.834209] Starting subtest: timeline_closed_signaled
[242.836483] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[242.891619] [055/133] (780s left) kms_addfb_basic (bad-pitch-32)
[242.948189] Starting subtest: bad-pitch-32
[242.950106] Subtest bad-pitch-32: SUCCESS (0.000s)
[243.081042] [056/133] (780s left) kms_psr2_su (page_flip-nv12)
[243.143964] Subtest page_flip-NV12: SKIP (0.000s)
[243.201905] [057/133] (780s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[243.313501] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[250.249370] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.937s)
[250.386135] [058/133] (773s left) kms_pm_rpm (modeset-non-lpsp)
[252.118333] Starting subtest: modeset-non-lpsp
[253.268219] Subtest modeset-non-lpsp: SKIP (1.147s)
[253.660386] [059/133] (769s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[253.715114] Starting subtest: multi-wait-all-for-submit-available-submitted
[253.717436] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[253.815762] [060/133] (769s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[253.922310] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[253.924542] Starting dynamic subtest: A-eDP1
[257.487541] Dynamic subtest A-eDP1: SUCCESS (3.564s)
[257.496983] Starting dynamic subtest: B-eDP1
[260.700549] Dynamic subtest B-eDP1: SUCCESS (3.212s)
[260.709715] Starting dynamic subtest: C-eDP1
[263.891755] Dynamic subtest C-eDP1: SUCCESS (3.193s)
[263.901355] Starting dynamic subtest: D-eDP1
[267.025064] Dynamic subtest D-eDP1: SUCCESS (3.129s)
[267.027372] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.105s)
[267.828250] [061/133] (755s left) gem_workarounds (basic-read)
[267.890680] Starting subtest: basic-read
[267.902726] Subtest basic-read: SUCCESS (0.011s)
[268.028901] [062/133] (755s left) i915_drm_fdinfo (virtual-idle)
[268.068312] Starting subtest: virtual-idle
[271.127845] Subtest virtual-idle: SUCCESS (3.060s)
[271.206725] [063/133] (752s left) kms_vrr (negative-basic)
[271.309129] Starting subtest: negative-basic
[271.315830] Starting dynamic subtest: pipe-A-eDP-1
[276.733054] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[277.022703] Subtest negative-basic: SUCCESS (5.713s)
[277.859664] [064/133] (745s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[277.963607] Starting subtest: yf-tiled-8bpp-rotate-0
[277.968038] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[278.095942] [065/133] (745s left) kms_psr (fbc-psr-primary-blt)
[278.191201] Starting subtest: fbc-psr-primary-blt
[278.193456] Starting dynamic subtest: eDP-1
[278.197685] Dynamic subtest eDP-1: SKIP (0.000s)
[278.201915] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[278.265318] [066/133] (745s left) gem_exec_schedule (manyslice)
[278.334719] Starting subtest: manyslice
[278.336674] Starting dynamic subtest: rcs0
[283.458080] Dynamic subtest rcs0: SUCCESS (5.130s)
[283.473092] Starting dynamic subtest: bcs0
[290.114137] Dynamic subtest bcs0: SUCCESS (6.654s)
[290.125126] Starting dynamic subtest: vcs0
[296.211829] Dynamic subtest vcs0: SUCCESS (6.095s)
[296.221626] Starting dynamic subtest: vcs1
[301.785041] Dynamic subtest vcs1: SUCCESS (5.571s)
[301.800956] Starting dynamic subtest: vecs0
[307.875272] Dynamic subtest vecs0: SUCCESS (6.088s)
[307.888096] Starting dynamic subtest: ccs0
[314.581817] Dynamic subtest ccs0: SUCCESS (6.705s)
[314.584873] Subtest manyslice: SUCCESS (36.254s)
[314.891591] [067/133] (709s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[315.001188] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[315.005138] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[315.087152] [068/133] (708s left) kms_fbcon_fbt (fbc)
[315.131182] Starting subtest: fbc
[321.475915] Subtest fbc: SUCCESS (6.343s)
[322.563078] [069/133] (701s left) gem_create (create-ext-cpu-access-big)
[322.731932] Starting subtest: create-ext-cpu-access-big
[322.737077] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[322.819799] [070/133] (701s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[322.919162] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[322.921478] Starting dynamic subtest: pipe-A-eDP-1
[322.981734] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[322.991733] Starting dynamic subtest: pipe-B-eDP-1
[323.046358] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[323.055364] Starting dynamic subtest: pipe-C-eDP-1
[323.111963] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[323.120892] Starting dynamic subtest: pipe-D-eDP-1
[323.175185] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[323.179433] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.027s)
[325.232309] [071/133] (698s left) gem_ctx_isolation (clean)
[325.296549] Starting subtest: clean
[325.298860] Starting dynamic subtest: rcs0
[325.351192] Dynamic subtest rcs0: SUCCESS (0.054s)
[325.361965] Starting dynamic subtest: bcs0
[325.391049] Dynamic subtest bcs0: SUCCESS (0.039s)
[325.399799] Starting dynamic subtest: vcs0
[325.450243] Dynamic subtest vcs0: SUCCESS (0.058s)
[325.460702] Starting dynamic subtest: vcs1
[326.947677] Dynamic subtest vcs1: SUCCESS (1.497s)
[326.957039] Starting dynamic subtest: vecs0
[328.942376] Dynamic subtest vecs0: SUCCESS (1.993s)
[328.950686] Starting dynamic subtest: ccs0
[330.964461] Dynamic subtest ccs0: SUCCESS (2.020s)
[330.966992] Subtest clean: SUCCESS (5.668s)
[331.228876] [072/133] (692s left) kms_rotation_crc (sprite-rotation-180)
[331.335665] Starting subtest: sprite-rotation-180
[338.183430] Subtest sprite-rotation-180: SUCCESS (6.848s)
[339.399320] [073/133] (684s left) gem_exec_whisper (basic-sync-all)
[339.466498] Starting subtest: basic-sync-all
[346.716193] Subtest basic-sync-all: SUCCESS (7.246s)
[346.898577] [074/133] (677s left) i915_pm_rpm (sysfs-read)
[349.065213] Starting subtest: sysfs-read
[350.232734] Subtest sysfs-read: SUCCESS (1.165s)
[350.621246] [075/133] (673s left) kms_plane (plane-panning-bottom-right-suspend)
[350.709425] Starting subtest: plane-panning-bottom-right-suspend
[350.711827] Starting dynamic subtest: pipe-A
[368.782137] Dynamic subtest pipe-A: SUCCESS (2.939s)
[368.793028] Starting dynamic subtest: pipe-B
[387.755309] Dynamic subtest pipe-B: SUCCESS (3.495s)
[387.757553] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.438s)
[388.547552] [076/133] (635s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[388.663310] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[388.667200] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[388.755150] [077/133] (635s left) kms_vblank (wait-busy-hang)
[388.841737] Starting subtest: wait-busy-hang
[388.843957] Starting dynamic subtest: pipe-A-eDP-1
[415.322748] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.625s)
[415.338747] Starting dynamic subtest: pipe-D-eDP-1
[440.368636] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.039s)
[440.370587] Subtest wait-busy-hang: SUCCESS (51.669s)
[441.160713] [078/133] (583s left) i915_selftest (mock)
[444.444869] Starting subtest: mock
[444.447327] Starting dynamic subtest: sanitycheck
[445.114023] Dynamic subtest sanitycheck: SUCCESS (0.669s)
[445.125549] Starting dynamic subtest: shmem
[445.769084] Dynamic subtest shmem: SUCCESS (0.653s)
[445.779117] Starting dynamic subtest: fence
[453.781862] Dynamic subtest fence: SUCCESS (8.012s)
[453.791641] Starting dynamic subtest: scatterlist
[455.445837] Dynamic subtest scatterlist: SUCCESS (1.662s)
[455.456033] Starting dynamic subtest: syncmap
[458.570939] Dynamic subtest syncmap: SUCCESS (3.124s)
[458.581269] Starting dynamic subtest: uncore
[459.254112] Dynamic subtest uncore: SUCCESS (0.682s)
[459.262188] Starting dynamic subtest: ring
[459.918988] Dynamic subtest ring: SUCCESS (0.663s)
[459.929118] Starting dynamic subtest: engine
[460.591295] Dynamic subtest engine: SUCCESS (0.670s)
[460.601502] Starting dynamic subtest: timelines
[464.477870] Dynamic subtest timelines: SUCCESS (3.885s)
[464.492729] Starting dynamic subtest: requests
[468.037139] Dynamic subtest requests: SUCCESS (3.558s)
[468.046870] Starting dynamic subtest: objects
[468.797835] Dynamic subtest objects: SUCCESS (0.760s)
[468.808015] Starting dynamic subtest: phys
[469.539862] Dynamic subtest phys: SUCCESS (0.741s)
[469.549977] Starting dynamic subtest: dmabuf
[470.305954] Dynamic subtest dmabuf: SUCCESS (0.765s)
[470.315986] Starting dynamic subtest: vma
[476.159814] Dynamic subtest vma: SUCCESS (5.854s)
[476.167963] Starting dynamic subtest: evict
[477.594959] Dynamic subtest evict: SUCCESS (1.434s)
[477.604349] Starting dynamic subtest: gtt
[480.893889] Dynamic subtest gtt: SUCCESS (3.299s)
[480.903652] Starting dynamic subtest: hugepages
[481.766103] Dynamic subtest hugepages: SUCCESS (0.871s)
[481.776192] Starting dynamic subtest: memory_region
[484.391370] Dynamic subtest memory_region: SUCCESS (2.622s)
[484.393681] Subtest mock: SUCCESS (39.958s)
[484.420450] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[484.421193] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[484.424610] [079/133] (540s left) gem_readwrite (write-bad-handle)
[485.943499] Subtest write-bad-handle: SKIP (0.000s)
[486.001972] [FACT gem_readwrite (write-bad-handle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[486.003311] [FACT gem_readwrite (write-bad-handle)] new: kernel.kmod_is_loaded.i915: true
[486.007314] [080/133] (538s left) syncobj_timeline (reset-during-wait-for-submit)
[486.077923] Starting subtest: reset-during-wait-for-submit
[486.182405] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[486.264044] [081/133] (538s left) fbdev (write)
[486.311307] Starting subtest: write
[486.669359] Subtest write: SUCCESS (0.359s)
[486.733068] [082/133] (537s left) gem_eio (in-flight-1us)
[486.867327] Starting subtest: in-flight-1us
[494.348763] Subtest in-flight-1us: SUCCESS (7.478s)
[494.510739] [083/133] (530s left) syncobj_wait (invalid-wait-bad-flags)
[494.568512] Starting subtest: invalid-wait-bad-flags
[494.570330] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[494.690109] [084/133] (529s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[494.772393] Starting subtest: primary-x-tiled-reflect-x-180
[501.893982] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.122s)
[503.109145] [085/133] (521s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[503.215629] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[503.219750] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[503.305911] [086/133] (521s left) perf_pmu (enable-race)
[503.348729] Starting subtest: enable-race
[503.350897] Starting dynamic subtest: rcs0
[516.112503] Dynamic subtest rcs0: SUCCESS (12.764s)
[516.122865] Starting dynamic subtest: bcs0
[528.858597] Dynamic subtest bcs0: SUCCESS (12.744s)
[528.873030] Starting dynamic subtest: vcs0
[544.619064] Dynamic subtest vcs0: SUCCESS (15.757s)
[544.631952] Starting dynamic subtest: vcs1
[560.554391] Dynamic subtest vcs1: SUCCESS (15.936s)
[560.566870] Starting dynamic subtest: vecs0
[576.554183] Dynamic subtest vecs0: SUCCESS (16.000s)
[576.564951] Starting dynamic subtest: ccs0
[589.295902] Dynamic subtest ccs0: SUCCESS (12.744s)
[589.298825] Subtest enable-race: SUCCESS (85.961s)
[589.388673] [087/133] (435s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[589.499765] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[589.504534] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[589.597850] [088/133] (435s left) gem_exec_schedule (implicit-boths)
[589.668638] Starting subtest: implicit-boths
[589.670649] Starting dynamic subtest: rcs0
[589.786932] Dynamic subtest rcs0: SUCCESS (0.130s)
[589.799371] Starting dynamic subtest: vcs0
[589.876571] Dynamic subtest vcs0: SUCCESS (0.087s)
[589.888479] Starting dynamic subtest: vcs1
[589.964132] Dynamic subtest vcs1: SUCCESS (0.087s)
[589.974734] Starting dynamic subtest: vecs0
[590.043038] Dynamic subtest vecs0: SUCCESS (0.078s)
[590.055782] Starting dynamic subtest: ccs0
[590.139516] Dynamic subtest ccs0: SUCCESS (0.095s)
[590.142243] Subtest implicit-boths: SUCCESS (0.483s)
[591.684766] [089/133] (433s left) gem_exec_schedule (u-fairslice)
[591.755943] Starting subtest: u-fairslice
[591.758095] Starting dynamic subtest: rcs0
[593.772217] Dynamic subtest rcs0: SUCCESS (2.024s)
[593.785249] Starting dynamic subtest: bcs0
[595.797616] Dynamic subtest bcs0: SUCCESS (2.023s)
[595.807221] Starting dynamic subtest: vcs0
[597.819143] Dynamic subtest vcs0: SUCCESS (2.021s)
[597.829520] Starting dynamic subtest: vcs1
[599.840236] Dynamic subtest vcs1: SUCCESS (2.020s)
[599.849794] Starting dynamic subtest: vecs0
[601.860497] Dynamic subtest vecs0: SUCCESS (2.021s)
[601.870957] Starting dynamic subtest: ccs0
[603.885935] Dynamic subtest ccs0: SUCCESS (2.025s)
[603.887784] Subtest u-fairslice: SUCCESS (12.139s)
[604.200145] [090/133] (420s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[604.312101] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[605.147108] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s)
[605.325847] [091/133] (419s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[605.423107] Starting subtest: compare-crc-sanitycheck-xr24
[605.425003] Starting dynamic subtest: pipe-A-eDP-1
[606.083971] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.659s)
[606.099658] Starting dynamic subtest: pipe-B-eDP-1
[607.372760] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.290s)
[607.383295] Starting dynamic subtest: pipe-C-eDP-1
[608.627193] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.252s)
[608.637579] Starting dynamic subtest: pipe-D-eDP-1
[609.863562] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[609.865797] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.444s)
[610.723340] [092/133] (414s left) kms_properties (plane-properties-atomic)
[610.812701] Starting subtest: plane-properties-atomic
[610.814899] Starting dynamic subtest: pipe-A-eDP-1
[611.371512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[611.381322] Starting dynamic subtest: pipe-B-eDP-1
[612.682371] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.311s)
[612.692246] Starting dynamic subtest: pipe-C-eDP-1
[613.919055] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[613.929029] Starting dynamic subtest: pipe-D-eDP-1
[615.156483] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[615.158744] Subtest plane-properties-atomic: SUCCESS (4.343s)
[615.954369] [093/133] (409s left) gem_ringfill (legacy-basic)
[621.614666] Starting subtest: legacy-basic
[621.617553] Starting dynamic subtest: default
[621.661939] Dynamic subtest default: SUCCESS (0.047s)
[621.673157] Starting dynamic subtest: render
[621.702284] Dynamic subtest render: SUCCESS (0.039s)
[621.713693] Starting dynamic subtest: bsd
[621.742975] Dynamic subtest bsd: SUCCESS (0.040s)
[621.753739] Starting dynamic subtest: bsd1
[621.783292] Dynamic subtest bsd1: SUCCESS (0.038s)
[621.793955] Starting dynamic subtest: bsd2
[621.827101] Dynamic subtest bsd2: SUCCESS (0.041s)
[621.838091] Starting dynamic subtest: blt
[621.872112] Dynamic subtest blt: SUCCESS (0.042s)
[621.882958] Starting dynamic subtest: vebox
[621.915928] Dynamic subtest vebox: SUCCESS (0.042s)
[621.918412] Subtest legacy-basic: SUCCESS (0.303s)
[621.996825] [094/133] (403s left) gem_mmap_wc (read)
[622.046671] Subtest read: SKIP (0.000s)
[622.112451] [095/133] (403s left) kms_psr (psr2-cursor-mmap-gtt)
[622.220003] Starting subtest: psr2-cursor-mmap-gtt
[622.222355] Starting dynamic subtest: eDP-1
[623.942138] Dynamic subtest eDP-1: SUCCESS (1.721s)
[623.944477] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.722s)
[624.730930] [096/133] (400s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[624.823311] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[624.827830] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[624.919972] [097/133] (400s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[625.025047] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[625.029507] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[625.137365] [098/133] (400s left) gem_exec_balancer (full-pulse)
[625.200171] Starting subtest: full-pulse
[629.492798] Subtest full-pulse: SUCCESS (4.294s)
[629.830520] [099/133] (395s left) gem_exec_whisper (basic-fds-priority-all)
[629.904549] Starting subtest: basic-fds-priority-all
[653.596543] Subtest basic-fds-priority-all: SUCCESS (23.683s)
[653.780623] [100/133] (371s left) kms_pm_backlight (basic-brightness)
[653.876908] Starting subtest: basic-brightness
[653.934397] Starting dynamic subtest: eDP-1
[654.245203] Dynamic subtest eDP-1: SUCCESS (0.311s)
[654.247501] Subtest basic-brightness: SUCCESS (0.368s)
[655.058793] [101/133] (370s left) gem_ctx_persistence (legacy-engines-mixed-process)
[655.126256] Starting subtest: legacy-engines-mixed-process
[655.128567] Starting dynamic subtest: render
[656.631761] Dynamic subtest render: SUCCESS (1.505s)
[656.649515] Starting dynamic subtest: bsd1
[658.621741] Dynamic subtest bsd1: SUCCESS (1.987s)
[658.636161] Starting dynamic subtest: bsd2
[660.608047] Dynamic subtest bsd2: SUCCESS (1.983s)
[660.619946] Starting dynamic subtest: blt
[662.583729] Dynamic subtest blt: SUCCESS (1.973s)
[662.594469] Starting dynamic subtest: vebox
[664.626587] Dynamic subtest vebox: SUCCESS (2.041s)
[664.628938] Subtest legacy-engines-mixed-process: SUCCESS (9.501s)
[664.707965] [102/133] (360s left) gem_exec_reloc (basic-wc-gtt-active)
[664.769500] Subtest basic-wc-gtt-active: SKIP (0.000s)
[664.846246] [103/133] (360s left) gem_wait (await)
[664.908173] Starting subtest: await
[664.910650] Starting dynamic subtest: all-engines
[666.110603] Dynamic subtest all-engines: SUCCESS (1.202s)
[666.125170] Starting dynamic subtest: rcs0
[667.194778] Dynamic subtest rcs0: SUCCESS (1.082s)
[667.207916] Starting dynamic subtest: bcs0
[668.262536] Dynamic subtest bcs0: SUCCESS (1.066s)
[668.279948] Starting dynamic subtest: vcs0
[669.322942] Dynamic subtest vcs0: SUCCESS (1.058s)
[669.340944] Starting dynamic subtest: vcs1
[670.381867] Dynamic subtest vcs1: SUCCESS (1.056s)
[670.399621] Starting dynamic subtest: vecs0
[671.441537] Dynamic subtest vecs0: SUCCESS (1.058s)
[671.457480] Starting dynamic subtest: ccs0
[672.503746] Dynamic subtest ccs0: SUCCESS (1.060s)
[672.506863] Subtest await: SUCCESS (7.596s)
[672.704282] [104/133] (352s left) kms_psr (fbc-psr2-sprite-blt)
[672.791939] Starting subtest: fbc-psr2-sprite-blt
[672.794178] Starting dynamic subtest: eDP-1
[672.798205] Dynamic subtest eDP-1: SKIP (0.000s)
[672.802283] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[672.868568] [105/133] (352s left) i915_drm_fdinfo (virtual-busy-hang)
[672.912587] Starting subtest: virtual-busy-hang
[672.917537] Subtest virtual-busy-hang: SKIP (0.000s)
[672.976790] [106/133] (352s left) gem_exec_create (madvise)
[673.037713] Starting subtest: madvise
[673.040317] Starting dynamic subtest: smem
[694.632968] Dynamic subtest smem: SUCCESS (21.595s)
[694.635595] Subtest madvise: SUCCESS (21.596s)
[695.518410] [107/133] (330s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[695.628056] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[695.631949] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[695.722369] [108/133] (330s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[695.817503] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[695.821761] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[695.887304] [109/133] (329s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[695.981525] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[695.985599] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[696.086720] [110/133] (329s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[696.184579] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[702.758211] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.577s)
[702.905417] [111/133] (322s left) gem_exec_fence (syncobj-timeline-repeat)
[703.488508] Starting subtest: syncobj-timeline-repeat
[703.731955] Subtest syncobj-timeline-repeat: SUCCESS (0.244s)
[704.673812] [112/133] (321s left) gem_mmap_gtt (basic-write-read)
[704.725645] Subtest basic-write-read: SKIP (0.000s)
[704.797219] [113/133] (321s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[704.901714] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[704.906036] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[704.998233] [114/133] (321s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[705.058713] Starting subtest: single-wait-all-for-submit-signaled
[705.061004] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[705.160917] [115/133] (320s left) kms_async_flips (async-flip-suspend-resume)
[705.245240] Starting subtest: async-flip-suspend-resume
[705.620553] Starting dynamic subtest: pipe-A-eDP-1
[723.360297] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.879s)
[723.744204] Starting dynamic subtest: pipe-B-eDP-1
[741.395919] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.917s)
[741.778148] Starting dynamic subtest: pipe-C-eDP-1
[759.391871] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.888s)
[759.779562] Starting dynamic subtest: pipe-D-eDP-1
[777.390753] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.877s)
[777.393106] Subtest async-flip-suspend-resume: SUCCESS (13.058s)
[778.570896] [116/133] (247s left) kms_flip (2x-flip-vs-dpms-on-nop)
[778.675607] Starting subtest: 2x-flip-vs-dpms-on-nop
[778.686911] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[778.782345] [117/133] (247s left) prime_vgem (basic-fence-read)
[778.860593] Starting subtest: basic-fence-read
[778.869218] Subtest basic-fence-read: SKIP (0.006s)
[778.976202] [118/133] (247s left) gem_unref_active_buffers
[779.171032] [119/133] (247s left) kms_psr (pr-primary-mmap-gtt)
[779.260248] Starting subtest: pr-primary-mmap-gtt
[779.264263] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[779.348557] [120/133] (246s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[779.406101] Starting subtest: etime-single-wait-available-unsubmitted
[779.514411] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[779.594264] [121/133] (246s left) syncobj_wait (single-wait-for-submit-signaled)
[779.650864] Starting subtest: single-wait-for-submit-signaled
[779.653186] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[779.789865] [122/133] (246s left) gem_ctx_bad_destroy (invalid-ctx)
[779.836688] Starting subtest: invalid-ctx
[779.839112] Subtest invalid-ctx: SUCCESS (0.000s)
[779.915720] [123/133] (246s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[780.041215] Starting subtest: protected-encrypted-src-copy-not-readible
[780.169150] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.129s)
[780.307644] [124/133] (246s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[780.395387] Starting subtest: 2x-absolute-wf_vblank-interruptible
[780.406456] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[780.497483] [125/133] (245s left) gem_userptr_blits (relocations)
[780.562742] Starting subtest: relocations
[780.566906] Subtest relocations: SKIP (0.001s)
[780.697185] [126/133] (245s left) kms_properties (colorop-properties-legacy)
[780.791251] Starting subtest: colorop-properties-legacy
[780.793106] Starting dynamic subtest: pipe-A-eDP-1
[781.162062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.370s)
[781.172847] Starting dynamic subtest: pipe-B-eDP-1
[782.243578] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.075s)
[782.254038] Starting dynamic subtest: pipe-C-eDP-1
[783.272503] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.027s)
[783.285591] Starting dynamic subtest: pipe-D-eDP-1
[784.320908] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.041s)
[784.322864] Subtest colorop-properties-legacy: SUCCESS (3.519s)
[785.120731] [127/133] (241s left) gem_mmap_gtt (hang-user)
[785.176870] Subtest hang-user: SKIP (0.000s)
[785.236444] [128/133] (241s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[785.326224] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[789.839050] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.506s)
[791.039644] [129/133] (235s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[791.143302] Starting subtest: plane-lut1d-ctm3x4
[791.290592] Starting dynamic subtest: pipe-A-plane-0
[791.644417] Dynamic subtest pipe-A-plane-0: FAIL (0.182s)
[791.659512] Starting dynamic subtest: pipe-A-plane-1
[791.882826] Dynamic subtest pipe-A-plane-1: FAIL (0.181s)
[791.895731] Starting dynamic subtest: pipe-A-plane-2
[792.115849] Dynamic subtest pipe-A-plane-2: FAIL (0.178s)
[793.031113] Starting dynamic subtest: pipe-B-plane-0
[793.485440] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[793.496258] Starting dynamic subtest: pipe-B-plane-1
[793.801652] Dynamic subtest pipe-B-plane-1: FAIL (0.168s)
[793.812312] Starting dynamic subtest: pipe-B-plane-2
[794.103798] Dynamic subtest pipe-B-plane-2: FAIL (0.188s)
[794.762658] Starting dynamic subtest: pipe-C-plane-0
[795.254444] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[795.267051] Starting dynamic subtest: pipe-C-plane-1
[795.674642] Dynamic subtest pipe-C-plane-1: FAIL (0.154s)
[795.686387] Starting dynamic subtest: pipe-C-plane-2
[796.045880] Dynamic subtest pipe-C-plane-2: FAIL (0.615s)
[796.900437] Starting dynamic subtest: pipe-D-plane-0
[797.491942] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[797.504366] Starting dynamic subtest: pipe-D-plane-1
[797.961202] Dynamic subtest pipe-D-plane-1: FAIL (0.609s)
[797.973286] Starting dynamic subtest: pipe-D-plane-2
[798.402866] Dynamic subtest pipe-D-plane-2: FAIL (0.544s)
[798.481290] Subtest plane-lut1d-ctm3x4: FAIL (7.332s)
[799.354479] [130/133] (227s left) sysfs_timeslice_duration (duration)
[799.405677] Starting subtest: duration
[799.408246] Starting dynamic subtest: vecs0
[812.566959] Dynamic subtest vecs0: SUCCESS (13.158s)
[812.579909] Starting dynamic subtest: ccs0
[825.717068] Dynamic subtest ccs0: SUCCESS (13.149s)
[825.731062] Starting dynamic subtest: vcs0
[839.539544] Dynamic subtest vcs0: SUCCESS (13.816s)
[839.552966] Starting dynamic subtest: bcs0
[852.684022] Dynamic subtest bcs0: SUCCESS (13.139s)
[852.697419] Starting dynamic subtest: rcs0
[865.840227] Dynamic subtest rcs0: SUCCESS (13.149s)
[865.853766] Starting dynamic subtest: vcs1
[880.563591] Dynamic subtest vcs1: SUCCESS (14.719s)
[880.566403] Subtest duration: SUCCESS (81.147s)
[880.646965] [131/133] (146s left) gem_spin_batch (resubmit-new)
[880.715341] Starting subtest: resubmit-new
[880.717766] Starting dynamic subtest: rcs0
[880.728625] Dynamic subtest rcs0: SUCCESS (0.013s)
[880.740925] Starting dynamic subtest: bcs0
[880.742850] Dynamic subtest bcs0: SUCCESS (0.006s)
[880.753411] Starting dynamic subtest: vcs0
[880.755638] Dynamic subtest vcs0: SUCCESS (0.008s)
[880.765801] Starting dynamic subtest: vcs1
[880.768065] Dynamic subtest vcs1: SUCCESS (0.008s)
[880.778156] Starting dynamic subtest: vecs0
[880.780388] Dynamic subtest vecs0: SUCCESS (0.009s)
[880.790215] Starting dynamic subtest: ccs0
[880.792360] Dynamic subtest ccs0: SUCCESS (0.008s)
[880.794574] Subtest resubmit-new: SUCCESS (0.060s)
[882.691742] [132/133] (144s left) gem_userptr_blits (create-destroy-sync)
[882.758653] Starting subtest: create-destroy-sync
[887.770454] Subtest create-destroy-sync: SUCCESS (5.012s)
[887.912759] [133/133] (138s left) dmabuf_sync_file (export-multiwait)
[887.959211] Starting subtest: export-multiwait
[887.961124] Subtest export-multiwait: SUCCESS (0.001s)
[888.013217] 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.