[56.601720] Initializing watchdogs
[56.601766]   /dev/watchdog0
[56.616567] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.620950] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.623461] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.626790] [001/156] (960s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[56.756198] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[56.760246] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[56.851343] [002/156] (960s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[56.963045] Starting subtest: 2x-cursor-vs-flip-atomic
[56.967702] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[57.100513] [003/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw)
[57.198565] Starting subtest: psrhdr-1p-pri-indfb-multidraw
[57.202575] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[57.305203] [004/156] (959s left) gem_mmap_gtt (cpuset-basic-small-copy)
[57.361779] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[57.416559] [005/156] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[57.527669] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[57.531064] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[57.673749] [006/156] (959s left) gem_caching (read-writes)
[57.735186] Subtest read-writes: SKIP (0.000s)
[57.810715] [007/156] (959s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[57.914688] Starting subtest: fbcpsr-tiling-y
[57.918079] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[58.017565] [008/156] (959s left) gem_tiled_wb
[58.132517] [009/156] (959s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[58.226928] Starting subtest: bad-aux-stride-yf-tiled-ccs
[58.228845] Starting dynamic subtest: pipe-A-eDP-1
[58.247374] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.255344] Starting dynamic subtest: pipe-B-eDP-1
[58.273127] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.279959] Starting dynamic subtest: pipe-C-eDP-1
[58.297675] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.304334] Starting dynamic subtest: pipe-D-eDP-1
[58.322917] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.326532] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[60.511593] [010/156] (956s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[60.638276] Starting subtest: basic-flip-after-cursor-atomic
[61.572694] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.950s)
[62.420150] [011/156] (955s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[62.799594] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[63.608013] [012/156] (953s left) perf (invalid-oa-exponent)
[63.756702] Starting subtest: invalid-oa-exponent
[63.769898] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[63.815177] [013/156] (953s left) kms_cursor_crc (cursor-tearing-position-change)
[63.936350] Starting subtest: cursor-tearing-position-change
[63.938643] Starting dynamic subtest: pipe-A-eDP-1
[64.512157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[64.521566] Starting dynamic subtest: pipe-D-eDP-1
[65.749110] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[65.751503] Subtest cursor-tearing-position-change: SUCCESS (1.829s)
[66.567112] [014/156] (951s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[66.662488] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[66.666631] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[66.760888] [015/156] (950s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[66.856639] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[66.860720] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[66.944699] [016/156] (950s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[66.994757] Starting subtest: invalid-smem-bo-on-discrete
[66.999120] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[67.136744] [017/156] (950s left) kms_psr (psr2-dpms)
[67.241017] Starting subtest: psr2-dpms
[67.243345] Starting dynamic subtest: eDP-1
[70.188254] Dynamic subtest eDP-1: SUCCESS (2.961s)
[70.190761] Subtest psr2-dpms: SUCCESS (2.962s)
[71.057890] [018/156] (946s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[71.157972] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[71.957636] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s)
[72.128915] [019/156] (945s left) syncobj_wait (wait-for-submit-snapshot)
[72.255396] Starting subtest: wait-for-submit-snapshot
[72.337481] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[72.411908] [020/156] (945s left) i915_pm_freq_api (freq-suspend)
[72.627930] Starting subtest: freq-suspend
[72.630428] Starting dynamic subtest: gt0
[89.146215] Dynamic subtest gt0: SUCCESS (1.650s)
[89.157935] Starting dynamic subtest: gt1
[105.146640] Dynamic subtest gt1: SUCCESS (1.211s)
[105.148825] Subtest freq-suspend: SUCCESS (2.863s)
[106.209875] [021/156] (912s left) prime_self_import (basic-llseek-bad)
[106.254412] Starting subtest: basic-llseek-bad
[106.273069] Subtest basic-llseek-bad: SUCCESS (0.017s)
[106.356738] [022/156] (912s left) kms_atomic_interruptible (legacy-setmode)
[106.450739] Starting subtest: legacy-setmode
[106.453264] Starting dynamic subtest: pipe-A-eDP-1
[113.328899] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.078s)
[113.331482] Subtest legacy-setmode: SUCCESS (7.079s)
[114.126207] [023/156] (904s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[114.227924] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[114.232936] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[114.300878] [024/156] (904s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[114.402076] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[115.454928] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.068s)
[115.561225] [025/156] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[115.656718] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[115.660567] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[115.747333] [026/156] (903s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[115.851365] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[115.855771] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[115.946414] [027/156] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[116.039917] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[116.044800] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[116.123494] [028/156] (903s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[116.234833] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[116.239576] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[116.374788] [029/156] (902s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[116.473894] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[116.478482] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[116.569798] [030/156] (902s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[116.632881] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[116.637856] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[116.840436] [031/156] (902s left) kms_setmode (invalid-clone-single-crtc)
[116.900972] Starting subtest: invalid-clone-single-crtc
[116.909664] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[116.997442] [032/156] (902s left) gem_render_copy_redux (interruptible)
[117.053720] Starting subtest: interruptible
[117.360910] Subtest interruptible: SUCCESS (0.310s)
[117.485617] [033/156] (901s left) gem_mmap_gtt (pf-nonblock)
[117.547501] Subtest pf-nonblock: SKIP (0.000s)
[117.608760] [034/156] (901s left) gem_exec_whisper (basic-queues-priority-all)
[117.665185] Starting subtest: basic-queues-priority-all
[141.157927] Subtest basic-queues-priority-all: SUCCESS (23.562s)
[141.354633] [035/156] (878s left) syncobj_timeline (single-wait-signaled)
[141.420312] Starting subtest: single-wait-signaled
[141.422868] Subtest single-wait-signaled: SUCCESS (0.001s)
[141.518332] [036/156] (877s left) kms_psr (psr2-cursor-plane-move)
[141.608531] Starting subtest: psr2-cursor-plane-move
[141.611098] Starting dynamic subtest: eDP-1
[143.288869] Dynamic subtest eDP-1: SUCCESS (1.680s)
[143.291511] Subtest psr2-cursor-plane-move: SUCCESS (1.680s)
[144.174570] [037/156] (875s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[144.276068] Starting subtest: y-tiled-64bpp-rotate-90
[144.281244] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[144.372991] [038/156] (875s left) kms_vblank (query-forked)
[144.470945] Starting subtest: query-forked
[144.473672] Starting dynamic subtest: pipe-A-eDP-1
[146.283361] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[146.300055] Starting dynamic subtest: pipe-D-eDP-1
[148.798941] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.513s)
[148.802013] Subtest query-forked: SUCCESS (4.329s)
[149.664247] [039/156] (869s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[149.759079] Starting subtest: fbc-pr-sprite-mmap-cpu
[149.764951] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[149.829880] [040/156] (869s left) kms_color (legacy-gamma-reset)
[149.919307] Starting subtest: legacy-gamma-reset
[149.921403] Starting dynamic subtest: pipe-A-eDP-1
[150.305073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[150.315126] Starting dynamic subtest: pipe-B-eDP-1
[150.320970] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[150.330629] Starting dynamic subtest: pipe-C-eDP-1
[150.332993] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s)
[150.342788] Starting dynamic subtest: pipe-D-eDP-1
[150.345580] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[150.347967] Subtest legacy-gamma-reset: SUCCESS (0.426s)
[151.098964] [041/156] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[151.205309] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[157.905445] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.705s)
[158.046059] [042/156] (861s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[158.144346] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[158.149384] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[158.239392] [043/156] (861s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[158.347114] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[158.351922] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[158.437178] [044/156] (861s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[158.544869] Starting subtest: psr-rgb565-draw-mmap-gtt
[158.549801] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[158.664546] [045/156] (861s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[158.766949] Starting subtest: pr-cursor-plane-update-sf
[158.772481] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[158.839793] [046/156] (861s left) api_intel_bb (full-batch)
[158.891055] Starting subtest: full-batch
[158.897000] Subtest full-batch: SUCCESS (0.007s)
[159.018756] [047/156] (860s left) kms_getfb (getfb2-handle-closed)
[159.106539] Starting subtest: getfb2-handle-closed
[159.108957] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[159.200276] [048/156] (860s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[159.247928] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[159.356346] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[159.432557] [049/156] (860s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[159.497220] Starting subtest: invalid-single-wait-all-unsubmitted
[159.499929] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[159.584567] [050/156] (860s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[159.677276] Starting subtest: 4-tiled-addfb-size-offset-overflow
[159.679614] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[159.776742] [051/156] (860s left) gem_userptr_blits (nohangcheck)
[159.849574] Starting subtest: nohangcheck
[160.101068] Subtest nohangcheck: SUCCESS (0.251s)
[160.213636] [052/156] (859s left) gem_softpin (softpin)
[160.270787] Starting subtest: softpin
[192.618087] Subtest softpin: SUCCESS (32.351s)
[192.739264] [053/156] (827s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[192.847499] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[192.849919] Starting dynamic subtest: pipe-A-eDP-1
[192.915005] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[192.926702] Starting dynamic subtest: pipe-B-eDP-1
[192.994060] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[193.005217] Starting dynamic subtest: pipe-C-eDP-1
[193.074034] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[193.084072] Starting dynamic subtest: pipe-D-eDP-1
[193.150037] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[193.155166] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[195.182425] [054/156] (825s left) syncobj_basic (create-signaled)
[195.236977] Starting subtest: create-signaled
[195.239575] Subtest create-signaled: SUCCESS (0.000s)
[195.332990] [055/156] (824s left) gen9_exec_parse (batch-zero-length)
[195.388044] Subtest batch-zero-length: SKIP (0.000s)
[195.471294] [056/156] (824s left) gem_exec_balancer (fairslice)
[195.529477] Starting subtest: fairslice
[198.461941] Subtest fairslice: SUCCESS (2.934s)
[198.938444] [057/156] (821s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[199.042487] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[199.047594] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[199.142040] [058/156] (821s left) gem_exec_fence (invalid-timeline-fence-array)
[199.725723] Starting subtest: invalid-timeline-fence-array
[199.732891] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[201.001541] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[201.005785] [059/156] (819s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[201.061079] Starting subtest: multi-wait-all-for-submit-submitted
[201.163680] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[201.240106] [060/156] (819s left) kms_lease (empty-lease)
[201.335510] Starting subtest: empty-lease
[201.337929] Starting dynamic subtest: pipe-A-eDP-1
[201.340494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[201.350467] Starting dynamic subtest: pipe-B-eDP-1
[201.352929] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[201.362443] Starting dynamic subtest: pipe-C-eDP-1
[201.364840] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[201.374502] Starting dynamic subtest: pipe-D-eDP-1
[201.376870] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[201.379569] Subtest empty-lease: SUCCESS (0.008s)
[201.452779] [061/156] (819s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[201.518276] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[201.521055] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[201.617064] [062/156] (818s left) gem_pwrite (basic-self)
[201.674910] Subtest basic-self: SKIP (0.000s)
[201.729465] [063/156] (818s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[201.822078] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[201.826923] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[201.903500] [064/156] (818s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[201.997866] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[202.002635] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[202.090572] [065/156] (818s left) kms_psr (fbc-psr-primary-render)
[202.177835] Starting subtest: fbc-psr-primary-render
[202.179849] Starting dynamic subtest: eDP-1
[202.183837] Dynamic subtest eDP-1: SKIP (0.000s)
[202.187811] Subtest fbc-psr-primary-render: SKIP (0.001s)
[202.250574] [066/156] (818s left) kms_vblank (query-idle)
[202.351069] Starting subtest: query-idle
[202.353439] Starting dynamic subtest: pipe-A-eDP-1
[204.095538] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[204.113088] Starting dynamic subtest: pipe-D-eDP-1
[206.518432] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s)
[206.520929] Subtest query-idle: SUCCESS (4.165s)
[207.346098] [067/156] (813s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[207.439871] Starting subtest: plane-primary-overlay-mutable-zpos
[210.904234] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.461s)
[212.086870] [068/156] (808s left) syncobj_wait (invalid-wait-illegal-handle)
[212.142974] Starting subtest: invalid-wait-illegal-handle
[212.145820] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[212.234062] [069/156] (808s left) syncobj_wait (invalid-reset-illegal-handle)
[212.282203] Starting subtest: invalid-reset-illegal-handle
[212.284873] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[212.363903] [070/156] (808s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[212.467065] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[212.472895] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[212.547875] [071/156] (808s left) perf_pmu (rc6)
[212.586249] Starting subtest: rc6
[212.589216] Starting dynamic subtest: gt0
[219.016802] Dynamic subtest gt0: SUCCESS (6.373s)
[219.029459] Starting dynamic subtest: runtime-pm-gt0
[226.707878] Dynamic subtest runtime-pm-gt0: SUCCESS (7.742s)
[226.721126] Starting dynamic subtest: runtime-pm-long-gt0
[239.178863] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.469s)
[239.194075] Starting dynamic subtest: other-idle-gt0
[245.523063] Dynamic subtest other-idle-gt0: SUCCESS (6.343s)
[245.537287] Starting dynamic subtest: gt1
[251.864697] Dynamic subtest gt1: SUCCESS (6.340s)
[251.878380] Starting dynamic subtest: runtime-pm-gt1
[259.359326] Dynamic subtest runtime-pm-gt1: SUCCESS (7.494s)
[259.373209] Starting dynamic subtest: runtime-pm-long-gt1
[271.850804] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.492s)
[271.861494] Starting dynamic subtest: other-idle-gt1
[278.201735] Dynamic subtest other-idle-gt1: SUCCESS (6.350s)
[278.204867] Subtest rc6: SUCCESS (65.616s)
[279.511101] [072/156] (741s left) kms_plane_alpha_blend (alpha-basic)
[279.608944] Starting subtest: alpha-basic
[279.898833] Starting dynamic subtest: pipe-A-eDP-1
[281.864350] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.962s)
[281.891971] Starting dynamic subtest: pipe-D-eDP-1
[284.579076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.694s)
[284.581974] Subtest alpha-basic: SUCCESS (4.971s)
[285.432956] [073/156] (735s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-onoff)
[285.530925] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-onoff
[285.536103] Subtest fbchdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[285.605834] [074/156] (735s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[285.705845] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[285.710660] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[285.773353] [075/156] (735s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[285.858326] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[285.860833] Starting dynamic subtest: pipe-A
[287.031474] Dynamic subtest pipe-A: SUCCESS (1.174s)
[287.041349] Starting dynamic subtest: pipe-B
[289.305965] Dynamic subtest pipe-B: SUCCESS (2.274s)
[289.321336] Starting dynamic subtest: pipe-C
[290.545061] Dynamic subtest pipe-C: SUCCESS (1.236s)
[290.555476] Starting dynamic subtest: pipe-D
[291.766746] Dynamic subtest pipe-D: SUCCESS (1.221s)
[291.769060] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.910s)
[292.943972] [076/156] (728s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[292.999058] Starting subtest: wait-all-for-submit-delayed-submit
[293.100089] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[293.159399] [077/156] (728s left) gem_ctx_persistence (engines-hostile-preempt)
[293.213571] Starting subtest: engines-hostile-preempt
[293.216103] Starting dynamic subtest: rcs0
[293.279260] Dynamic subtest rcs0: SUCCESS (0.065s)
[293.291248] Starting dynamic subtest: bcs0
[293.303926] Dynamic subtest bcs0: SUCCESS (0.023s)
[293.314272] Starting dynamic subtest: vcs0
[294.927990] Dynamic subtest vcs0: SUCCESS (1.622s)
[294.944040] Starting dynamic subtest: vcs1
[296.894067] Dynamic subtest vcs1: SUCCESS (1.964s)
[296.910671] Starting dynamic subtest: vecs0
[299.014862] Dynamic subtest vecs0: SUCCESS (2.066s)
[299.028091] Starting dynamic subtest: ccs0
[299.030559] Dynamic subtest ccs0: SUCCESS (0.027s)
[299.032933] Subtest engines-hostile-preempt: SUCCESS (5.778s)
[299.088046] [078/156] (722s left) kms_psr (psr-sprite-plane-move)
[299.191786] Starting subtest: psr-sprite-plane-move
[299.194395] Starting dynamic subtest: eDP-1
[300.969406] Dynamic subtest eDP-1: SUCCESS (1.780s)
[300.971980] Subtest psr-sprite-plane-move: SUCCESS (1.781s)
[301.806739] [079/156] (719s left) kms_plane_multiple (2x-tiling-4)
[301.904848] Starting subtest: 2x-tiling-4
[301.909840] Subtest 2x-tiling-4: SKIP (0.000s)
[301.955779] [080/156] (719s left) gem_bad_reloc (negative-reloc-lut)
[302.014821] Subtest negative-reloc-lut: SKIP (0.000s)
[302.098084] [081/156] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[302.197945] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[309.162064] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.972s)
[309.263676] [082/156] (712s left) kms_prop_blob (invalid-set-prop)
[309.315886] Starting subtest: invalid-set-prop
[309.318636] Subtest invalid-set-prop: SUCCESS (0.000s)
[309.390574] [083/156] (712s left) kms_draw_crc (draw-method-pwrite)
[309.482054] Starting subtest: draw-method-pwrite
[309.484492] Starting dynamic subtest: xrgb8888-untiled
[310.069787] Dynamic subtest xrgb8888-untiled: SUCCESS (0.589s)
[310.081594] Starting dynamic subtest: rgb565-untiled
[310.547571] Dynamic subtest rgb565-untiled: SUCCESS (0.476s)
[310.558084] Starting dynamic subtest: xrgb2101010-untiled
[311.114000] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.565s)
[311.128790] Starting dynamic subtest: xbgr16161616f-untiled
[311.902855] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.787s)
[311.914053] Starting dynamic subtest: xrgb8888-xtiled
[313.812945] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.910s)
[313.823706] Starting dynamic subtest: rgb565-xtiled
[314.957979] Dynamic subtest rgb565-xtiled: SUCCESS (1.144s)
[314.969214] Starting dynamic subtest: xrgb2101010-xtiled
[316.812822] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.855s)
[316.823728] Starting dynamic subtest: xbgr16161616f-xtiled
[320.234051] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.421s)
[320.245042] Starting dynamic subtest: xrgb8888-4tiled
[321.413879] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.177s)
[321.424325] Starting dynamic subtest: rgb565-4tiled
[322.000648] Dynamic subtest rgb565-4tiled: SUCCESS (0.588s)
[322.011083] Starting dynamic subtest: xrgb2101010-4tiled
[323.144690] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.142s)
[323.155731] Starting dynamic subtest: xbgr16161616f-4tiled
[326.233753] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.087s)
[326.236426] Subtest draw-method-pwrite: SUCCESS (16.757s)
[326.319262] [084/156] (695s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-blt)
[326.429642] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-blt
[326.434667] Subtest hdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[326.493765] [085/156] (695s left) kms_pm_rpm (system-suspend-modeset)
[328.123848] Starting subtest: system-suspend-modeset
[348.259600] Subtest system-suspend-modeset: SUCCESS (4.281s)
[348.613254] [086/156] (672s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[348.719795] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[355.499101] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.949s)
[355.618460] [087/156] (665s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[355.715413] Starting subtest: basic-max-pipe-crc-check
[355.721401] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[355.764083] [088/156] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[355.865588] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[355.870571] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[355.930803] [089/156] (665s left) gem_mmap_gtt (big-bo-tiledy)
[355.990358] Subtest big-bo-tiledY: SKIP (0.000s)
[356.062800] [090/156] (665s left) vgem_slow (nohang)
[356.103050] Starting subtest: nohang
[366.629488] Subtest nohang: SUCCESS (10.559s)
[366.673653] [091/156] (655s left) gem_mmap_wc (set-cache-level)
[366.727152] Subtest set-cache-level: SKIP (0.000s)
[366.799805] [092/156] (655s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[366.909250] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[366.914178] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[366.989934] [093/156] (654s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[367.080422] Starting subtest: fb-8bpc-vs-panel-6bpc
[367.082978] Starting dynamic subtest: pipe-A-eDP-1
[368.477315] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.398s)
[368.480025] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.401s)
[369.323957] [094/156] (652s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite)
[369.421337] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite
[369.426320] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[369.489396] [095/156] (652s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[369.594605] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[369.599502] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[369.665891] [096/156] (652s left) dmabuf_sync_file (export-wait-after-attach)
[369.713382] Starting subtest: export-wait-after-attach
[369.716423] Subtest export-wait-after-attach: SUCCESS (0.001s)
[369.761255] [097/156] (652s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[369.857243] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[369.859737] Starting dynamic subtest: pipe-A-eDP-1
[370.758076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.895s)
[370.768858] Starting dynamic subtest: pipe-B-eDP-1
[372.379932] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.624s)
[372.393273] Starting dynamic subtest: pipe-C-eDP-1
[373.971731] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.592s)
[373.986496] Starting dynamic subtest: pipe-D-eDP-1
[375.541719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.572s)
[375.544393] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.689s)
[376.660653] [098/156] (645s left) i915_pm_rps (engine-order)
[376.720245] Starting subtest: engine-order
[381.839719] Subtest engine-order: SUCCESS (5.123s)
[381.925287] [099/156] (640s left) kms_chamelium_audio (dp-audio-edid)
[382.315863] Subtest dp-audio-edid: SKIP (0.000s)
[383.191063] [100/156] (638s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[383.285703] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[383.290408] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[383.343954] [101/156] (638s left) kms_pm_lpsp (kms-lpsp)
[384.440984] Starting subtest: kms-lpsp
[384.443457] Starting dynamic subtest: pipe-A-eDP-1
[384.578265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[384.882559] Subtest kms-lpsp: SUCCESS (0.442s)
[385.713727] [102/156] (636s left) kms_plane (pixel-format-y-tiled-modifier)
[385.802296] Starting subtest: pixel-format-y-tiled-modifier
[385.807750] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[385.854718] [103/156] (636s left) api_intel_allocator (simple-allocator)
[385.909252] Starting subtest: simple-allocator
[385.911744] Starting dynamic subtest: basic
[385.914286] Dynamic subtest basic: SUCCESS (0.004s)
[385.927436] Starting dynamic subtest: parallel-one
[386.091636] Dynamic subtest parallel-one: SUCCESS (0.177s)
[386.102009] Starting dynamic subtest: print
[386.104308] Dynamic subtest print: SUCCESS (0.000s)
[386.114597] Starting dynamic subtest: reuse
[386.117044] Dynamic subtest reuse: SUCCESS (0.000s)
[386.127179] Starting dynamic subtest: reserve
[386.129446] Dynamic subtest reserve: SUCCESS (0.000s)
[386.139469] Starting dynamic subtest: fork-reopen-allocator
[386.141884] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[386.144044] Subtest simple-allocator: SUCCESS (0.201s)
[386.192980] [104/156] (636s left) kms_chamelium_edid (dp-edid-read)
[386.578230] Subtest dp-edid-read: SKIP (0.000s)
[387.440900] [105/156] (634s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[387.547687] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[394.927032] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.382s)
[396.052075] [106/156] (626s left) perf (gen12-oa-tlb-invalidate)
[396.120776] Starting subtest: gen12-oa-tlb-invalidate
[396.123571] Starting dynamic subtest: 0-rcs0
[406.228364] Dynamic subtest 0-rcs0: SUCCESS (10.055s)
[406.241544] Starting dynamic subtest: 1-vcs1
[416.272727] Dynamic subtest 1-vcs1: SUCCESS (10.046s)
[416.275410] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.104s)
[416.320224] [107/156] (606s left) gem_exec_schedule (submit-late-slice)
[416.396362] Starting subtest: submit-late-slice
[416.399347] Starting dynamic subtest: rcs0
[416.460838] Dynamic subtest rcs0: SUCCESS (0.070s)
[416.474372] Starting dynamic subtest: bcs0
[416.508940] Dynamic subtest bcs0: SUCCESS (0.048s)
[416.525596] Starting dynamic subtest: vcs0
[416.568163] Dynamic subtest vcs0: SUCCESS (0.058s)
[416.578515] Starting dynamic subtest: vcs1
[416.613212] Dynamic subtest vcs1: SUCCESS (0.044s)
[416.626392] Starting dynamic subtest: vecs0
[416.659297] Dynamic subtest vecs0: SUCCESS (0.046s)
[416.671919] Starting dynamic subtest: ccs0
[416.714646] Dynamic subtest ccs0: SUCCESS (0.055s)
[416.717238] Subtest submit-late-slice: SUCCESS (0.326s)
[417.940786] [108/156] (604s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen)
[418.041400] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen
[418.046268] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[418.119089] [109/156] (604s left) kms_pm_backlight (fade)
[418.216616] Starting subtest: fade
[418.262796] Starting dynamic subtest: eDP-1
[421.257488] Dynamic subtest eDP-1: SUCCESS (2.993s)
[421.260230] Subtest fade: SUCCESS (3.044s)
[422.067235] [110/156] (600s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[422.160455] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[422.163010] Starting dynamic subtest: pipe-A-default-mode
[423.346430] Dynamic subtest pipe-A-default-mode: SKIP (1.181s)
[423.351505] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.183s)
[423.472839] [111/156] (599s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[423.540002] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[423.606459] [112/156] (599s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[423.708402] Starting subtest: x-tiled-8bpp-rotate-270
[423.729510] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[423.811276] [113/156] (598s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[423.870107] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[423.875127] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.001s)
[423.938561] [114/156] (598s left) kms_flip (wf_vblank-ts-check-interruptible)
[424.029455] Starting subtest: wf_vblank-ts-check-interruptible
[424.031935] Starting dynamic subtest: A-eDP1
[432.983264] Dynamic subtest A-eDP1: SUCCESS (8.921s)
[432.997262] Starting dynamic subtest: B-eDP1
[441.895936] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[441.908361] Starting dynamic subtest: C-eDP1
[450.845852] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[450.858366] Starting dynamic subtest: D-eDP1
[459.785930] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[459.788236] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.713s)
[460.939969] [115/156] (561s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[461.072858] Starting subtest: cursorA-vs-flipA-legacy
[472.195345] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.119s)
[472.990918] [116/156] (549s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[473.085361] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc
[473.089760] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[473.158269] [117/156] (549s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[473.256366] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[473.261559] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[473.324342] [118/156] (549s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[473.446954] Starting subtest: verify-pxp-key-change-after-suspend-resume
[480.645732] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.201s)
[480.739349] [119/156] (542s left) gem_exec_parallel (engines)
[480.792597] Starting subtest: engines
[480.795248] Starting dynamic subtest: basic
[482.901152] Dynamic subtest basic: SUCCESS (2.106s)
[482.915514] Starting dynamic subtest: contexts
[487.235581] Dynamic subtest contexts: SUCCESS (4.332s)
[487.246551] Starting dynamic subtest: fds
[491.135697] Dynamic subtest fds: SUCCESS (3.897s)
[491.150475] Starting dynamic subtest: userptr
[494.869919] Dynamic subtest userptr: SUCCESS (3.732s)
[494.873020] Subtest engines: SUCCESS (14.076s)
[495.040424] [120/156] (528s left) gem_exec_async (forked-writes)
[495.113043] Starting subtest: forked-writes
[495.115753] Starting dynamic subtest: rcs0
[495.149037] Dynamic subtest rcs0: SUCCESS (0.036s)
[495.161427] Starting dynamic subtest: bcs0
[495.172494] Dynamic subtest bcs0: SUCCESS (0.023s)
[495.184756] Starting dynamic subtest: vcs0
[495.195331] Dynamic subtest vcs0: SUCCESS (0.022s)
[495.206848] Starting dynamic subtest: vcs1
[495.221481] Dynamic subtest vcs1: SUCCESS (0.025s)
[495.233099] Starting dynamic subtest: vecs0
[495.244706] Dynamic subtest vecs0: SUCCESS (0.022s)
[495.257072] Starting dynamic subtest: ccs0
[495.270090] Dynamic subtest ccs0: SUCCESS (0.024s)
[495.272596] Subtest forked-writes: SUCCESS (0.158s)
[495.475209] [121/156] (527s left) gem_partial_pwrite_pread (write)
[495.543628] Subtest write: SKIP (0.000s)
[495.621260] [122/156] (527s left) syncobj_timeline (host-signal-points)
[495.679556] Starting subtest: host-signal-points
[495.685176] Subtest host-signal-points: SUCCESS (0.005s)
[495.763879] [123/156] (527s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[495.869991] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[495.877835] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[495.933364] [124/156] (527s left) gem_ctx_persistence (heartbeat-stop)
[495.987911] Starting subtest: heartbeat-stop
[495.993296] Subtest heartbeat-stop: SKIP (0.000s)
[496.070291] [125/156] (527s left) gem_softpin (full)
[496.128024] Starting subtest: full
[496.135178] Subtest full: SUCCESS (0.007s)
[496.230743] [126/156] (527s left) kms_frontbuffer_tracking (fbc-2p-rte)
[496.329438] Starting subtest: fbc-2p-rte
[496.334345] Subtest fbc-2p-rte: SKIP (0.000s)
[496.434913] [127/156] (526s left) i915_selftest (mock)
[499.858826] Starting subtest: mock
[499.861279] Starting dynamic subtest: sanitycheck
[501.349582] Dynamic subtest sanitycheck: SUCCESS (1.494s)
[501.361088] Starting dynamic subtest: shmem
[502.875270] Dynamic subtest shmem: SUCCESS (1.524s)
[502.886462] Starting dynamic subtest: fence
[512.016847] Dynamic subtest fence: SUCCESS (9.140s)
[512.028578] Starting dynamic subtest: scatterlist
[514.573002] Dynamic subtest scatterlist: SUCCESS (2.555s)
[514.584361] Starting dynamic subtest: syncmap
[518.538307] Dynamic subtest syncmap: SUCCESS (3.964s)
[518.549338] Starting dynamic subtest: uncore
[520.068236] Dynamic subtest uncore: SUCCESS (1.528s)
[520.079460] Starting dynamic subtest: ring
[521.579321] Dynamic subtest ring: SUCCESS (1.510s)
[521.590855] Starting dynamic subtest: engine
[523.130901] Dynamic subtest engine: SUCCESS (1.550s)
[523.147259] Starting dynamic subtest: timelines
[527.867605] Dynamic subtest timelines: SUCCESS (4.735s)
[527.877797] Starting dynamic subtest: requests
[532.183298] Dynamic subtest requests: SUCCESS (4.315s)
[532.193063] Starting dynamic subtest: objects
[533.822282] Dynamic subtest objects: SUCCESS (1.637s)
[533.832190] Starting dynamic subtest: phys
[535.460209] Dynamic subtest phys: SUCCESS (1.637s)
[535.470461] Starting dynamic subtest: dmabuf
[537.084565] Dynamic subtest dmabuf: SUCCESS (1.623s)
[537.095303] Starting dynamic subtest: vma
[543.686935] Dynamic subtest vma: SUCCESS (6.603s)
[543.697382] Starting dynamic subtest: evict
[545.950969] Dynamic subtest evict: SUCCESS (2.264s)
[545.961461] Starting dynamic subtest: gtt
[550.139282] Dynamic subtest gtt: SUCCESS (4.188s)
[550.151269] Starting dynamic subtest: hugepages
[551.927336] Dynamic subtest hugepages: SUCCESS (1.787s)
[551.938631] Starting dynamic subtest: memory_region
[555.354289] Dynamic subtest memory_region: SUCCESS (3.427s)
[555.357272] Subtest mock: SUCCESS (55.506s)
[555.389284] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[555.390086] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[555.394038] [128/156] (467s left) gem_exec_params (no-bsd)
[557.719581] Starting subtest: no-bsd
[557.725442] Subtest no-bsd: SUCCESS (0.006s)
[558.917374] [FACT gem_exec_params (no-bsd)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[558.918634] [FACT gem_exec_params (no-bsd)] new: kernel.kmod_is_loaded.i915: true
[558.923111] [129/156] (464s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[558.989496] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[558.992109] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[559.064875] [130/156] (464s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[559.334116] Starting subtest: cursor-rapid-movement-256x85
[559.387558] Subtest cursor-rapid-movement-256x85: SKIP (0.049s)
[559.537902] [131/156] (463s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[559.586345] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[559.588631] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[559.654480] [132/156] (463s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[559.745069] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[559.747487] Starting dynamic subtest: pipe-A-eDP-1
[559.771011] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[559.783690] Starting dynamic subtest: pipe-B-eDP-1
[559.808425] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[559.818245] Starting dynamic subtest: pipe-C-eDP-1
[559.843769] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[559.853436] Starting dynamic subtest: pipe-D-eDP-1
[559.879494] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[559.884360] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[562.259765] [133/156] (461s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[562.348244] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[562.350767] Starting dynamic subtest: pipe-A-eDP-1
[562.499902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s)
[562.510402] Starting dynamic subtest: pipe-B-eDP-1
[562.532206] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[562.542404] Starting dynamic subtest: pipe-C-eDP-1
[562.565989] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[562.578405] Starting dynamic subtest: pipe-D-eDP-1
[562.601385] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[562.604185] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.153s)
[564.845387] [134/156] (458s left) kms_addfb_basic (size-max)
[564.944407] Starting subtest: size-max
[564.947206] Subtest size-max: SUCCESS (0.000s)
[565.025154] [135/156] (458s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[565.130812] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[565.135886] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[565.185126] [136/156] (458s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[565.314434] Starting subtest: dp-mst-type-1-suspend-resume
[565.320094] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[565.406819] [137/156] (458s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[565.510399] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[572.500372] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.998s)
[572.605367] [138/156] (451s left) kms_addfb_basic (unused-offsets)
[572.667250] Starting subtest: unused-offsets
[572.669450] Subtest unused-offsets: SUCCESS (0.000s)
[572.782124] [139/156] (451s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[572.876345] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[572.881590] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[572.929122] [140/156] (450s left) gem_ctx_engines (invalid-engines)
[572.978970] Starting subtest: invalid-engines
[572.988401] Subtest invalid-engines: SUCCESS (0.009s)
[573.187657] [141/156] (450s left) gem_exec_fence (invalid-fence-array)
[573.615059] Starting subtest: invalid-fence-array
[573.617630] Subtest invalid-fence-array: SUCCESS (0.002s)
[574.927462] [142/156] (449s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[575.026276] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[575.031367] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[575.088868] [143/156] (448s left) kms_cursor_crc (cursor-dpms)
[575.215982] Starting subtest: cursor-dpms
[575.218602] Starting dynamic subtest: pipe-A-eDP-1
[578.320265] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.104s)
[578.334360] Starting dynamic subtest: pipe-D-eDP-1
[581.986675] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.666s)
[581.989305] Subtest cursor-dpms: SUCCESS (6.773s)
[582.813418] [144/156] (441s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[582.906512] Starting subtest: fbc-psr2-primary-mmap-cpu
[582.909293] Starting dynamic subtest: eDP-1
[582.913628] Dynamic subtest eDP-1: SKIP (0.000s)
[582.918415] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[582.959088] [145/156] (441s left) kms_frontbuffer_tracking (psr-1p-rte)
[583.069256] Starting subtest: psr-1p-rte
[588.483137] Subtest psr-1p-rte: SUCCESS (5.422s)
[588.594930] [146/156] (435s left) perf_pmu (faulting-read)
[588.636974] Starting subtest: faulting-read
[588.639729] Starting dynamic subtest: wb
[588.642430] Dynamic subtest wb: SUCCESS (0.001s)
[588.653184] Starting dynamic subtest: wc
[588.655613] Dynamic subtest wc: SUCCESS (0.000s)
[588.666315] Starting dynamic subtest: uc
[588.669098] Dynamic subtest uc: SUCCESS (0.000s)
[588.671492] Subtest faulting-read: SUCCESS (0.003s)
[588.726563] [147/156] (435s left) vgem_basic (busy-fence)
[588.766487] Starting subtest: busy-fence
[588.769337] Subtest busy-fence: SUCCESS (0.000s)
[588.813407] [148/156] (435s left) i915_drm_fdinfo (all-busy-idle-check-all)
[588.850342] Starting subtest: all-busy-idle-check-all
[588.858983] Subtest all-busy-idle-check-all: SKIP (0.004s)
[588.907189] [149/156] (435s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[589.028369] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[589.033583] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[589.097800] [150/156] (435s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[589.198301] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[596.664515] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.473s)
[596.780421] [151/156] (427s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[596.831422] Starting subtest: framebuffer-vs-set-tiling
[596.836607] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[596.948555] [152/156] (427s left) gem_eio (wait-10ms)
[597.150510] Starting subtest: wait-10ms
[597.477299] Subtest wait-10ms: SUCCESS (0.327s)
[597.573805] [153/156] (426s left) gem_exec_suspend (basic-s0)
[597.626766] Starting subtest: basic-S0
[597.629104] Starting dynamic subtest: smem
[618.069795] Dynamic subtest smem: SUCCESS (6.300s)
[618.072963] Subtest basic-S0: SUCCESS (6.302s)
[618.234361] [154/156] (406s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[618.338905] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[618.343850] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[618.404561] [155/156] (406s left) gem_exec_schedule (implicit-write-read)
[618.477981] Starting subtest: implicit-write-read
[618.480520] Starting dynamic subtest: rcs0
[618.580316] Dynamic subtest rcs0: SUCCESS (0.120s)
[618.594326] Starting dynamic subtest: vcs0
[618.666094] Dynamic subtest vcs0: SUCCESS (0.087s)
[618.678688] Starting dynamic subtest: vcs1
[618.747579] Dynamic subtest vcs1: SUCCESS (0.084s)
[618.761121] Starting dynamic subtest: vecs0
[618.825877] Dynamic subtest vecs0: SUCCESS (0.080s)
[618.839104] Starting dynamic subtest: ccs0
[618.914864] Dynamic subtest ccs0: SUCCESS (0.091s)
[618.917876] Subtest implicit-write-read: SUCCESS (0.467s)
[620.194606] [156/156] (404s left) syncobj_wait (multi-wait-all-submitted)
[620.246896] Starting subtest: multi-wait-all-submitted
[620.352938] Subtest multi-wait-all-submitted: SUCCESS (0.110s)
[620.405965] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_caching
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_tiled_wb
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: i915_pm_freq_api
results: parsing output: 20/ for test: prime_self_import
results: parsing output: 21/ for test: kms_atomic_interruptible
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_setmode
results: parsing output: 31/ for test: gem_render_copy_redux
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_getfb
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: syncobj_basic
results: parsing output: 54/ for test: gen9_exec_parse
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_pwrite
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: kms_atomic
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_plane_alpha_blend
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_plane_multiple
results: parsing output: 79/ for test: gem_bad_reloc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_prop_blob
results: parsing output: 82/ for test: kms_draw_crc
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_pm_rpm
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_multipipe_modeset
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: vgem_slow
results: parsing output: 90/ for test: gem_mmap_wc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_dither
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: dmabuf_sync_file
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: i915_pm_rps
results: parsing output: 98/ for test: kms_chamelium_audio
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pm_lpsp
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_pm_backlight
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: kms_pipe_b_c_ivb
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: sriov_basic
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: gem_exec_parallel
results: parsing output: 119/ for test: gem_exec_async
results: parsing output: 120/ for test: gem_partial_pwrite_pread
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: i915_selftest
results: parsing output: 127/ for test: gem_exec_params
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_ccs
results: parsing output: 133/ for test: kms_addfb_basic
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_content_protection
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_addfb_basic
results: parsing output: 138/ for test: kms_flip_scaled_crc
results: parsing output: 139/ for test: gem_ctx_engines
results: parsing output: 140/ for test: gem_exec_fence
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_cursor_crc
results: parsing output: 143/ for test: kms_psr
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: perf_pmu
results: parsing output: 146/ for test: vgem_basic
results: parsing output: 147/ for test: i915_drm_fdinfo
results: parsing output: 148/ for test: kms_frontbuffer_tracking
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_eio
results: parsing output: 152/ for test: gem_exec_suspend
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: gem_exec_schedule
results: parsing output: 155/ for test: syncobj_wait
Done.