[67.164952] Initializing watchdogs
[67.165044]   /dev/watchdog0
[67.196325] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.211133] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.215859] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.218865] [001/156] (960s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[68.752547] Starting subtest: primary-y-tiled-reflect-x-90
[79.398363] Subtest primary-y-tiled-reflect-x-90: SUCCESS (10.639s)
[79.649886] [002/156] (948s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[79.697548] Starting subtest: multi-wait-all-for-submit-signaled
[79.698487] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[79.808858] [003/156] (948s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt)
[81.305124] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt
[81.306894] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[81.462884] [004/156] (946s left) gem_ctx_param (root-set)
[81.517319] Starting subtest: root-set
[81.518372] Subtest root-set: SUCCESS (0.001s)
[81.651834] [005/156] (946s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[81.698811] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[81.807803] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[81.923981] [006/156] (946s left) gem_mmap_offset (pf-nonblock)
[81.969164] Starting subtest: pf-nonblock
[81.995582] Subtest pf-nonblock: SUCCESS (0.027s)
[82.155937] [007/156] (946s left) kms_atomic (plane-invalid-params)
[83.646313] Starting subtest: plane-invalid-params
[83.647153] Starting dynamic subtest: pipe-A-HDMI-A-4
[84.193184] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.547s)
[84.194046] Subtest plane-invalid-params: SUCCESS (0.548s)
[84.407185] [008/156] (943s left) kms_hdr (bpc-switch-dpms)
[85.896775] Starting subtest: bpc-switch-dpms
[85.897680] Starting dynamic subtest: pipe-A-HDMI-A-4-XRGB2101010
[85.899478] Dynamic subtest pipe-A-HDMI-A-4-XRGB2101010: SKIP (0.000s)
[85.908315] Starting dynamic subtest: pipe-A-HDMI-A-4-XRGB16161616F
[85.910284] Dynamic subtest pipe-A-HDMI-A-4-XRGB16161616F: SKIP (0.000s)
[85.912519] Subtest bpc-switch-dpms: SKIP (0.004s)
[86.024341] [009/156] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[86.081848] Starting subtest: invalid-reset-one-illegal-handle
[86.082762] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[86.202953] [010/156] (942s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[87.690984] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[87.691931] Starting dynamic subtest: pipe-A-HDMI-A-4
[89.630165] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.934s)
[89.639460] Starting dynamic subtest: pipe-B-HDMI-A-4
[89.746927] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.113s)
[89.755945] Starting dynamic subtest: pipe-C-HDMI-A-4
[89.857625] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.112s)
[89.866607] Starting dynamic subtest: pipe-D-HDMI-A-4
[89.970776] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.111s)
[89.971659] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.275s)
[90.241659] [011/156] (938s left) kms_flip (dpms-vs-vblank-race)
[91.731977] Starting subtest: dpms-vs-vblank-race
[91.738882] Starting dynamic subtest: A-HDMI-A4
[94.858041] Dynamic subtest A-HDMI-A4: SUCCESS (3.119s)
[94.867321] Starting dynamic subtest: B-HDMI-A4
[97.832349] Dynamic subtest B-HDMI-A4: SUCCESS (2.972s)
[97.841517] Starting dynamic subtest: C-HDMI-A4
[100.790131] Dynamic subtest C-HDMI-A4: SUCCESS (2.957s)
[100.800437] Starting dynamic subtest: D-HDMI-A4
[103.808520] Dynamic subtest D-HDMI-A4: SUCCESS (3.016s)
[103.809373] Subtest dpms-vs-vblank-race: SUCCESS (12.077s)
[104.028820] [012/156] (924s left) kms_chamelium_color (ctm-negative)
[105.526024] Subtest ctm-negative: SKIP (0.000s)
[105.605971] [013/156] (922s left) gem_wait (invalid-buf)
[105.661189] Starting subtest: invalid-buf
[105.662105] Subtest invalid-buf: SUCCESS (0.000s)
[106.002716] [014/156] (922s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[107.497598] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[107.499209] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[107.661944] [015/156] (921s left) kms_flip (wf_vblank-ts-check)
[109.161672] Starting subtest: wf_vblank-ts-check
[109.169977] Starting dynamic subtest: A-HDMI-A4
[117.197258] Dynamic subtest A-HDMI-A4: SUCCESS (8.027s)
[117.209584] Starting dynamic subtest: B-HDMI-A4
[125.178602] Dynamic subtest B-HDMI-A4: SUCCESS (7.979s)
[125.190355] Starting dynamic subtest: C-HDMI-A4
[133.164144] Dynamic subtest C-HDMI-A4: SUCCESS (7.984s)
[133.175419] Starting dynamic subtest: D-HDMI-A4
[141.149454] Dynamic subtest D-HDMI-A4: SUCCESS (7.983s)
[141.150331] Subtest wf_vblank-ts-check: SUCCESS (31.988s)
[141.365672] [016/156] (887s left) gem_userptr_blits (sync-unmap-after-close)
[141.429031] Starting subtest: sync-unmap-after-close
[141.449536] Subtest sync-unmap-after-close: SUCCESS (0.021s)
[141.653443] [017/156] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[143.147787] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[143.149476] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[143.289324] [018/156] (885s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[144.818490] Starting subtest: yf-tiled-64bpp-rotate-270
[144.820321] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[144.995363] [019/156] (884s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[145.044893] Starting subtest: etime-multi-wait-available-unsubmitted
[145.148748] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s)
[145.362427] [020/156] (883s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[146.896865] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[147.021851] [021/156] (882s left) gem_exec_reloc (basic-gtt-read)
[147.075044] Subtest basic-gtt-read: SKIP (0.000s)
[147.180704] [022/156] (882s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[148.676103] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[148.678140] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[148.867669] [023/156] (880s left) kms_cursor_crc (cursor-offscreen-256x256)
[150.578704] Starting subtest: cursor-offscreen-256x256
[150.585692] Starting dynamic subtest: pipe-A-HDMI-A-4
[153.087378] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.502s)
[153.120672] Starting dynamic subtest: pipe-D-HDMI-A-4
[155.517205] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.405s)
[155.518142] Subtest cursor-offscreen-256x256: SUCCESS (4.939s)
[155.884120] [024/156] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[157.380975] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[157.382973] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[157.553596] [025/156] (872s left) prime_vgem (busy)
[157.713546] Starting subtest: busy
[157.714542] Starting dynamic subtest: rcs0
[157.767148] Dynamic subtest rcs0: SUCCESS (0.053s)
[157.778194] Starting dynamic subtest: bcs0
[157.807489] Dynamic subtest bcs0: SUCCESS (0.039s)
[157.820092] Starting dynamic subtest: vcs0
[157.849298] Dynamic subtest vcs0: SUCCESS (0.040s)
[157.869258] Starting dynamic subtest: vcs1
[157.891228] Dynamic subtest vcs1: SUCCESS (0.039s)
[157.911612] Starting dynamic subtest: vecs0
[157.933275] Dynamic subtest vecs0: SUCCESS (0.040s)
[157.934623] Subtest busy: SUCCESS (0.221s)
[158.093265] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[158.096324] [026/156] (871s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[159.585503] Starting subtest: plane-primary-toggle-with-vblank-wait
[159.586409] Starting dynamic subtest: pipe-A-HDMI-A-4
[159.813397] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.226s)
[159.943354] Starting dynamic subtest: pipe-B-HDMI-A-4
[160.208688] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.284s)
[160.266108] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.680s)
[160.461829] [027/156] (869s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[161.958884] Starting subtest: fbcpsr-rgb101010-draw-render
[161.960653] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[162.154791] [028/156] (867s left) kms_big_fb (linear-64bpp-rotate-90)
[163.664630] Starting subtest: linear-64bpp-rotate-90
[163.742246] Subtest linear-64bpp-rotate-90: SKIP (0.075s)
[163.916249] [029/156] (866s left) kms_psr (psr2-no-drrs)
[165.406303] Subtest psr2-no-drrs: SKIP (0.000s)
[165.488789] [030/156] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[166.983992] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[166.985922] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[167.154804] [031/156] (863s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[168.656754] Starting subtest: psr-rgb565-draw-mmap-gtt
[168.658391] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[168.808638] [032/156] (861s left) gem_ctx_engines (execute-allforone)
[168.875415] Starting subtest: execute-allforone
[168.903990] Subtest execute-allforone: SUCCESS (0.030s)
[169.240587] [033/156] (861s left) gem_vm_create (invalid-create)
[169.293374] Starting subtest: invalid-create
[169.295940] Subtest invalid-create: SUCCESS (0.002s)
[169.459632] [034/156] (861s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[170.954051] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[170.956058] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[171.116859] [035/156] (859s left) gem_exec_fence (submit)
[171.340877] Starting subtest: submit
[171.343459] Subtest submit: SKIP (0.000s)
[171.948715] [036/156] (858s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[173.442137] Starting subtest: cursor-vs-flip-atomic-transitions
[205.588874] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (32.147s)
[205.794973] [037/156] (824s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[207.289868] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[207.290844] Starting dynamic subtest: pipe-A-HDMI-A-4
[207.321407] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[207.331159] Starting dynamic subtest: pipe-B-HDMI-A-4
[207.351792] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[207.361200] Starting dynamic subtest: pipe-C-HDMI-A-4
[207.381607] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[207.391054] Starting dynamic subtest: pipe-D-HDMI-A-4
[207.414504] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[207.416101] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.021s)
[207.603369] [038/156] (823s left) gem_mmap_wc (write-read)
[207.651630] Subtest write-read: SKIP (0.000s)
[207.722599] [039/156] (823s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[209.321966] Starting subtest: cursor-rapid-movement-32x10
[209.375846] Subtest cursor-rapid-movement-32x10: SKIP (0.052s)
[209.839438] [040/156] (821s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[211.337161] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[211.339296] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[211.503145] [041/156] (819s left) gem_pxp (create-regular-buffer)
[214.075326] Starting subtest: create-regular-buffer
[214.077525] Subtest create-regular-buffer: SKIP (0.000s)
[214.206306] [042/156] (817s left) gem_basic (multigpu-create-close)
[214.252946] Starting subtest: multigpu-create-close
[214.255044] Subtest multigpu-create-close: SKIP (0.000s)
[214.380754] [043/156] (816s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[215.869869] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[215.871707] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[215.982588] [044/156] (815s left) drm_read (short-buffer-block)
[217.546534] Starting subtest: short-buffer-block
[217.547431] Subtest short-buffer-block: SUCCESS (0.000s)
[217.814212] [045/156] (813s left) i915_pm_rpm (gem-execbuf-stress)
[222.046041] Starting subtest: gem-execbuf-stress
[222.048538] Starting dynamic subtest: lmem0
[234.708950] Dynamic subtest lmem0: SUCCESS (12.657s)
[234.770914] Starting dynamic subtest: extra-wait-lmem0
[293.997476] Dynamic subtest extra-wait-lmem0: SUCCESS (59.279s)
[294.007425] Starting dynamic subtest: smem0
[305.102834] Dynamic subtest smem0: SUCCESS (11.100s)
[305.158194] Starting dynamic subtest: extra-wait-smem0
[365.171979] Dynamic subtest extra-wait-smem0: SUCCESS (60.060s)
[365.173158] Subtest gem-execbuf-stress: SUCCESS (143.125s)
[366.103883] [046/156] (665s left) kms_frontbuffer_tracking (basic)
[367.602218] Starting subtest: basic
[370.570055] Subtest basic: SUCCESS (2.968s)
[370.772129] [047/156] (660s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[372.261722] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[372.346437] [048/156] (659s left) kms_feature_discovery (dp-mst)
[373.836614] Starting subtest: dp-mst
[373.838239] Subtest dp-mst: SKIP (0.000s)
[373.962713] [049/156] (657s left) kms_vblank (ts-continuation-modeset-rpm)
[375.461577] Starting subtest: ts-continuation-modeset-rpm
[375.462512] Starting dynamic subtest: pipe-A-HDMI-A-4
[377.907968] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.445s)
[377.920970] Starting dynamic subtest: pipe-D-HDMI-A-4
[379.950996] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.037s)
[379.951965] Subtest ts-continuation-modeset-rpm: SUCCESS (4.489s)
[380.149008] [050/156] (651s left) kms_color (invalid-gamma-lut-sizes)
[381.639766] Starting subtest: invalid-gamma-lut-sizes
[381.640745] Starting dynamic subtest: pipe-A
[381.689756] Dynamic subtest pipe-A: SUCCESS (0.051s)
[381.701793] Starting dynamic subtest: pipe-B
[381.702747] Dynamic subtest pipe-B: SUCCESS (0.002s)
[381.712641] Starting dynamic subtest: pipe-C
[381.713525] Dynamic subtest pipe-C: SUCCESS (0.001s)
[381.726262] Starting dynamic subtest: pipe-D
[381.727161] Dynamic subtest pipe-D: SUCCESS (0.001s)
[381.728106] Subtest invalid-gamma-lut-sizes: SUCCESS (0.061s)
[381.875381] [051/156] (650s left) i915_suspend (sysfs-reader)
[381.921638] Starting subtest: sysfs-reader
[404.416107] Subtest sysfs-reader: SUCCESS (12.091s)
[409.569285] [052/156] (627s left) gem_exec_fence (syncobj-wait)
[410.000397] Starting subtest: syncobj-wait
[410.052911] Subtest syncobj-wait: SUCCESS (0.053s)
[410.523258] [053/156] (626s left) syncobj_timeline (multi-wait-available-signaled)
[410.570999] Starting subtest: multi-wait-available-signaled
[410.573427] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[410.707561] [054/156] (626s left) sysfs_heartbeat_interval (precise)
[410.758642] Starting subtest: precise
[410.759532] Starting dynamic subtest: vecs0
[412.075216] Dynamic subtest vecs0: SUCCESS (1.315s)
[412.089714] Starting dynamic subtest: vcs0
[413.361322] Dynamic subtest vcs0: SUCCESS (1.285s)
[413.375708] Starting dynamic subtest: bcs0
[414.613349] Dynamic subtest bcs0: SUCCESS (1.250s)
[414.628525] Starting dynamic subtest: rcs0
[415.823215] Dynamic subtest rcs0: SUCCESS (1.208s)
[415.837325] Starting dynamic subtest: vcs1
[417.894375] Dynamic subtest vcs1: SUCCESS (2.069s)
[417.895349] Subtest precise: SUCCESS (7.136s)
[418.039924] [055/156] (619s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[419.531501] Starting subtest: fb-8bpc-vs-panel-8bpc
[419.534091] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.001s)
[419.667269] [056/156] (617s left) gem_ctx_shared (exec-shared-gtt)
[419.734577] Starting subtest: exec-shared-gtt
[419.735457] Starting dynamic subtest: rcs0
[419.745311] Dynamic subtest rcs0: SUCCESS (0.010s)
[419.759773] Starting dynamic subtest: bcs0
[419.760620] Dynamic subtest bcs0: SUCCESS (0.009s)
[419.774979] Starting dynamic subtest: vcs0
[419.775946] Dynamic subtest vcs0: SUCCESS (0.009s)
[419.788553] Starting dynamic subtest: vcs1
[419.789525] Dynamic subtest vcs1: SUCCESS (0.009s)
[419.802541] Starting dynamic subtest: vecs0
[419.803656] Dynamic subtest vecs0: SUCCESS (0.007s)
[419.804680] Subtest exec-shared-gtt: SUCCESS (0.051s)
[420.095955] [057/156] (617s left) kms_addfb_basic (small-bo)
[421.587954] Starting subtest: small-bo
[421.588867] Subtest small-bo: SUCCESS (0.000s)
[421.789106] [058/156] (615s left) gem_exec_params (rel-constants-invalid)
[421.840390] Starting subtest: rel-constants-invalid
[421.841474] Subtest rel-constants-invalid: SUCCESS (0.000s)
[422.041826] [059/156] (615s left) api_intel_bb (delta-check)
[422.088902] Starting subtest: delta-check
[422.111645] Subtest delta-check: SUCCESS (0.023s)
[422.311606] [060/156] (615s left) gem_pxp (reject-modify-context-protection-on)
[424.885072] Starting subtest: reject-modify-context-protection-on
[424.887582] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[425.010644] [061/156] (612s left) gem_exec_balancer (bonded-pair)
[425.069032] Starting subtest: bonded-pair
[425.070700] Subtest bonded-pair: SKIP (0.000s)
[425.548829] [062/156] (612s left) gem_lmem_swapping (parallel-random-verify-ccs)
[430.007104] Starting subtest: parallel-random-verify-ccs
[430.008209] Starting dynamic subtest: lmem0
[430.010483] Dynamic subtest lmem0: SKIP (0.000s)
[430.012550] Subtest parallel-random-verify-ccs: SKIP (0.002s)
[433.927071] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[433.928249] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[433.930613] [063/156] (604s left) gem_exec_schedule (preempt-user)
[437.295272] Starting subtest: preempt-user
[437.296419] Starting dynamic subtest: rcs0
[437.386686] Dynamic subtest rcs0: SUCCESS (0.093s)
[437.401043] Starting dynamic subtest: bcs0
[437.438182] Dynamic subtest bcs0: SUCCESS (0.050s)
[437.453039] Starting dynamic subtest: vcs0
[437.487215] Dynamic subtest vcs0: SUCCESS (0.048s)
[437.500465] Starting dynamic subtest: vcs1
[437.534484] Dynamic subtest vcs1: SUCCESS (0.046s)
[437.548516] Starting dynamic subtest: vecs0
[437.581525] Dynamic subtest vecs0: SUCCESS (0.046s)
[437.582470] Subtest preempt-user: SUCCESS (0.289s)
[438.010689] [FACT gem_exec_schedule (preempt-user)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[438.013883] [FACT gem_exec_schedule (preempt-user)] new: kernel.kmod_is_loaded.i915: true
[438.017470] [064/156] (600s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[439.520086] Starting subtest: psr-farfromfence-mmap-gtt
[439.522048] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[439.687629] [065/156] (598s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[441.188417] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[441.190622] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[441.358919] [066/156] (597s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[442.855430] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[442.857158] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[443.019010] [067/156] (595s left) kms_universal_plane (cursor-fb-leak)
[444.514940] Starting subtest: cursor-fb-leak
[444.515922] Starting dynamic subtest: pipe-A-HDMI-A-4
[445.085927] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.570s)
[445.131744] Starting dynamic subtest: pipe-B-HDMI-A-4
[445.674664] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.578s)
[445.713100] Starting dynamic subtest: pipe-C-HDMI-A-4
[446.232849] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.550s)
[446.257199] Starting dynamic subtest: pipe-D-HDMI-A-4
[446.818356] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.578s)
[446.825151] Subtest cursor-fb-leak: SUCCESS (2.306s)
[447.169282] [068/156] (591s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[447.224918] Starting subtest: y-tiled-to-vebox-x-tiled
[447.225947] Starting dynamic subtest: smem
[447.310453] Dynamic subtest smem: SUCCESS (0.085s)
[447.324552] Starting dynamic subtest: lmem0
[448.064275] Dynamic subtest lmem0: SUCCESS (0.749s)
[448.065262] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.837s)
[448.330770] [069/156] (590s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[449.829305] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[449.831194] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[450.011380] [070/156] (588s left) gem_reg_read (bad-register)
[450.057808] Starting subtest: bad-register
[450.059036] Subtest bad-register: SUCCESS (0.000s)
[450.186174] [071/156] (588s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[451.699220] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[452.814946] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.113s)
[452.998804] [072/156] (585s left) prime_vgem (basic-fence-flip)
[453.118678] Starting subtest: basic-fence-flip
[454.586307] Subtest basic-fence-flip: SKIP (1.466s)
[454.783361] [073/156] (584s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render)
[456.280628] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render
[456.282626] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[456.441536] [074/156] (582s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[457.934690] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[457.937205] Starting dynamic subtest: pipe-A-valid-mode
[459.296048] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.360s)
[459.297217] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (1.362s)
[459.496554] [075/156] (579s left) kms_pm_backlight (basic-brightness)
[460.986740] Subtest basic-brightness: SKIP (0.000s)
[461.066132] [076/156] (578s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[462.563032] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[462.564899] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[462.722453] [077/156] (576s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[464.222680] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[464.224526] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[464.400508] [078/156] (575s left) gem_exec_flush (basic-batch-kernel-default-uc)
[464.469289] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[464.575425] [079/156] (575s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[466.111704] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[466.276988] [080/156] (573s left) core_getclient (basic)
[466.332350] Starting subtest: basic
[466.333332] Subtest basic: SUCCESS (0.000s)
[466.455756] [081/156] (573s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[467.950904] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[467.952514] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[468.086351] [082/156] (571s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[469.587271] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[469.589085] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[469.753763] [083/156] (570s left) gem_lmem_swapping (heavy-verify-random-ccs)
[473.978602] Starting subtest: heavy-verify-random-ccs
[473.979507] Starting dynamic subtest: lmem0
[473.981692] Dynamic subtest lmem0: SKIP (0.000s)
[473.983541] Subtest heavy-verify-random-ccs: SKIP (0.002s)
[477.151454] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[477.152585] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[477.155520] [084/156] (562s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[481.979763] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[481.981380] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[482.196101] [FACT kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[482.199846] [FACT kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[482.206930] [085/156] (557s left) kms_flip (2x-flip-vs-wf_vblank)
[483.700793] Starting subtest: 2x-flip-vs-wf_vblank
[483.717208] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s)
[483.862274] [086/156] (556s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[485.361065] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[488.673973] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.313s)
[488.889830] [087/156] (551s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[490.385671] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[490.387343] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[490.577813] [088/156] (549s left) i915_drm_fdinfo (virtual-busy-idle)
[490.632816] Starting subtest: virtual-busy-idle
[490.634534] Subtest virtual-busy-idle: SKIP (0.000s)
[490.785838] [089/156] (549s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[492.276014] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[492.352468] [090/156] (548s left) gem_ctx_persistence (userptr)
[492.407808] Starting subtest: userptr
[492.599347] Subtest userptr: SUCCESS (0.191s)
[492.814660] [091/156] (547s left) kms_properties (get_properties-sanity-non-atomic)
[494.305507] Starting subtest: get_properties-sanity-non-atomic
[494.308190] Subtest get_properties-sanity-non-atomic: SUCCESS (0.004s)
[494.431698] [092/156] (546s left) gem_userptr_blits (create-destroy-sync)
[494.503590] Starting subtest: create-destroy-sync
[499.532762] Subtest create-destroy-sync: SUCCESS (5.027s)
[499.745149] [093/156] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[501.242416] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[501.244600] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[501.421498] [094/156] (539s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[502.914329] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[503.002055] [095/156] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[504.499123] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[504.501111] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[504.691636] [096/156] (536s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[506.188618] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[506.190612] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[506.375262] [097/156] (535s left) gem_fence_thrash (bo-write-verify-none)
[506.420039] Starting subtest: bo-write-verify-none
[506.424276] Subtest bo-write-verify-none: SKIP (0.003s)
[506.502515] [098/156] (534s left) kms_cursor_crc (cursor-sliding-64x21)
[508.161090] Starting subtest: cursor-sliding-64x21
[508.168198] Starting dynamic subtest: pipe-A-HDMI-A-4
[512.629314] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.462s)
[512.667664] Starting dynamic subtest: pipe-D-HDMI-A-4
[516.994661] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.338s)
[516.995667] Subtest cursor-sliding-64x21: SUCCESS (8.833s)
[517.475571] [099/156] (524s left) gen9_exec_parse (valid-registers)
[517.528477] Subtest valid-registers: SKIP (0.000s)
[517.609756] [100/156] (523s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[519.114978] Starting subtest: extended-modeset-hang-oldfb-with-reset
[519.117352] Starting dynamic subtest: pipe-A
[529.849828] Dynamic subtest pipe-A: SUCCESS (10.733s)
[529.866445] Starting dynamic subtest: pipe-D
[540.568272] Dynamic subtest pipe-D: SUCCESS (10.712s)
[540.569144] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.454s)
[540.799287] [101/156] (500s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[542.299901] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[542.301516] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[542.447899] [102/156] (499s left) drm_read (fault-buffer)
[544.007941] Starting subtest: fault-buffer
[544.009255] Subtest fault-buffer: SUCCESS (0.001s)
[544.259264] [103/156] (497s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[545.751789] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[545.752860] Starting dynamic subtest: pipe-A-HDMI-A-4
[545.762140] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[545.775399] Starting dynamic subtest: pipe-B-HDMI-A-4
[545.786011] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[545.798572] Starting dynamic subtest: pipe-C-HDMI-A-4
[545.806418] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[545.819028] Starting dynamic subtest: pipe-D-HDMI-A-4
[545.827251] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[545.828851] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[546.064242] [104/156] (495s left) kms_plane_alpha_blend (constant-alpha-mid)
[547.556098] Starting subtest: constant-alpha-mid
[547.813711] Starting dynamic subtest: pipe-A-HDMI-A-4
[548.491608] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.677s)
[548.506160] Starting dynamic subtest: pipe-D-HDMI-A-4
[549.193621] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.700s)
[549.194419] Subtest constant-alpha-mid: SUCCESS (1.640s)
[549.415787] [105/156] (492s left) gem_eio (suspend)
[549.594007] Starting subtest: suspend
[562.686690] Subtest suspend: SUCCESS (13.094s)
[569.257654] [106/156] (477s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[570.748710] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[570.750452] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[570.873318] [107/156] (476s left) gem_exec_whisper (basic-queues-all)
[570.943294] Starting subtest: basic-queues-all
[577.914884] Subtest basic-queues-all: SUCCESS (6.971s)
[578.214465] [108/156] (469s left) kms_big_fb (4-tiled-addfb-size-overflow)
[579.724666] Starting subtest: 4-tiled-addfb-size-overflow
[579.726655] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[579.923649] [109/156] (467s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[581.421018] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[581.423729] Starting dynamic subtest: pipe-A-HDMI-A-4
[581.427311] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[581.441349] Starting dynamic subtest: pipe-B-HDMI-A-4
[581.445301] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[581.459133] Starting dynamic subtest: pipe-C-HDMI-A-4
[581.462951] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[581.476279] Starting dynamic subtest: pipe-D-HDMI-A-4
[581.480248] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[581.482144] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[581.735471] [110/156] (465s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[581.783130] Starting subtest: wait-all-for-submit-delayed-submit
[581.892414] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.105s)
[582.033865] [111/156] (465s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[583.525951] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[583.602476] [112/156] (464s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[585.098302] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[588.123389] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.025s)
[588.343305] [113/156] (459s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render)
[589.840250] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render
[589.842114] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[590.018615] [114/156] (457s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[591.516560] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[591.518326] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[591.697042] [115/156] (456s left) kms_psr (psr-primary-page-flip)
[593.187673] Subtest psr-primary-page-flip: SKIP (0.000s)
[593.269580] [116/156] (454s left) perf_pmu (render-node-busy-idle)
[593.326448] Starting subtest: render-node-busy-idle
[593.327584] Starting dynamic subtest: rcs0
[594.027748] Dynamic subtest rcs0: SUCCESS (0.701s)
[594.078629] Starting dynamic subtest: bcs0
[594.708796] Dynamic subtest bcs0: SUCCESS (0.673s)
[594.734010] Starting dynamic subtest: vcs0
[595.373898] Dynamic subtest vcs0: SUCCESS (0.657s)
[595.399100] Starting dynamic subtest: vcs1
[596.040785] Dynamic subtest vcs1: SUCCESS (0.659s)
[596.096794] Starting dynamic subtest: vecs0
[596.725788] Dynamic subtest vecs0: SUCCESS (0.677s)
[596.734665] Subtest render-node-busy-idle: SUCCESS (3.404s)
[596.875889] [117/156] (451s left) kms_flip (flip-vs-panning-vs-hang)
[598.367386] Starting subtest: flip-vs-panning-vs-hang
[598.370822] Starting dynamic subtest: A-HDMI-A4
[649.840383] Dynamic subtest A-HDMI-A4: SUCCESS (51.471s)
[649.856813] Starting dynamic subtest: D-HDMI-A4
[699.870677] Dynamic subtest D-HDMI-A4: SUCCESS (50.029s)
[699.871674] Subtest flip-vs-panning-vs-hang: SUCCESS (101.508s)
[700.125679] [118/156] (348s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move)
[701.620932] Starting subtest: hdr-2p-primscrn-cur-indfb-move
[701.622620] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[701.812074] [119/156] (346s left) gem_eio (wait-wedge-10ms)
[701.980651] Starting subtest: wait-wedge-10ms
[703.302556] Subtest wait-wedge-10ms: SUCCESS (1.322s)
[704.909634] [120/156] (343s left) gem_exec_schedule (preempt)
[705.015061] Starting subtest: preempt
[705.016073] Starting dynamic subtest: rcs0
[705.110085] Dynamic subtest rcs0: SUCCESS (0.094s)
[705.126600] Starting dynamic subtest: bcs0
[705.169789] Dynamic subtest bcs0: SUCCESS (0.058s)
[705.187017] Starting dynamic subtest: vcs0
[705.226878] Dynamic subtest vcs0: SUCCESS (0.055s)
[705.243719] Starting dynamic subtest: vcs1
[705.289007] Dynamic subtest vcs1: SUCCESS (0.060s)
[705.307925] Starting dynamic subtest: vecs0
[705.351592] Dynamic subtest vecs0: SUCCESS (0.061s)
[705.352455] Subtest preempt: SUCCESS (0.338s)
[705.757414] [121/156] (342s left) gem_render_copy (x-tiled)
[705.811015] Starting subtest: x-tiled
[705.811919] Starting dynamic subtest: smem
[705.899985] Dynamic subtest smem: SUCCESS (0.088s)
[705.917149] Starting dynamic subtest: lmem0
[706.663398] Dynamic subtest lmem0: SUCCESS (0.759s)
[706.664520] Subtest x-tiled: SUCCESS (0.850s)
[706.932715] [122/156] (341s left) gem_exec_fence (concurrent)
[707.108014] Starting subtest: concurrent
[707.110060] Subtest concurrent: SKIP (0.000s)
[707.797882] [123/156] (340s left) kms_pm_rpm (drm-resources-equal)
[711.327846] Starting subtest: drm-resources-equal
[716.445606] Subtest drm-resources-equal: SUCCESS (5.117s)
[716.649306] [124/156] (332s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[718.146431] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[718.148422] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[718.330462] [125/156] (330s left) kms_plane_multiple (tiling-4)
[719.820626] Starting subtest: tiling-4
[719.822307] Subtest tiling-4: SKIP (0.000s)
[719.937869] [126/156] (329s left) gen9_exec_parse (bb-start-out)
[719.996098] Subtest bb-start-out: SKIP (0.000s)
[720.076258] [127/156] (329s left) gem_workarounds (basic-read-context)
[720.149919] Starting subtest: basic-read-context
[720.180100] Subtest basic-read-context: SUCCESS (0.029s)
[720.388423] [128/156] (328s left) gem_ctx_param (vm)
[720.434638] Starting subtest: vm
[720.503093] Subtest vm: SUCCESS (0.070s)
[720.710533] [129/156] (328s left) kms_content_protection (srm)
[722.257320] Starting subtest: srm
[722.262632] Subtest srm: SKIP (0.004s)
[722.461666] [130/156] (326s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[723.952782] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[724.042282] [131/156] (325s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[725.551108] Starting subtest: y-tiled-32bpp-rotate-0
[727.597568] Subtest y-tiled-32bpp-rotate-0: SUCCESS (2.042s)
[727.823138] [132/156] (321s left) gem_exec_reloc (basic-write-wc-active)
[727.876395] Subtest basic-write-wc-active: SKIP (0.000s)
[727.979622] [133/156] (321s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[729.476058] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[732.694221] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.218s)
[732.905380] [134/156] (316s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[734.400789] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[734.402423] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[734.599565] [135/156] (315s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render)
[736.098412] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render
[736.100654] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[736.273088] [136/156] (313s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt)
[737.770640] Starting subtest: psrhdr-rgb565-draw-blt
[737.772545] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s)
[738.028380] [137/156] (312s left) perf (gen12-oa-tlb-invalidate)
[738.161880] Starting subtest: gen12-oa-tlb-invalidate
[738.162727] Starting dynamic subtest: 0-rcs0
[748.233409] Dynamic subtest 0-rcs0: SUCCESS (10.068s)
[748.234383] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.069s)
[748.311934] [138/156] (301s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[749.821200] Starting subtest: x-tiled-64bpp-rotate-180
[752.512293] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.688s)
[752.704317] [139/156] (297s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[754.199646] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[756.644054] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (2.445s)
[756.924757] [140/156] (293s left) kms_addfb_basic (bad-pitch-1024)
[756.971723] Starting subtest: bad-pitch-1024
[756.972643] Subtest bad-pitch-1024: SUCCESS (0.000s)
[758.623472] [141/156] (291s left) kms_pm_rpm (pc8-residency)
[762.460489] Starting subtest: pc8-residency
[762.462727] Subtest pc8-residency: SKIP (0.000s)
[763.436043] [142/156] (287s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[763.489339] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[763.567784] [143/156] (287s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[765.063154] Starting subtest: hdr-rgb101010-draw-render
[765.065071] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[765.262156] [144/156] (285s left) kms_lease (setcrtc-implicit-plane)
[766.753106] Starting subtest: setcrtc-implicit-plane
[766.754193] Starting dynamic subtest: pipe-A-HDMI-A-4
[767.192577] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.439s)
[767.210751] Starting dynamic subtest: pipe-B-HDMI-A-4
[767.458971] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.264s)
[767.478120] Starting dynamic subtest: pipe-C-HDMI-A-4
[767.725892] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.262s)
[767.741898] Starting dynamic subtest: pipe-D-HDMI-A-4
[767.999252] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.271s)
[768.000435] Subtest setcrtc-implicit-plane: SUCCESS (1.247s)
[768.239163] [145/156] (282s left) kms_psr (psr2-cursor-plane-move)
[769.730408] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[769.820043] [146/156] (281s left) kms_flip (dpms-off-confusion)
[771.310027] Starting subtest: dpms-off-confusion
[771.318574] Starting dynamic subtest: A-HDMI-A4
[779.069473] Dynamic subtest A-HDMI-A4: SUCCESS (7.750s)
[779.097358] Starting dynamic subtest: B-HDMI-A4
[786.782264] Dynamic subtest B-HDMI-A4: SUCCESS (7.704s)
[786.798979] Starting dynamic subtest: C-HDMI-A4
[794.483958] Dynamic subtest C-HDMI-A4: SUCCESS (7.700s)
[794.501095] Starting dynamic subtest: D-HDMI-A4
[802.203396] Dynamic subtest D-HDMI-A4: SUCCESS (7.717s)
[802.204296] Subtest dpms-off-confusion: SUCCESS (30.894s)
[802.458249] [147/156] (248s left) kms_joiner (basic-ultra-joiner)
[803.951208] Starting subtest: basic-ultra-joiner
[803.952849] Subtest basic-ultra-joiner: SKIP (0.000s)
[804.071511] [148/156] (247s left) dumb_buffer (create-valid-dumb)
[804.124033] Starting subtest: create-valid-dumb
[804.124931] Subtest create-valid-dumb: SUCCESS (0.000s)
[804.319404] [149/156] (246s left) kms_plane (plane-position-hole)
[805.807644] Starting subtest: plane-position-hole
[806.265376] Starting dynamic subtest: pipe-A-plane-1
[806.627500] Dynamic subtest pipe-A-plane-1: SUCCESS (0.361s)
[806.642933] Starting dynamic subtest: pipe-A-plane-2
[807.007621] Dynamic subtest pipe-A-plane-2: SUCCESS (0.376s)
[807.022772] Starting dynamic subtest: pipe-A-plane-3
[807.383045] Dynamic subtest pipe-A-plane-3: SUCCESS (0.377s)
[807.398297] Starting dynamic subtest: pipe-A-plane-4
[807.765227] Dynamic subtest pipe-A-plane-4: SUCCESS (0.381s)
[807.782403] Starting dynamic subtest: pipe-A-plane-5
[808.144098] Dynamic subtest pipe-A-plane-5: SUCCESS (0.377s)
[808.159352] Starting dynamic subtest: pipe-A-plane-6
[808.521815] Dynamic subtest pipe-A-plane-6: SUCCESS (0.377s)
[808.536889] Starting dynamic subtest: pipe-A-plane-7
[808.542833] Dynamic subtest pipe-A-plane-7: SUCCESS (0.019s)
[808.834670] Starting dynamic subtest: pipe-B-plane-1
[809.183392] Dynamic subtest pipe-B-plane-1: SUCCESS (0.362s)
[809.198622] Starting dynamic subtest: pipe-B-plane-2
[809.556934] Dynamic subtest pipe-B-plane-2: SUCCESS (0.371s)
[809.572603] Starting dynamic subtest: pipe-B-plane-3
[809.933956] Dynamic subtest pipe-B-plane-3: SUCCESS (0.375s)
[809.951354] Starting dynamic subtest: pipe-B-plane-4
[810.281897] Dynamic subtest pipe-B-plane-4: SUCCESS (0.347s)
[810.299239] Starting dynamic subtest: pipe-B-plane-5
[810.629429] Dynamic subtest pipe-B-plane-5: SUCCESS (0.346s)
[810.650308] Starting dynamic subtest: pipe-B-plane-6
[810.996429] Dynamic subtest pipe-B-plane-6: SUCCESS (0.364s)
[811.011886] Starting dynamic subtest: pipe-B-plane-7
[811.025017] Dynamic subtest pipe-B-plane-7: SUCCESS (0.027s)
[811.025934] Subtest plane-position-hole: SUCCESS (5.218s)
[811.338046] [150/156] (240s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[812.836082] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[812.837958] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[813.029795] [151/156] (238s left) kms_addfb_basic (master-rmfb)
[813.077997] Starting subtest: master-rmfb
[813.078851] Subtest master-rmfb: SUCCESS (0.001s)
[814.700947] [152/156] (236s left) gem_softpin (zero)
[814.754992] Starting subtest: zero
[814.760449] Subtest zero: SUCCESS (0.006s)
[814.990523] [153/156] (236s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[816.488778] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[816.490455] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[816.669734] [154/156] (235s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[816.718981] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[816.719885] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[816.848064] [155/156] (235s left) gem_gtt_cpu_tlb
[816.991931] [156/156] (235s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[818.487359] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[818.489373] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[818.685118] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: kms_atomic
results: parsing output: 7/ for test: kms_hdr
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_chamelium_color
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: prime_vgem
results: parsing output: 25/ for test: kms_atomic_transition
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_ctx_engines
results: parsing output: 32/ for test: gem_vm_create
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_mmap_wc
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_pxp
results: parsing output: 41/ for test: gem_basic
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: drm_read
results: parsing output: 44/ for test: i915_pm_rpm
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_feature_discovery
results: parsing output: 48/ for test: kms_vblank
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: i915_suspend
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: sysfs_heartbeat_interval
results: parsing output: 54/ for test: kms_dither
results: parsing output: 55/ for test: gem_ctx_shared
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: gem_lmem_swapping
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_universal_plane
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_reg_read
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_pm_backlight
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: core_getclient
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_lmem_swapping
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_fence_thrash
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: drm_read
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_plane_alpha_blend
results: parsing output: 104/ for test: gem_eio
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: gem_exec_fence
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_plane_multiple
results: parsing output: 125/ for test: gen9_exec_parse
results: parsing output: 126/ for test: gem_workarounds
results: parsing output: 127/ for test: gem_ctx_param
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: perf
results: parsing output: 137/ for test: kms_big_fb
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_addfb_basic
results: parsing output: 140/ for test: kms_pm_rpm
results: parsing output: 141/ for test: gem_fenced_exec_thrash
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_lease
results: parsing output: 144/ for test: kms_psr
results: parsing output: 145/ for test: kms_flip
results: parsing output: 146/ for test: kms_joiner
results: parsing output: 147/ for test: dumb_buffer
results: parsing output: 148/ for test: kms_plane
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_addfb_basic
results: parsing output: 151/ for test: gem_softpin
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: syncobj_timeline
results: parsing output: 154/ for test: gem_gtt_cpu_tlb
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.