[43.709987] Initializing watchdogs
[43.710087]   /dev/watchdog0
[43.729590] [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.736013] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.738693] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.740619] [001/133] (960s left) kms_cursor_legacy (torture-bo)
[43.831304] Starting subtest: torture-bo
[43.832095] Starting dynamic subtest: pipe-A
[49.315199] Dynamic subtest pipe-A: SUCCESS (5.483s)
[49.320660] Starting dynamic subtest: pipe-B
[54.765773] Dynamic subtest pipe-B: SUCCESS (5.510s)
[54.774616] Starting dynamic subtest: pipe-C
[60.319100] Dynamic subtest pipe-C: SUCCESS (5.564s)
[60.327876] Starting dynamic subtest: pipe-D
[65.802896] Dynamic subtest pipe-D: SUCCESS (5.501s)
[65.809858] Starting dynamic subtest: all-pipes
[71.287586] Dynamic subtest all-pipes: SUCCESS (5.493s)
[71.288345] Subtest torture-bo: SUCCESS (27.552s)
[71.318977] [002/133] (932s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[71.441292] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[71.581834] [003/133] (932s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[71.882974] Starting subtest: flip-vs-cursor-legacy
[78.610590] Subtest flip-vs-cursor-legacy: SUCCESS (6.732s)
[78.741081] [004/133] (925s left) kms_psr (psr-cursor-plane-onoff)
[78.830604] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[78.867670] [005/133] (925s left) gem_exec_gttfill (engines)
[78.913576] Starting subtest: engines
[78.914291] Starting dynamic subtest: rcs0
[102.500573] Dynamic subtest rcs0: SUCCESS (23.588s)
[102.508227] Starting dynamic subtest: bcs0
[125.634514] Dynamic subtest bcs0: SUCCESS (23.134s)
[125.641721] Starting dynamic subtest: vcs0
[148.872357] Dynamic subtest vcs0: SUCCESS (23.238s)
[148.879703] Starting dynamic subtest: vcs1
[172.100393] Dynamic subtest vcs1: SUCCESS (23.227s)
[172.106778] Starting dynamic subtest: vecs0
[195.072991] Dynamic subtest vecs0: SUCCESS (22.972s)
[195.073707] Subtest engines: SUCCESS (116.161s)
[195.248945] [006/133] (809s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[195.390618] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[195.391371] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.398216] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[195.404740] Starting dynamic subtest: pipe-B-HDMI-A-1
[195.411677] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[195.417810] Starting dynamic subtest: pipe-C-HDMI-A-1
[195.424715] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[195.430823] Starting dynamic subtest: pipe-D-HDMI-A-1
[195.437604] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[195.438958] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[195.625926] [007/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[195.718633] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[195.719997] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[195.810354] [008/133] (808s left) kms_force_connector_basic (force-load-detect)
[195.932849] Starting subtest: force-load-detect
[195.934260] Subtest force-load-detect: SKIP (0.000s)
[196.084067] [009/133] (808s left) kms_cursor_crc (cursor-alpha-transparent)
[196.170785] Starting subtest: cursor-alpha-transparent
[196.171524] Starting dynamic subtest: pipe-A-HDMI-A-1
[196.465139] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.294s)
[196.472811] Starting dynamic subtest: pipe-D-HDMI-A-1
[196.705166] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.239s)
[196.705911] Subtest cursor-alpha-transparent: SUCCESS (0.535s)
[196.841234] [010/133] (807s left) gem_ctx_shared (create-shared-gtt)
[196.886688] Starting subtest: create-shared-gtt
[199.044807] Subtest create-shared-gtt: SUCCESS (2.149s)
[199.225346] [011/133] (805s left) gem_exec_reloc (basic-gtt-read)
[199.262556] Starting subtest: basic-gtt-read
[199.269816] Subtest basic-gtt-read: SUCCESS (0.007s)
[199.378997] [012/133] (805s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[199.470453] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[199.471858] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[199.563924] [013/133] (805s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[199.605502] Starting subtest: invalid-multi-wait-all-unsubmitted
[199.606267] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[199.670304] [014/133] (805s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[199.766634] Starting subtest: y-tiled-32bpp-rotate-0
[201.006356] Subtest y-tiled-32bpp-rotate-0: SUCCESS (1.240s)
[201.134272] [015/133] (803s left) kms_setmode (invalid-clone-exclusive-crtc)
[201.168607] Starting subtest: invalid-clone-exclusive-crtc
[201.170674] Subtest invalid-clone-exclusive-crtc: SKIP (0.001s)
[201.224982] [016/133] (803s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[201.258690] Starting subtest: multi-wait-for-submit-submitted-signaled
[201.260081] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[201.313659] [017/133] (803s left) gem_mmap_offset (perf)
[201.345697] Starting subtest: perf
[201.346630] Starting dynamic subtest: smem0
[201.514149] Dynamic subtest smem0: SUCCESS (0.168s)
[201.514852] Subtest perf: SUCCESS (0.168s)
[201.606786] [018/133] (803s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[201.694511] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[201.695222] Starting dynamic subtest: pipe-A
[201.806834] Dynamic subtest pipe-A: SUCCESS (0.113s)
[201.814031] Starting dynamic subtest: pipe-B
[201.949743] Dynamic subtest pipe-B: SUCCESS (0.143s)
[201.956754] Starting dynamic subtest: pipe-C
[202.075130] Dynamic subtest pipe-C: SUCCESS (0.125s)
[202.088358] Starting dynamic subtest: pipe-D
[202.227151] Dynamic subtest pipe-D: SUCCESS (0.152s)
[202.228430] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.533s)
[202.393841] [019/133] (802s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[202.430731] Starting subtest: etime-single-wait-available-unsubmitted
[202.535721] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[202.606585] [020/133] (802s left) gem_set_tiling_vs_pwrite
[202.730417] [021/133] (802s left) gem_exec_balancer (sliced)
[202.773163] Starting subtest: sliced
[204.220458] Subtest sliced: SUCCESS (1.439s)
[204.394778] [022/133] (800s left) kms_selftest (drm_damage_helper)
[204.429132] Starting subtest: drm_damage_helper
[204.444272] Starting dynamic subtest: drm_test_damage_iter_no_damage
[204.519628] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.074s)
[204.532247] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[204.586326] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.066s)
[204.602181] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[204.663230] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.077s)
[204.680131] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[204.736610] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.072s)
[204.752380] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[204.797838] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.061s)
[204.813801] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[204.872082] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.072s)
[204.888783] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[204.945113] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.072s)
[204.961037] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[205.017437] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.071s)
[205.033291] Starting dynamic subtest: drm_test_damage_iter_single_damage
[205.086253] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.068s)
[205.101591] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[205.161317] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.074s)
[205.176989] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[205.234765] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.072s)
[205.250187] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[205.308277] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.074s)
[205.324227] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[205.376440] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.067s)
[205.392162] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[205.450211] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.074s)
[205.466025] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[205.518391] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.066s)
[205.533940] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[205.581570] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.062s)
[205.596611] Starting dynamic subtest: drm_test_damage_iter_damage
[205.652425] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.070s)
[205.668133] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[205.718391] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.064s)
[205.728563] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[205.784372] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.066s)
[205.798403] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[205.850953] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.067s)
[205.864551] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[205.915156] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.062s)
[205.916297] Subtest drm_damage_helper: SUCCESS (1.485s)
[206.047336] [023/133] (799s left) api_intel_bb (object-noreloc-purge-cache-simple)
[206.081470] Starting subtest: object-noreloc-purge-cache-simple
[206.085331] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.004s)
[206.177899] [024/133] (798s left) gem_busy (extended)
[206.354184] Starting subtest: extended
[206.355408] Starting dynamic subtest: rcs0
[206.383471] Dynamic subtest rcs0: SUCCESS (0.039s)
[206.401236] Starting dynamic subtest: bcs0
[206.402979] Dynamic subtest bcs0: SUCCESS (0.019s)
[206.410607] Starting dynamic subtest: vcs0
[206.417841] Dynamic subtest vcs0: SUCCESS (0.015s)
[206.424808] Starting dynamic subtest: vcs1
[206.436202] Dynamic subtest vcs1: SUCCESS (0.018s)
[206.449885] Starting dynamic subtest: vecs0
[206.454974] Dynamic subtest vecs0: SUCCESS (0.018s)
[206.455873] Subtest extended: SUCCESS (0.111s)
[206.658893] [025/133] (798s left) kms_psr (pr-cursor-blt)
[206.746012] Subtest pr-cursor-blt: SKIP (0.000s)
[206.780533] [026/133] (798s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[206.816876] Starting subtest: no-spare-fences-busy
[209.000484] Subtest no-spare-fences-busy: SUCCESS (2.183s)
[209.115736] [027/133] (796s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[209.148457] Starting subtest: cpuset-basic-small-copy-odd
[212.621657] Subtest cpuset-basic-small-copy-odd: SUCCESS (3.473s)
[212.703730] [028/133] (792s left) kms_cdclk (mode-transition)
[212.787148] Subtest mode-transition: SKIP (0.000s)
[212.825909] [029/133] (792s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[212.915897] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[212.956588] [030/133] (792s left) vgem_basic (mmap)
[213.030610] Starting subtest: mmap
[213.036702] Subtest mmap: SUCCESS (0.007s)
[213.086735] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[213.088437] [031/133] (792s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[213.184859] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[213.186250] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[213.273520] [032/133] (792s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[213.363530] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[213.372342] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.009s)
[213.429810] [033/133] (792s left) kms_cursor_crc (cursor-sliding-max-size)
[213.526447] Starting subtest: cursor-sliding-max-size
[213.528579] Subtest cursor-sliding-max-size: SKIP (0.000s)
[213.613848] [034/133] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[213.709133] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[213.710469] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.781400] [035/133] (791s left) gem_pxp (create-protected-buffer)
[213.883954] Starting subtest: create-protected-buffer
[213.885128] Subtest create-protected-buffer: SUCCESS (0.000s)
[213.978742] [036/133] (791s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[214.063739] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[214.065149] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[214.124169] [037/133] (791s left) gem_exec_fence (syncobj-timeline-export)
[214.575492] Starting subtest: syncobj-timeline-export
[214.576376] Subtest syncobj-timeline-export: SUCCESS (0.006s)
[214.753874] [038/133] (790s left) gem_unfence_active_buffers
[214.919568] [039/133] (790s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[215.004554] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[215.005276] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.022686] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[215.029641] Starting dynamic subtest: pipe-B-HDMI-A-1
[215.047427] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[215.054095] Starting dynamic subtest: pipe-C-HDMI-A-1
[215.071541] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[215.079619] Starting dynamic subtest: pipe-D-HDMI-A-1
[215.098024] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[215.099334] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.011s)
[215.248739] [040/133] (790s left) kms_fbcon_fbt (psr-suspend)
[215.290883] Starting subtest: psr-suspend
[215.292350] Subtest psr-suspend: SKIP (0.000s)
[215.381055] [041/133] (790s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[216.790936] Starting subtest: dpms-mode-unset-lpsp
[220.497505] Subtest dpms-mode-unset-lpsp: SUCCESS (3.707s)
[220.691997] [042/133] (785s left) i915_drm_fdinfo (busy-check-all)
[220.730458] Starting subtest: busy-check-all
[220.731175] Starting dynamic subtest: rcs0
[221.249354] Dynamic subtest rcs0: SUCCESS (0.519s)
[221.259267] Starting dynamic subtest: bcs0
[221.770474] Dynamic subtest bcs0: SUCCESS (0.520s)
[221.780431] Starting dynamic subtest: vcs0
[222.291960] Dynamic subtest vcs0: SUCCESS (0.520s)
[222.301431] Starting dynamic subtest: vcs1
[222.814235] Dynamic subtest vcs1: SUCCESS (0.522s)
[222.825834] Starting dynamic subtest: vecs0
[223.340027] Dynamic subtest vecs0: SUCCESS (0.525s)
[223.340970] Subtest busy-check-all: SUCCESS (2.611s)
[223.409399] [043/133] (782s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[223.502931] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[223.544764] [044/133] (782s left) kms_psr (psr-primary-page-flip)
[223.633994] Subtest psr-primary-page-flip: SKIP (0.000s)
[223.678041] [045/133] (782s left) gem_spin_batch (spin-each)
[223.720687] Starting subtest: spin-each
[227.080680] Subtest spin-each: SUCCESS (3.342s)
[227.247194] [046/133] (778s left) perf_pmu (busy-start)
[227.282729] Starting subtest: busy-start
[227.283656] Starting dynamic subtest: rcs0
[229.826266] Dynamic subtest rcs0: SUCCESS (2.519s)
[229.836505] Starting dynamic subtest: bcs0
[232.346437] Dynamic subtest bcs0: SUCCESS (2.517s)
[232.356671] Starting dynamic subtest: vcs0
[234.863405] Dynamic subtest vcs0: SUCCESS (2.517s)
[234.873932] Starting dynamic subtest: vcs1
[237.382017] Dynamic subtest vcs1: SUCCESS (2.524s)
[237.392733] Starting dynamic subtest: vecs0
[239.906971] Dynamic subtest vecs0: SUCCESS (2.519s)
[239.908073] Subtest busy-start: SUCCESS (12.601s)
[239.951696] [047/133] (766s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[240.094752] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[240.184986] [048/133] (765s left) kms_feature_discovery (chamelium)
[240.276398] Starting subtest: chamelium
[240.277874] Subtest chamelium: SKIP (0.000s)
[240.333241] [049/133] (765s left) kms_atomic_transition (modeset-transition-nonblocking)
[240.418444] Starting subtest: modeset-transition-nonblocking
[240.419161] Starting dynamic subtest: 1x-outputs
[241.615043] Dynamic subtest 1x-outputs: SUCCESS (1.197s)
[241.615871] Subtest modeset-transition-nonblocking: SUCCESS (1.197s)
[241.783969] [050/133] (764s left) syncobj_eventfd (binary-wait-before-signal)
[241.822369] Starting subtest: binary-wait-before-signal
[241.853953] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[241.922633] [051/133] (764s left) vgem_slow (nohang)
[241.960176] Starting subtest: nohang
[252.001035] Subtest nohang: SUCCESS (10.032s)
[252.055949] [052/133] (754s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[252.152479] Starting subtest: 2x-absolute-wf_vblank-interruptible
[252.161345] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.009s)
[252.223259] [053/133] (753s left) i915_pm_rpm (gem-idle)
[253.622692] Starting subtest: gem-idle
[259.928783] Subtest gem-idle: SUCCESS (6.307s)
[260.060964] [054/133] (746s left) dmabuf_sync_file (export-basic)
[260.102371] Starting subtest: export-basic
[260.103058] Subtest export-basic: SUCCESS (0.001s)
[260.154247] [055/133] (746s left) gem_ctx_exec (basic-close-race)
[260.189655] Starting subtest: basic-close-race
[265.770618] Subtest basic-close-race: SUCCESS (5.546s)
[265.852319] [056/133] (740s left) kms_properties (plane-properties-atomic)
[265.948260] Starting subtest: plane-properties-atomic
[265.948965] Starting dynamic subtest: pipe-A-HDMI-A-1
[266.209744] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.261s)
[266.218269] Starting dynamic subtest: pipe-B-HDMI-A-1
[266.491261] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.280s)
[266.500590] Starting dynamic subtest: pipe-C-HDMI-A-1
[266.768019] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.275s)
[266.776136] Starting dynamic subtest: pipe-D-HDMI-A-1
[267.039292] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.270s)
[267.040011] Subtest plane-properties-atomic: SUCCESS (1.092s)
[267.195024] [057/133] (739s left) gem_render_copy (linear-to-vebox-yf-tiled)
[267.241066] Starting subtest: linear-to-vebox-yf-tiled
[267.241758] Starting dynamic subtest: smem
[267.310423] Dynamic subtest smem: SUCCESS (0.069s)
[267.311139] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.070s)
[267.487677] [058/133] (738s left) gen9_exec_parse (bb-secure)
[267.524510] Subtest bb-secure: SKIP (0.000s)
[267.568439] [059/133] (738s left) gem_lmem_swapping (heavy-verify-random)
[267.605349] Subtest heavy-verify-random: SKIP (0.000s)
[267.644670] [060/133] (738s left) gem_exec_schedule (wide)
[267.813371] Starting subtest: wide
[267.814240] Starting dynamic subtest: rcs0
[278.072342] Dynamic subtest rcs0: SUCCESS (10.226s)
[278.082315] Starting dynamic subtest: bcs0
[289.163043] Dynamic subtest bcs0: SUCCESS (11.090s)
[289.173247] Starting dynamic subtest: vcs0
[300.760866] Dynamic subtest vcs0: SUCCESS (11.622s)
[300.768743] Starting dynamic subtest: vcs1
[312.306620] Dynamic subtest vcs1: SUCCESS (11.519s)
[312.316427] Starting dynamic subtest: vecs0
[323.743366] Dynamic subtest vecs0: SUCCESS (11.436s)
[323.744201] Subtest wide: SUCCESS (55.898s)
[325.933895] [061/133] (680s left) kms_psr (fbc-pr-basic)
[326.023584] Subtest fbc-pr-basic: SKIP (0.000s)
[326.069403] [062/133] (680s left) gem_exec_flush (basic-wb-ro-before-default)
[326.111335] Starting subtest: basic-wb-ro-before-default
[331.539224] Subtest basic-wb-ro-before-default: SUCCESS (5.428s)
[331.742925] [063/133] (674s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[331.831443] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[331.832155] Starting dynamic subtest: pipe-A-HDMI-A-1
[331.838790] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[331.846566] Starting dynamic subtest: pipe-B-HDMI-A-1
[331.853361] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[331.860932] Starting dynamic subtest: pipe-C-HDMI-A-1
[331.867825] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[331.875185] Starting dynamic subtest: pipe-D-HDMI-A-1
[331.882195] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[331.883483] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[332.062197] [064/133] (674s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[332.160323] Starting subtest: 4-tiled-8bpp-rotate-90
[332.161768] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[332.236871] [065/133] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[332.325465] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[332.326910] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[332.406409] [066/133] (674s left) perf (polling)
[332.498262] Starting subtest: polling
[332.499017] Starting dynamic subtest: 0-rcs0
[342.518222] Dynamic subtest 0-rcs0: SUCCESS (10.012s)
[342.518968] Subtest polling: SUCCESS (10.013s)
[342.552585] [067/133] (664s left) kms_plane_alpha_blend (constant-alpha-min)
[342.645444] Starting subtest: constant-alpha-min
[342.718424] Starting dynamic subtest: pipe-A-HDMI-A-1
[343.100122] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.381s)
[343.109162] Starting dynamic subtest: pipe-D-HDMI-A-1
[343.514502] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.412s)
[343.515231] Subtest constant-alpha-min: SUCCESS (0.869s)
[343.667286] [068/133] (663s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[343.757784] Starting subtest: primary-x-tiled-reflect-x-0
[347.332359] Subtest primary-x-tiled-reflect-x-0: SUCCESS (3.575s)
[347.516687] [069/133] (659s left) gem_userptr_blits (process-exit-busy)
[347.564699] Starting subtest: process-exit-busy
[347.579906] Subtest process-exit-busy: SUCCESS (0.016s)
[347.695127] [070/133] (659s left) gem_ctx_persistence (engines-queued)
[347.731292] Starting subtest: engines-queued
[347.732047] Starting dynamic subtest: rcs0
[347.783617] Dynamic subtest rcs0: SUCCESS (0.051s)
[347.800973] Starting dynamic subtest: bcs0
[347.834418] Dynamic subtest bcs0: SUCCESS (0.049s)
[347.851629] Starting dynamic subtest: vcs0
[347.883571] Dynamic subtest vcs0: SUCCESS (0.048s)
[347.901501] Starting dynamic subtest: vcs1
[347.933514] Dynamic subtest vcs1: SUCCESS (0.048s)
[347.948708] Starting dynamic subtest: vecs0
[347.979620] Dynamic subtest vecs0: SUCCESS (0.045s)
[347.980693] Subtest engines-queued: SUCCESS (0.249s)
[348.058326] [071/133] (658s left) sriov_basic (enable-vfs-bind-unbind-each)
[348.092149] Starting subtest: enable-vfs-bind-unbind-each
[348.092904] Starting dynamic subtest: numvfs-1
[348.122784] Dynamic subtest numvfs-1: FAIL (0.017s)
[348.131467] Starting dynamic subtest: numvfs-2
[348.153779] Dynamic subtest numvfs-2: FAIL (0.006s)
[348.161538] Starting dynamic subtest: numvfs-3
[348.183436] Dynamic subtest numvfs-3: FAIL (0.006s)
[348.190782] Starting dynamic subtest: numvfs-4
[348.211914] Dynamic subtest numvfs-4: FAIL (0.006s)
[348.219121] Starting dynamic subtest: numvfs-5
[348.240596] Dynamic subtest numvfs-5: FAIL (0.006s)
[348.247694] Starting dynamic subtest: numvfs-6
[348.269275] Dynamic subtest numvfs-6: FAIL (0.006s)
[348.276221] Starting dynamic subtest: numvfs-7
[348.297809] Dynamic subtest numvfs-7: FAIL (0.006s)
[348.304862] Starting dynamic subtest: numvfs-random
[348.326040] Dynamic subtest numvfs-random: FAIL (0.006s)
[348.326739] Subtest enable-vfs-bind-unbind-each: FAIL (0.065s)
[348.358006] [072/133] (658s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[348.450615] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[348.451985] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[348.564723] [073/133] (658s left) kms_prime (basic-crc-vgem)
[348.664047] Starting subtest: basic-crc-vgem
[348.664770] Starting dynamic subtest: second-to-first
[349.363170] Dynamic subtest second-to-first: SUCCESS (0.699s)
[349.364397] Subtest basic-crc-vgem: SUCCESS (0.701s)
[349.462579] [074/133] (657s left) gem_partial_pwrite_pread (reads-display)
[349.500101] Starting subtest: reads-display
[351.347464] Subtest reads-display: SUCCESS (1.847s)
[351.452229] [075/133] (655s left) kms_properties (get_properties-sanity-non-atomic)
[351.540817] Starting subtest: get_properties-sanity-non-atomic
[351.542838] Subtest get_properties-sanity-non-atomic: SUCCESS (0.003s)
[351.599784] [076/133] (655s left) gem_exec_reloc (basic-write-wc-active)
[351.637726] Starting subtest: basic-write-wc-active
[351.768044] Subtest basic-write-wc-active: SUCCESS (0.122s)
[351.881785] [077/133] (655s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[351.972730] Starting subtest: fbc-rgb565-draw-mmap-gtt
[353.230688] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.258s)
[353.342684] [078/133] (653s left) gem_exec_schedule (pi-distinct-iova)
[353.510770] Starting subtest: pi-distinct-iova
[353.511657] Starting dynamic subtest: rcs0
[353.535218] Dynamic subtest rcs0: SUCCESS (0.025s)
[353.543887] Starting dynamic subtest: bcs0
[353.556638] Dynamic subtest bcs0: SUCCESS (0.021s)
[353.564890] Starting dynamic subtest: vcs0
[353.578534] Dynamic subtest vcs0: SUCCESS (0.021s)
[353.586817] Starting dynamic subtest: vcs1
[353.601877] Dynamic subtest vcs1: SUCCESS (0.022s)
[353.610034] Starting dynamic subtest: vecs0
[353.623780] Dynamic subtest vecs0: SUCCESS (0.021s)
[353.624622] Subtest pi-distinct-iova: SUCCESS (0.114s)
[353.823617] [079/133] (653s left) kms_flip (2x-flip-vs-suspend-interruptible)
[353.918443] Starting subtest: 2x-flip-vs-suspend-interruptible
[353.928268] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.009s)
[353.990952] [080/133] (653s left) vgem_basic (dmabuf-fence)
[354.031328] Starting subtest: dmabuf-fence
[354.032020] Subtest dmabuf-fence: SUCCESS (0.000s)
[354.092937] [081/133] (653s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[354.188845] Starting subtest: yf-tiled-64bpp-rotate-0
[354.190206] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[354.260592] [082/133] (653s left) gem_ctx_shared (single-timeline)
[354.302485] Starting subtest: single-timeline
[354.308654] Subtest single-timeline: SUCCESS (0.005s)
[354.487329] [083/133] (652s left) gem_exec_reloc (basic-cpu-noreloc)
[354.525658] Starting subtest: basic-cpu-noreloc
[354.527759] Subtest basic-cpu-noreloc: SUCCESS (0.003s)
[354.640503] [084/133] (652s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[354.681030] Starting subtest: y-tiled-ccs-to-yf-tiled
[354.681776] Starting dynamic subtest: smem
[354.756957] Dynamic subtest smem: SUCCESS (0.077s)
[354.757717] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.077s)
[354.935609] [085/133] (652s left) gem_ctx_param (get-priority-new-ctx)
[354.969739] Starting subtest: get-priority-new-ctx
[354.970460] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[355.033146] [086/133] (652s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[355.129275] Starting subtest: x-tiled-8bpp-rotate-0
[356.114569] Subtest x-tiled-8bpp-rotate-0: SUCCESS (0.985s)
[356.232933] [087/133] (651s left) gem_mmap_gtt (big-bo-tiledy)
[356.266645] Starting subtest: big-bo-tiledY
[356.428551] Subtest big-bo-tiledY: SUCCESS (0.162s)
[356.522551] [088/133] (651s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[356.605511] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[356.606213] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[356.677154] [089/133] (650s left) kms_vrr (flip-suspend)
[356.769933] Starting subtest: flip-suspend
[356.772045] Subtest flip-suspend: SKIP (0.000s)
[356.832501] [090/133] (650s left) kms_lease (lease-invalid-crtc)
[356.919238] Starting subtest: lease-invalid-crtc
[356.921180] Starting dynamic subtest: pipe-A-HDMI-A-1
[356.921906] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[356.931894] Starting dynamic subtest: pipe-B-HDMI-A-1
[356.932636] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[356.942066] Starting dynamic subtest: pipe-C-HDMI-A-1
[356.942791] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[356.952363] Starting dynamic subtest: pipe-D-HDMI-A-1
[356.953066] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[356.953761] Subtest lease-invalid-crtc: SUCCESS (0.005s)
[356.984935] [091/133] (650s left) kms_invalid_mode (bad-htotal)
[357.072608] Starting subtest: bad-htotal
[357.073339] Starting dynamic subtest: pipe-A-HDMI-A-1
[357.121907] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.048s)
[357.131116] Starting dynamic subtest: pipe-B-HDMI-A-1
[357.131803] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[357.139317] Starting dynamic subtest: pipe-C-HDMI-A-1
[357.140010] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[357.147447] Starting dynamic subtest: pipe-D-HDMI-A-1
[357.148128] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[357.148794] Subtest bad-htotal: SUCCESS (0.057s)
[357.258794] [092/133] (650s left) syncobj_timeline (wait-delayed-signal)
[357.297018] Starting subtest: wait-delayed-signal
[357.399048] Subtest wait-delayed-signal: SUCCESS (0.102s)
[357.499219] [093/133] (650s left) kms_busy (extended-modeset-hang-newfb)
[357.590240] Starting subtest: extended-modeset-hang-newfb
[357.592188] Starting dynamic subtest: pipe-A
[382.142762] Dynamic subtest pipe-A: SUCCESS (24.551s)
[382.156128] Starting dynamic subtest: pipe-D
[406.208822] Dynamic subtest pipe-D: SUCCESS (24.060s)
[406.209575] Subtest extended-modeset-hang-newfb: SUCCESS (48.619s)
[406.333408] [094/133] (601s left) gem_exec_schedule (smoketest)
[406.510200] Starting subtest: smoketest
[406.511092] Starting dynamic subtest: rcs0
[411.972594] Dynamic subtest rcs0: SUCCESS (5.424s)
[411.982465] Starting dynamic subtest: bcs0
[417.392552] Dynamic subtest bcs0: SUCCESS (5.419s)
[417.401660] Starting dynamic subtest: vcs0
[422.820608] Dynamic subtest vcs0: SUCCESS (5.428s)
[422.830085] Starting dynamic subtest: vcs1
[428.238499] Dynamic subtest vcs1: SUCCESS (5.417s)
[428.248185] Starting dynamic subtest: vecs0
[433.663634] Dynamic subtest vecs0: SUCCESS (5.422s)
[433.664562] Subtest smoketest: SUCCESS (27.115s)
[433.805046] [095/133] (574s left) kms_vblank (query-forked-hang)
[433.895373] Starting subtest: query-forked-hang
[433.897353] Starting dynamic subtest: pipe-A-HDMI-A-1
[447.633053] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.735s)
[447.644252] Starting dynamic subtest: pipe-D-HDMI-A-1
[461.445020] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.809s)
[461.447129] Subtest query-forked-hang: SUCCESS (27.551s)
[461.594371] [096/133] (546s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[461.690361] Starting subtest: 2x-flip-vs-rmfb-interruptible
[461.700074] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.009s)
[461.760629] [097/133] (546s left) kms_getfb (getfb-repeated-different-handles)
[461.846037] Starting subtest: getfb-repeated-different-handles
[461.846783] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[461.944149] [098/133] (546s left) gem_ppgtt (blt-vs-render-ctxn)
[461.981048] Starting subtest: blt-vs-render-ctxN
[494.457420] Subtest blt-vs-render-ctxN: SUCCESS (32.465s)
[494.554772] [099/133] (513s left) syncobj_wait (single-wait-all-signaled)
[494.633617] Starting subtest: single-wait-all-signaled
[494.634370] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[494.692288] [100/133] (513s left) kms_addfb_basic (clobberred-modifier)
[494.726587] Starting subtest: clobberred-modifier
[494.727320] Subtest clobberred-modifier: SUCCESS (0.000s)
[494.872131] [101/133] (513s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[494.906014] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[494.906801] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[494.973099] [102/133] (513s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[495.065847] Starting subtest: cursor-rapid-movement-256x256
[495.070723] Starting dynamic subtest: pipe-A-HDMI-A-1
[495.370986] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.300s)
[495.407056] Starting dynamic subtest: pipe-D-HDMI-A-1
[495.618512] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.219s)
[495.619235] Subtest cursor-rapid-movement-256x256: SUCCESS (0.553s)
[495.755409] [103/133] (512s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[495.849614] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[495.851013] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[495.949187] [104/133] (512s left) gem_tiled_pread_basic (basic)
[495.985063] Starting subtest: basic
[496.066498] Subtest basic: SUCCESS (0.082s)
[496.147740] [105/133] (512s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[496.233936] Starting subtest: bad-pixel-format-y-tiled-ccs
[496.234634] Starting dynamic subtest: pipe-A-HDMI-A-1
[496.241371] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[496.249488] Starting dynamic subtest: pipe-B-HDMI-A-1
[496.256136] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[496.264062] Starting dynamic subtest: pipe-C-HDMI-A-1
[496.270658] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[496.278366] Starting dynamic subtest: pipe-D-HDMI-A-1
[496.285900] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[496.287217] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s)
[496.469077] [106/133] (511s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[496.555974] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[496.557387] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[496.613916] [107/133] (511s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[496.701858] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[496.703211] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[496.792636] [108/133] (511s left) kms_frontbuffer_tracking (psr-1p-rte)
[496.883818] Starting subtest: psr-1p-rte
[496.885214] Subtest psr-1p-rte: SKIP (0.000s)
[496.996606] [109/133] (511s left) gem_reg_read (timestamp-moving)
[497.029825] Starting subtest: timestamp-moving
[498.039389] Subtest timestamp-moving: SUCCESS (1.001s)
[498.104262] [110/133] (510s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[498.197830] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[498.199240] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[498.301441] [111/133] (510s left) syncobj_timeline (wait-all-interrupted)
[498.336737] Starting subtest: wait-all-interrupted
[498.438825] Subtest wait-all-interrupted: SUCCESS (0.101s)
[498.509623] [112/133] (510s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[498.599786] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[499.724188] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.124s)
[499.861671] [113/133] (508s left) gem_exec_reloc (basic-cpu-wc)
[499.901093] Starting subtest: basic-cpu-wc
[499.906878] Subtest basic-cpu-wc: SUCCESS (0.006s)
[500.026728] [114/133] (508s left) kms_psr (fbc-psr-cursor-render)
[500.113700] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[500.162846] [115/133] (508s left) i915_pciid
[500.275838] [116/133] (508s left) kms_content_protection (uevent)
[500.366364] Starting subtest: uevent
[500.372336] Subtest uevent: SKIP (0.004s)
[500.458198] [117/133] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[500.547818] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[500.549199] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[500.664535] [118/133] (508s left) syncobj_wait (invalid-reset-illegal-handle)
[500.698979] Starting subtest: invalid-reset-illegal-handle
[500.699718] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[500.779629] [119/133] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[500.870446] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[500.871794] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[500.958434] [120/133] (507s left) kms_getfb (getfb2-handle-zero)
[501.046181] Starting subtest: getfb2-handle-zero
[501.046926] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[501.132742] [121/133] (507s left) i915_selftest (live)
[502.062067] Starting subtest: live
[502.063202] Starting dynamic subtest: sanitycheck
[503.293455] Dynamic subtest sanitycheck: SUCCESS (1.222s)
[503.300701] Starting dynamic subtest: uncore
[504.474751] Dynamic subtest uncore: SUCCESS (1.179s)
[504.485955] Starting dynamic subtest: workarounds
[506.023698] Dynamic subtest workarounds: SUCCESS (1.547s)
[506.036971] Starting dynamic subtest: gt_engines
[507.792580] Dynamic subtest gt_engines: SUCCESS (1.766s)
[507.800427] Starting dynamic subtest: gt_timelines
[517.055558] Dynamic subtest gt_timelines: SUCCESS (9.260s)
[517.062819] Starting dynamic subtest: gt_contexts
[518.369448] Dynamic subtest gt_contexts: SUCCESS (1.312s)
[518.376991] Starting dynamic subtest: gt_lrc
[522.565688] Dynamic subtest gt_lrc: SUCCESS (4.194s)
[522.572782] Starting dynamic subtest: gt_mocs
[523.893650] Dynamic subtest gt_mocs: SUCCESS (1.326s)
[523.900933] Starting dynamic subtest: gt_pm
[545.366665] Dynamic subtest gt_pm: SUCCESS (21.470s)
[545.382528] Starting dynamic subtest: gt_heartbeat
[546.579647] Dynamic subtest gt_heartbeat: SUCCESS (1.211s)
[546.587276] Starting dynamic subtest: gt_tlb
[550.057343] Dynamic subtest gt_tlb: SUCCESS (3.483s)
[550.070720] Starting dynamic subtest: requests
[558.672479] Dynamic subtest requests: SUCCESS (8.605s)
[558.688293] Starting dynamic subtest: migrate
[563.003545] Dynamic subtest migrate: SUCCESS (4.329s)
[563.014921] Starting dynamic subtest: active
[564.212635] Dynamic subtest active: SUCCESS (1.207s)
[564.220041] Starting dynamic subtest: objects
[566.004637] Dynamic subtest objects: SUCCESS (1.790s)
[566.011917] Starting dynamic subtest: mman
[570.734720] Dynamic subtest mman: SUCCESS (4.728s)
[570.741900] Starting dynamic subtest: dmabuf
[572.031601] Dynamic subtest dmabuf: SUCCESS (1.294s)
[572.039092] Starting dynamic subtest: vma
[573.241661] Dynamic subtest vma: SUCCESS (1.208s)
[573.249192] Starting dynamic subtest: coherency
[577.281793] Dynamic subtest coherency: SUCCESS (4.038s)
[577.289961] Starting dynamic subtest: gtt
[585.588621] Dynamic subtest gtt: SUCCESS (8.304s)
[585.600639] Starting dynamic subtest: gem
[587.737486] Dynamic subtest gem: SUCCESS (2.147s)
[587.745288] Starting dynamic subtest: evict
[589.957593] Dynamic subtest evict: SUCCESS (2.218s)
[589.964964] Starting dynamic subtest: hugepages
[597.656649] Dynamic subtest hugepages: SUCCESS (7.696s)
[597.672609] Starting dynamic subtest: gem_contexts
[613.100461] Dynamic subtest gem_contexts: SUCCESS (15.442s)
[613.107275] Starting dynamic subtest: client
[614.342554] Dynamic subtest client: SUCCESS (1.240s)
[614.354576] Starting dynamic subtest: gem_migrate
[615.554760] Dynamic subtest gem_migrate: SUCCESS (1.209s)
[615.565664] Starting dynamic subtest: reset
[620.478522] Dynamic subtest reset: SUCCESS (4.921s)
[620.486779] Starting dynamic subtest: memory_region
[621.652692] Dynamic subtest memory_region: SUCCESS (1.172s)
[621.664132] Starting dynamic subtest: hangcheck
[651.636596] Dynamic subtest hangcheck: SUCCESS (29.982s)
[651.647904] Starting dynamic subtest: execlists
[665.434852] Dynamic subtest execlists: SUCCESS (13.795s)
[665.444249] Starting dynamic subtest: ring_submission
[666.624708] Dynamic subtest ring_submission: SUCCESS (1.188s)
[666.632106] Starting dynamic subtest: perf
[667.906725] Dynamic subtest perf: SUCCESS (1.280s)
[667.914970] Starting dynamic subtest: slpc
[669.104669] Dynamic subtest slpc: SUCCESS (1.196s)
[669.111895] Starting dynamic subtest: guc
[670.330613] Dynamic subtest guc: SUCCESS (1.224s)
[670.337995] Starting dynamic subtest: guc_multi_lrc
[671.485540] Dynamic subtest guc_multi_lrc: SUCCESS (1.153s)
[671.492970] Starting dynamic subtest: guc_hang
[672.674545] Dynamic subtest guc_hang: SUCCESS (1.187s)
[672.686632] Starting dynamic subtest: late_gt_pm
[673.931578] Dynamic subtest late_gt_pm: SUCCESS (1.255s)
[673.932482] Subtest live: SUCCESS (171.862s)
[673.960300] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[673.961103] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[673.965176] [122/133] (335s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[675.044958] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[675.046440] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[675.111243] [FACT kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[675.112579] [FACT kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)] new: kernel.kmod_is_loaded.i915: true
[675.114695] [123/133] (333s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[675.252099] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[675.338397] [124/133] (333s left) gem_fence_thrash (bo-copy)
[675.371299] Starting subtest: bo-copy
[676.609388] Subtest bo-copy: SUCCESS (1.230s)
[676.725372] [125/133] (332s left) syncobj_timeline (invalid-transfer-illegal-handle)
[676.759735] Starting subtest: invalid-transfer-illegal-handle
[676.760468] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[676.831452] [126/133] (332s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[676.946694] Starting subtest: yf-tiled-16bpp-rotate-0
[676.948116] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[677.025067] [127/133] (332s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[677.116880] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[677.118305] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[677.241496] [128/133] (332s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[677.329228] Starting subtest: 2x-long-flip-vs-cursor-legacy
[677.331561] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[677.393477] [129/133] (331s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[677.484144] Starting subtest: plane-lut1d-post-ctm3x4
[677.565806] Starting dynamic subtest: pipe-A-plane-0
[677.665219] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[677.681609] Starting dynamic subtest: pipe-A-plane-1
[677.756855] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s)
[677.771844] Starting dynamic subtest: pipe-A-plane-2
[677.856856] Dynamic subtest pipe-A-plane-2: SUCCESS (0.097s)
[678.049688] Starting dynamic subtest: pipe-B-plane-0
[678.129718] Dynamic subtest pipe-B-plane-0: SUCCESS (0.090s)
[678.144581] Starting dynamic subtest: pipe-B-plane-1
[678.221397] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[678.235666] Starting dynamic subtest: pipe-B-plane-2
[678.313484] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[678.528797] Starting dynamic subtest: pipe-C-plane-0
[678.607801] Dynamic subtest pipe-C-plane-0: SUCCESS (0.091s)
[678.622174] Starting dynamic subtest: pipe-C-plane-1
[678.706948] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[678.719346] Starting dynamic subtest: pipe-C-plane-2
[678.800444] Dynamic subtest pipe-C-plane-2: SUCCESS (0.089s)
[679.022772] Starting dynamic subtest: pipe-D-plane-0
[679.104682] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s)
[679.114998] Starting dynamic subtest: pipe-D-plane-1
[679.204862] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[679.219739] Starting dynamic subtest: pipe-D-plane-2
[679.305116] Dynamic subtest pipe-D-plane-2: SUCCESS (0.097s)
[679.361337] Subtest plane-lut1d-post-ctm3x4: SUCCESS (1.877s)
[679.467086] [130/133] (329s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[679.556999] Starting subtest: addfb25-y-tiled-legacy
[679.557736] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[679.659949] [131/133] (329s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[679.745046] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[679.745753] Starting dynamic subtest: pipe-A
[680.204058] Dynamic subtest pipe-A: SUCCESS (0.460s)
[680.216016] Starting dynamic subtest: pipe-B
[680.638645] Dynamic subtest pipe-B: SUCCESS (0.433s)
[680.650643] Starting dynamic subtest: pipe-C
[681.072450] Dynamic subtest pipe-C: SUCCESS (0.433s)
[681.083753] Starting dynamic subtest: pipe-D
[681.506618] Dynamic subtest pipe-D: SUCCESS (0.433s)
[681.507313] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (1.763s)
[681.686898] [132/133] (327s left) api_intel_allocator (standalone)
[681.722749] Starting subtest: standalone
[681.741541] Subtest standalone: SUCCESS (0.020s)
[681.823714] [133/133] (327s left) gem_exec_balancer (full-late-pulse)
[681.868590] Starting subtest: full-late-pulse
[683.459721] Subtest full-late-pulse: SUCCESS (1.591s)
[683.648782] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_exec_gttfill
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_force_connector_basic
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: gem_ctx_shared
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_setmode
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_mmap_offset
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_selftest
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: gem_busy
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_fenced_exec_thrash
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: kms_cdclk
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: vgem_basic
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_pxp
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: gem_unfence_active_buffers
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_fbcon_fbt
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: i915_drm_fdinfo
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: kms_chamelium_frames
results: parsing output: 47/ for test: kms_feature_discovery
results: parsing output: 48/ for test: kms_atomic_transition
results: parsing output: 49/ for test: syncobj_eventfd
results: parsing output: 50/ for test: vgem_slow
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: i915_pm_rpm
results: parsing output: 53/ for test: dmabuf_sync_file
results: parsing output: 54/ for test: gem_ctx_exec
results: parsing output: 55/ for test: kms_properties
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_exec_flush
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: perf
results: parsing output: 66/ for test: kms_plane_alpha_blend
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: sriov_basic
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_prime
results: parsing output: 73/ for test: gem_partial_pwrite_pread
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_vrr
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: kms_invalid_mode
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_busy
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: gem_ppgtt
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_tiled_pread_basic
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_reg_read
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: i915_pciid
results: parsing output: 115/ for test: kms_content_protection
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: i915_selftest
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: gem_fence_thrash
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_color_pipeline
results: parsing output: 129/ for test: kms_addfb_basic
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: api_intel_allocator
results: parsing output: 132/ for test: gem_exec_balancer
Done.