[54.423802] Initializing watchdogs
[54.423852]   /dev/watchdog0
[54.437774] [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]
[54.442045] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.444357] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.447643] [001/130] (960s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[54.520509] Starting subtest: y-tiled-to-vebox-y-tiled
[54.525257] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[54.700376] [002/130] (960s left) gem_exec_reloc (basic-cpu-read)
[54.769208] Subtest basic-cpu-read: SKIP (0.000s)
[54.831227] [003/130] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[54.950603] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[59.186463] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.240s)
[60.394041] [004/130] (954s left) gem_exec_schedule (noreorder-corked)
[60.582625] Starting subtest: noreorder-corked
[60.585164] Starting dynamic subtest: rcs0
[61.731536] Dynamic subtest rcs0: SUCCESS (1.150s)
[61.740478] Starting dynamic subtest: vcs0
[62.953359] Dynamic subtest vcs0: SUCCESS (1.221s)
[62.963228] Starting dynamic subtest: vcs1
[64.912824] Dynamic subtest vcs1: SUCCESS (1.958s)
[64.921374] Starting dynamic subtest: vecs0
[66.920907] Dynamic subtest vecs0: SUCCESS (2.008s)
[66.929471] Starting dynamic subtest: ccs0
[68.079318] Dynamic subtest ccs0: SUCCESS (1.160s)
[68.081776] Subtest noreorder-corked: SUCCESS (7.498s)
[68.257783] [005/130] (946s left) kms_vblank (query-idle-hang)
[68.360055] Starting subtest: query-idle-hang
[68.362467] Starting dynamic subtest: pipe-A-eDP-1
[94.664661] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.302s)
[94.677627] Starting dynamic subtest: pipe-D-eDP-1
[109.642850] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.974s)
[109.644778] Subtest query-idle-hang: SUCCESS (41.280s)
[110.507559] [006/130] (904s left) gem_bad_reloc (negative-reloc-lut)
[110.575933] Subtest negative-reloc-lut: SKIP (0.000s)
[110.653153] [007/130] (904s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[110.753589] Starting subtest: psr-rgb101010-draw-render
[117.967961] Subtest psr-rgb101010-draw-render: SUCCESS (7.217s)
[118.101492] [008/130] (897s left) syncobj_eventfd (binary-wait-before-signal)
[118.158046] Starting subtest: binary-wait-before-signal
[118.186911] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[118.256934] [009/130] (896s left) kms_plane_multiple (tiling-yf)
[118.356128] Starting subtest: tiling-yf
[118.360784] Subtest tiling-yf: SKIP (0.000s)
[118.427334] [010/130] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[118.524308] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[125.512606] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.991s)
[125.631452] [011/130] (889s left) perf (gen12-oa-tlb-invalidate)
[125.742951] Starting subtest: gen12-oa-tlb-invalidate
[125.744845] Starting dynamic subtest: 0-rcs0
[135.791132] Dynamic subtest 0-rcs0: SUCCESS (10.048s)
[135.798340] Starting dynamic subtest: 1-vcs0
[145.837343] Dynamic subtest 1-vcs0: SUCCESS (10.046s)
[145.839631] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.094s)
[145.881889] [012/130] (869s left) vgem_basic (second-client)
[145.952322] Starting subtest: second-client
[145.973971] Subtest second-client: SUCCESS (0.022s)
[146.025224] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[146.028347] [013/130] (869s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[151.035209] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[151.039732] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[151.888540] [014/130] (863s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[151.985363] Starting subtest: primary-y-tiled-reflect-x-270
[151.990044] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[152.056816] [015/130] (863s left) gem_caching (reads)
[152.125510] Subtest reads: SKIP (0.000s)
[152.216400] [016/130] (863s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[152.314472] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[152.326458] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[152.397506] [017/130] (863s left) syncobj_wait (single-wait-all-submitted)
[152.461064] Starting subtest: single-wait-all-submitted
[152.566852] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[152.639807] [018/130] (862s left) gem_mmap_offset (blt-coherency)
[152.694505] Starting subtest: blt-coherency
[152.699921] Subtest blt-coherency: SUCCESS (0.008s)
[152.834711] [019/130] (862s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[152.937390] Starting subtest: x-tiled-8bpp-rotate-180
[154.126830] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.191s)
[154.262019] [020/130] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[154.364090] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[154.367845] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[154.468249] [021/130] (861s left) gen9_exec_parse (bb-start-cmd)
[154.519852] Subtest bb-start-cmd: SKIP (0.000s)
[154.574366] [022/130] (861s left) gem_exec_flush (basic-wb-pro-default)
[154.644603] Starting subtest: basic-wb-pro-default
[160.095504] Subtest basic-wb-pro-default: SUCCESS (5.450s)
[160.279876] [023/130] (855s left) kms_scaling_modes (scaling-mode-full-aspect)
[160.383052] Starting subtest: scaling-mode-full-aspect
[160.385403] Starting dynamic subtest: pipe-A-eDP-1
[160.486709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.103s)
[160.495161] Starting dynamic subtest: pipe-B-eDP-1
[161.608784] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.121s)
[161.617083] Starting dynamic subtest: pipe-C-eDP-1
[162.713262] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[162.721626] Starting dynamic subtest: pipe-D-eDP-1
[163.839262] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[163.841588] Subtest scaling-mode-full-aspect: SUCCESS (3.456s)
[164.985016] [024/130] (850s left) syncobj_wait (single-wait-all-for-submit-signaled)
[165.049574] Starting subtest: single-wait-all-for-submit-signaled
[165.051761] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[165.155078] [025/130] (850s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[165.259281] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[174.581477] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (9.325s)
[174.713910] [026/130] (841s left) gem_userptr_blits (coherency-unsync)
[174.768189] Subtest coherency-unsync: SKIP (0.000s)
[174.909349] [027/130] (841s left) kms_chamelium_hpd (dp-hpd)
[175.290461] Subtest dp-hpd: SKIP (0.000s)
[176.116700] [028/130] (839s left) sw_sync (alloc_fence)
[176.152830] Starting subtest: alloc_fence
[176.155083] Subtest alloc_fence: SUCCESS (0.000s)
[176.205011] [029/130] (839s left) gem_workarounds (basic-read)
[176.265321] Starting subtest: basic-read
[176.276341] Subtest basic-read: SUCCESS (0.011s)
[176.398779] [030/130] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[176.504133] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[183.251880] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.752s)
[183.386401] [031/130] (832s left) perf (whitelisted-registers-userspace-config)
[183.475418] Starting subtest: whitelisted-registers-userspace-config
[183.477836] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[183.516979] [032/130] (832s left) gem_create (create-clear)
[183.569587] Starting subtest: create-clear
[183.572057] Starting dynamic subtest: smem0
[216.339098] Dynamic subtest smem0: SUCCESS (32.766s)
[216.341084] Subtest create-clear: SUCCESS (32.766s)
[216.521941] [033/130] (799s left) gem_close (many-handles-one-vma)
[216.576982] Starting subtest: many-handles-one-vma
[216.626755] Subtest many-handles-one-vma: SUCCESS (0.051s)
[216.766359] [034/130] (799s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[216.865265] Starting subtest: bad-aux-stride-yf-tiled-ccs
[216.867536] Starting dynamic subtest: pipe-A-eDP-1
[216.889905] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[216.898934] Starting dynamic subtest: pipe-B-eDP-1
[216.920687] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[216.927613] Starting dynamic subtest: pipe-C-eDP-1
[216.950680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[216.957718] Starting dynamic subtest: pipe-D-eDP-1
[216.979806] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[216.983832] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[219.070853] [035/130] (797s left) kms_cursor_crc (cursor-sliding-32x10)
[219.242811] Starting subtest: cursor-sliding-32x10
[219.287940] Subtest cursor-sliding-32x10: SKIP (0.040s)
[219.553935] [036/130] (796s left) api_intel_bb (simple-bb-ctx)
[219.609287] Starting subtest: simple-bb-ctx
[219.616321] Subtest simple-bb-ctx: SUCCESS (0.009s)
[219.743470] [037/130] (796s left) syncobj_eventfd (invalid-illegal-eventfd)
[219.796860] Starting subtest: invalid-illegal-eventfd
[219.799156] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[219.884602] [038/130] (796s left) gem_exec_reloc (basic-wc-read-noreloc)
[219.938509] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[220.016277] [039/130] (796s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[220.109288] Starting subtest: fbcpsr-tiling-4
[227.170568] Subtest fbcpsr-tiling-4: SUCCESS (7.063s)
[227.324263] [040/130] (789s left) gem_mmap_gtt (basic-small-bo-tiledy)
[227.386643] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[227.439727] [041/130] (789s left) gem_exec_reloc (basic-write-wc-active)
[227.499646] Subtest basic-write-wc-active: SKIP (0.000s)
[227.566091] [042/130] (788s left) gem_exec_balancer (persistence)
[227.827050] Starting subtest: persistence
[228.718052] Subtest persistence: SUCCESS (0.890s)
[228.853915] [043/130] (787s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[228.947167] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[228.949459] Starting dynamic subtest: pipe-A-eDP-1
[228.971446] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[228.980083] Starting dynamic subtest: pipe-B-eDP-1
[229.001393] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[229.009024] Starting dynamic subtest: pipe-C-eDP-1
[229.030798] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[229.038075] Starting dynamic subtest: pipe-D-eDP-1
[229.060239] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[229.064251] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[231.224101] [044/130] (785s left) kms_flip (flip-vs-suspend)
[231.325882] Starting subtest: flip-vs-suspend
[231.328151] Starting dynamic subtest: A-eDP1
[280.567254] Dynamic subtest A-eDP1: SUCCESS (4.464s)
[280.574900] Starting dynamic subtest: B-eDP1
[329.570474] Dynamic subtest B-eDP1: SUCCESS (4.278s)
[329.581092] Starting dynamic subtest: C-eDP1
[378.571675] Dynamic subtest C-eDP1: SUCCESS (4.330s)
[378.584784] Starting dynamic subtest: D-eDP1
[427.573047] Dynamic subtest D-eDP1: SUCCESS (4.331s)
[427.575341] Subtest flip-vs-suspend: SUCCESS (17.414s)
[428.788290] [045/130] (587s left) kms_setmode (invalid-clone-single-crtc)
[428.857069] Starting subtest: invalid-clone-single-crtc
[428.864037] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[428.950951] [046/130] (587s left) sw_sync (sync_busy_fork)
[428.981232] Starting subtest: sync_busy_fork
[429.993805] Subtest sync_busy_fork: SUCCESS (1.012s)
[430.055367] [047/130] (586s left) kms_pm_rpm (pc8-residency)
[431.878612] Starting subtest: pc8-residency
[431.883697] Subtest pc8-residency: SKIP (0.000s)
[432.319114] [048/130] (584s left) gem_exec_reloc (basic-write-gtt-noreloc)
[432.384309] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[432.470844] [049/130] (584s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[432.576269] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[432.580335] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[432.673870] [050/130] (584s left) perf (invalid-open-flags)
[432.745806] Starting subtest: invalid-open-flags
[432.748606] Subtest invalid-open-flags: SUCCESS (0.000s)
[432.796045] [051/130] (584s left) kms_psr (fbc-pr-cursor-render)
[432.882341] Starting subtest: fbc-pr-cursor-render
[432.887818] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[432.954117] [052/130] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[433.054654] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[433.059204] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[433.156563] [053/130] (583s left) kms_plane_scaling (intel-max-src-size)
[433.250949] Starting subtest: intel-max-src-size
[433.256979] Subtest intel-max-src-size: SKIP (0.001s)
[433.349998] [054/130] (583s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[433.446141] Starting subtest: modeset-transition-nonblocking-fencing
[433.447781] Starting dynamic subtest: 1x-outputs
[444.469374] Dynamic subtest 1x-outputs: SUCCESS (11.018s)
[444.755467] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.303s)
[445.582955] [055/130] (571s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[445.675754] Starting subtest: compare-crc-sanitycheck-xr24
[445.678474] Starting dynamic subtest: pipe-A-eDP-1
[446.285275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[446.294879] Starting dynamic subtest: pipe-B-eDP-1
[447.530566] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s)
[447.540815] Starting dynamic subtest: pipe-C-eDP-1
[448.714293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s)
[448.727696] Starting dynamic subtest: pipe-D-eDP-1
[449.931611] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[449.934348] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.255s)
[450.786758] [056/130] (566s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[455.736000] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[455.739042] Starting dynamic subtest: pipe-A-eDP-1
[467.778583] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.037s)
[467.787848] Starting dynamic subtest: pipe-B-eDP-1
[479.804449] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.020s)
[479.807030] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.061s)
[480.635710] [057/130] (536s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[480.736172] Starting subtest: psr-1p-primscrn-spr-indfb-move
[488.133760] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.398s)
[488.290097] [058/130] (528s left) gem_exec_suspend (basic-s3)
[488.357788] Starting subtest: basic-S3
[488.360456] Starting dynamic subtest: smem
[508.594144] Dynamic subtest smem: SUCCESS (6.390s)
[508.597265] Subtest basic-S3: SUCCESS (6.392s)
[508.777292] [059/130] (508s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[508.888520] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[508.890671] Starting dynamic subtest: pipe-A
[509.938634] Dynamic subtest pipe-A: SUCCESS (1.050s)
[509.946676] Starting dynamic subtest: pipe-B
[512.074635] Dynamic subtest pipe-B: SUCCESS (2.134s)
[512.082824] Starting dynamic subtest: pipe-C
[513.273916] Dynamic subtest pipe-C: SUCCESS (1.198s)
[513.282474] Starting dynamic subtest: pipe-D
[514.403730] Dynamic subtest pipe-D: SUCCESS (1.128s)
[514.406428] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.512s)
[515.597249] [060/130] (501s left) i915_drm_fdinfo (most-busy-check-all)
[515.639832] Starting subtest: most-busy-check-all
[515.642566] Starting dynamic subtest: rcs0
[515.647535] Dynamic subtest rcs0: SKIP (0.005s)
[515.656194] Starting dynamic subtest: bcs0
[515.661507] Dynamic subtest bcs0: SKIP (0.000s)
[515.675019] Starting dynamic subtest: vcs0
[515.680004] Dynamic subtest vcs0: SKIP (0.000s)
[515.689143] Starting dynamic subtest: vcs1
[515.694076] Dynamic subtest vcs1: SKIP (0.000s)
[515.701896] Starting dynamic subtest: vecs0
[515.707214] Dynamic subtest vecs0: SKIP (0.000s)
[515.715244] Starting dynamic subtest: ccs0
[515.720237] Dynamic subtest ccs0: SKIP (0.000s)
[515.724740] Subtest most-busy-check-all: SKIP (0.009s)
[515.760509] [061/130] (501s left) kms_chamelium_audio (dp-audio)
[516.199664] Subtest dp-audio: SKIP (0.000s)
[517.007651] [062/130] (500s left) kms_big_fb (y-tiled-addfb-size-overflow)
[517.112761] Starting subtest: y-tiled-addfb-size-overflow
[517.117433] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[517.202823] [063/130] (500s left) kms_rmfb (close-fd)
[517.285540] Starting subtest: close-fd
[517.287982] Starting dynamic subtest: pipe-A-eDP-1
[517.396596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[517.405331] Starting dynamic subtest: pipe-B-eDP-1
[518.584276] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s)
[518.592959] Starting dynamic subtest: pipe-C-eDP-1
[519.717422] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[519.725627] Starting dynamic subtest: pipe-D-eDP-1
[520.824715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.105s)
[520.827123] Subtest close-fd: SUCCESS (3.535s)
[522.019896] [064/130] (495s left) syncobj_timeline (signal)
[522.080543] Starting subtest: signal
[522.082919] Subtest signal: SUCCESS (0.000s)
[522.195495] [065/130] (495s left) gem_eio (in-flight-immediate)
[522.428591] Starting subtest: in-flight-immediate
[530.637599] Subtest in-flight-immediate: SUCCESS (8.205s)
[530.790799] [066/130] (486s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[530.878748] Starting subtest: async-flip-with-page-flip-events-tiled
[531.263165] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[533.996182] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.733s)
[534.005632] Starting dynamic subtest: pipe-A-eDP-1-4
[536.183052] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[536.192282] Starting dynamic subtest: pipe-A-eDP-1-4
[538.193861] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[538.203037] Starting dynamic subtest: pipe-A-eDP-1-x
[540.385173] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[540.752013] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[543.517940] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.774s)
[543.527348] Starting dynamic subtest: pipe-B-eDP-1-4
[545.704588] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[545.717149] Starting dynamic subtest: pipe-B-eDP-1-4
[547.714047] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[547.723626] Starting dynamic subtest: pipe-B-eDP-1-x
[549.915573] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[550.277019] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[553.042175] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[553.054468] Starting dynamic subtest: pipe-C-eDP-1-4
[555.228743] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[555.241192] Starting dynamic subtest: pipe-C-eDP-1-4
[557.238192] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[557.253790] Starting dynamic subtest: pipe-C-eDP-1-x
[559.417813] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[559.780176] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[562.563443] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[562.572892] Starting dynamic subtest: pipe-D-eDP-1-4
[564.739006] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[564.748152] Starting dynamic subtest: pipe-D-eDP-1-4
[566.749229] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[566.759269] Starting dynamic subtest: pipe-D-eDP-1-x
[568.951169] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s)
[568.953898] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.066s)
[570.146236] [067/130] (447s left) gem_tiled_partial_pwrite_pread (writes)
[570.218762] Subtest writes: SKIP (0.000s)
[570.290734] [068/130] (447s left) i915_pm_rpm (system-suspend-devices)
[571.808851] Starting subtest: system-suspend-devices
[579.368003] Subtest system-suspend-devices: SUCCESS (7.557s)
[579.735878] [069/130] (437s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[579.836494] Starting subtest: fbc-psr2-sprite-mmap-gtt
[579.838470] Starting dynamic subtest: eDP-1
[579.842587] Dynamic subtest eDP-1: SKIP (0.000s)
[579.847290] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[579.910283] [070/130] (437s left) gem_ctx_engines (independent)
[579.967761] Starting subtest: independent
[579.970471] Starting dynamic subtest: rcs0
[580.110000] Dynamic subtest rcs0: SUCCESS (0.140s)
[580.122459] Starting dynamic subtest: bcs0
[580.206167] Dynamic subtest bcs0: SUCCESS (0.097s)
[580.220821] Starting dynamic subtest: vcs0
[580.322422] Dynamic subtest vcs0: SUCCESS (0.115s)
[580.334777] Starting dynamic subtest: vcs1
[580.433057] Dynamic subtest vcs1: SUCCESS (0.110s)
[580.445435] Starting dynamic subtest: vecs0
[580.546430] Dynamic subtest vecs0: SUCCESS (0.113s)
[580.558012] Starting dynamic subtest: ccs0
[580.673008] Dynamic subtest ccs0: SUCCESS (0.124s)
[580.684752] Starting dynamic subtest: all-engines
[581.238808] Dynamic subtest all-engines: SUCCESS (0.566s)
[581.241273] Subtest independent: SUCCESS (1.271s)
[581.699820] [071/130] (435s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[581.803869] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[588.312767] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.513s)
[588.435401] [072/130] (429s left) gem_ctx_persistence (engines-hang)
[588.494992] Starting subtest: engines-hang
[588.498019] Starting dynamic subtest: rcs0
[588.570237] Dynamic subtest rcs0: SUCCESS (0.075s)
[588.581878] Starting dynamic subtest: bcs0
[588.661120] Dynamic subtest bcs0: SUCCESS (0.090s)
[588.673752] Starting dynamic subtest: vcs0
[588.771214] Dynamic subtest vcs0: SUCCESS (0.108s)
[588.782672] Starting dynamic subtest: vcs1
[588.883272] Dynamic subtest vcs1: SUCCESS (0.111s)
[588.895805] Starting dynamic subtest: vecs0
[589.012036] Dynamic subtest vecs0: SUCCESS (0.127s)
[589.024004] Starting dynamic subtest: ccs0
[589.142858] Dynamic subtest ccs0: SUCCESS (0.129s)
[589.145596] Subtest engines-hang: SUCCESS (0.649s)
[589.219312] [073/130] (428s left) api_intel_bb (blit-noreloc-purge-cache)
[589.281678] Starting subtest: blit-noreloc-purge-cache
[589.290686] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[589.418477] [074/130] (428s left) gem_exec_parallel (engines)
[589.476281] Starting subtest: engines
[589.478564] Starting dynamic subtest: basic
[591.602796] Dynamic subtest basic: SUCCESS (2.125s)
[591.613859] Starting dynamic subtest: contexts
[595.949232] Dynamic subtest contexts: SUCCESS (4.343s)
[595.960800] Starting dynamic subtest: fds
[599.749456] Dynamic subtest fds: SUCCESS (3.798s)
[599.761767] Starting dynamic subtest: userptr
[601.587534] Dynamic subtest userptr: SUCCESS (1.837s)
[601.590469] Subtest engines: SUCCESS (12.110s)
[601.777618] [075/130] (416s left) vgem_basic (dmabuf-export)
[601.827833] Starting subtest: dmabuf-export
[601.866261] Subtest dmabuf-export: SUCCESS (0.041s)
[601.994498] [076/130] (415s left) kms_invalid_mode (bad-htotal)
[602.099322] Starting subtest: bad-htotal
[602.101816] Starting dynamic subtest: pipe-A-eDP-1
[602.393028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[602.402846] Starting dynamic subtest: pipe-B-eDP-1
[602.405681] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[602.414492] Starting dynamic subtest: pipe-C-eDP-1
[602.416900] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[602.425669] Starting dynamic subtest: pipe-D-eDP-1
[602.428008] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[602.430585] Subtest bad-htotal: SUCCESS (0.301s)
[603.262557] [077/130] (414s left) gem_eio (context-create)
[603.498896] Starting subtest: context-create
[603.863385] Subtest context-create: SUCCESS (0.363s)
[604.017160] [078/130] (413s left) gem_exec_whisper (basic-queues-priority-all)
[604.078616] Starting subtest: basic-queues-priority-all
[626.972821] Subtest basic-queues-priority-all: SUCCESS (22.886s)
[627.155159] [079/130] (390s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[627.553015] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[628.376478] [080/130] (389s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[628.439804] Starting subtest: single-wait-for-submit-available-signaled
[628.442200] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[628.535445] [081/130] (389s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[628.622659] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[628.625113] Starting dynamic subtest: pipe-A-default-mode
[631.310745] Dynamic subtest pipe-A-default-mode: SUCCESS (2.683s)
[631.313634] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.684s)
[632.163799] [082/130] (385s left) i915_module_load (resize-bar)
[632.201220] Starting subtest: resize-bar
[632.209397] Subtest resize-bar: SKIP (0.006s)
[632.254858] [083/130] (385s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[632.358121] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[632.362790] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[632.441181] [084/130] (385s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[632.501912] Starting subtest: etime-single-wait-all-for-submit-submitted
[632.606006] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[632.685712] [085/130] (385s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[632.791741] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[637.233647] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.446s)
[638.343541] [086/130] (379s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[638.454967] Starting subtest: x-tiled-32bpp-rotate-270
[638.476226] Subtest x-tiled-32bpp-rotate-270: SKIP (0.021s)
[638.599593] [087/130] (379s left) kms_cursor_crc (cursor-random-512x512)
[638.886710] Starting subtest: cursor-random-512x512
[638.891638] Subtest cursor-random-512x512: SKIP (0.001s)
[639.058956] [088/130] (379s left) vgem_basic (mmap)
[639.108105] Starting subtest: mmap
[639.165899] Subtest mmap: SUCCESS (0.060s)
[639.226309] [089/130] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[639.320765] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[639.324377] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[639.426095] [090/130] (379s left) gen3_render_mixed_blits
[639.542601] [091/130] (378s left) gem_exec_schedule (u-lateslice)
[639.602855] Starting subtest: u-lateslice
[639.604722] Starting dynamic subtest: rcs0
[639.615746] Dynamic subtest rcs0: SUCCESS (0.022s)
[639.625831] Starting dynamic subtest: bcs0
[639.633901] Dynamic subtest bcs0: SUCCESS (0.017s)
[639.643725] Starting dynamic subtest: vcs0
[639.651131] Dynamic subtest vcs0: SUCCESS (0.017s)
[639.660009] Starting dynamic subtest: vcs1
[639.669287] Dynamic subtest vcs1: SUCCESS (0.018s)
[639.678406] Starting dynamic subtest: vecs0
[639.687396] Dynamic subtest vecs0: SUCCESS (0.018s)
[639.696163] Starting dynamic subtest: ccs0
[639.705204] Dynamic subtest ccs0: SUCCESS (0.017s)
[639.707364] Subtest u-lateslice: SUCCESS (0.112s)
[641.664347] [092/130] (376s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[641.753546] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[641.756573] Starting dynamic subtest: pipe-A-eDP-1
[641.767483] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[641.781161] Starting dynamic subtest: pipe-B-eDP-1
[641.791190] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[641.802764] Starting dynamic subtest: pipe-C-eDP-1
[641.812535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[641.822355] Starting dynamic subtest: pipe-D-eDP-1
[641.832497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[641.842560] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[643.888570] [093/130] (374s left) kms_flip (plain-flip-fb-recreate-interruptible)
[643.993340] Starting subtest: plain-flip-fb-recreate-interruptible
[643.995841] Starting dynamic subtest: A-eDP1
[652.873659] Dynamic subtest A-eDP1: SUCCESS (8.879s)
[652.886629] Starting dynamic subtest: B-eDP1
[661.692808] Dynamic subtest B-eDP1: SUCCESS (8.815s)
[661.702588] Starting dynamic subtest: C-eDP1
[670.507444] Dynamic subtest C-eDP1: SUCCESS (8.811s)
[670.517172] Starting dynamic subtest: D-eDP1
[679.329621] Dynamic subtest D-eDP1: SUCCESS (8.818s)
[679.334692] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.336s)
[680.496122] [094/130] (338s left) kms_cursor_crc (cursor-offscreen-256x85)
[680.763003] Starting subtest: cursor-offscreen-256x85
[680.809016] Subtest cursor-offscreen-256x85: SKIP (0.041s)
[681.003852] [095/130] (337s left) kms_psr (pr-cursor-mmap-cpu)
[681.110247] Starting subtest: pr-cursor-mmap-cpu
[681.114628] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[681.186262] [096/130] (337s left) gem_busy (close-race)
[681.244800] Starting subtest: close-race
[706.547187] Subtest close-race: SUCCESS (25.294s)
[706.920554] [097/130] (311s left) kms_draw_crc (draw-method-mmap-wc)
[707.070514] Starting subtest: draw-method-mmap-wc
[707.072400] Starting dynamic subtest: xrgb8888-untiled
[707.314818] Dynamic subtest xrgb8888-untiled: SUCCESS (0.246s)
[707.325725] Starting dynamic subtest: rgb565-untiled
[707.536984] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[707.547060] Starting dynamic subtest: xrgb2101010-untiled
[707.725995] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.188s)
[707.736739] Starting dynamic subtest: xbgr16161616f-untiled
[707.936640] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[707.946358] Starting dynamic subtest: xrgb8888-xtiled
[708.059210] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[708.069935] Starting dynamic subtest: rgb565-xtiled
[708.192491] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[708.205448] Starting dynamic subtest: xrgb2101010-xtiled
[708.325663] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[708.339582] Starting dynamic subtest: xbgr16161616f-xtiled
[708.448278] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[708.458022] Starting dynamic subtest: xrgb8888-4tiled
[708.592695] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[708.602599] Starting dynamic subtest: rgb565-4tiled
[708.736991] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[708.746858] Starting dynamic subtest: xrgb2101010-4tiled
[708.870434] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[708.880404] Starting dynamic subtest: xbgr16161616f-4tiled
[709.037271] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[709.039294] Subtest draw-method-mmap-wc: SUCCESS (1.969s)
[709.141296] [098/130] (309s left) kms_psr (pr-primary-page-flip)
[709.241229] Starting subtest: pr-primary-page-flip
[709.245165] Subtest pr-primary-page-flip: SKIP (0.000s)
[709.312339] [099/130] (309s left) gem_exec_fence (submit3)
[709.493495] Starting subtest: submit3
[709.498906] Subtest submit3: SKIP (0.000s)
[711.657150] [100/130] (307s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[711.763751] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[712.598439] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[712.772148] [101/130] (306s left) gen7_exec_parse (basic-allocation)
[712.832537] Subtest basic-allocation: SKIP (0.000s)
[712.901753] [102/130] (306s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[712.962668] Starting subtest: invalid-single-wait-unsubmitted
[712.965605] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[713.083347] [103/130] (305s left) kms_psr (psr-cursor-blt)
[713.174865] Starting subtest: psr-cursor-blt
[713.177321] Starting dynamic subtest: eDP-1
[714.890701] Dynamic subtest eDP-1: SUCCESS (1.715s)
[714.893560] Subtest psr-cursor-blt: SUCCESS (1.716s)
[715.752152] [104/130] (303s left) kms_lease (lease-revoke)
[715.852493] Starting subtest: lease-revoke
[715.854793] Starting dynamic subtest: pipe-A-eDP-1
[715.888697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[715.898901] Starting dynamic subtest: pipe-B-eDP-1
[715.915826] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[715.925697] Starting dynamic subtest: pipe-C-eDP-1
[715.946361] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[715.956880] Starting dynamic subtest: pipe-D-eDP-1
[715.978191] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[715.980262] Subtest lease-revoke: SUCCESS (0.124s)
[716.118175] [105/130] (302s left) gem_mmap_offset (basic-uaf)
[716.176882] Starting subtest: basic-uaf
[716.179785] Subtest basic-uaf: SUCCESS (0.001s)
[716.288324] [106/130] (302s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[716.388007] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[716.392766] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[716.481752] [107/130] (302s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[716.536326] Starting subtest: yf-tiled-ccs-to-y-tiled
[716.541232] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[716.722431] [108/130] (302s left) kms_cursor_edge_walk (128x128-left-edge)
[716.820282] Starting subtest: 128x128-left-edge
[716.822584] Starting dynamic subtest: pipe-A-eDP-1
[720.309908] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.490s)
[720.321629] Starting dynamic subtest: pipe-D-eDP-1
[723.413736] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.102s)
[723.416559] Subtest 128x128-left-edge: SUCCESS (6.595s)
[724.221601] [109/130] (295s left) perf_pmu (invalid-init)
[724.259209] Starting subtest: invalid-init
[724.261690] Subtest invalid-init: SUCCESS (0.000s)
[724.387480] [110/130] (294s left) gem_exec_schedule (preemptive-hang)
[724.567629] Starting subtest: preemptive-hang
[724.570772] Starting dynamic subtest: rcs0
[733.723999] Dynamic subtest rcs0: SUCCESS (9.153s)
[733.745689] Starting dynamic subtest: bcs0
[742.677739] Dynamic subtest bcs0: SUCCESS (8.952s)
[742.690065] Starting dynamic subtest: vcs0
[751.708169] Dynamic subtest vcs0: SUCCESS (9.026s)
[751.720799] Starting dynamic subtest: vcs1
[760.667913] Dynamic subtest vcs1: SUCCESS (8.954s)
[760.685674] Starting dynamic subtest: vecs0
[769.687905] Dynamic subtest vecs0: SUCCESS (9.017s)
[769.699688] Starting dynamic subtest: ccs0
[778.712271] Dynamic subtest ccs0: SUCCESS (9.025s)
[778.714789] Subtest preemptive-hang: SUCCESS (54.133s)
[778.965648] [111/130] (240s left) gem_ctx_persistence (smoketest)
[779.036815] Starting subtest: smoketest
[819.473325] Subtest smoketest: SUCCESS (40.425s)
[819.552224] [112/130] (199s left) perf_pmu (init-sema)
[819.591819] Starting subtest: init-sema
[819.594751] Starting dynamic subtest: rcs0
[819.597293] Dynamic subtest rcs0: SUCCESS (0.003s)
[819.609347] Starting dynamic subtest: bcs0
[819.611888] Dynamic subtest bcs0: SUCCESS (0.001s)
[819.621423] Starting dynamic subtest: vcs0
[819.623614] Dynamic subtest vcs0: SUCCESS (0.001s)
[819.633593] Starting dynamic subtest: vcs1
[819.635974] Dynamic subtest vcs1: SUCCESS (0.001s)
[819.645564] Starting dynamic subtest: vecs0
[819.648154] Dynamic subtest vecs0: SUCCESS (0.001s)
[819.659050] Starting dynamic subtest: ccs0
[819.661630] Dynamic subtest ccs0: SUCCESS (0.000s)
[819.664005] Subtest init-sema: SUCCESS (0.009s)
[819.740276] [113/130] (199s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[819.829603] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[819.831993] Starting dynamic subtest: pipe-A-default-mode
[820.119320] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[820.124315] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.287s)
[820.960480] [114/130] (198s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[821.065397] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[827.317813] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.255s)
[828.446240] [115/130] (191s left) gem_spin_batch (spin-all)
[828.520695] Starting subtest: spin-all
[828.538017] Subtest spin-all: SUCCESS (0.016s)
[830.620563] [116/130] (188s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[830.714512] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[830.719262] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[830.821340] [117/130] (188s left) kms_addfb_basic (bad-pitch-256)
[830.881641] Starting subtest: bad-pitch-256
[830.883549] Subtest bad-pitch-256: SUCCESS (0.000s)
[831.038461] [118/130] (188s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[831.144485] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[831.149675] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[831.245070] [119/130] (188s left) kms_vblank (ts-continuation-modeset-hang)
[831.339652] Starting subtest: ts-continuation-modeset-hang
[831.342493] Starting dynamic subtest: pipe-A-eDP-1
[857.322145] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.974s)
[857.339312] Starting dynamic subtest: pipe-D-eDP-1
[872.314971] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.984s)
[872.317233] Subtest ts-continuation-modeset-hang: SUCCESS (40.962s)
[873.148632] [120/130] (146s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[873.243470] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[873.245832] Starting dynamic subtest: pipe-A-eDP-1
[874.053662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[874.064162] Starting dynamic subtest: pipe-B-eDP-1
[875.590575] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.535s)
[875.601597] Starting dynamic subtest: pipe-C-eDP-1
[877.046909] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.455s)
[877.057488] Starting dynamic subtest: pipe-D-eDP-1
[878.489107] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.440s)
[878.491279] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.233s)
[879.647345] [121/130] (140s left) kms_addfb_basic (legacy-format)
[879.711365] Starting subtest: legacy-format
[879.741895] Subtest legacy-format: SUCCESS (0.027s)
[879.894604] [122/130] (139s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[879.994854] Starting subtest: fbc-shrfb-scaledprimary
[885.038399] Subtest fbc-shrfb-scaledprimary: SUCCESS (5.045s)
[886.247815] [123/130] (133s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[886.742896] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[887.524524] [124/130] (132s left) gem_mmap (bad-offset)
[887.575764] Subtest bad-offset: SKIP (0.000s)
[887.650833] [125/130] (132s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[887.751508] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[887.756192] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[887.842193] [126/130] (132s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[887.960671] Starting subtest: verify-pxp-key-change-after-suspend-resume
[895.021010] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.062s)
[895.168056] [127/130] (124s left) drm_read (empty-block)
[895.340678] Starting subtest: empty-block
[896.337890] Subtest empty-block: SUCCESS (1.002s)
[896.494322] [128/130] (123s left) kms_pm_dc (dc5-dpms-negative)
[897.596844] Starting subtest: dc5-dpms-negative
[897.601898] Subtest dc5-dpms-negative: SKIP (0.000s)
[897.669330] [129/130] (122s left) kms_setmode (basic)
[897.724636] Starting subtest: basic
[898.042852] Starting dynamic subtest: pipe-A-eDP-1
[900.228984] Dynamic subtest pipe-A-eDP-1: FAIL (2.063s)
[900.435916] Starting dynamic subtest: pipe-B-eDP-1
[902.629974] Dynamic subtest pipe-B-eDP-1: FAIL (2.074s)
[902.803850] Subtest basic: FAIL (5.087s)
[903.630858] [130/130] (116s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[903.720997] Starting subtest: fbc-rgb101010-draw-pwrite
[909.086633] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.378s)
[910.201057] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: gem_bad_reloc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_eventfd
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: vgem_basic
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: gem_caching
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gen9_exec_parse
results: parsing output: 21/ for test: gem_exec_flush
results: parsing output: 22/ for test: kms_scaling_modes
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: gem_workarounds
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_create
results: parsing output: 32/ for test: gem_close
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: syncobj_eventfd
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_setmode
results: parsing output: 45/ for test: sw_sync
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_atomic_transition
results: parsing output: 54/ for test: kms_pipe_crc_basic
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_suspend
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: kms_chamelium_audio
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_rmfb
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 67/ for test: i915_pm_rpm
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_ctx_engines
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: gem_exec_parallel
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: kms_invalid_mode
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: i915_module_load
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: vgem_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gen3_render_mixed_blits
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_busy
results: parsing output: 96/ for test: kms_draw_crc
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gen7_exec_parse
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_cursor_edge_walk
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_spin_batch
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: gem_mmap
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_pxp
results: parsing output: 126/ for test: drm_read
results: parsing output: 127/ for test: kms_pm_dc
results: parsing output: 128/ for test: kms_setmode
results: parsing output: 129/ for test: kms_frontbuffer_tracking
Done.