[57.910645] Initializing watchdogs
[57.910694]   /dev/watchdog0
[57.925447] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.929547] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.931746] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.935761] [001/133] (960s left) gem_exec_fence (basic-await)
[58.134618] Starting subtest: basic-await
[58.137076] Starting dynamic subtest: rcs0
[58.214867] Dynamic subtest rcs0: SUCCESS (0.083s)
[58.225553] Starting dynamic subtest: bcs0
[58.292764] Dynamic subtest bcs0: SUCCESS (0.078s)
[58.303020] Starting dynamic subtest: vcs0
[58.370877] Dynamic subtest vcs0: SUCCESS (0.076s)
[58.380900] Starting dynamic subtest: vcs1
[58.446422] Dynamic subtest vcs1: SUCCESS (0.076s)
[58.457458] Starting dynamic subtest: vecs0
[58.522116] Dynamic subtest vecs0: SUCCESS (0.075s)
[58.530360] Starting dynamic subtest: ccs0
[58.598034] Dynamic subtest ccs0: SUCCESS (0.074s)
[58.600882] Subtest basic-await: SUCCESS (0.466s)
[60.923713] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[60.926388] [002/133] (957s left) kms_big_fb (linear-8bpp-rotate-0)
[61.010671] Starting subtest: linear-8bpp-rotate-0
[62.235108] Subtest linear-8bpp-rotate-0: SUCCESS (1.225s)
[62.364403] [003/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[62.459478] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[62.463179] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[62.552270] [004/133] (955s left) gem_exec_params (rel-constants-invalid)
[62.615872] Starting subtest: rel-constants-invalid
[62.618250] Subtest rel-constants-invalid: SUCCESS (0.000s)
[62.735536] [005/133] (955s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[62.820610] Starting subtest: 4-tiled-addfb-size-offset-overflow
[62.822306] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[62.928091] [006/133] (955s left) gem_sync (basic-store-all)
[63.000789] Starting subtest: basic-store-all
[65.299608] Subtest basic-store-all: SUCCESS (2.308s)
[65.483889] [007/133] (953s left) gem_mmap_gtt (fault-concurrent-x)
[65.533760] Subtest fault-concurrent-X: SKIP (0.000s)
[65.597907] [008/133] (953s left) kms_chamelium_color (ctm-blue-to-red)
[65.682720] Subtest ctm-blue-to-red: SKIP (0.000s)
[65.726814] [009/133] (953s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[65.792827] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[65.795904] Starting dynamic subtest: pipe-A-default-mode
[68.469502] Dynamic subtest pipe-A-default-mode: SUCCESS (2.675s)
[68.471557] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.676s)
[69.328498] [010/133] (949s left) kms_hdr (static-toggle)
[69.400199] Starting subtest: static-toggle
[69.406561] Subtest static-toggle: SKIP (0.000s)
[69.467182] [011/133] (949s left) prime_vgem (fence-wait)
[69.539536] Starting subtest: fence-wait
[69.541476] Starting dynamic subtest: rcs0
[70.587948] Dynamic subtest rcs0: SUCCESS (1.048s)
[70.596271] Starting dynamic subtest: bcs0
[71.645887] Dynamic subtest bcs0: SUCCESS (1.057s)
[71.654224] Starting dynamic subtest: vcs0
[72.689643] Dynamic subtest vcs0: SUCCESS (1.044s)
[72.698845] Starting dynamic subtest: vcs1
[73.731664] Dynamic subtest vcs1: SUCCESS (1.041s)
[73.740662] Starting dynamic subtest: vecs0
[74.774541] Dynamic subtest vecs0: SUCCESS (1.041s)
[74.783793] Starting dynamic subtest: ccs0
[75.815771] Dynamic subtest ccs0: SUCCESS (1.041s)
[75.818615] Subtest fence-wait: SUCCESS (6.277s)
[75.933848] [012/133] (942s left) gen7_exec_parse (cmd-crossing-page)
[75.995850] Subtest cmd-crossing-page: SKIP (0.000s)
[76.070674] [013/133] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[76.156757] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[76.161045] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[76.244950] [014/133] (942s left) kms_chamelium_hpd (dp-hpd-storm)
[76.609556] Subtest dp-hpd-storm: SKIP (0.000s)
[77.437368] [015/133] (941s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[77.522762] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[77.524970] Starting dynamic subtest: pipe-A-eDP-1
[78.406252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.876s)
[78.415975] Starting dynamic subtest: pipe-B-eDP-1
[80.044614] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.635s)
[80.053386] Starting dynamic subtest: pipe-C-eDP-1
[81.607141] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.562s)
[81.616487] Starting dynamic subtest: pipe-D-eDP-1
[83.130071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[83.132330] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.599s)
[84.306650] [016/133] (934s left) kms_content_protection (legacy-hdcp14)
[84.433076] Starting subtest: legacy-hdcp14
[84.437710] Subtest legacy-hdcp14: SKIP (0.000s)
[84.553326] [017/133] (934s left) kms_plane_multiple (tiling-yf)
[84.622467] Starting subtest: tiling-yf
[84.626398] Subtest tiling-yf: SKIP (0.000s)
[84.692091] [018/133] (934s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[84.761886] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[84.766543] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[85.923747] [019/133] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[85.996191] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[93.002834] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.010s)
[93.147103] [020/133] (926s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[93.225073] Starting subtest: invalidate-primary-flip-overlay
[103.907850] Subtest invalidate-primary-flip-overlay: SUCCESS (10.684s)
[104.009985] [021/133] (915s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[104.088711] Starting subtest: y-tiled-32bpp-rotate-180
[104.092303] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[104.184427] [022/133] (915s left) kms_lease (atomic-implicit-crtc)
[104.257076] Starting subtest: atomic-implicit-crtc
[104.258837] Starting dynamic subtest: pipe-A-eDP-1
[104.268383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[104.281592] Starting dynamic subtest: pipe-B-eDP-1
[104.290841] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[104.297844] Starting dynamic subtest: pipe-C-eDP-1
[104.306521] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[104.313108] Starting dynamic subtest: pipe-D-eDP-1
[104.321932] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[104.323779] Subtest atomic-implicit-crtc: SUCCESS (0.033s)
[104.398621] [023/133] (914s left) kms_cursor_crc (cursor-dpms)
[104.506090] Starting subtest: cursor-dpms
[104.507906] Starting dynamic subtest: pipe-A-eDP-1
[107.570054] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.062s)
[107.580218] Starting dynamic subtest: pipe-D-eDP-1
[111.163761] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.594s)
[111.166197] Subtest cursor-dpms: SUCCESS (6.658s)
[112.007038] [024/133] (907s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[112.076768] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[112.079710] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[112.223928] [025/133] (907s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[112.312954] Starting subtest: x-tiled-32bpp-rotate-270
[112.332160] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[112.467744] [026/133] (906s left) kms_cursor_crc (cursor-tearing-position-change)
[112.558648] Starting subtest: cursor-tearing-position-change
[112.560936] Starting dynamic subtest: pipe-A-eDP-1
[113.126512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[113.134460] Starting dynamic subtest: pipe-D-eDP-1
[114.336484] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[114.338766] Subtest cursor-tearing-position-change: SUCCESS (1.775s)
[115.172905] [027/133] (904s left) api_intel_allocator (execbuf-with-allocator)
[115.220946] Starting subtest: execbuf-with-allocator
[115.226107] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[115.342184] [028/133] (904s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[115.421677] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[115.449090] Starting dynamic subtest: pipe-A-plane-0
[115.737626] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[115.747241] Starting dynamic subtest: pipe-A-plane-3
[115.982413] Dynamic subtest pipe-A-plane-3: SUCCESS (0.243s)
[115.992299] Starting dynamic subtest: pipe-A-plane-5
[115.997057] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[117.059478] Starting dynamic subtest: pipe-B-plane-0
[117.352919] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[117.361064] Starting dynamic subtest: pipe-B-plane-3
[117.586694] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[117.594474] Starting dynamic subtest: pipe-B-plane-5
[117.598674] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[117.898200] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.478s)
[118.727642] [029/133] (900s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[118.825381] Starting subtest: cursorB-vs-flipA-varying-size
[118.829917] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[118.967884] [030/133] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[119.042300] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[119.046582] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[119.134522] [031/133] (900s left) gem_exec_reloc (basic-gtt-read-active)
[119.193633] Subtest basic-gtt-read-active: SKIP (0.000s)
[119.258792] [032/133] (900s left) kms_async_flips (crc-atomic)
[119.328897] Starting subtest: crc-atomic
[119.715702] Starting dynamic subtest: pipe-A-eDP-1
[122.647341] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.931s)
[123.035051] Starting dynamic subtest: pipe-B-eDP-1
[125.968885] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.941s)
[126.360207] Starting dynamic subtest: pipe-C-eDP-1
[129.187415] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.837s)
[129.553539] Starting dynamic subtest: pipe-D-eDP-1
[132.408260] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.861s)
[132.410666] Subtest crc-atomic: SUCCESS (13.080s)
[133.591964] [033/133] (886s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[133.669796] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[133.674118] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[133.743410] [034/133] (885s left) api_intel_bb (object-noreloc-purge-cache-simple)
[133.811199] Starting subtest: object-noreloc-purge-cache-simple
[133.819694] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[133.940184] [035/133] (885s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[134.275076] Starting subtest: cursor-rapid-movement-256x85
[134.352741] Subtest cursor-rapid-movement-256x85: SKIP (0.073s)
[134.530200] [036/133] (885s left) syncobj_wait (wait-all-snapshot)
[134.585685] Starting subtest: wait-all-snapshot
[134.665753] Subtest wait-all-snapshot: SUCCESS (0.081s)
[134.742725] [037/133] (885s left) gem_eio (kms)
[134.993986] Starting subtest: kms
[155.642103] Subtest kms: SUCCESS (20.647s)
[155.774106] [038/133] (864s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[155.853525] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[155.857730] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[155.957217] [039/133] (863s left) gem_render_copy_redux (interruptible)
[156.019360] Starting subtest: interruptible
[156.374196] Subtest interruptible: SUCCESS (0.355s)
[156.483960] [040/133] (863s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[156.574686] Starting subtest: fbcpsr-slowdraw
[181.662108] Subtest fbcpsr-slowdraw: SUCCESS (25.090s)
[181.790091] [041/133] (838s left) syncobj_basic (bad-handle-to-fd)
[181.843031] Starting subtest: bad-handle-to-fd
[181.845222] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[181.922521] [042/133] (838s left) gem_exec_reloc (basic-gtt-read)
[181.988835] Subtest basic-gtt-read: SKIP (0.000s)
[182.095422] [043/133] (838s left) kms_atomic_transition (plane-all-modeset-transition)
[182.169311] Starting subtest: plane-all-modeset-transition
[182.173644] Subtest plane-all-modeset-transition: SKIP (0.000s)
[182.244368] [044/133] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[182.329763] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[182.333840] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[182.423045] [045/133] (837s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[182.482318] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[182.590238] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[182.665355] [046/133] (837s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[182.787064] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[191.736584] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.947s)
[192.598197] [047/133] (827s left) kms_chamelium_frames (hdmi-crc-multiple)
[192.983874] Subtest hdmi-crc-multiple: SKIP (0.000s)
[193.814227] [048/133] (826s left) kms_sequence (get-idle)
[193.901454] Starting subtest: get-idle
[193.903460] Starting dynamic subtest: pipe-A-eDP-1
[195.725308] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s)
[195.735644] Starting dynamic subtest: pipe-B-eDP-1
[198.218726] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.491s)
[198.227948] Starting dynamic subtest: pipe-C-eDP-1
[200.633476] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.414s)
[200.643738] Starting dynamic subtest: pipe-D-eDP-1
[203.049890] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.415s)
[203.052196] Subtest get-idle: SUCCESS (9.149s)
[203.863507] [049/133] (816s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[203.937123] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[203.939389] Starting dynamic subtest: pipe-A-eDP-1
[203.960368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[203.970268] Starting dynamic subtest: pipe-B-eDP-1
[203.989111] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[203.996963] Starting dynamic subtest: pipe-C-eDP-1
[204.016218] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[204.023890] Starting dynamic subtest: pipe-D-eDP-1
[204.043757] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[204.046039] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[206.128427] [050/133] (814s left) kms_feature_discovery (display-4x)
[206.210287] Starting subtest: display-4x
[206.214351] Subtest display-4x: SKIP (0.000s)
[206.283307] [051/133] (814s left) kms_cursor_legacy (single-move)
[206.376328] Starting subtest: single-move
[206.378534] Starting dynamic subtest: pipe-A
[211.814571] Dynamic subtest pipe-A: SUCCESS (5.380s)
[211.824683] Starting dynamic subtest: pipe-B
[217.193848] Dynamic subtest pipe-B: SUCCESS (5.379s)
[217.204093] Starting dynamic subtest: pipe-C
[222.575737] Dynamic subtest pipe-C: SUCCESS (5.379s)
[222.585967] Starting dynamic subtest: pipe-D
[227.956697] Dynamic subtest pipe-D: SUCCESS (5.379s)
[227.967256] Starting dynamic subtest: all-pipes
[233.344699] Dynamic subtest all-pipes: SUCCESS (5.387s)
[233.347107] Subtest single-move: SUCCESS (26.916s)
[233.434843] [052/133] (787s left) kms_plane_scaling (planes-scaler-unity-scaling)
[233.519055] Starting subtest: planes-scaler-unity-scaling
[233.521478] Starting dynamic subtest: pipe-A
[233.579901] Dynamic subtest pipe-A: SUCCESS (0.064s)
[233.588551] Starting dynamic subtest: pipe-B
[234.754719] Dynamic subtest pipe-B: SUCCESS (1.173s)
[234.764627] Starting dynamic subtest: pipe-C
[235.862687] Dynamic subtest pipe-C: SUCCESS (1.107s)
[235.871416] Starting dynamic subtest: pipe-D
[236.998705] Dynamic subtest pipe-D: SUCCESS (1.135s)
[237.001042] Subtest planes-scaler-unity-scaling: SUCCESS (3.483s)
[238.168811] [053/133] (782s left) gem_pxp (fail-invalid-protected-context)
[238.300489] Starting subtest: fail-invalid-protected-context
[238.302823] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[238.405240] [054/133] (782s left) sw_sync (timeline_closed_signaled)
[238.442554] Starting subtest: timeline_closed_signaled
[238.444731] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[238.489436] [055/133] (782s left) kms_addfb_basic (bad-pitch-32)
[238.538040] Starting subtest: bad-pitch-32
[238.540279] Subtest bad-pitch-32: SUCCESS (0.000s)
[238.652845] [056/133] (782s left) kms_psr2_su (page_flip-nv12)
[238.708071] Subtest page_flip-NV12: SKIP (0.000s)
[238.770332] [057/133] (781s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[238.843181] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[245.709359] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.868s)
[245.834372] [058/133] (774s left) kms_pm_rpm (modeset-non-lpsp)
[248.040574] Starting subtest: modeset-non-lpsp
[249.195731] Subtest modeset-non-lpsp: SKIP (1.157s)
[249.555132] [059/133] (771s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[249.615385] Starting subtest: multi-wait-all-for-submit-available-submitted
[249.617829] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[249.711983] [060/133] (771s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[249.784860] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[249.787073] Starting dynamic subtest: A-eDP1
[253.376197] Dynamic subtest A-eDP1: SUCCESS (3.591s)
[253.384504] Starting dynamic subtest: B-eDP1
[256.569300] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[256.578591] Starting dynamic subtest: C-eDP1
[259.668509] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[259.681023] Starting dynamic subtest: D-eDP1
[262.771230] Dynamic subtest D-eDP1: SUCCESS (3.102s)
[262.773516] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.990s)
[263.579417] [061/133] (757s left) gem_workarounds (basic-read)
[263.653413] Starting subtest: basic-read
[263.665821] Subtest basic-read: SUCCESS (0.011s)
[263.780070] [062/133] (757s left) i915_drm_fdinfo (virtual-idle)
[263.824557] Starting subtest: virtual-idle
[266.861206] Subtest virtual-idle: SUCCESS (3.035s)
[266.951760] [063/133] (754s left) kms_vrr (negative-basic)
[267.024111] Starting subtest: negative-basic
[267.030889] Starting dynamic subtest: pipe-A-eDP-1
[272.501057] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.414s)
[272.735254] Subtest negative-basic: SUCCESS (5.712s)
[273.615154] [064/133] (747s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[273.695919] Starting subtest: yf-tiled-8bpp-rotate-0
[273.700595] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[273.794169] [065/133] (747s left) kms_psr (fbc-psr-primary-blt)
[273.869074] Starting subtest: fbc-psr-primary-blt
[273.871210] Starting dynamic subtest: eDP-1
[273.875164] Dynamic subtest eDP-1: SKIP (0.000s)
[273.879145] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[273.946427] [066/133] (747s left) gem_exec_schedule (manyslice)
[274.012179] Starting subtest: manyslice
[274.014273] Starting dynamic subtest: rcs0
[279.158603] Dynamic subtest rcs0: SUCCESS (5.100s)
[279.169622] Starting dynamic subtest: bcs0
[285.253732] Dynamic subtest bcs0: SUCCESS (6.095s)
[285.261872] Starting dynamic subtest: vcs0
[290.825331] Dynamic subtest vcs0: SUCCESS (5.569s)
[290.833057] Starting dynamic subtest: vcs1
[296.384505] Dynamic subtest vcs1: SUCCESS (5.558s)
[296.392774] Starting dynamic subtest: vecs0
[302.443157] Dynamic subtest vecs0: SUCCESS (6.057s)
[302.452999] Starting dynamic subtest: ccs0
[309.091523] Dynamic subtest ccs0: SUCCESS (6.646s)
[309.093672] Subtest manyslice: SUCCESS (35.033s)
[309.344643] [067/133] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[309.433851] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[309.438273] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[309.526826] [068/133] (711s left) kms_fbcon_fbt (fbc)
[309.574561] Starting subtest: fbc
[315.969880] Subtest fbc: SUCCESS (6.395s)
[317.052572] [069/133] (704s left) gem_create (create-ext-cpu-access-big)
[317.223943] Starting subtest: create-ext-cpu-access-big
[317.229069] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[317.296788] [070/133] (703s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[317.366530] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[317.368980] Starting dynamic subtest: pipe-A-eDP-1
[317.429160] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[317.436858] Starting dynamic subtest: pipe-B-eDP-1
[317.494603] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[317.504125] Starting dynamic subtest: pipe-C-eDP-1
[317.560857] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[317.570137] Starting dynamic subtest: pipe-D-eDP-1
[317.628278] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[317.632420] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[319.635725] [071/133] (701s left) gem_ctx_isolation (clean)
[319.693826] Starting subtest: clean
[319.696256] Starting dynamic subtest: rcs0
[319.754479] Dynamic subtest rcs0: SUCCESS (0.060s)
[319.764238] Starting dynamic subtest: bcs0
[319.819150] Dynamic subtest bcs0: SUCCESS (0.062s)
[319.828983] Starting dynamic subtest: vcs0
[319.882263] Dynamic subtest vcs0: SUCCESS (0.063s)
[319.892063] Starting dynamic subtest: vcs1
[321.877560] Dynamic subtest vcs1: SUCCESS (1.994s)
[321.887893] Starting dynamic subtest: vecs0
[323.865269] Dynamic subtest vecs0: SUCCESS (1.985s)
[323.874328] Starting dynamic subtest: ccs0
[325.876660] Dynamic subtest ccs0: SUCCESS (2.011s)
[325.879076] Subtest clean: SUCCESS (6.183s)
[326.111582] [072/133] (695s left) kms_rotation_crc (sprite-rotation-180)
[326.195533] Starting subtest: sprite-rotation-180
[333.026757] Subtest sprite-rotation-180: SUCCESS (6.832s)
[334.199920] [073/133] (687s left) gem_exec_whisper (basic-sync-all)
[334.277110] Starting subtest: basic-sync-all
[341.528160] Subtest basic-sync-all: SUCCESS (7.248s)
[341.723248] [074/133] (679s left) i915_pm_rpm (sysfs-read)
[343.940777] Starting subtest: sysfs-read
[345.084382] Subtest sysfs-read: SUCCESS (1.143s)
[345.440366] [075/133] (675s left) kms_plane (plane-panning-bottom-right-suspend)
[345.518566] Starting subtest: plane-panning-bottom-right-suspend
[345.521058] Starting dynamic subtest: pipe-A
[363.199155] Dynamic subtest pipe-A: SUCCESS (2.971s)
[363.209258] Starting dynamic subtest: pipe-B
[382.178552] Dynamic subtest pipe-B: SUCCESS (3.526s)
[382.180860] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.500s)
[382.996281] [076/133] (638s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[383.085696] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[383.089889] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[383.185451] [077/133] (638s left) kms_vblank (wait-busy-hang)
[383.253410] Starting subtest: wait-busy-hang
[383.255730] Starting dynamic subtest: pipe-A-eDP-1
[409.863701] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.593s)
[409.878097] Starting dynamic subtest: pipe-D-eDP-1
[424.816081] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.955s)
[424.818391] Subtest wait-busy-hang: SUCCESS (41.553s)
[425.694242] [078/133] (595s left) i915_selftest (mock)
[427.454091] Starting subtest: mock
[427.456308] Starting dynamic subtest: sanitycheck
[428.111485] Dynamic subtest sanitycheck: SUCCESS (0.657s)
[428.120650] Starting dynamic subtest: shmem
[428.767287] Dynamic subtest shmem: SUCCESS (0.653s)
[428.776991] Starting dynamic subtest: fence
[436.146066] Dynamic subtest fence: SUCCESS (7.376s)
[436.155662] Starting dynamic subtest: scatterlist
[437.815924] Dynamic subtest scatterlist: SUCCESS (1.668s)
[437.825949] Starting dynamic subtest: syncmap
[440.928242] Dynamic subtest syncmap: SUCCESS (3.110s)
[440.938263] Starting dynamic subtest: uncore
[441.573513] Dynamic subtest uncore: SUCCESS (0.643s)
[441.585732] Starting dynamic subtest: ring
[442.225222] Dynamic subtest ring: SUCCESS (0.649s)
[442.235456] Starting dynamic subtest: engine
[442.858247] Dynamic subtest engine: SUCCESS (0.631s)
[442.868277] Starting dynamic subtest: timelines
[446.647642] Dynamic subtest timelines: SUCCESS (3.786s)
[446.657417] Starting dynamic subtest: requests
[449.969699] Dynamic subtest requests: SUCCESS (3.321s)
[449.979281] Starting dynamic subtest: objects
[450.704193] Dynamic subtest objects: SUCCESS (0.734s)
[450.716166] Starting dynamic subtest: phys
[451.454153] Dynamic subtest phys: SUCCESS (0.748s)
[451.464127] Starting dynamic subtest: dmabuf
[452.233937] Dynamic subtest dmabuf: SUCCESS (0.777s)
[452.244260] Starting dynamic subtest: vma
[457.861212] Dynamic subtest vma: SUCCESS (5.624s)
[457.871385] Starting dynamic subtest: evict
[459.277282] Dynamic subtest evict: SUCCESS (1.414s)
[459.294175] Starting dynamic subtest: gtt
[462.873403] Dynamic subtest gtt: SUCCESS (3.593s)
[462.883101] Starting dynamic subtest: hugepages
[463.714772] Dynamic subtest hugepages: SUCCESS (0.840s)
[463.724816] Starting dynamic subtest: memory_region
[466.136312] Dynamic subtest memory_region: SUCCESS (2.419s)
[466.139004] Subtest mock: SUCCESS (38.679s)
[466.169262] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[466.169983] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[466.173543] [079/133] (555s left) gem_readwrite (write-bad-handle)
[467.651971] Subtest write-bad-handle: SKIP (0.000s)
[467.723053] [FACT gem_readwrite (write-bad-handle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[467.724186] [FACT gem_readwrite (write-bad-handle)] new: kernel.kmod_is_loaded.i915: true
[467.729269] [080/133] (553s left) syncobj_timeline (reset-during-wait-for-submit)
[467.803535] Starting subtest: reset-during-wait-for-submit
[467.908678] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[467.985475] [081/133] (553s left) fbdev (write)
[468.035123] Starting subtest: write
[468.559397] Subtest write: SUCCESS (0.523s)
[468.621924] [082/133] (553s left) gem_eio (in-flight-1us)
[468.773924] Starting subtest: in-flight-1us
[475.657133] Subtest in-flight-1us: SUCCESS (6.882s)
[475.793694] [083/133] (545s left) syncobj_wait (invalid-wait-bad-flags)
[475.835764] Starting subtest: invalid-wait-bad-flags
[475.837427] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[475.929090] [084/133] (545s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[476.003277] Starting subtest: primary-x-tiled-reflect-x-180
[482.990198] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.990s)
[484.188118] [085/133] (537s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[484.266412] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[484.270919] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[484.362112] [086/133] (537s left) perf_pmu (enable-race)
[484.410830] Starting subtest: enable-race
[484.413215] Starting dynamic subtest: rcs0
[497.204558] Dynamic subtest rcs0: SUCCESS (12.776s)
[497.214695] Starting dynamic subtest: bcs0
[509.949077] Dynamic subtest bcs0: SUCCESS (12.741s)
[509.965188] Starting dynamic subtest: vcs0
[525.988370] Dynamic subtest vcs0: SUCCESS (16.054s)
[526.001100] Starting dynamic subtest: vcs1
[541.988879] Dynamic subtest vcs1: SUCCESS (15.996s)
[542.001334] Starting dynamic subtest: vecs0
[557.988404] Dynamic subtest vecs0: SUCCESS (15.995s)
[557.998919] Starting dynamic subtest: ccs0
[570.769785] Dynamic subtest ccs0: SUCCESS (12.760s)
[570.771738] Subtest enable-race: SUCCESS (86.335s)
[570.838928] [087/133] (451s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[570.918198] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[570.922242] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[571.010647] [088/133] (450s left) gem_exec_schedule (implicit-boths)
[571.080135] Starting subtest: implicit-boths
[571.082082] Starting dynamic subtest: rcs0
[571.194447] Dynamic subtest rcs0: SUCCESS (0.124s)
[571.206138] Starting dynamic subtest: vcs0
[571.279467] Dynamic subtest vcs0: SUCCESS (0.084s)
[571.290813] Starting dynamic subtest: vcs1
[571.362707] Dynamic subtest vcs1: SUCCESS (0.082s)
[571.377513] Starting dynamic subtest: vecs0
[571.439531] Dynamic subtest vecs0: SUCCESS (0.076s)
[571.451417] Starting dynamic subtest: ccs0
[571.529513] Dynamic subtest ccs0: SUCCESS (0.089s)
[571.531908] Subtest implicit-boths: SUCCESS (0.460s)
[573.122077] [089/133] (448s left) gem_exec_schedule (u-fairslice)
[573.188690] Starting subtest: u-fairslice
[573.190719] Starting dynamic subtest: rcs0
[575.206402] Dynamic subtest rcs0: SUCCESS (2.025s)
[575.217807] Starting dynamic subtest: bcs0
[577.230759] Dynamic subtest bcs0: SUCCESS (2.024s)
[577.240728] Starting dynamic subtest: vcs0
[579.253353] Dynamic subtest vcs0: SUCCESS (2.021s)
[579.262456] Starting dynamic subtest: vcs1
[581.276738] Dynamic subtest vcs1: SUCCESS (2.020s)
[581.289599] Starting dynamic subtest: vecs0
[583.298081] Dynamic subtest vecs0: SUCCESS (2.022s)
[583.308394] Starting dynamic subtest: ccs0
[585.327415] Dynamic subtest ccs0: SUCCESS (2.027s)
[585.329338] Subtest u-fairslice: SUCCESS (12.144s)
[585.625501] [090/133] (436s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[585.717612] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[586.542271] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[586.703088] [091/133] (435s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[586.792091] Starting subtest: compare-crc-sanitycheck-xr24
[586.793937] Starting dynamic subtest: pipe-A-eDP-1
[587.458728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.667s)
[587.468206] Starting dynamic subtest: pipe-B-eDP-1
[588.832556] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.371s)
[588.842363] Starting dynamic subtest: pipe-C-eDP-1
[590.060717] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.228s)
[590.070529] Starting dynamic subtest: pipe-D-eDP-1
[591.281565] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s)
[591.283526] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.489s)
[592.138859] [092/133] (429s left) kms_properties (plane-properties-atomic)
[592.213561] Starting subtest: plane-properties-atomic
[592.215909] Starting dynamic subtest: pipe-A-eDP-1
[592.775145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[592.786865] Starting dynamic subtest: pipe-B-eDP-1
[594.109904] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s)
[594.119203] Starting dynamic subtest: pipe-C-eDP-1
[595.436258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.324s)
[595.446428] Starting dynamic subtest: pipe-D-eDP-1
[596.683571] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[596.685698] Subtest plane-properties-atomic: SUCCESS (4.470s)
[597.473139] [093/133] (424s left) gem_ringfill (legacy-basic)
[603.047230] Starting subtest: legacy-basic
[603.049946] Starting dynamic subtest: default
[603.108267] Dynamic subtest default: SUCCESS (0.059s)
[603.118880] Starting dynamic subtest: render
[603.150065] Dynamic subtest render: SUCCESS (0.040s)
[603.163828] Starting dynamic subtest: bsd
[603.196279] Dynamic subtest bsd: SUCCESS (0.044s)
[603.206549] Starting dynamic subtest: bsd1
[603.236169] Dynamic subtest bsd1: SUCCESS (0.037s)
[603.249093] Starting dynamic subtest: bsd2
[603.279200] Dynamic subtest bsd2: SUCCESS (0.040s)
[603.289861] Starting dynamic subtest: blt
[603.326986] Dynamic subtest blt: SUCCESS (0.045s)
[603.343582] Starting dynamic subtest: vebox
[603.371650] Dynamic subtest vebox: SUCCESS (0.043s)
[603.374112] Subtest legacy-basic: SUCCESS (0.325s)
[603.456748] [094/133] (418s left) gem_mmap_wc (read)
[603.518152] Subtest read: SKIP (0.000s)
[603.576912] [095/133] (418s left) kms_psr (psr2-cursor-mmap-gtt)
[603.658109] Starting subtest: psr2-cursor-mmap-gtt
[603.660422] Starting dynamic subtest: eDP-1
[605.342867] Dynamic subtest eDP-1: SUCCESS (1.685s)
[605.345212] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.686s)
[606.142397] [096/133] (416s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[606.240924] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[606.244970] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[606.342372] [097/133] (415s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[606.427099] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[606.430977] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[606.541674] [098/133] (415s left) gem_exec_balancer (full-pulse)
[606.608554] Starting subtest: full-pulse
[610.881986] Subtest full-pulse: SUCCESS (4.273s)
[611.252704] [099/133] (411s left) gem_exec_whisper (basic-fds-priority-all)
[611.329577] Starting subtest: basic-fds-priority-all
[635.075073] Subtest basic-fds-priority-all: SUCCESS (23.745s)
[635.272980] [100/133] (387s left) kms_pm_backlight (basic-brightness)
[635.357189] Starting subtest: basic-brightness
[635.410649] Starting dynamic subtest: eDP-1
[635.721720] Dynamic subtest eDP-1: SUCCESS (0.309s)
[635.724193] Subtest basic-brightness: SUCCESS (0.365s)
[636.567529] [101/133] (385s left) gem_ctx_persistence (legacy-engines-mixed-process)
[636.617091] Starting subtest: legacy-engines-mixed-process
[636.619467] Starting dynamic subtest: render
[637.969669] Dynamic subtest render: SUCCESS (1.352s)
[637.981745] Starting dynamic subtest: bsd1
[639.978902] Dynamic subtest bsd1: SUCCESS (2.008s)
[639.990890] Starting dynamic subtest: bsd2
[641.966872] Dynamic subtest bsd2: SUCCESS (1.987s)
[641.979074] Starting dynamic subtest: blt
[644.025862] Dynamic subtest blt: SUCCESS (2.053s)
[644.037694] Starting dynamic subtest: vebox
[646.024966] Dynamic subtest vebox: SUCCESS (2.000s)
[646.027398] Subtest legacy-engines-mixed-process: SUCCESS (9.409s)
[646.118358] [102/133] (376s left) gem_exec_reloc (basic-wc-gtt-active)
[646.188853] Subtest basic-wc-gtt-active: SKIP (0.000s)
[646.266718] [103/133] (376s left) gem_wait (await)
[646.333618] Starting subtest: await
[646.336346] Starting dynamic subtest: all-engines
[647.479087] Dynamic subtest all-engines: SUCCESS (1.145s)
[647.504400] Starting dynamic subtest: rcs0
[648.552711] Dynamic subtest rcs0: SUCCESS (1.071s)
[648.569624] Starting dynamic subtest: bcs0
[649.616403] Dynamic subtest bcs0: SUCCESS (1.063s)
[649.631776] Starting dynamic subtest: vcs0
[650.673249] Dynamic subtest vcs0: SUCCESS (1.055s)
[650.690153] Starting dynamic subtest: vcs1
[651.728442] Dynamic subtest vcs1: SUCCESS (1.053s)
[651.747073] Starting dynamic subtest: vecs0
[652.782254] Dynamic subtest vecs0: SUCCESS (1.052s)
[652.799259] Starting dynamic subtest: ccs0
[653.839357] Dynamic subtest ccs0: SUCCESS (1.055s)
[653.841800] Subtest await: SUCCESS (7.507s)
[654.043277] [104/133] (368s left) kms_psr (fbc-psr2-sprite-blt)
[654.120205] Starting subtest: fbc-psr2-sprite-blt
[654.122382] Starting dynamic subtest: eDP-1
[654.126273] Dynamic subtest eDP-1: SKIP (0.000s)
[654.130276] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[654.193912] [105/133] (368s left) i915_drm_fdinfo (virtual-busy-hang)
[654.226441] Starting subtest: virtual-busy-hang
[654.230812] Subtest virtual-busy-hang: SKIP (0.000s)
[654.291481] [106/133] (368s left) gem_exec_create (madvise)
[654.356415] Starting subtest: madvise
[654.358818] Starting dynamic subtest: smem
[675.041842] Dynamic subtest smem: SUCCESS (20.682s)
[675.044799] Subtest madvise: SUCCESS (20.683s)
[675.880489] [107/133] (346s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[675.964653] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[675.968993] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[676.065418] [108/133] (346s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[676.137776] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[676.142226] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[676.208846] [109/133] (346s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[676.283152] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[676.287848] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[676.373326] [110/133] (346s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[676.456785] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[683.068302] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.614s)
[683.192627] [111/133] (339s left) gem_exec_fence (syncobj-timeline-repeat)
[683.760127] Starting subtest: syncobj-timeline-repeat
[683.997084] Subtest syncobj-timeline-repeat: SUCCESS (0.237s)
[685.113178] [112/133] (337s left) gem_mmap_gtt (basic-write-read)
[685.157321] Subtest basic-write-read: SKIP (0.000s)
[685.214649] [113/133] (337s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[685.300461] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[685.304499] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[685.413086] [114/133] (337s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[685.475083] Starting subtest: single-wait-all-for-submit-signaled
[685.477100] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[685.563879] [115/133] (337s left) kms_async_flips (async-flip-suspend-resume)
[685.639778] Starting subtest: async-flip-suspend-resume
[686.013551] Starting dynamic subtest: pipe-A-eDP-1
[703.750946] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.696s)
[704.129817] Starting dynamic subtest: pipe-B-eDP-1
[721.776117] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.932s)
[722.155649] Starting dynamic subtest: pipe-C-eDP-1
[739.764094] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.895s)
[740.132442] Starting dynamic subtest: pipe-D-eDP-1
[757.786128] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.949s)
[757.788668] Subtest async-flip-suspend-resume: SUCCESS (13.945s)
[758.967670] [116/133] (264s left) kms_flip (2x-flip-vs-dpms-on-nop)
[759.047027] Starting subtest: 2x-flip-vs-dpms-on-nop
[759.054627] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.008s)
[759.137573] [117/133] (264s left) prime_vgem (basic-fence-read)
[759.203002] Starting subtest: basic-fence-read
[759.210992] Subtest basic-fence-read: SKIP (0.006s)
[759.324725] [118/133] (263s left) gem_unref_active_buffers
[759.520967] [119/133] (263s left) kms_psr (pr-primary-mmap-gtt)
[759.584859] Starting subtest: pr-primary-mmap-gtt
[759.589462] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[759.667413] [120/133] (263s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[759.722705] Starting subtest: etime-single-wait-available-unsubmitted
[759.829704] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[759.917025] [121/133] (263s left) syncobj_wait (single-wait-for-submit-signaled)
[759.974214] Starting subtest: single-wait-for-submit-signaled
[759.976406] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[760.086949] [122/133] (263s left) gem_ctx_bad_destroy (invalid-ctx)
[760.137312] Starting subtest: invalid-ctx
[760.139614] Subtest invalid-ctx: SUCCESS (0.000s)
[760.213703] [123/133] (263s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[760.342441] Starting subtest: protected-encrypted-src-copy-not-readible
[760.453245] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[760.568113] [124/133] (262s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[760.646198] Starting subtest: 2x-absolute-wf_vblank-interruptible
[760.654755] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.008s)
[760.745041] [125/133] (262s left) gem_userptr_blits (relocations)
[760.807778] Starting subtest: relocations
[760.812051] Subtest relocations: SKIP (0.000s)
[760.933075] [126/133] (262s left) kms_properties (colorop-properties-legacy)
[761.012367] Starting subtest: colorop-properties-legacy
[761.014662] Starting dynamic subtest: pipe-A-eDP-1
[761.351748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.337s)
[761.362524] Starting dynamic subtest: pipe-B-eDP-1
[762.451806] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.097s)
[762.467961] Starting dynamic subtest: pipe-C-eDP-1
[763.476274] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.020s)
[763.487178] Starting dynamic subtest: pipe-D-eDP-1
[764.520608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.043s)
[764.523032] Subtest colorop-properties-legacy: SUCCESS (3.503s)
[765.322725] [127/133] (258s left) gem_mmap_gtt (hang-user)
[765.386008] Subtest hang-user: SKIP (0.000s)
[765.457281] [128/133] (258s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[765.540299] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[769.955202] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.413s)
[771.131729] [129/133] (252s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[771.205342] Starting subtest: plane-lut1d-ctm3x4
[771.353359] Starting dynamic subtest: pipe-A-plane-0
[771.683447] Dynamic subtest pipe-A-plane-0: FAIL (0.158s)
[771.694701] Starting dynamic subtest: pipe-A-plane-1
[771.911490] Dynamic subtest pipe-A-plane-1: FAIL (0.182s)
[771.923613] Starting dynamic subtest: pipe-A-plane-2
[772.154506] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[773.119893] Starting dynamic subtest: pipe-B-plane-0
[773.552957] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[773.564943] Starting dynamic subtest: pipe-B-plane-1
[773.878998] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[773.891262] Starting dynamic subtest: pipe-B-plane-2
[774.196598] Dynamic subtest pipe-B-plane-2: FAIL (0.631s)
[775.246280] Starting dynamic subtest: pipe-C-plane-0
[775.740093] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[775.752356] Starting dynamic subtest: pipe-C-plane-1
[776.150952] Dynamic subtest pipe-C-plane-1: FAIL (0.609s)
[776.160065] Starting dynamic subtest: pipe-C-plane-2
[776.528270] Dynamic subtest pipe-C-plane-2: FAIL (0.147s)
[777.285277] Starting dynamic subtest: pipe-D-plane-0
[777.876889] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[777.889170] Starting dynamic subtest: pipe-D-plane-1
[778.351756] Dynamic subtest pipe-D-plane-1: FAIL (0.607s)
[778.363219] Starting dynamic subtest: pipe-D-plane-2
[778.803739] Dynamic subtest pipe-D-plane-2: FAIL (0.540s)
[778.863983] Subtest plane-lut1d-ctm3x4: FAIL (7.653s)
[779.661131] [130/133] (244s left) sysfs_timeslice_duration (duration)
[779.723501] Starting subtest: duration
[779.725831] Starting dynamic subtest: vecs0
[793.166674] Dynamic subtest vecs0: SUCCESS (13.440s)
[793.178453] Starting dynamic subtest: ccs0
[806.325138] Dynamic subtest ccs0: SUCCESS (13.144s)
[806.335143] Starting dynamic subtest: vcs0
[821.134440] Dynamic subtest vcs0: SUCCESS (14.820s)
[821.146689] Starting dynamic subtest: bcs0
[834.292530] Dynamic subtest bcs0: SUCCESS (13.132s)
[834.310382] Starting dynamic subtest: rcs0
[847.423668] Dynamic subtest rcs0: SUCCESS (13.146s)
[847.436681] Starting dynamic subtest: vcs1
[861.133967] Dynamic subtest vcs1: SUCCESS (13.707s)
[861.137053] Subtest duration: SUCCESS (81.407s)
[861.217577] [131/133] (162s left) gem_spin_batch (resubmit-new)
[861.283092] Starting subtest: resubmit-new
[861.285076] Starting dynamic subtest: rcs0
[861.294995] Dynamic subtest rcs0: SUCCESS (0.014s)
[861.307047] Starting dynamic subtest: bcs0
[861.309238] Dynamic subtest bcs0: SUCCESS (0.006s)
[861.318998] Starting dynamic subtest: vcs0
[861.321317] Dynamic subtest vcs0: SUCCESS (0.007s)
[861.331583] Starting dynamic subtest: vcs1
[861.333997] Dynamic subtest vcs1: SUCCESS (0.008s)
[861.345694] Starting dynamic subtest: vecs0
[861.347956] Dynamic subtest vecs0: SUCCESS (0.005s)
[861.357195] Starting dynamic subtest: ccs0
[861.359416] Dynamic subtest ccs0: SUCCESS (0.008s)
[861.361723] Subtest resubmit-new: SUCCESS (0.053s)
[863.196411] [132/133] (160s left) gem_userptr_blits (create-destroy-sync)
[863.259746] Starting subtest: create-destroy-sync
[868.323755] Subtest create-destroy-sync: SUCCESS (5.011s)
[868.402430] [133/133] (155s left) dmabuf_sync_file (export-multiwait)
[868.443938] Starting subtest: export-multiwait
[868.446127] Subtest export-multiwait: SUCCESS (0.001s)
[868.499765] 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.