[56.662568] Initializing watchdogs
[56.662615]   /dev/watchdog0
[56.678502] [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.682955] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.685529] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.689117] [001/155] (960s left) syncobj_eventfd (binary-wait-signaled)
[56.764108] Starting subtest: binary-wait-signaled
[56.766554] Subtest binary-wait-signaled: SUCCESS (0.000s)
[56.856324] [002/155] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[56.955569] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[56.959712] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[57.040425] [003/155] (960s left) gem_userptr_blits (map-fixed-invalidate-busy)
[57.108660] Starting subtest: map-fixed-invalidate-busy
[57.112758] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[57.245308] [004/155] (960s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[57.303740] Starting subtest: legacy-engines-hostile-preempt
[57.305983] Starting dynamic subtest: render
[57.373615] Dynamic subtest render: SUCCESS (0.073s)
[57.386140] Starting dynamic subtest: bsd1
[59.267523] Dynamic subtest bsd1: SUCCESS (1.925s)
[59.278557] Starting dynamic subtest: bsd2
[61.252695] Dynamic subtest bsd2: SUCCESS (2.010s)
[61.263754] Starting dynamic subtest: blt
[61.297555] Dynamic subtest blt: SUCCESS (0.047s)
[61.308272] Starting dynamic subtest: vebox
[63.291507] Dynamic subtest vebox: SUCCESS (2.011s)
[63.294548] Subtest legacy-engines-hostile-preempt: SUCCESS (6.074s)
[63.371349] [005/155] (953s left) kms_panel_fitting (atomic-fastset)
[63.472032] Starting subtest: atomic-fastset
[63.474345] Starting dynamic subtest: pipe-A-eDP-1
[63.668713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.200s)
[63.677172] Starting dynamic subtest: pipe-B-eDP-1
[64.947793] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s)
[64.958479] Starting dynamic subtest: pipe-C-eDP-1
[66.131756] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.192s)
[66.141559] Starting dynamic subtest: pipe-D-eDP-1
[67.362834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[67.365338] Subtest atomic-fastset: SUCCESS (3.920s)
[68.583038] [006/155] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[68.679864] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[68.684293] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[68.767150] [007/155] (948s left) kms_psr (pr-sprite-render)
[68.863760] Starting subtest: pr-sprite-render
[68.868166] Subtest pr-sprite-render: SKIP (0.000s)
[68.934373] [008/155] (948s left) perf_pmu (invalid-open)
[68.973919] Starting subtest: invalid-open
[68.976401] Subtest invalid-open: SUCCESS (0.000s)
[69.076035] [009/155] (948s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[69.170754] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[69.175232] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[69.265922] [010/155] (948s left) gem_exec_fence (concurrent)
[69.435687] Starting subtest: concurrent
[69.440637] Subtest concurrent: SKIP (0.000s)
[71.379333] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[71.382556] [011/155] (946s left) i915_drm_fdinfo (busy-idle)
[71.418533] Starting subtest: busy-idle
[71.420759] Starting dynamic subtest: rcs0
[71.451599] Dynamic subtest rcs0: SKIP (0.031s)
[71.461482] Starting dynamic subtest: bcs0
[71.465500] Dynamic subtest bcs0: SKIP (0.000s)
[71.473409] Starting dynamic subtest: vcs0
[71.477765] Dynamic subtest vcs0: SKIP (0.000s)
[71.485437] Starting dynamic subtest: vcs1
[71.489452] Dynamic subtest vcs1: SKIP (0.000s)
[71.497047] Starting dynamic subtest: vecs0
[71.501818] Dynamic subtest vecs0: SKIP (0.000s)
[71.511208] Starting dynamic subtest: ccs0
[71.515385] Dynamic subtest ccs0: SKIP (0.000s)
[71.519527] Subtest busy-idle: SKIP (0.034s)
[71.556156] [012/155] (946s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[71.664853] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[71.668974] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[71.766237] [013/155] (945s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[71.856910] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[71.859334] Starting dynamic subtest: pipe-A-eDP-1
[74.162045] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.310s)
[74.171869] Starting dynamic subtest: pipe-B-eDP-1
[76.492164] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.335s)
[76.501494] Starting dynamic subtest: pipe-C-eDP-1
[78.609174] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.118s)
[78.617915] Starting dynamic subtest: pipe-D-eDP-1
[80.720536] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.114s)
[80.722529] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.880s)
[81.921273] [014/155] (935s left) gem_softpin (allocator-nopin)
[81.982717] Starting subtest: allocator-nopin
[82.082492] Subtest allocator-nopin: SUCCESS (0.099s)
[82.197877] [015/155] (935s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[82.256870] Starting subtest: invalid-multi-wait-unsubmitted
[82.259200] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[82.361368] [016/155] (935s left) gem_mmap_gtt (basic-wc)
[82.426850] Subtest basic-wc: SKIP (0.000s)
[82.492260] [017/155] (935s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[82.591781] Starting subtest: fbcpsrhdr-tiling-4
[82.596763] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[82.690120] [018/155] (935s left) gem_sync (basic-each)
[82.756260] Starting subtest: basic-each
[85.129655] Subtest basic-each: SUCCESS (2.384s)
[85.317260] [019/155] (932s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[85.427542] Starting subtest: pr-cursor-plane-update-sf
[85.431871] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[85.499618] [020/155] (932s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[85.611533] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[85.615591] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[85.710631] [021/155] (932s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[85.802185] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[85.806216] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[85.909776] [022/155] (932s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[86.008805] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[86.012769] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[86.100489] [023/155] (931s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt)
[86.203189] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt
[86.207224] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[86.289907] [024/155] (931s left) kms_chamelium_audio (hdmi-audio)
[86.675513] Subtest hdmi-audio: SKIP (0.000s)
[87.523638] [025/155] (930s left) gem_partial_pwrite_pread (write-uncached)
[87.592989] Subtest write-uncached: SKIP (0.000s)
[87.660103] [026/155] (930s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[87.755405] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[88.568350] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.814s)
[88.756210] [027/155] (929s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[88.862327] Starting subtest: sprite-rotation-90-pos-100-0
[88.866638] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[88.934675] [028/155] (929s left) kms_cursor_legacy (single-bo)
[89.051419] Starting subtest: single-bo
[89.053712] Starting dynamic subtest: pipe-A
[94.436020] Dynamic subtest pipe-A: SUCCESS (5.379s)
[94.446930] Starting dynamic subtest: pipe-B
[99.819399] Dynamic subtest pipe-B: SUCCESS (5.380s)
[99.829790] Starting dynamic subtest: pipe-C
[105.204412] Dynamic subtest pipe-C: SUCCESS (5.383s)
[105.217771] Starting dynamic subtest: pipe-D
[110.585954] Dynamic subtest pipe-D: SUCCESS (5.380s)
[110.596232] Starting dynamic subtest: all-pipes
[115.975535] Dynamic subtest all-pipes: SUCCESS (5.388s)
[115.977921] Subtest single-bo: SUCCESS (26.917s)
[116.119890] [029/155] (902s left) gem_render_copy (linear-to-vebox-yf-tiled)
[116.190256] Starting subtest: linear-to-vebox-yf-tiled
[116.194597] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[116.374205] [030/155] (901s left) gem_exec_reloc (basic-scanout)
[116.426222] Subtest basic-scanout: SKIP (0.000s)
[116.497997] [031/155] (901s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[116.616119] Starting subtest: 4-tiled-64bpp-rotate-180
[118.117621] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.501s)
[118.284702] [032/155] (900s left) kms_joiner (basic-force-big-joiner)
[118.382054] Starting subtest: basic-force-big-joiner
[118.386646] Subtest basic-force-big-joiner: SKIP (0.000s)
[118.462729] [033/155] (900s left) kms_psr (psr-cursor-plane-move)
[118.545329] Starting subtest: psr-cursor-plane-move
[118.547226] Starting dynamic subtest: eDP-1
[120.247819] Dynamic subtest eDP-1: SUCCESS (1.700s)
[120.250094] Subtest psr-cursor-plane-move: SUCCESS (1.701s)
[121.114129] [034/155] (897s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[121.222148] Starting subtest: fbc-pr-cursor-plane-update-sf
[121.226319] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[121.289053] [035/155] (897s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[121.395282] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[121.399153] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[121.481675] [036/155] (897s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[121.588493] Starting subtest: cursorB-vs-flipB-legacy
[121.593106] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[121.745577] [037/155] (896s left) gem_bad_reloc (negative-reloc-bltcopy)
[121.802278] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[121.871665] [038/155] (896s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[121.963707] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[121.990860] Starting dynamic subtest: pipe-A-plane-0
[122.279235] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[122.287959] Starting dynamic subtest: pipe-A-plane-3
[122.513276] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[123.599477] Starting dynamic subtest: pipe-B-plane-0
[123.892238] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[123.901843] Starting dynamic subtest: pipe-B-plane-3
[124.125834] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[124.436549] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.474s)
[125.283713] [039/155] (893s left) gem_softpin (overlap)
[125.332468] Starting subtest: overlap
[126.217859] Subtest overlap: SUCCESS (0.884s)
[126.335734] [040/155] (892s left) gem_exec_reloc (basic-write-cpu)
[126.390942] Subtest basic-write-cpu: SKIP (0.000s)
[126.495218] [041/155] (892s left) kms_cursor_crc (cursor-onscreen-128x42)
[126.699062] Starting subtest: cursor-onscreen-128x42
[126.747993] Subtest cursor-onscreen-128x42: SKIP (0.045s)
[126.945216] [042/155] (891s left) sysfs_heartbeat_interval (invalid)
[127.004067] Starting subtest: invalid
[127.006324] Starting dynamic subtest: vecs0
[127.008545] Dynamic subtest vecs0: SUCCESS (0.000s)
[127.016487] Starting dynamic subtest: ccs0
[127.018373] Dynamic subtest ccs0: SUCCESS (0.000s)
[127.026615] Starting dynamic subtest: vcs0
[127.028827] Dynamic subtest vcs0: SUCCESS (0.000s)
[127.036962] Starting dynamic subtest: bcs0
[127.039236] Dynamic subtest bcs0: SUCCESS (0.000s)
[127.047550] Starting dynamic subtest: rcs0
[127.049474] Dynamic subtest rcs0: SUCCESS (0.000s)
[127.057496] Starting dynamic subtest: vcs1
[127.059718] Dynamic subtest vcs1: SUCCESS (0.000s)
[127.061957] Subtest invalid: SUCCESS (0.004s)
[127.104618] [043/155] (891s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[127.188076] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[127.192510] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[127.275748] [044/155] (891s left) kms_chamelium_color (gamma)
[127.373504] Subtest gamma: SKIP (0.000s)
[127.416278] [045/155] (891s left) gem_exec_reloc (basic-cpu-read-noreloc)
[127.473225] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[127.552985] [046/155] (891s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[127.650289] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[127.653805] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[127.739233] [047/155] (891s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[127.796690] Starting subtest: single-wait-all-for-submit-available-signaled
[127.798842] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[127.886602] [048/155] (891s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[127.997884] Starting subtest: fbc-rgb565-draw-pwrite
[132.654457] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.661s)
[133.795407] [049/155] (885s left) kms_plane_alpha_blend (constant-alpha-mid)
[133.891481] Starting subtest: constant-alpha-mid
[134.184733] Starting dynamic subtest: pipe-A-eDP-1
[135.098730] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.912s)
[135.107844] Starting dynamic subtest: pipe-D-eDP-1
[136.569527] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.469s)
[136.571650] Subtest constant-alpha-mid: SUCCESS (2.677s)
[137.437555] [050/155] (881s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[137.495184] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[137.596298] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[137.673175] [051/155] (881s left) api_intel_bb (object-noreloc-purge-cache-simple)
[137.721816] Starting subtest: object-noreloc-purge-cache-simple
[137.727629] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.008s)
[137.818869] [052/155] (881s left) gem_exec_parallel (basic)
[137.880460] Starting subtest: basic
[137.882700] Starting dynamic subtest: rcs0
[139.309481] Dynamic subtest rcs0: SUCCESS (1.428s)
[139.318763] Starting dynamic subtest: bcs0
[140.810322] Dynamic subtest bcs0: SUCCESS (1.500s)
[140.820100] Starting dynamic subtest: vcs0
[142.323243] Dynamic subtest vcs0: SUCCESS (1.510s)
[142.332648] Starting dynamic subtest: vcs1
[144.265252] Dynamic subtest vcs1: SUCCESS (1.940s)
[144.277294] Starting dynamic subtest: vecs0
[146.248524] Dynamic subtest vecs0: SUCCESS (1.980s)
[146.262185] Starting dynamic subtest: ccs0
[147.761456] Dynamic subtest ccs0: SUCCESS (1.513s)
[147.763918] Subtest basic: SUCCESS (9.882s)
[147.948987] [053/155] (871s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[148.011049] Starting subtest: y-tiled-ccs-to-x-tiled
[148.015801] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[148.202859] [054/155] (871s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[148.312334] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[148.316276] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[148.403872] [055/155] (870s left) kms_pm_rpm (pm-tiling)
[150.441701] Starting subtest: pm-tiling
[150.446586] Subtest pm-tiling: SKIP (0.000s)
[150.816945] [056/155] (868s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[150.953880] Starting subtest: dp-mst-lic-type-0-hdcp14
[150.958708] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[151.098959] [057/155] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[151.202852] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[158.745492] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.546s)
[158.868314] [058/155] (860s left) kms_plane (plane-position-covered)
[158.956176] Starting subtest: plane-position-covered
[159.484814] Starting dynamic subtest: pipe-A-plane-1
[160.814554] Dynamic subtest pipe-A-plane-1: SUCCESS (1.330s)
[160.824065] Starting dynamic subtest: pipe-A-plane-2
[162.121105] Dynamic subtest pipe-A-plane-2: SUCCESS (1.305s)
[162.130542] Starting dynamic subtest: pipe-A-plane-3
[163.379372] Dynamic subtest pipe-A-plane-3: SUCCESS (1.258s)
[163.388066] Starting dynamic subtest: pipe-A-plane-4
[164.701978] Dynamic subtest pipe-A-plane-4: SUCCESS (1.322s)
[164.713908] Starting dynamic subtest: pipe-A-plane-5
[164.726955] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[165.872099] Starting dynamic subtest: pipe-B-plane-1
[167.181093] Dynamic subtest pipe-B-plane-1: SUCCESS (1.317s)
[167.191151] Starting dynamic subtest: pipe-B-plane-2
[168.503439] Dynamic subtest pipe-B-plane-2: SUCCESS (1.323s)
[168.512158] Starting dynamic subtest: pipe-B-plane-3
[169.863052] Dynamic subtest pipe-B-plane-3: SUCCESS (1.358s)
[169.873918] Starting dynamic subtest: pipe-B-plane-4
[171.130854] Dynamic subtest pipe-B-plane-4: SUCCESS (1.268s)
[171.141052] Starting dynamic subtest: pipe-B-plane-5
[171.160800] Dynamic subtest pipe-B-plane-5: SUCCESS (0.028s)
[171.163271] Subtest plane-position-covered: SUCCESS (12.205s)
[171.954613] [059/155] (847s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[172.013677] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[172.116272] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[172.210116] [060/155] (847s left) kms_frontbuffer_tracking (psr-1p-rte)
[172.312137] Starting subtest: psr-1p-rte
[177.730733] Subtest psr-1p-rte: SUCCESS (5.424s)
[177.867117] [061/155] (841s left) gem_exec_whisper (basic-fds)
[177.934667] Starting subtest: basic-fds
[185.255664] Subtest basic-fds: SUCCESS (7.317s)
[185.457818] [062/155] (834s left) kms_chamelium_hpd (vga-hpd)
[185.843408] Subtest vga-hpd: SKIP (0.000s)
[186.679268] [063/155] (833s left) kms_atomic_interruptible (universal-setplane-cursor)
[186.776368] Starting subtest: universal-setplane-cursor
[186.778754] Starting dynamic subtest: pipe-A-eDP-1
[194.223682] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.445s)
[194.225935] Subtest universal-setplane-cursor: SUCCESS (7.447s)
[195.070581] [064/155] (824s left) kms_psr (fbc-psr2-primary-render)
[195.163429] Starting subtest: fbc-psr2-primary-render
[195.165770] Starting dynamic subtest: eDP-1
[195.170196] Dynamic subtest eDP-1: SKIP (0.000s)
[195.174583] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[195.236377] [065/155] (824s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[195.347300] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[195.351393] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[195.445963] [066/155] (824s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[195.544124] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[195.548269] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[195.631317] [067/155] (824s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[195.727057] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[195.729339] Starting dynamic subtest: pipe-A
[195.746985] Dynamic subtest pipe-A: SKIP (0.017s)
[195.756670] Starting dynamic subtest: pipe-B
[195.787097] Dynamic subtest pipe-B: SKIP (0.040s)
[195.797667] Starting dynamic subtest: pipe-C
[195.823271] Dynamic subtest pipe-C: SKIP (0.035s)
[195.831987] Starting dynamic subtest: pipe-D
[195.856923] Dynamic subtest pipe-D: SKIP (0.033s)
[195.861856] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.128s)
[195.953705] [068/155] (823s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[196.052207] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[196.055758] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[196.147878] [069/155] (823s left) api_intel_allocator (gem-pool)
[196.197175] Starting subtest: gem-pool
[196.203873] Subtest gem-pool: SUCCESS (0.008s)
[196.325481] [070/155] (823s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[196.415816] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[196.419213] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[196.510653] [071/155] (823s left) kms_color (ctm-0-50)
[196.605606] Starting subtest: ctm-0-50
[196.607590] Starting dynamic subtest: pipe-A-eDP-1
[200.184080] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.575s)
[200.193035] Starting dynamic subtest: pipe-B-eDP-1
[204.467968] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.285s)
[204.479452] Starting dynamic subtest: pipe-C-eDP-1
[208.512678] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.044s)
[208.522648] Starting dynamic subtest: pipe-D-eDP-1
[212.510825] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.995s)
[212.513070] Subtest ctm-0-50: SUCCESS (15.904s)
[213.331010] [072/155] (806s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt)
[213.443245] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt
[213.447639] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[213.548202] [073/155] (806s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[213.657459] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite
[213.661354] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[213.753677] [074/155] (806s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[213.866180] Starting subtest: cursorA-vs-flipA-varying-size
[224.997782] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.128s)
[225.872412] [075/155] (794s left) gem_ctx_param (invalid-set-ringsize)
[225.928953] Starting subtest: invalid-set-ringsize
[225.931401] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[226.016299] [076/155] (794s left) kms_flip (2x-flip-vs-panning)
[226.109295] Starting subtest: 2x-flip-vs-panning
[226.120875] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[226.215361] [077/155] (794s left) gem_pread (snoop)
[226.276138] Subtest snoop: SKIP (0.000s)
[226.336898] [078/155] (794s left) gem_gpgpu_fill (offset-16x16)
[226.388493] Starting subtest: offset-16x16
[226.394759] Subtest offset-16x16: SUCCESS (0.008s)
[226.543732] [079/155] (793s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[226.599564] Starting subtest: yf-tiled-to-vebox-y-tiled
[226.604074] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[226.797358] [080/155] (793s left) kms_psr (psr-sprite-mmap-cpu)
[226.884247] Starting subtest: psr-sprite-mmap-cpu
[226.886398] Starting dynamic subtest: eDP-1
[228.668914] Dynamic subtest eDP-1: SUCCESS (1.784s)
[228.671187] Subtest psr-sprite-mmap-cpu: SUCCESS (1.786s)
[229.521688] [081/155] (790s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[229.625190] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[229.629231] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[229.728445] [082/155] (790s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[229.831432] Starting subtest: hdr-1p-pri-indfb-multidraw
[229.835677] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[229.919181] [083/155] (790s left) kms_psr (pr-cursor-mmap-cpu)
[230.013272] Starting subtest: pr-cursor-mmap-cpu
[230.017640] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[230.087929] [084/155] (790s left) kms_feature_discovery (psr1)
[230.183651] Starting subtest: psr1
[230.185519] Subtest psr1: SUCCESS (0.000s)
[230.256168] [085/155] (790s left) gem_mmap_wc (write-read-distinct)
[230.310648] Subtest write-read-distinct: SKIP (0.000s)
[230.367995] [086/155] (790s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[230.465657] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[230.467588] Starting dynamic subtest: pipe-A-eDP-1
[230.486891] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.496953] Starting dynamic subtest: pipe-B-eDP-1
[230.514719] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.523396] Starting dynamic subtest: pipe-C-eDP-1
[230.540478] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.551324] Starting dynamic subtest: pipe-D-eDP-1
[230.569654] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.573342] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[232.790908] [087/155] (787s left) kms_atomic (atomic-plane-damage)
[232.881313] Starting subtest: atomic-plane-damage
[232.931051] Starting dynamic subtest: pipe-A-eDP-1
[233.447159] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.518s)
[233.449550] Subtest atomic-plane-damage: SUCCESS (0.567s)
[234.306987] [088/155] (786s left) perf_pmu (invalid-init)
[234.343873] Starting subtest: invalid-init
[234.346191] Subtest invalid-init: SUCCESS (0.000s)
[234.451490] [089/155] (786s left) kms_big_fb (linear-64bpp-rotate-180)
[234.571286] Starting subtest: linear-64bpp-rotate-180
[236.284052] Subtest linear-64bpp-rotate-180: SUCCESS (1.713s)
[236.439912] [090/155] (784s left) gem_exec_reloc (basic-write-gtt)
[236.489590] Subtest basic-write-gtt: SKIP (0.000s)
[236.570525] [091/155] (784s left) kms_vblank (wait-forked-busy)
[236.660508] Starting subtest: wait-forked-busy
[236.662498] Starting dynamic subtest: pipe-A-eDP-1
[238.536775] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[238.551751] Starting dynamic subtest: pipe-D-eDP-1
[241.079336] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[241.081829] Subtest wait-forked-busy: SUCCESS (4.420s)
[241.884834] [092/155] (779s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[242.003545] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[246.191108] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.194s)
[247.417478] [093/155] (773s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[247.522041] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[247.526257] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[247.609658] [094/155] (773s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[248.177783] Starting subtest: syncobj-timeline-invalid-flags
[248.179785] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[249.391829] [095/155] (771s left) i915_pm_rps (thresholds-idle)
[249.455210] Starting subtest: thresholds-idle
[249.460099] Subtest thresholds-idle: SKIP (0.001s)
[249.534172] [096/155] (771s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[249.630826] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[249.635317] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[249.747502] [097/155] (771s left) gem_exec_balancer (fairslice)
[249.825711] Starting subtest: fairslice
[252.788800] Subtest fairslice: SUCCESS (2.961s)
[253.334688] [098/155] (767s left) gem_mmap_gtt (cpuset-medium-copy)
[253.395611] Subtest cpuset-medium-copy: SKIP (0.000s)
[253.483297] [099/155] (767s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[253.571056] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[253.573322] Starting dynamic subtest: pipe-A-eDP-1
[253.594113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[253.605370] Starting dynamic subtest: pipe-B-eDP-1
[253.624679] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[253.633908] Starting dynamic subtest: pipe-C-eDP-1
[253.653360] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[253.662347] Starting dynamic subtest: pipe-D-eDP-1
[253.681781] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[253.683750] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[255.856205] [100/155] (765s left) kms_flip (flip-vs-expired-vblank-interruptible)
[255.957673] Starting subtest: flip-vs-expired-vblank-interruptible
[255.962438] Starting dynamic subtest: A-eDP1
[264.654262] Dynamic subtest A-eDP1: SUCCESS (8.692s)
[264.666296] Starting dynamic subtest: B-eDP1
[273.292773] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[273.302456] Starting dynamic subtest: C-eDP1
[281.914535] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[281.926966] Starting dynamic subtest: D-eDP1
[290.548058] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[290.553437] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.595s)
[291.721512] [101/155] (729s left) perf (gen12-oa-tlb-invalidate)
[291.849204] Starting subtest: gen12-oa-tlb-invalidate
[291.851146] Starting dynamic subtest: 0-rcs0
[301.889346] Dynamic subtest 0-rcs0: SUCCESS (10.039s)
[301.898754] Starting dynamic subtest: 1-vcs0
[311.940387] Dynamic subtest 1-vcs0: SUCCESS (10.049s)
[311.943169] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.091s)
[311.991449] [102/155] (709s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt)
[312.096762] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt
[312.101221] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[312.206891] [103/155] (709s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[312.309469] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[312.313638] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[312.417155] [104/155] (709s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[312.511896] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[312.516081] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[312.613878] [105/155] (708s left) prime_mmap (test_dup)
[312.671587] Starting subtest: test_dup
[312.673643] Starting dynamic subtest: test_dup-smem
[312.703779] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[312.706134] Subtest test_dup: SUCCESS (0.034s)
[312.777311] [106/155] (708s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[312.887645] Starting subtest: y-tiled-16bpp-rotate-270
[312.892128] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[312.993303] [107/155] (708s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[313.093016] Starting subtest: fbc-rgb101010-draw-pwrite
[316.480710] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.391s)
[317.641041] [108/155] (704s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[317.733736] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[317.736130] Starting dynamic subtest: pipe-A-eDP-1
[323.714931] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.981s)
[323.726650] Starting dynamic subtest: pipe-B-eDP-1
[330.376072] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.662s)
[330.378417] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.646s)
[331.248628] [109/155] (690s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-render)
[331.350282] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-render
[331.354664] Subtest psrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[331.436759] [110/155] (690s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[331.531802] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[335.580852] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.053s)
[336.757705] [111/155] (685s left) kms_cursor_crc (cursor-random-256x85)
[337.007809] Starting subtest: cursor-random-256x85
[337.053093] Subtest cursor-random-256x85: SKIP (0.043s)
[337.217227] [112/155] (684s left) fbdev (pan)
[337.254275] Starting subtest: pan
[337.275848] Subtest pan: SUCCESS (0.026s)
[337.358089] [113/155] (684s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt)
[337.446758] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt
[337.450758] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[337.547308] [114/155] (684s left) i915_hangman (detector)
[337.611066] Starting subtest: detector
[337.613364] Starting dynamic subtest: rcs0
[349.287996] Dynamic subtest rcs0: SUCCESS (11.675s)
[349.301068] Starting dynamic subtest: bcs0
[361.255870] Dynamic subtest bcs0: SUCCESS (11.964s)
[361.275943] Starting dynamic subtest: vcs0
[373.223074] Dynamic subtest vcs0: SUCCESS (11.964s)
[373.235550] Starting dynamic subtest: vcs1
[384.294861] Dynamic subtest vcs1: SUCCESS (11.068s)
[384.309999] Starting dynamic subtest: vecs0
[396.199612] Dynamic subtest vecs0: SUCCESS (11.902s)
[396.213219] Starting dynamic subtest: ccs0
[408.296073] Dynamic subtest ccs0: SUCCESS (12.093s)
[408.299447] Subtest detector: SUCCESS (70.683s)
[408.457374] [115/155] (613s left) gem_exec_params (no-vebox)
[408.513509] Starting subtest: no-vebox
[408.518813] Subtest no-vebox: SUCCESS (0.003s)
[410.359871] [116/155] (611s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[410.456044] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[410.460360] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[410.540621] [117/155] (611s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[410.641051] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[410.645278] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[410.759864] [118/155] (611s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[410.873604] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[410.877700] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[410.969027] [119/155] (611s left) i915_pm_rps (reset)
[411.030600] Starting subtest: reset
[419.472847] Subtest reset: SUCCESS (8.441s)
[419.618062] [120/155] (602s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[419.684139] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[419.740227] [121/155] (602s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[419.837062] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[419.839471] Starting dynamic subtest: pipe-A-eDP-1
[419.865126] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[419.877301] Starting dynamic subtest: pipe-B-eDP-1
[419.901119] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[419.910615] Starting dynamic subtest: pipe-C-eDP-1
[419.934375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[419.943310] Starting dynamic subtest: pipe-D-eDP-1
[419.967343] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[419.971719] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[422.091989] [122/155] (600s left) gem_ctx_engines (independent)
[422.147067] Starting subtest: independent
[422.149486] Starting dynamic subtest: rcs0
[422.300893] Dynamic subtest rcs0: SUCCESS (0.152s)
[422.311249] Starting dynamic subtest: bcs0
[422.444050] Dynamic subtest bcs0: SUCCESS (0.143s)
[422.456985] Starting dynamic subtest: vcs0
[422.592529] Dynamic subtest vcs0: SUCCESS (0.147s)
[422.605740] Starting dynamic subtest: vcs1
[422.770358] Dynamic subtest vcs1: SUCCESS (0.177s)
[422.783076] Starting dynamic subtest: vecs0
[422.947535] Dynamic subtest vecs0: SUCCESS (0.176s)
[422.958171] Starting dynamic subtest: ccs0
[423.119596] Dynamic subtest ccs0: SUCCESS (0.171s)
[423.132125] Starting dynamic subtest: all-engines
[423.844290] Dynamic subtest all-engines: SUCCESS (0.724s)
[423.846695] Subtest independent: SUCCESS (1.696s)
[424.466884] [123/155] (597s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[424.563138] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[431.422417] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.863s)
[431.538675] [124/155] (590s left) gen7_exec_parse (oacontrol-tracking)
[431.604643] Subtest oacontrol-tracking: SKIP (0.000s)
[431.683411] [125/155] (590s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[431.778229] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[431.782573] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[431.866448] [126/155] (590s left) kms_setmode (invalid-clone-single-crtc)
[431.917832] Starting subtest: invalid-clone-single-crtc
[431.924310] Subtest invalid-clone-single-crtc: SKIP (0.001s)
[432.035826] [127/155] (590s left) syncobj_timeline (etime-multi-wait-all-submitted)
[432.083687] Starting subtest: etime-multi-wait-all-submitted
[432.189058] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[432.268050] [128/155] (590s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[432.365701] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[432.369971] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[432.482107] [129/155] (590s left) kms_lease (lessee-list)
[432.571527] Starting subtest: lessee-list
[432.573999] Starting dynamic subtest: pipe-A-eDP-1
[432.576381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[432.586566] Starting dynamic subtest: pipe-B-eDP-1
[432.588445] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[432.597495] Starting dynamic subtest: pipe-C-eDP-1
[432.599492] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[432.608742] Starting dynamic subtest: pipe-D-eDP-1
[432.610733] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[432.612615] Subtest lessee-list: SUCCESS (0.009s)
[432.691435] [130/155] (589s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[432.796264] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[432.798630] Starting dynamic subtest: pipe-A-default-mode
[435.589415] Dynamic subtest pipe-A-default-mode: SUCCESS (2.791s)
[435.591436] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.793s)
[436.425111] [131/155] (586s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[436.537278] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[443.901529] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.369s)
[444.027481] [132/155] (578s left) gem_exec_schedule (submit-late-slice)
[444.098683] Starting subtest: submit-late-slice
[444.101076] Starting dynamic subtest: rcs0
[444.134111] Dynamic subtest rcs0: SUCCESS (0.040s)
[444.145458] Starting dynamic subtest: bcs0
[444.174385] Dynamic subtest bcs0: SUCCESS (0.039s)
[444.185243] Starting dynamic subtest: vcs0
[444.215442] Dynamic subtest vcs0: SUCCESS (0.041s)
[444.225927] Starting dynamic subtest: vcs1
[444.248943] Dynamic subtest vcs1: SUCCESS (0.033s)
[444.259432] Starting dynamic subtest: vecs0
[444.287028] Dynamic subtest vecs0: SUCCESS (0.037s)
[444.296524] Starting dynamic subtest: ccs0
[444.327756] Dynamic subtest ccs0: SUCCESS (0.040s)
[444.330092] Subtest submit-late-slice: SUCCESS (0.234s)
[445.426750] [133/155] (577s left) gem_wait (invalid-flags)
[445.485201] Starting subtest: invalid-flags
[445.487569] Subtest invalid-flags: SUCCESS (0.000s)
[445.689430] [134/155] (577s left) gem_exec_schedule (lateslice)
[445.759644] Starting subtest: lateslice
[445.761720] Starting dynamic subtest: rcs0
[445.770386] Dynamic subtest rcs0: SUCCESS (0.021s)
[445.781136] Starting dynamic subtest: bcs0
[445.788863] Dynamic subtest bcs0: SUCCESS (0.017s)
[445.799721] Starting dynamic subtest: vcs0
[445.806592] Dynamic subtest vcs0: SUCCESS (0.017s)
[445.816094] Starting dynamic subtest: vcs1
[445.824715] Dynamic subtest vcs1: SUCCESS (0.017s)
[445.837056] Starting dynamic subtest: vecs0
[445.843582] Dynamic subtest vecs0: SUCCESS (0.018s)
[445.853355] Starting dynamic subtest: ccs0
[445.862724] Dynamic subtest ccs0: SUCCESS (0.019s)
[445.864918] Subtest lateslice: SUCCESS (0.114s)
[447.395190] [135/155] (575s left) kms_async_flips (async-flip-suspend-resume)
[447.497611] Starting subtest: async-flip-suspend-resume
[447.881782] Starting dynamic subtest: pipe-A-eDP-1
[466.226003] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.949s)
[466.596139] Starting dynamic subtest: pipe-B-eDP-1
[485.304083] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.263s)
[485.681612] Starting dynamic subtest: pipe-C-eDP-1
[504.029279] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.949s)
[504.402484] Starting dynamic subtest: pipe-D-eDP-1
[522.242479] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.156s)
[522.244834] Subtest async-flip-suspend-resume: SUCCESS (14.823s)
[523.401085] [136/155] (499s left) gem_mmap (short-mmap)
[523.469270] Subtest short-mmap: SKIP (0.000s)
[523.531688] [137/155] (499s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[523.624156] Starting subtest: x-tiled-16bpp-rotate-270
[523.642951] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[523.778279] [138/155] (499s left) gem_watchdog (default-physical)
[523.848442] Starting subtest: default-physical
[525.604441] Subtest default-physical: SUCCESS (1.823s)
[525.699181] [139/155] (497s left) gem_ppgtt (shrink-vs-evict-any)
[525.766599] Starting subtest: shrink-vs-evict-any
[531.484188] Subtest shrink-vs-evict-any: SUCCESS (5.827s)
[531.570264] [140/155] (491s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[531.679837] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[531.684264] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[531.793275] [141/155] (491s left) gem_exec_reloc (basic-gtt-wc)
[531.853250] Subtest basic-gtt-wc: SKIP (0.000s)
[531.939428] [142/155] (491s left) gem_ctx_shared (exec-shared-gtt)
[532.011404] Starting subtest: exec-shared-gtt
[532.013780] Starting dynamic subtest: rcs0
[532.016133] Dynamic subtest rcs0: SUCCESS (0.006s)
[532.029084] Starting dynamic subtest: bcs0
[532.031354] Dynamic subtest bcs0: SUCCESS (0.005s)
[532.041661] Starting dynamic subtest: vcs0
[532.043987] Dynamic subtest vcs0: SUCCESS (0.005s)
[532.054371] Starting dynamic subtest: vcs1
[532.056190] Dynamic subtest vcs1: SUCCESS (0.006s)
[532.065946] Starting dynamic subtest: vecs0
[532.067755] Dynamic subtest vecs0: SUCCESS (0.007s)
[532.077333] Starting dynamic subtest: ccs0
[532.079174] Dynamic subtest ccs0: SUCCESS (0.004s)
[532.081023] Subtest exec-shared-gtt: SUCCESS (0.039s)
[532.234910] [143/155] (490s left) dumb_buffer (map-invalid-size)
[532.294460] Starting subtest: map-invalid-size
[532.296795] Subtest map-invalid-size: SUCCESS (0.000s)
[532.418313] [144/155] (490s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[532.519845] Starting subtest: fbcpsr-slowdraw
[557.708458] Subtest fbcpsr-slowdraw: SUCCESS (25.276s)
[557.869040] [145/155] (465s left) syncobj_timeline (invalid-transfer-illegal-handle)
[557.935247] Starting subtest: invalid-transfer-illegal-handle
[557.937719] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[558.046148] [146/155] (465s left) kms_pm_rpm (i2c)
[559.673071] Starting subtest: i2c
[564.955553] Subtest i2c: SUCCESS (5.271s)
[565.066415] [147/155] (458s left) kms_flip (blocking-absolute-wf_vblank)
[565.164795] Starting subtest: blocking-absolute-wf_vblank
[565.167123] Starting dynamic subtest: A-eDP1
[573.891790] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[573.905057] Starting dynamic subtest: B-eDP1
[582.630527] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[582.641750] Starting dynamic subtest: C-eDP1
[591.360428] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[591.372649] Starting dynamic subtest: D-eDP1
[600.090281] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[600.092752] Subtest blocking-absolute-wf_vblank: SUCCESS (34.916s)
[601.314988] [148/155] (422s left) gem_mmap_gtt (hang-busy)
[601.371330] Subtest hang-busy: SKIP (0.000s)
[601.440011] [149/155] (421s left) kms_getfb (getfb-handle-protection)
[601.532617] Starting subtest: getfb-handle-protection
[601.550975] Subtest getfb-handle-protection: SUCCESS (0.019s)
[601.676233] [150/155] (421s left) syncobj_timeline (reset-unsignaled)
[601.725164] Starting subtest: reset-unsignaled
[601.727519] Subtest reset-unsignaled: SUCCESS (0.000s)
[601.810189] [151/155] (421s left) syncobj_wait (multi-wait-submitted)
[601.859755] Starting subtest: multi-wait-submitted
[601.959794] Subtest multi-wait-submitted: SUCCESS (0.101s)
[602.061427] [152/155] (421s left) gem_exec_reloc (basic-write-wc)
[602.125284] Subtest basic-write-wc: SKIP (0.000s)
[602.193679] [153/155] (421s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[602.325541] Starting subtest: basic-busy-flip-before-cursor-varying-size
[602.329333] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[602.482689] [154/155] (421s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[602.576879] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[602.580539] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[602.670838] [155/155] (421s left) kms_tiled_display (basic-test-pattern)
[602.787344] Subtest basic-test-pattern: SKIP (0.000s)
[602.830837] Closing watchdogs
results: parsing output: 0/ for test: syncobj_eventfd
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_userptr_blits
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: kms_panel_fitting
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_sync
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_chamelium_audio
results: parsing output: 24/ for test: gem_partial_pwrite_pread
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_rotation_crc
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_joiner
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: gem_bad_reloc
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: sysfs_heartbeat_interval
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: kms_chamelium_color
results: parsing output: 44/ for test: gem_exec_reloc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_plane_alpha_blend
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: gem_exec_parallel
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_content_protection
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_atomic_interruptible
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: api_intel_allocator
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gem_ctx_param
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: gem_pread
results: parsing output: 77/ for test: gem_gpgpu_fill
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_feature_discovery
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_atomic
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_vblank
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: i915_pm_rps
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: fbdev
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_hangman
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: i915_pm_rps
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_ctx_engines
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gen7_exec_parse
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_setmode
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: gem_wait
results: parsing output: 133/ for test: gem_exec_schedule
results: parsing output: 134/ for test: kms_async_flips
results: parsing output: 135/ for test: gem_mmap
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: gem_watchdog
results: parsing output: 138/ for test: gem_ppgtt
results: parsing output: 139/ for test: kms_big_fb
results: parsing output: 140/ for test: gem_exec_reloc
results: parsing output: 141/ for test: gem_ctx_shared
results: parsing output: 142/ for test: dumb_buffer
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: syncobj_timeline
results: parsing output: 145/ for test: kms_pm_rpm
results: parsing output: 146/ for test: kms_flip
results: parsing output: 147/ for test: gem_mmap_gtt
results: parsing output: 148/ for test: kms_getfb
results: parsing output: 149/ for test: syncobj_timeline
results: parsing output: 150/ for test: syncobj_wait
results: parsing output: 151/ for test: gem_exec_reloc
results: parsing output: 152/ for test: kms_cursor_legacy
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_tiled_display
Done.