[43.787142] Initializing watchdogs
[43.787210]   /dev/watchdog0
[43.803320] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[43.809155] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.811496] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.813374] [001/133] (960s left) kms_psr (fbc-pr-basic)
[43.903365] Subtest fbc-pr-basic: SKIP (0.000s)
[43.944303] [002/133] (960s left) gem_ctx_persistence (engines-mixed-process)
[43.983969] Starting subtest: engines-mixed-process
[43.984868] Starting dynamic subtest: rcs0
[44.345309] Dynamic subtest rcs0: SUCCESS (0.361s)
[44.352970] Starting dynamic subtest: bcs0
[44.723904] Dynamic subtest bcs0: SUCCESS (0.377s)
[44.739201] Starting dynamic subtest: vcs0
[45.114070] Dynamic subtest vcs0: SUCCESS (0.390s)
[45.126661] Starting dynamic subtest: vcs1
[45.482037] Dynamic subtest vcs1: SUCCESS (0.367s)
[45.493103] Starting dynamic subtest: vecs0
[45.861176] Dynamic subtest vecs0: SUCCESS (0.378s)
[45.862757] Subtest engines-mixed-process: SUCCESS (1.877s)
[45.954308] [003/133] (958s left) gem_watchdog (default-physical)
[45.993533] Starting subtest: default-physical
[47.262222] Subtest default-physical: SUCCESS (1.259s)
[47.364464] [004/133] (957s left) syncobj_timeline (32bits-limit)
[47.398155] Starting subtest: 32bits-limit
[47.399666] Subtest 32bits-limit: SUCCESS (0.001s)
[47.467733] [005/133] (956s left) kms_colorop (plane-xr30-xr30-pq_125_eotf)
[47.607834] Subtest plane-XR30-XR30-pq_125_eotf: SKIP (0.000s)
[47.684659] [006/133] (956s left) gem_mmap_wc (bad-size)
[47.716861] Starting subtest: bad-size
[47.717621] Subtest bad-size: SUCCESS (0.000s)
[47.813903] [007/133] (956s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[47.902200] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[47.903560] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[48.030671] [008/133] (956s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[48.113949] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[48.115592] Starting dynamic subtest: pipe-A-valid-mode
[48.981885] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.866s)
[48.982626] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.868s)
[49.145235] [009/133] (955s left) tools_test (tools_test)
[49.183378] Starting subtest: tools_test
[49.253110] Subtest tools_test: SUCCESS (0.074s)
[49.323370] [010/133] (955s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[49.407732] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[49.408469] Starting dynamic subtest: pipe-A
[50.645305] Dynamic subtest pipe-A: SUCCESS (1.238s)
[50.652457] Starting dynamic subtest: pipe-B
[51.896352] Dynamic subtest pipe-B: SUCCESS (1.251s)
[51.902073] Starting dynamic subtest: pipe-C
[52.105674] Dynamic subtest pipe-C: SUCCESS (0.209s)
[52.114168] Starting dynamic subtest: pipe-D
[52.314485] Dynamic subtest pipe-D: SUCCESS (0.208s)
[52.315214] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (2.907s)
[52.515017] [011/133] (952s left) syncobj_basic (illegal-fd-to-handle)
[52.549291] Starting subtest: illegal-fd-to-handle
[52.549991] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[52.627377] [012/133] (952s left) api_intel_bb (simple-bb)
[52.659636] Starting subtest: simple-bb
[52.662669] Subtest simple-bb: SUCCESS (0.004s)
[52.782393] [013/133] (951s left) gem_pipe_control_store_loop (reused-buffer)
[52.818030] Starting subtest: reused-buffer
[54.977904] Subtest reused-buffer: SUCCESS (2.151s)
[55.079704] [014/133] (949s left) kms_joiner (basic-force-ultra-joiner)
[55.173330] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[55.246758] [015/133] (949s left) kms_psr (fbc-psr2-sprite-plane-move)
[55.333334] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[55.367307] [016/133] (949s left) kms_chamelium_audio (hdmi-audio-edid)
[55.498676] Subtest hdmi-audio-edid: SKIP (0.000s)
[55.584722] [017/133] (949s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[55.674503] Starting subtest: primary-yf-tiled-reflect-x-90
[55.725630] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.051s)
[55.820600] [018/133] (949s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[55.914063] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[56.525699] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.611s)
[56.676072] [019/133] (948s left) kms_big_fb (linear-8bpp-rotate-270)
[56.768899] Starting subtest: linear-8bpp-rotate-270
[56.848225] Subtest linear-8bpp-rotate-270: SKIP (0.078s)
[56.980346] [020/133] (948s left) kms_vrr (flip-basic-fastset)
[57.065608] Starting subtest: flip-basic-fastset
[57.067721] Subtest flip-basic-fastset: SKIP (0.000s)
[57.122044] [021/133] (947s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[57.205463] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[57.206164] Starting dynamic subtest: pipe-A-HDMI-A-1
[57.212180] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[57.218333] Starting dynamic subtest: pipe-B-HDMI-A-1
[57.224311] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[57.230152] Starting dynamic subtest: pipe-C-HDMI-A-1
[57.236205] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[57.242137] Starting dynamic subtest: pipe-D-HDMI-A-1
[57.248086] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[57.248748] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.011s)
[57.477174] [022/133] (947s left) gem_exec_suspend (basic-s3-devices)
[57.516087] Starting subtest: basic-S3-devices
[57.516815] Starting dynamic subtest: smem
[64.304866] Dynamic subtest smem: SUCCESS (6.789s)
[64.305582] Subtest basic-S3-devices: SUCCESS (6.789s)
[73.541753] [023/133] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[73.652590] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[73.654100] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[73.760291] [024/133] (940s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[73.852427] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[73.853921] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[73.945756] [025/133] (940s left) gem_busy (semaphore)
[74.122483] Starting subtest: semaphore
[74.123592] Starting dynamic subtest: rcs0
[74.160617] Dynamic subtest rcs0: SUCCESS (0.046s)
[74.175462] Starting dynamic subtest: bcs0
[74.187577] Dynamic subtest bcs0: SUCCESS (0.026s)
[74.199772] Starting dynamic subtest: vcs0
[74.218569] Dynamic subtest vcs0: SUCCESS (0.030s)
[74.231447] Starting dynamic subtest: vcs1
[74.242516] Dynamic subtest vcs1: SUCCESS (0.023s)
[74.255356] Starting dynamic subtest: vecs0
[74.265426] Dynamic subtest vecs0: SUCCESS (0.022s)
[74.266348] Subtest semaphore: SUCCESS (0.152s)
[74.526147] [026/133] (939s left) perf_pmu (module-unload)
[74.568797] Starting subtest: module-unload
[77.563427] Subtest module-unload: FAIL (2.966s)
[77.584183] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[77.585684] [027/133] (936s left) syncobj_timeline (transfer-timeline-point)
[78.592919] Starting subtest: transfer-timeline-point
[78.593829] Subtest transfer-timeline-point: SUCCESS (0.000s)
[78.639280] [FACT syncobj_timeline (transfer-timeline-point)] new: kernel.kmod_is_loaded.i915: true
[78.642763] [028/133] (935s left) syncobj_wait (wait-any-interrupted)
[78.686280] Starting subtest: wait-any-interrupted
[78.787526] Subtest wait-any-interrupted: SUCCESS (0.101s)
[78.865015] [029/133] (935s left) api_intel_allocator (default-alignment)
[78.896511] Starting subtest: default-alignment
[78.899808] Subtest default-alignment: SUCCESS (0.003s)
[79.016295] [030/133] (935s left) gem_exec_gttfill (all-engines)
[79.059924] Starting subtest: all-engines
[103.044131] Subtest all-engines: SUCCESS (23.981s)
[103.236320] [031/133] (911s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[103.323153] Starting subtest: invalid-signal-one-illegal-handle
[103.323867] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[103.392835] [032/133] (911s left) gem_lmem_evict (dontneed-evict-race)
[103.430891] Subtest dontneed-evict-race: SKIP (0.000s)
[103.469531] [033/133] (911s left) kms_draw_crc (draw-method-blt)
[103.562985] Starting subtest: draw-method-blt
[103.563756] Starting dynamic subtest: xrgb8888-untiled
[103.743107] Dynamic subtest xrgb8888-untiled: SUCCESS (0.180s)
[103.753728] Starting dynamic subtest: rgb565-untiled
[103.901394] Dynamic subtest rgb565-untiled: SUCCESS (0.157s)
[103.916606] Starting dynamic subtest: xrgb2101010-untiled
[104.051266] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.149s)
[104.066487] Starting dynamic subtest: xbgr16161616f-untiled
[104.218018] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.165s)
[104.236134] Starting dynamic subtest: xrgb8888-xtiled
[104.309706] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.090s)
[104.326358] Starting dynamic subtest: rgb565-xtiled
[104.392991] Dynamic subtest rgb565-xtiled: SUCCESS (0.082s)
[104.407652] Starting dynamic subtest: xrgb2101010-xtiled
[104.468177] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.074s)
[104.482096] Starting dynamic subtest: xbgr16161616f-xtiled
[104.551406] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.082s)
[104.565862] Starting dynamic subtest: xrgb8888-ytiled
[104.634701] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.082s)
[104.651248] Starting dynamic subtest: rgb565-ytiled
[104.718323] Dynamic subtest rgb565-ytiled: SUCCESS (0.082s)
[104.734376] Starting dynamic subtest: xrgb2101010-ytiled
[104.801385] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.082s)
[104.817446] Starting dynamic subtest: xbgr16161616f-ytiled
[104.893161] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.090s)
[104.894163] Subtest draw-method-blt: SUCCESS (1.331s)
[105.033148] [034/133] (909s left) kms_content_protection (dp-mst-type-1)
[105.129480] Starting subtest: dp-mst-type-1
[105.130961] Subtest dp-mst-type-1: SKIP (0.000s)
[105.247710] [035/133] (909s left) i915_drm_fdinfo (isolation)
[105.283320] Starting subtest: isolation
[105.284077] Starting dynamic subtest: rcs0
[105.808312] Dynamic subtest rcs0: SUCCESS (0.524s)
[105.819309] Starting dynamic subtest: bcs0
[106.330198] Dynamic subtest bcs0: SUCCESS (0.521s)
[106.341053] Starting dynamic subtest: vcs0
[106.860328] Dynamic subtest vcs0: SUCCESS (0.529s)
[106.871046] Starting dynamic subtest: vcs1
[107.385334] Dynamic subtest vcs1: SUCCESS (0.524s)
[107.395524] Starting dynamic subtest: vecs0
[107.914484] Dynamic subtest vecs0: SUCCESS (0.528s)
[107.915712] Subtest isolation: SUCCESS (2.631s)
[107.994511] [036/133] (906s left) syncobj_timeline (invalid-transfer-non-existent-point)
[108.027098] Starting subtest: invalid-transfer-non-existent-point
[108.027820] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[108.102509] [037/133] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[108.193783] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[108.195184] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[108.299168] [038/133] (906s left) kms_pm_dc (dc6-psr)
[109.405298] Starting subtest: dc6-psr
[109.406752] Subtest dc6-psr: SKIP (0.000s)
[109.466599] [039/133] (905s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[109.503294] Starting subtest: basic-gtt-cpu-noreloc
[109.507489] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s)
[109.644795] [040/133] (905s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[109.732023] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[109.733417] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[109.899925] [041/133] (904s left) kms_selftest (drm_dp_mst_helper)
[109.939756] Starting subtest: drm_dp_mst_helper
[109.945144] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[110.038380] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.092s)
[110.053408] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[110.136753] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.098s)
[110.148549] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[110.241192] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.102s)
[110.242083] Subtest drm_dp_mst_helper: SUCCESS (0.300s)
[110.416622] [042/133] (904s left) kms_legacy_colorkey (basic)
[110.500782] Starting subtest: basic
[110.501472] Starting dynamic subtest: pipe-A
[110.551358] Dynamic subtest pipe-A: SUCCESS (0.050s)
[110.567680] Starting dynamic subtest: pipe-B
[110.568555] Dynamic subtest pipe-B: SUCCESS (0.001s)
[110.578124] Starting dynamic subtest: pipe-C
[110.578821] Dynamic subtest pipe-C: SUCCESS (0.001s)
[110.585734] Starting dynamic subtest: pipe-D
[110.586427] Dynamic subtest pipe-D: SUCCESS (0.001s)
[110.587125] Subtest basic: SUCCESS (0.059s)
[110.680650] [043/133] (904s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[110.712788] Starting subtest: etime-multi-wait-for-submit-submitted
[110.822027] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[110.907197] [044/133] (904s left) kms_flip (flip-vs-absolute-wf_vblank)
[110.992671] Starting subtest: flip-vs-absolute-wf_vblank
[110.994385] Starting dynamic subtest: A-HDMI-A1
[118.831782] Dynamic subtest A-HDMI-A1: SUCCESS (7.837s)
[118.841991] Starting dynamic subtest: B-HDMI-A1
[126.654529] Dynamic subtest B-HDMI-A1: SUCCESS (7.794s)
[126.661993] Starting dynamic subtest: C-HDMI-A1
[134.462557] Dynamic subtest C-HDMI-A1: SUCCESS (7.805s)
[134.470617] Starting dynamic subtest: D-HDMI-A1
[142.243797] Dynamic subtest D-HDMI-A1: SUCCESS (7.805s)
[142.244476] Subtest flip-vs-absolute-wf_vblank: SUCCESS (31.250s)
[142.406250] [045/133] (872s left) gem_eio (execbuf)
[142.448144] Starting subtest: execbuf
[142.476485] Subtest execbuf: SUCCESS (0.027s)
[142.617560] [046/133] (872s left) gem_ctx_persistence (saturated-hostile)
[142.653988] Starting subtest: saturated-hostile
[142.654798] Starting dynamic subtest: rcs0
[143.394254] Dynamic subtest rcs0: SUCCESS (0.731s)
[143.408992] Starting dynamic subtest: bcs0
[144.161743] Dynamic subtest bcs0: SUCCESS (0.766s)
[144.172912] Starting dynamic subtest: vcs0
[144.907898] Dynamic subtest vcs0: SUCCESS (0.744s)
[144.918851] Starting dynamic subtest: vcs1
[145.656615] Dynamic subtest vcs1: SUCCESS (0.748s)
[145.667177] Starting dynamic subtest: vecs0
[146.409575] Dynamic subtest vecs0: SUCCESS (0.752s)
[146.410602] Subtest saturated-hostile: SUCCESS (3.747s)
[146.535645] [047/133] (868s left) gem_ctx_bad_destroy (invalid-pad)
[146.567813] Starting subtest: invalid-pad
[146.568510] Subtest invalid-pad: SUCCESS (0.000s)
[146.643737] [048/133] (868s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[146.734972] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[146.736445] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[146.845695] [049/133] (868s left) kms_flip (flip-vs-panning-interruptible)
[146.934139] Starting subtest: flip-vs-panning-interruptible
[146.936884] Starting dynamic subtest: A-HDMI-A1
[154.608345] Dynamic subtest A-HDMI-A1: SUCCESS (7.671s)
[154.624495] Starting dynamic subtest: B-HDMI-A1
[162.255121] Dynamic subtest B-HDMI-A1: SUCCESS (7.645s)
[162.265523] Starting dynamic subtest: C-HDMI-A1
[169.902911] Dynamic subtest C-HDMI-A1: SUCCESS (7.645s)
[169.916611] Starting dynamic subtest: D-HDMI-A1
[177.552819] Dynamic subtest D-HDMI-A1: SUCCESS (7.647s)
[177.557647] Subtest flip-vs-panning-interruptible: SUCCESS (30.623s)
[177.784870] [050/133] (837s left) syncobj_wait (reset-signaled)
[177.817997] Starting subtest: reset-signaled
[177.818764] Subtest reset-signaled: SUCCESS (0.000s)
[177.878798] [051/133] (837s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[177.967690] Starting subtest: fbc-rgb101010-draw-mmap-wc
[180.444854] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.477s)
[180.567182] [052/133] (834s left) gem_mmap_offset (partial-mmap)
[180.600815] Starting subtest: partial-mmap
[180.601584] Starting dynamic subtest: smem0
[180.603074] Dynamic subtest smem0: SUCCESS (0.003s)
[180.603825] Subtest partial-mmap: SUCCESS (0.004s)
[180.733745] [053/133] (834s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[180.829804] Starting subtest: x-tiled-addfb-size-offset-overflow
[180.830560] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[180.940257] [054/133] (834s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[181.031727] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[181.066568] [055/133] (834s left) gem_render_copy (linear-to-vebox-yf-tiled)
[181.108426] Starting subtest: linear-to-vebox-yf-tiled
[181.109136] Starting dynamic subtest: smem
[181.176369] Dynamic subtest smem: SUCCESS (0.067s)
[181.177090] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.068s)
[181.367789] [056/133] (834s left) kms_chamelium_frames (vga-frame-dump)
[181.506924] Subtest vga-frame-dump: SKIP (0.000s)
[181.601079] [057/133] (833s left) kms_plane_alpha_blend (constant-alpha-mid)
[181.686938] Starting subtest: constant-alpha-mid
[181.752987] Starting dynamic subtest: pipe-A-HDMI-A-1
[182.153449] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.400s)
[182.162265] Starting dynamic subtest: pipe-D-HDMI-A-1
[182.553492] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.398s)
[182.554308] Subtest constant-alpha-mid: SUCCESS (0.867s)
[182.705125] [058/133] (832s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[182.797332] Starting subtest: addfb25-yf-tiled-legacy
[182.798088] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[182.902116] [059/133] (832s left) gem_exec_reloc (basic-wc-read-noreloc)
[182.939804] Starting subtest: basic-wc-read-noreloc
[182.941926] Subtest basic-wc-read-noreloc: SUCCESS (0.003s)
[183.068187] [060/133] (832s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[183.105896] Starting subtest: yf-tiled-to-vebox-x-tiled
[183.106597] Starting dynamic subtest: smem
[183.200999] Dynamic subtest smem: SUCCESS (0.095s)
[183.201765] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.095s)
[183.387960] [061/133] (832s left) gem_ctx_shared (single-timeline)
[183.427327] Starting subtest: single-timeline
[183.433190] Subtest single-timeline: SUCCESS (0.006s)
[183.637943] [062/133] (832s left) gen9_exec_parse (bb-start-cmd)
[183.674363] Subtest bb-start-cmd: SKIP (0.000s)
[183.716482] [063/133] (832s left) gem_exec_schedule (u-semaphore-resolve)
[183.760169] Starting subtest: u-semaphore-resolve
[183.776969] Subtest u-semaphore-resolve: SUCCESS (0.017s)
[184.095933] [064/133] (831s left) i915_pm_rps (min-max-config-loaded)
[184.133838] Starting subtest: min-max-config-loaded
[184.462615] Subtest min-max-config-loaded: SUCCESS (0.324s)
[184.596233] [065/133] (831s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[184.689738] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[185.938736] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (1.249s)
[186.102828] [066/133] (829s left) gem_render_copy_redux (normal)
[186.139941] Starting subtest: normal
[186.464507] Subtest normal: SUCCESS (0.316s)
[186.587320] [067/133] (829s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[186.676737] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[186.678099] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[186.795738] [068/133] (829s left) kms_plane (plane-position-hole-dpms)
[186.880388] Starting subtest: plane-position-hole-dpms
[187.096832] Starting dynamic subtest: pipe-A-plane-1
[187.419134] Dynamic subtest pipe-A-plane-1: SUCCESS (0.323s)
[187.431704] Starting dynamic subtest: pipe-A-plane-2
[187.738896] Dynamic subtest pipe-A-plane-2: SUCCESS (0.318s)
[187.748854] Starting dynamic subtest: pipe-A-plane-3
[188.052399] Dynamic subtest pipe-A-plane-3: SUCCESS (0.314s)
[188.062026] Starting dynamic subtest: pipe-A-plane-4
[188.351640] Dynamic subtest pipe-A-plane-4: SUCCESS (0.298s)
[188.359876] Starting dynamic subtest: pipe-A-plane-5
[188.672294] Dynamic subtest pipe-A-plane-5: SUCCESS (0.320s)
[188.680348] Starting dynamic subtest: pipe-A-plane-6
[188.980579] Dynamic subtest pipe-A-plane-6: SUCCESS (0.307s)
[188.988926] Starting dynamic subtest: pipe-A-plane-7
[188.990340] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[189.174799] Starting dynamic subtest: pipe-B-plane-1
[189.486364] Dynamic subtest pipe-B-plane-1: SUCCESS (0.319s)
[189.495534] Starting dynamic subtest: pipe-B-plane-2
[189.782425] Dynamic subtest pipe-B-plane-2: SUCCESS (0.294s)
[189.790552] Starting dynamic subtest: pipe-B-plane-3
[190.089399] Dynamic subtest pipe-B-plane-3: SUCCESS (0.307s)
[190.098562] Starting dynamic subtest: pipe-B-plane-4
[190.393306] Dynamic subtest pipe-B-plane-4: SUCCESS (0.303s)
[190.402369] Starting dynamic subtest: pipe-B-plane-5
[190.716234] Dynamic subtest pipe-B-plane-5: SUCCESS (0.322s)
[190.724137] Starting dynamic subtest: pipe-B-plane-6
[191.012202] Dynamic subtest pipe-B-plane-6: SUCCESS (0.295s)
[191.020157] Starting dynamic subtest: pipe-B-plane-7
[191.021486] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[191.022151] Subtest plane-position-hole-dpms: SUCCESS (4.136s)
[191.153331] [069/133] (824s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[191.253081] Starting subtest: 4-tiled-32bpp-rotate-0
[191.254481] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[191.359543] [070/133] (824s left) kms_colorop (plane-xr24-xr24-ctm_3x4_50_desat)
[191.497052] Subtest plane-XR24-XR24-ctm_3x4_50_desat: SKIP (0.000s)
[191.577546] [071/133] (824s left) syncobj_wait (multi-wait-all-submitted-signaled)
[191.610918] Starting subtest: multi-wait-all-submitted-signaled
[191.717708] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[191.801509] [072/133] (824s left) kms_invalid_mode (bad-hsync-start)
[191.886768] Starting subtest: bad-hsync-start
[191.887478] Starting dynamic subtest: pipe-A-HDMI-A-1
[191.936559] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.049s)
[191.945769] Starting dynamic subtest: pipe-B-HDMI-A-1
[191.946471] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[191.954416] Starting dynamic subtest: pipe-C-HDMI-A-1
[191.955122] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[191.962842] Starting dynamic subtest: pipe-D-HDMI-A-1
[191.963578] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[191.964270] Subtest bad-hsync-start: SUCCESS (0.058s)
[192.090949] [073/133] (824s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[192.125114] Starting subtest: multi-wait-for-submit-submitted-signaled
[192.125807] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[192.197735] [074/133] (823s left) gem_exec_suspend (basic-s0)
[192.238451] Starting subtest: basic-S0
[192.239211] Starting dynamic subtest: smem
[209.597996] Dynamic subtest smem: SUCCESS (2.586s)
[209.598741] Subtest basic-S0: SUCCESS (2.587s)
[217.809908] [075/133] (806s left) syncobj_wait (single-wait-signaled)
[217.845379] Starting subtest: single-wait-signaled
[217.846101] Subtest single-wait-signaled: SUCCESS (0.000s)
[217.917760] [076/133] (806s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[218.416040] Starting subtest: syncobj-timeline-multiple-ext-nodes
[218.417016] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[218.589964] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[218.592733] [077/133] (805s left) gem_create (create-ext-placement-sanity-check)
[218.745841] Starting subtest: create-ext-placement-sanity-check
[218.746601] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[218.830120] [078/133] (805s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[218.918211] Starting subtest: 2x-long-flip-vs-cursor-atomic
[218.920704] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.003s)
[219.006699] [079/133] (805s left) kms_colorop (plane-xr24-xr24-srgb_inv_eotf_lut)
[219.144457] Subtest plane-XR24-XR24-srgb_inv_eotf_lut: SKIP (0.000s)
[219.212261] [080/133] (805s left) gem_sync (basic-store-all)
[219.255201] Starting subtest: basic-store-all
[221.721999] Subtest basic-store-all: SUCCESS (2.466s)
[221.923796] [081/133] (802s left) perf (invalid-open-flags)
[222.020954] Starting subtest: invalid-open-flags
[222.021676] Subtest invalid-open-flags: SUCCESS (0.000s)
[222.062113] [082/133] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[222.155952] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[222.157374] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[222.254917] [083/133] (802s left) gem_userptr_blits (create-destroy-sync)
[222.298204] Starting subtest: create-destroy-sync
[227.342381] Subtest create-destroy-sync: SUCCESS (5.008s)
[227.457722] [084/133] (797s left) kms_addfb_basic (bad-pitch-0)
[227.489700] Starting subtest: bad-pitch-0
[227.490407] Subtest bad-pitch-0: SUCCESS (0.000s)
[227.663222] [085/133] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[227.759485] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[227.760840] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[227.879794] [086/133] (796s left) gem_madvise (dontneed-before-mmap)
[227.910918] Starting subtest: dontneed-before-mmap
[227.916014] Subtest dontneed-before-mmap: SUCCESS (0.006s)
[228.047612] [087/133] (796s left) kms_atomic (plane-invalid-params)
[228.133933] Starting subtest: plane-invalid-params
[228.135771] Starting dynamic subtest: pipe-A-HDMI-A-1
[228.295218] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.160s)
[228.295933] Subtest plane-invalid-params: SUCCESS (0.162s)
[228.444685] [088/133] (796s left) kms_flip (flip-vs-rmfb-interruptible)
[228.535228] Starting subtest: flip-vs-rmfb-interruptible
[228.538156] Starting dynamic subtest: A-HDMI-A1
[236.175008] Dynamic subtest A-HDMI-A1: SUCCESS (7.630s)
[236.192082] Starting dynamic subtest: B-HDMI-A1
[243.797573] Dynamic subtest B-HDMI-A1: SUCCESS (7.616s)
[243.809952] Starting dynamic subtest: C-HDMI-A1
[251.430448] Dynamic subtest C-HDMI-A1: SUCCESS (7.628s)
[251.446287] Starting dynamic subtest: D-HDMI-A1
[259.064579] Dynamic subtest D-HDMI-A1: SUCCESS (7.629s)
[259.070330] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.521s)
[259.275019] [089/133] (765s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[259.364009] Starting subtest: cursorB-vs-flipB-toggle
[259.365397] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[259.454123] [090/133] (765s left) gem_exec_reloc (basic-cpu-read-active)
[259.490197] Starting subtest: basic-cpu-read-active
[259.617692] Subtest basic-cpu-read-active: SUCCESS (0.121s)
[259.749970] [091/133] (765s left) kms_psr (fbc-psr-sprite-blt)
[259.836576] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[259.880802] [092/133] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[259.971690] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[259.973082] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[260.080975] [093/133] (764s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[260.166017] Starting subtest: basic-busy-flip-before-cursor-varying-size
[260.167412] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[260.253761] [094/133] (764s left) kms_prop_blob (invalid-set-prop-any)
[260.285812] Starting subtest: invalid-set-prop-any
[260.286535] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[260.371927] [095/133] (764s left) dmabuf_sync_file (export-wait-after-attach)
[260.406827] Starting subtest: export-wait-after-attach
[260.407549] Subtest export-wait-after-attach: SUCCESS (0.001s)
[260.473366] [096/133] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[260.565924] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[261.874206] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.308s)
[262.004874] [097/133] (763s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[262.098642] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[262.100043] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[262.206669] [098/133] (762s left) kms_vblank (query-forked-busy)
[262.294958] Starting subtest: query-forked-busy
[262.297216] Starting dynamic subtest: pipe-A-HDMI-A-1
[263.587091] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.290s)
[263.611316] Starting dynamic subtest: pipe-D-HDMI-A-1
[264.869828] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.274s)
[264.870606] Subtest query-forked-busy: SUCCESS (2.574s)
[265.035550] [099/133] (760s left) i915_selftest (mock)
[266.140623] Starting subtest: mock
[266.141657] Starting dynamic subtest: sanitycheck
[266.957554] Dynamic subtest sanitycheck: SUCCESS (0.807s)
[266.966813] Starting dynamic subtest: shmem
[267.700542] Dynamic subtest shmem: SUCCESS (0.741s)
[267.710126] Starting dynamic subtest: fence
[275.857642] Dynamic subtest fence: SUCCESS (8.153s)
[275.868182] Starting dynamic subtest: scatterlist
[277.604615] Dynamic subtest scatterlist: SUCCESS (1.744s)
[277.614261] Starting dynamic subtest: syncmap
[280.596592] Dynamic subtest syncmap: SUCCESS (2.989s)
[280.606073] Starting dynamic subtest: uncore
[281.344503] Dynamic subtest uncore: SUCCESS (0.746s)
[281.355552] Starting dynamic subtest: ring
[282.105698] Dynamic subtest ring: SUCCESS (0.759s)
[282.115339] Starting dynamic subtest: engine
[282.840571] Dynamic subtest engine: SUCCESS (0.732s)
[282.851749] Starting dynamic subtest: timelines
[287.285621] Dynamic subtest timelines: SUCCESS (4.442s)
[287.295095] Starting dynamic subtest: requests
[290.130559] Dynamic subtest requests: SUCCESS (2.842s)
[290.137295] Starting dynamic subtest: objects
[290.976583] Dynamic subtest objects: SUCCESS (0.843s)
[290.986086] Starting dynamic subtest: phys
[291.855912] Dynamic subtest phys: SUCCESS (0.877s)
[291.870709] Starting dynamic subtest: dmabuf
[292.686615] Dynamic subtest dmabuf: SUCCESS (0.828s)
[292.702385] Starting dynamic subtest: vma
[300.190644] Dynamic subtest vma: SUCCESS (7.500s)
[300.200004] Starting dynamic subtest: evict
[301.933608] Dynamic subtest evict: SUCCESS (1.740s)
[301.942562] Starting dynamic subtest: gtt
[305.706346] Dynamic subtest gtt: SUCCESS (3.770s)
[305.713919] Starting dynamic subtest: hugepages
[306.752623] Dynamic subtest hugepages: SUCCESS (1.044s)
[306.762242] Starting dynamic subtest: memory_region
[310.049720] Dynamic subtest memory_region: SUCCESS (3.294s)
[310.050822] Subtest mock: SUCCESS (43.894s)
[310.085791] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[310.086568] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[310.089620] [100/133] (715s left) kms_cursor_crc (cursor-sliding-64x64)
[311.154759] Starting subtest: cursor-sliding-64x64
[311.177474] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.032206] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.857s)
[313.079683] Starting dynamic subtest: pipe-D-HDMI-A-1
[314.882939] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.810s)
[314.883728] Subtest cursor-sliding-64x64: SUCCESS (3.728s)
[315.032366] [FACT kms_cursor_crc (cursor-sliding-64x64)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[315.033720] [FACT kms_cursor_crc (cursor-sliding-64x64)] new: kernel.kmod_is_loaded.i915: true
[315.036741] [101/133] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[315.131830] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[315.133304] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[315.246745] [102/133] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[315.336391] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[315.337806] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[315.447736] [103/133] (709s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[315.532903] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[315.534283] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[315.703680] [104/133] (709s left) perf_pmu (busy-accuracy-98)
[315.744413] Starting subtest: busy-accuracy-98
[315.745147] Starting dynamic subtest: rcs0
[318.776161] Dynamic subtest rcs0: SUCCESS (3.027s)
[318.785712] Starting dynamic subtest: bcs0
[321.804100] Dynamic subtest bcs0: SUCCESS (3.027s)
[321.813238] Starting dynamic subtest: vcs0
[324.830042] Dynamic subtest vcs0: SUCCESS (3.025s)
[324.839136] Starting dynamic subtest: vcs1
[327.856662] Dynamic subtest vcs1: SUCCESS (3.027s)
[327.865382] Starting dynamic subtest: vecs0
[330.882577] Dynamic subtest vecs0: SUCCESS (3.026s)
[330.883519] Subtest busy-accuracy-98: SUCCESS (15.137s)
[330.983487] [105/133] (694s left) gem_exec_flush (basic-batch-kernel-default-uc)
[331.025295] Starting subtest: basic-batch-kernel-default-uc
[336.646367] Subtest basic-batch-kernel-default-uc: SUCCESS (5.622s)
[336.851426] [106/133] (688s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[336.938221] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[336.941114] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[337.016991] [107/133] (688s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[337.051139] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[337.051878] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[337.117930] [108/133] (688s left) sysfs_timeslice_duration (idempotent)
[337.154008] Starting subtest: idempotent
[337.155921] Starting dynamic subtest: vecs0
[337.156628] Dynamic subtest vecs0: SUCCESS (0.000s)
[337.164497] Starting dynamic subtest: vcs0
[337.165202] Dynamic subtest vcs0: SUCCESS (0.000s)
[337.173211] Starting dynamic subtest: bcs0
[337.173919] Dynamic subtest bcs0: SUCCESS (0.000s)
[337.181557] Starting dynamic subtest: rcs0
[337.182266] Dynamic subtest rcs0: SUCCESS (0.000s)
[337.189883] Starting dynamic subtest: vcs1
[337.190578] Dynamic subtest vcs1: SUCCESS (0.000s)
[337.191250] Subtest idempotent: SUCCESS (0.007s)
[337.238792] [109/133] (688s left) perf (disabled-read-error)
[337.331560] Starting subtest: disabled-read-error
[337.346250] Subtest disabled-read-error: SUCCESS (0.016s)
[337.387434] [110/133] (688s left) kms_feature_discovery (dp-mst)
[337.476907] Starting subtest: dp-mst
[337.478249] Subtest dp-mst: SKIP (0.000s)
[337.548741] [111/133] (688s left) gem_spin_batch (legacy)
[337.589104] Starting subtest: legacy
[337.589845] Starting dynamic subtest: default
[340.941462] Dynamic subtest default: SUCCESS (3.317s)
[340.951993] Starting dynamic subtest: render
[344.259891] Dynamic subtest render: SUCCESS (3.317s)
[344.270880] Starting dynamic subtest: bsd
[347.578787] Dynamic subtest bsd: SUCCESS (3.317s)
[347.589652] Starting dynamic subtest: bsd1
[350.898167] Dynamic subtest bsd1: SUCCESS (3.318s)
[350.908672] Starting dynamic subtest: bsd2
[354.217772] Dynamic subtest bsd2: SUCCESS (3.317s)
[354.226621] Starting dynamic subtest: blt
[357.537825] Dynamic subtest blt: SUCCESS (3.318s)
[357.548681] Starting dynamic subtest: vebox
[360.858090] Dynamic subtest vebox: SUCCESS (3.317s)
[360.859103] Subtest legacy: SUCCESS (23.237s)
[361.016696] [112/133] (664s left) gem_lmem_swapping (verify-random)
[361.052656] Subtest verify-random: SKIP (0.000s)
[361.093049] [113/133] (664s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[361.180744] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[361.182509] Starting dynamic subtest: pipe-A-HDMI-A-1
[361.189126] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[361.196931] Starting dynamic subtest: pipe-B-HDMI-A-1
[361.203512] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[361.211086] Starting dynamic subtest: pipe-C-HDMI-A-1
[361.218248] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[361.225779] Starting dynamic subtest: pipe-D-HDMI-A-1
[361.232444] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[361.233736] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[361.447485] [114/133] (664s left) kms_psr (fbc-psr2-no-drrs)
[361.535635] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[361.578877] [115/133] (664s left) kms_psr (psr-sprite-render)
[361.664683] Subtest psr-sprite-render: SKIP (0.000s)
[361.711478] [116/133] (664s left) gem_exec_balancer (bonded-semaphore)
[361.752239] Starting subtest: bonded-semaphore
[366.018291] Subtest bonded-semaphore: SUCCESS (4.232s)
[366.188906] [117/133] (659s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[366.281600] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[366.282969] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[366.414346] [118/133] (659s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[366.504837] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[366.506276] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[366.630935] [119/133] (659s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[366.667691] Starting subtest: basic-wc-cpu-noreloc
[366.670623] Subtest basic-wc-cpu-noreloc: SUCCESS (0.003s)
[366.790701] [120/133] (659s left) gem_partial_pwrite_pread (reads)
[366.827253] Starting subtest: reads
[368.588081] Subtest reads: SUCCESS (1.761s)
[368.722163] [121/133] (657s left) gem_exec_schedule (in-order)
[368.767389] Starting subtest: in-order
[368.768197] Starting dynamic subtest: rcs0
[368.827226] Dynamic subtest rcs0: SUCCESS (0.059s)
[368.840563] Starting dynamic subtest: bcs0
[368.890820] Dynamic subtest bcs0: SUCCESS (0.061s)
[368.903947] Starting dynamic subtest: vcs0
[368.956511] Dynamic subtest vcs0: SUCCESS (0.064s)
[368.970406] Starting dynamic subtest: vcs1
[369.021951] Dynamic subtest vcs1: SUCCESS (0.063s)
[369.035487] Starting dynamic subtest: vecs0
[369.085236] Dynamic subtest vecs0: SUCCESS (0.061s)
[369.086463] Subtest in-order: SUCCESS (0.319s)
[369.392451] [122/133] (656s left) gem_workarounds (suspend-resume-context)
[369.438942] Starting subtest: suspend-resume-context
[386.122410] Subtest suspend-resume-context: SUCCESS (1.205s)
[395.299854] [123/133] (639s left) kms_pm_rpm (system-suspend-modeset)
[396.723384] Starting subtest: system-suspend-modeset
[416.346368] Subtest system-suspend-modeset: SUCCESS (4.749s)
[423.618038] [124/133] (618s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[423.711825] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[423.713297] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[423.825807] [125/133] (618s left) kms_cursor_crc (cursor-onscreen-512x170)
[423.916525] Starting subtest: cursor-onscreen-512x170
[423.917939] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[424.025103] [126/133] (618s left) kms_psr (psr2-sprite-blt)
[424.110137] Subtest psr2-sprite-blt: SKIP (0.000s)
[424.157507] [127/133] (618s left) kms_busy (extended-modeset-hang-newfb)
[424.245477] Starting subtest: extended-modeset-hang-newfb
[424.247335] Starting dynamic subtest: pipe-A
[448.252011] Dynamic subtest pipe-A: SUCCESS (24.003s)
[448.265889] Starting dynamic subtest: pipe-D
[472.325195] Dynamic subtest pipe-D: SUCCESS (24.071s)
[472.325914] Subtest extended-modeset-hang-newfb: SUCCESS (48.081s)
[472.457746] [128/133] (570s left) i915_drm_fdinfo (virtual-busy-idle)
[472.496380] Starting subtest: virtual-busy-idle
[475.714337] Subtest virtual-busy-idle: SUCCESS (3.218s)
[475.799661] [129/133] (566s left) gem_exec_fence (basic-wait)
[475.961322] Starting subtest: basic-wait
[475.962536] Starting dynamic subtest: rcs0
[476.000165] Dynamic subtest rcs0: SUCCESS (0.038s)
[476.020233] Starting dynamic subtest: bcs0
[476.039069] Dynamic subtest bcs0: SUCCESS (0.037s)
[476.057291] Starting dynamic subtest: vcs0
[476.074970] Dynamic subtest vcs0: SUCCESS (0.033s)
[476.088255] Starting dynamic subtest: vcs1
[476.110067] Dynamic subtest vcs1: SUCCESS (0.032s)
[476.123804] Starting dynamic subtest: vecs0
[476.142780] Dynamic subtest vecs0: SUCCESS (0.030s)
[476.143873] Subtest basic-wait: SUCCESS (0.183s)
[476.614281] [130/133] (565s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[476.703218] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[477.778219] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.075s)
[477.952356] [131/133] (564s left) kms_chamelium_hpd (hdmi-hpd-fast)
[478.095833] Subtest hdmi-hpd-fast: SKIP (0.000s)
[478.187257] [132/133] (564s left) gem_eio (in-flight-contexts-1us)
[478.233565] Starting subtest: in-flight-contexts-1us
[492.004089] Subtest in-flight-contexts-1us: SUCCESS (13.771s)
[492.154971] [133/133] (550s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[492.249820] Starting subtest: y-tiled-8bpp-rotate-0
[493.286454] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.036s)
[493.435066] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: gem_watchdog
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_colorop
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: syncobj_basic
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: gem_pipe_control_store_loop
results: parsing output: 13/ for test: kms_joiner
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_chamelium_audio
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_vrr
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_suspend
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_busy
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: api_intel_allocator
results: parsing output: 29/ for test: gem_exec_gttfill
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_lmem_evict
results: parsing output: 32/ for test: kms_draw_crc
results: parsing output: 33/ for test: kms_content_protection
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_pm_dc
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_selftest
results: parsing output: 41/ for test: kms_legacy_colorkey
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: gem_ctx_bad_destroy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: kms_plane_alpha_blend
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: i915_pm_rps
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_render_copy_redux
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_colorop
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_invalid_mode
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_exec_suspend
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: gem_create
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_colorop
results: parsing output: 79/ for test: gem_sync
results: parsing output: 80/ for test: perf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_madvise
results: parsing output: 86/ for test: kms_atomic
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_prop_blob
results: parsing output: 94/ for test: dmabuf_sync_file
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_vblank
results: parsing output: 98/ for test: i915_selftest
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: gem_exec_flush
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: sysfs_timeslice_duration
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_feature_discovery
results: parsing output: 110/ for test: gem_spin_batch
results: parsing output: 111/ for test: gem_lmem_swapping
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: gem_partial_pwrite_pread
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_workarounds
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_busy
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: kms_big_fb
Done.