[104.890627] Initializing watchdogs
[104.890709]   /dev/watchdog0
[104.905449] [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]
[104.909830] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[104.912215] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[104.915441] [001/133] (960s left) kms_pm_backlight (fade)
[105.033778] Starting subtest: fade
[105.132669] Starting dynamic subtest: eDP-1
[107.611048] Dynamic subtest eDP-1: SUCCESS (2.479s)
[107.613569] Subtest fade: SUCCESS (2.578s)
[108.497971] [002/133] (956s left) gem_ctx_persistence (file)
[108.552895] Starting subtest: file
[108.651988] Subtest file: SUCCESS (0.099s)
[108.788130] [003/133] (956s left) gem_cs_tlb (engines)
[108.845979] Starting subtest: engines
[108.848345] Starting dynamic subtest: rcs0
[111.000177] Dynamic subtest rcs0: SUCCESS (2.152s)
[111.008084] Starting dynamic subtest: bcs0
[113.155892] Dynamic subtest bcs0: SUCCESS (2.153s)
[113.163535] Starting dynamic subtest: vcs0
[115.309270] Dynamic subtest vcs0: SUCCESS (2.151s)
[115.319063] Starting dynamic subtest: vcs1
[117.462882] Dynamic subtest vcs1: SUCCESS (2.152s)
[117.473211] Starting dynamic subtest: vecs0
[119.616793] Dynamic subtest vecs0: SUCCESS (2.152s)
[119.626166] Starting dynamic subtest: ccs0
[121.768075] Dynamic subtest ccs0: SUCCESS (2.152s)
[121.770538] Subtest engines: SUCCESS (12.915s)
[121.874337] [004/133] (943s left) kms_chamelium_audio (hdmi-audio)
[122.275113] Subtest hdmi-audio: SKIP (0.000s)
[123.110895] [005/133] (942s left) kms_big_fb (linear-32bpp-rotate-270)
[123.228194] Starting subtest: linear-32bpp-rotate-270
[123.246584] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[123.379863] [006/133] (942s left) gem_ctx_param (invalid-ctx-get)
[123.443650] Starting subtest: invalid-ctx-get
[123.445990] Subtest invalid-ctx-get: SUCCESS (0.000s)
[123.516521] [007/133] (942s left) fbdev (unaligned-read)
[123.559668] Starting subtest: unaligned-read
[123.572617] Subtest unaligned-read: SUCCESS (0.015s)
[123.657510] [008/133] (942s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[123.758962] Starting subtest: y-tiled-16bpp-rotate-180
[123.763190] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[123.863578] [009/133] (941s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[123.970788] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[123.973085] Starting dynamic subtest: pipe-A
[124.034595] Dynamic subtest pipe-A: SUCCESS (0.067s)
[124.043734] Starting dynamic subtest: pipe-B
[125.162876] Dynamic subtest pipe-B: SUCCESS (1.127s)
[125.171226] Starting dynamic subtest: pipe-C
[126.270396] Dynamic subtest pipe-C: SUCCESS (1.106s)
[126.279769] Starting dynamic subtest: pipe-D
[127.404148] Dynamic subtest pipe-D: SUCCESS (1.133s)
[127.406926] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.435s)
[128.562776] [010/133] (937s left) kms_plane_multiple (tiling-none)
[128.661196] Starting subtest: tiling-none
[128.663575] Starting dynamic subtest: pipe-A-eDP-1
[132.409253] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.748s)
[132.419156] Starting dynamic subtest: pipe-B-eDP-1
[136.763768] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.353s)
[136.772009] Starting dynamic subtest: pipe-C-eDP-1
[141.180304] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.415s)
[141.189296] Starting dynamic subtest: pipe-D-eDP-1
[145.522544] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.340s)
[145.524830] Subtest tiling-none: SUCCESS (16.860s)
[146.328596] [011/133] (919s left) gen3_render_mixed_blits
[146.456176] [012/133] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[146.555785] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[146.559899] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[146.647510] [013/133] (919s left) gem_exec_params (invalid-batch-start-offset)
[146.719359] Starting subtest: invalid-batch-start-offset
[146.724060] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[146.849486] [014/133] (919s left) kms_scaling_modes (scaling-mode-center)
[146.943085] Starting subtest: scaling-mode-center
[146.945418] Starting dynamic subtest: pipe-A-eDP-1
[147.039660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s)
[147.050669] Starting dynamic subtest: pipe-B-eDP-1
[148.256474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[148.265770] Starting dynamic subtest: pipe-C-eDP-1
[149.378597] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[149.385864] Starting dynamic subtest: pipe-D-eDP-1
[150.514159] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[150.516452] Subtest scaling-mode-center: SUCCESS (3.574s)
[151.677815] [015/133] (914s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[151.766556] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[151.769056] Starting dynamic subtest: pipe-A-eDP-1
[152.620650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s)
[152.628839] Starting dynamic subtest: pipe-B-eDP-1
[154.337042] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.714s)
[154.346448] Starting dynamic subtest: pipe-C-eDP-1
[155.840840] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s)
[155.848819] Starting dynamic subtest: pipe-D-eDP-1
[157.354140] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.512s)
[157.356352] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.581s)
[158.517421] [016/133] (907s left) testdisplay
[158.825932] [017/133] (907s left) vgem_basic (bad-flag)
[158.941570] Starting subtest: bad-flag
[158.943617] Subtest bad-flag: SUCCESS (0.000s)
[158.994754] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true
[158.997950] [018/133] (907s left) gem_mmap (short-mmap)
[159.048267] Subtest short-mmap: SKIP (0.000s)
[159.107784] [019/133] (907s left) kms_psr (pr-cursor-blt)
[159.193257] Starting subtest: pr-cursor-blt
[159.197349] Subtest pr-cursor-blt: SKIP (0.000s)
[159.268283] [020/133] (906s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[159.357180] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[159.361142] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[159.459237] [021/133] (906s left) kms_joiner (invalid-modeset-big-joiner)
[159.565718] Starting subtest: invalid-modeset-big-joiner
[159.569213] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[159.634496] [022/133] (906s left) i915_query (query-garbage)
[159.685677] Starting subtest: query-garbage
[159.687631] Subtest query-garbage: SUCCESS (0.000s)
[159.779326] [023/133] (906s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[159.862982] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[159.865182] Starting dynamic subtest: pipe-A-eDP-1
[159.884595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.893862] Starting dynamic subtest: pipe-B-eDP-1
[159.911719] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.918358] Starting dynamic subtest: pipe-C-eDP-1
[159.935706] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.942291] Starting dynamic subtest: pipe-D-eDP-1
[159.960158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.963520] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[162.206967] [024/133] (904s left) gem_exec_reloc (basic-write-gtt)
[162.273935] Subtest basic-write-gtt: SKIP (0.000s)
[162.353384] [025/133] (904s left) gem_mmap (pf-nonblock)
[162.416078] Subtest pf-nonblock: SKIP (0.000s)
[162.473090] [026/133] (903s left) kms_addfb_basic (size-max)
[162.580393] Starting subtest: size-max
[162.582779] Subtest size-max: SUCCESS (0.000s)
[162.701325] [027/133] (903s left) i915_suspend (forcewake)
[162.752932] Starting subtest: forcewake
[195.888035] Subtest forcewake: SUCCESS (3.152s)
[201.977817] [028/133] (870s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[202.105175] Starting subtest: 4-tiled-64bpp-rotate-90
[202.125157] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[202.243503] [029/133] (870s left) gem_exec_reloc (basic-gtt-cpu)
[202.306277] Subtest basic-gtt-cpu: SKIP (0.000s)
[202.382776] [030/133] (870s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[202.481891] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[202.486363] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[202.584768] [031/133] (870s left) gem_eio (wait-10ms)
[202.825068] Starting subtest: wait-10ms
[203.188505] Subtest wait-10ms: SUCCESS (0.359s)
[203.304589] [032/133] (869s left) kms_draw_crc (draw-method-render)
[203.404594] Starting subtest: draw-method-render
[203.406174] Starting dynamic subtest: xrgb8888-untiled
[203.662351] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[203.670417] Starting dynamic subtest: rgb565-untiled
[203.888003] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[203.896818] Starting dynamic subtest: xrgb2101010-untiled
[204.124472] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[204.133346] Starting dynamic subtest: xbgr16161616f-untiled
[204.383062] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.254s)
[204.391438] Starting dynamic subtest: xrgb8888-xtiled
[204.518185] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[204.526663] Starting dynamic subtest: rgb565-xtiled
[204.630792] Dynamic subtest rgb565-xtiled: SUCCESS (0.109s)
[204.638690] Starting dynamic subtest: xrgb2101010-xtiled
[204.754401] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[204.762395] Starting dynamic subtest: xbgr16161616f-xtiled
[204.889528] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[204.897532] Starting dynamic subtest: xrgb8888-4tiled
[205.024389] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[205.033838] Starting dynamic subtest: rgb565-4tiled
[205.136532] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[205.144730] Starting dynamic subtest: xrgb2101010-4tiled
[205.260137] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s)
[205.274484] Starting dynamic subtest: xbgr16161616f-4tiled
[205.395030] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[205.397062] Subtest draw-method-render: SUCCESS (1.967s)
[205.516882] [033/133] (867s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[205.648699] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[205.653663] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[205.829312] [034/133] (867s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[205.932889] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[205.934843] Starting dynamic subtest: pipe-A-eDP-1
[206.059550] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[206.068445] Starting dynamic subtest: pipe-B-eDP-1
[207.203745] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[207.208524] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.262s)
[208.435261] [035/133] (864s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[208.541405] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[208.543755] Starting dynamic subtest: pipe-A-eDP-1
[208.604762] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[208.612816] Starting dynamic subtest: pipe-B-eDP-1
[208.669075] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[208.677353] Starting dynamic subtest: pipe-C-eDP-1
[208.731600] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[208.739898] Starting dynamic subtest: pipe-D-eDP-1
[208.794516] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[208.798770] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.011s)
[210.900501] [036/133] (862s left) gem_ctx_shared (q-independent)
[210.958667] Starting subtest: Q-independent
[210.960531] Starting dynamic subtest: rcs0
[211.028487] Dynamic subtest rcs0: SUCCESS (0.071s)
[211.040637] Starting dynamic subtest: vcs0
[211.071070] Dynamic subtest vcs0: SUCCESS (0.042s)
[211.081069] Starting dynamic subtest: vcs1
[211.113729] Dynamic subtest vcs1: SUCCESS (0.042s)
[211.123783] Starting dynamic subtest: vecs0
[211.165463] Dynamic subtest vecs0: SUCCESS (0.050s)
[211.174319] Starting dynamic subtest: ccs0
[211.218471] Dynamic subtest ccs0: SUCCESS (0.053s)
[211.220770] Subtest Q-independent: SUCCESS (0.262s)
[213.001874] [037/133] (859s left) gem_ctx_persistence (engines-persistence)
[213.070257] Starting subtest: engines-persistence
[213.072615] Starting dynamic subtest: rcs0
[213.878418] Dynamic subtest rcs0: SUCCESS (0.804s)
[213.889691] Starting dynamic subtest: bcs0
[214.646434] Dynamic subtest bcs0: SUCCESS (0.762s)
[214.660769] Starting dynamic subtest: vcs0
[215.405092] Dynamic subtest vcs0: SUCCESS (0.754s)
[215.418055] Starting dynamic subtest: vcs1
[216.172183] Dynamic subtest vcs1: SUCCESS (0.761s)
[216.183194] Starting dynamic subtest: vecs0
[216.939511] Dynamic subtest vecs0: SUCCESS (0.763s)
[216.953492] Starting dynamic subtest: ccs0
[217.706180] Dynamic subtest ccs0: SUCCESS (0.762s)
[217.708647] Subtest engines-persistence: SUCCESS (4.622s)
[217.788246] [038/133] (855s left) kms_cursor_edge_walk (64x64-top-edge)
[217.881680] Starting subtest: 64x64-top-edge
[217.884064] Starting dynamic subtest: pipe-A-eDP-1
[221.301214] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s)
[221.310257] Starting dynamic subtest: pipe-D-eDP-1
[224.425674] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[224.427937] Subtest 64x64-top-edge: SUCCESS (6.534s)
[225.248744] [039/133] (847s left) api_intel_allocator (two-level-inception-interruptible)
[225.299813] Starting subtest: two-level-inception-interruptible
[230.711074] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[230.834362] [040/133] (842s left) gem_softpin (allocator-basic)
[230.893362] Starting subtest: allocator-basic
[230.983645] Subtest allocator-basic: SUCCESS (0.090s)
[231.152499] [041/133] (842s left) kms_cursor_crc (cursor-random-32x10)
[231.326788] Starting subtest: cursor-random-32x10
[231.377237] Subtest cursor-random-32x10: SKIP (0.045s)
[231.650417] [042/133] (841s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[231.759208] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[238.688571] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.929s)
[238.812574] [043/133] (834s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[238.901604] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[239.559145] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[239.719996] [044/133] (833s left) sw_sync (alloc_fence)
[239.758063] Starting subtest: alloc_fence
[239.760274] Subtest alloc_fence: SUCCESS (0.000s)
[239.806207] [045/133] (833s left) gem_wait (write-wait)
[239.865989] Starting subtest: write-wait
[239.868412] Starting dynamic subtest: all-engines
[240.966359] Dynamic subtest all-engines: SUCCESS (1.100s)
[240.978290] Starting dynamic subtest: rcs0
[242.025175] Dynamic subtest rcs0: SUCCESS (1.056s)
[242.042541] Starting dynamic subtest: bcs0
[243.084522] Dynamic subtest bcs0: SUCCESS (1.057s)
[243.101526] Starting dynamic subtest: vcs0
[244.140398] Dynamic subtest vcs0: SUCCESS (1.052s)
[244.156653] Starting dynamic subtest: vcs1
[245.194469] Dynamic subtest vcs1: SUCCESS (1.051s)
[245.209350] Starting dynamic subtest: vecs0
[246.247487] Dynamic subtest vecs0: SUCCESS (1.051s)
[246.262994] Starting dynamic subtest: ccs0
[247.302521] Dynamic subtest ccs0: SUCCESS (1.053s)
[247.305082] Subtest write-wait: SUCCESS (7.436s)
[247.515587] [046/133] (825s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[247.575772] Subtest writes-after-reads: SKIP (0.000s)
[247.634154] [047/133] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[247.731822] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[254.300945] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.569s)
[254.417367] [048/133] (819s left) kms_setmode (basic)
[254.471115] Starting subtest: basic
[254.797134] Starting dynamic subtest: pipe-A-eDP-1
[256.872692] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.070s)
[257.219954] Starting dynamic subtest: pipe-B-eDP-1
[259.299958] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.083s)
[259.621395] Subtest basic: SUCCESS (5.146s)
[260.461429] [049/133] (813s left) gem_mmap_offset (bad-object)
[260.520286] Starting subtest: bad-object
[260.522345] Subtest bad-object: SUCCESS (0.001s)
[260.612273] [050/133] (812s left) syncobj_timeline (wait-all-snapshot)
[260.656728] Starting subtest: wait-all-snapshot
[260.738309] Subtest wait-all-snapshot: SUCCESS (0.082s)
[260.815866] [051/133] (812s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[260.914516] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[260.918626] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[260.986789] [052/133] (812s left) vgem_slow (nohang)
[261.024489] Starting subtest: nohang
[271.246898] Subtest nohang: SUCCESS (10.218s)
[271.313733] [053/133] (802s left) kms_psr (fbc-psr-cursor-blt)
[271.412589] Starting subtest: fbc-psr-cursor-blt
[271.414880] Starting dynamic subtest: eDP-1
[271.419161] Dynamic subtest eDP-1: SKIP (0.000s)
[271.423247] Subtest fbc-psr-cursor-blt: SKIP (0.002s)
[271.492164] [054/133] (802s left) i915_pm_rc6_residency (media-rc6-accuracy)
[271.539223] Starting subtest: media-rc6-accuracy
[271.543478] Subtest media-rc6-accuracy: SKIP (0.000s)
[271.624177] [055/133] (802s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[271.686502] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[271.762192] [056/133] (802s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[271.858926] Starting subtest: x-tiled-64bpp-rotate-90
[271.878326] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[271.979692] [057/133] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[272.073090] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[279.578337] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.505s)
[279.691366] [058/133] (794s left) kms_cursor_crc (cursor-offscreen-64x21)
[279.876395] Starting subtest: cursor-offscreen-64x21
[279.922715] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[280.180974] [059/133] (793s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[280.276121] Starting subtest: psr-rgb565-draw-mmap-cpu
[287.158805] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.882s)
[287.287721] [060/133] (786s left) i915_drm_fdinfo (busy-hang)
[287.331080] Starting subtest: busy-hang
[287.333011] Starting dynamic subtest: rcs0
[287.351485] Dynamic subtest rcs0: SKIP (0.020s)
[287.362636] Starting dynamic subtest: bcs0
[287.367212] Dynamic subtest bcs0: SKIP (0.001s)
[287.375755] Starting dynamic subtest: vcs0
[287.380233] Dynamic subtest vcs0: SKIP (0.000s)
[287.388902] Starting dynamic subtest: vcs1
[287.393007] Dynamic subtest vcs1: SKIP (0.000s)
[287.401881] Starting dynamic subtest: vecs0
[287.405732] Dynamic subtest vecs0: SKIP (0.000s)
[287.413567] Starting dynamic subtest: ccs0
[287.417511] Dynamic subtest ccs0: SKIP (0.000s)
[287.421513] Subtest busy-hang: SKIP (0.026s)
[287.458727] [061/133] (786s left) gem_exec_create (basic)
[287.510143] Starting subtest: basic
[287.512340] Starting dynamic subtest: smem
[290.866788] Dynamic subtest smem: SUCCESS (3.353s)
[290.869752] Subtest basic: SUCCESS (3.355s)
[291.059645] [062/133] (782s left) gem_exec_whisper (basic-normal-all)
[291.127914] Starting subtest: basic-normal-all
[294.474578] Subtest basic-normal-all: SUCCESS (3.344s)
[294.661856] [063/133] (779s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[294.762639] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[294.766601] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[294.860352] [064/133] (779s left) gem_mmap_gtt (bad-object)
[294.909602] Subtest bad-object: SKIP (0.000s)
[294.972746] [065/133] (779s left) gem_exec_schedule (noreorder)
[295.168082] Starting subtest: noreorder
[295.170490] Starting dynamic subtest: rcs0
[295.242670] Dynamic subtest rcs0: SUCCESS (0.076s)
[295.256492] Starting dynamic subtest: vcs0
[296.879486] Dynamic subtest vcs0: SUCCESS (1.633s)
[296.891346] Starting dynamic subtest: vcs1
[298.839169] Dynamic subtest vcs1: SUCCESS (1.958s)
[298.850525] Starting dynamic subtest: vecs0
[300.921675] Dynamic subtest vecs0: SUCCESS (2.081s)
[300.933110] Starting dynamic subtest: ccs0
[300.992051] Dynamic subtest ccs0: SUCCESS (0.069s)
[300.994414] Subtest noreorder: SUCCESS (5.830s)
[301.176065] [066/133] (773s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[301.566970] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[302.413550] [067/133] (771s left) kms_frontbuffer_tracking (psr-slowdraw)
[302.507151] Starting subtest: psr-slowdraw
[327.773260] Subtest psr-slowdraw: SUCCESS (25.272s)
[327.888402] [068/133] (746s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[327.948865] Starting subtest: invalid-multi-wait-all-unsubmitted
[327.951268] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[328.054870] [069/133] (746s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[328.143128] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[328.145346] Starting dynamic subtest: pipe-A
[329.295323] Dynamic subtest pipe-A: SUCCESS (1.153s)
[329.304121] Starting dynamic subtest: pipe-B
[331.493658] Dynamic subtest pipe-B: SUCCESS (2.197s)
[331.504700] Starting dynamic subtest: pipe-C
[332.678972] Dynamic subtest pipe-C: SUCCESS (1.184s)
[332.688938] Starting dynamic subtest: pipe-D
[333.927073] Dynamic subtest pipe-D: SUCCESS (1.247s)
[333.929671] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.786s)
[335.120466] [070/133] (739s left) perf_pmu (interrupts-sync)
[335.166697] Starting subtest: interrupts-sync
[336.251006] Subtest interrupts-sync: SUCCESS (1.084s)
[336.362759] [071/133] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[336.463939] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[336.468052] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[336.567229] [072/133] (737s left) kms_chamelium_hpd (dp-hpd)
[336.948211] Subtest dp-hpd: SKIP (0.000s)
[337.730938] [073/133] (736s left) kms_busy (extended-modeset-hang-oldfb)
[337.824647] Starting subtest: extended-modeset-hang-oldfb
[337.827015] Starting dynamic subtest: pipe-A
[349.424739] Dynamic subtest pipe-A: SUCCESS (11.597s)
[349.434306] Starting dynamic subtest: pipe-D
[361.704970] Dynamic subtest pipe-D: SUCCESS (12.274s)
[361.707340] Subtest extended-modeset-hang-oldfb: SUCCESS (23.875s)
[362.497209] [074/133] (712s left) drm_mm (drm_mm)
[362.539794] Starting subtest: drm_mm
[362.561747] Starting dynamic subtest: drm_test_mm_init
[362.649669] Dynamic subtest drm_test_mm_init: SUCCESS (0.087s)
[362.659917] Starting dynamic subtest: drm_test_mm_debug
[362.742581] Dynamic subtest drm_test_mm_debug: SUCCESS (0.091s)
[362.752816] Starting dynamic subtest: drm_test_mm_align32
[362.831535] Dynamic subtest drm_test_mm_align32: SUCCESS (0.089s)
[362.841565] Starting dynamic subtest: drm_test_mm_align64
[362.948120] Dynamic subtest drm_test_mm_align64: SUCCESS (0.115s)
[362.958269] Starting dynamic subtest: drm_test_mm_lowest
[363.041896] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.093s)
[363.052309] Starting dynamic subtest: drm_test_mm_highest
[363.130504] Dynamic subtest drm_test_mm_highest: SUCCESS (0.088s)
[363.132749] Subtest drm_mm: SUCCESS (0.592s)
[363.269170] [075/133] (711s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[363.364114] Starting subtest: bad-aux-stride-yf-tiled-ccs
[363.366278] Starting dynamic subtest: pipe-A-eDP-1
[363.388537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.400165] Starting dynamic subtest: pipe-B-eDP-1
[363.420590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.429605] Starting dynamic subtest: pipe-C-eDP-1
[363.450091] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.461250] Starting dynamic subtest: pipe-D-eDP-1
[363.482027] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.485954] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[365.657854] [076/133] (708s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[365.747814] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[365.759528] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[365.871514] [077/133] (708s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[365.923323] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[365.925508] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[366.035670] [078/133] (708s left) gem_exec_whisper (basic-sync-all)
[366.088380] Starting subtest: basic-sync-all
[373.631622] Subtest basic-sync-all: SUCCESS (7.539s)
[373.814186] [079/133] (700s left) kms_vrr (seamless-rr-switch-vrr)
[373.930413] Starting subtest: seamless-rr-switch-vrr
[373.936556] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[374.003619] [080/133] (700s left) api_intel_bb (purge-bb)
[374.056915] Starting subtest: purge-bb
[374.061734] Subtest purge-bb: SUCCESS (0.006s)
[374.177937] [081/133] (700s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[374.298733] Starting subtest: cursor-vs-flip-atomic
[403.677196] Subtest cursor-vs-flip-atomic: SUCCESS (29.368s)
[404.504559] [082/133] (670s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[404.602197] Starting subtest: fbc-dirtyfb-ioctl
[404.604332] Starting dynamic subtest: A-eDP-1
[407.167864] Dynamic subtest A-eDP-1: SUCCESS (2.563s)
[407.169830] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.565s)
[407.962418] [083/133] (666s left) perf_pmu (init-sema)
[408.009698] Starting subtest: init-sema
[408.012005] Starting dynamic subtest: rcs0
[408.014395] Dynamic subtest rcs0: SUCCESS (0.002s)
[408.023760] Starting dynamic subtest: bcs0
[408.025592] Dynamic subtest bcs0: SUCCESS (0.000s)
[408.033932] Starting dynamic subtest: vcs0
[408.035779] Dynamic subtest vcs0: SUCCESS (0.001s)
[408.044678] Starting dynamic subtest: vcs1
[408.046844] Dynamic subtest vcs1: SUCCESS (0.001s)
[408.055429] Starting dynamic subtest: vecs0
[408.057280] Dynamic subtest vecs0: SUCCESS (0.001s)
[408.065825] Starting dynamic subtest: ccs0
[408.068030] Dynamic subtest ccs0: SUCCESS (0.001s)
[408.070228] Subtest init-sema: SUCCESS (0.010s)
[408.114402] [084/133] (666s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[408.207809] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[412.286938] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.080s)
[413.486356] [085/133] (661s left) prime_self_import (basic-llseek-size)
[413.525320] Starting subtest: basic-llseek-size
[413.549077] Subtest basic-llseek-size: SUCCESS (0.025s)
[413.654391] [086/133] (661s left) gem_exec_fence (parallel)
[413.827727] Starting subtest: parallel
[413.830147] Starting dynamic subtest: rcs0
[415.979192] Dynamic subtest rcs0: SUCCESS (2.151s)
[415.989753] Starting dynamic subtest: bcs0
[418.135632] Dynamic subtest bcs0: SUCCESS (2.154s)
[418.146162] Starting dynamic subtest: vcs0
[420.286495] Dynamic subtest vcs0: SUCCESS (2.149s)
[420.297190] Starting dynamic subtest: vcs1
[422.439352] Dynamic subtest vcs1: SUCCESS (2.152s)
[422.450101] Starting dynamic subtest: vecs0
[424.591825] Dynamic subtest vecs0: SUCCESS (2.152s)
[424.602201] Starting dynamic subtest: ccs0
[426.746163] Dynamic subtest ccs0: SUCCESS (2.154s)
[426.748199] Subtest parallel: SUCCESS (12.920s)
[427.983327] [087/133] (647s left) gem_flink_race (flink_close)
[428.024076] Starting subtest: flink_close
[433.121360] Subtest flink_close: SUCCESS (5.099s)
[433.201575] [088/133] (641s left) gem_exec_balancer (sequential)
[433.273049] Starting subtest: sequential
[436.379071] Subtest sequential: SUCCESS (3.106s)
[436.700490] [089/133] (638s left) kms_plane (pixel-format-x-tiled-modifier)
[436.810456] Starting subtest: pixel-format-x-tiled-modifier
[436.837285] Starting dynamic subtest: pipe-A-plane-0
[437.514625] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[437.524134] Starting dynamic subtest: pipe-A-plane-3
[437.936483] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[437.945160] Starting dynamic subtest: pipe-A-plane-5
[437.948988] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[439.038406] Starting dynamic subtest: pipe-B-plane-0
[439.732360] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[439.742820] Starting dynamic subtest: pipe-B-plane-3
[440.185819] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[440.197134] Starting dynamic subtest: pipe-B-plane-5
[440.200868] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[440.496722] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.687s)
[441.310547] [090/133] (633s left) gem_ppgtt (flink-and-close-vma-leak)
[441.371922] Starting subtest: flink-and-close-vma-leak
[441.414064] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[441.547862] [091/133] (633s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[441.642683] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[441.646983] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[441.747097] [092/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[441.840793] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[441.844901] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[441.929222] [093/133] (633s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[444.073987] Starting subtest: modeset-lpsp-stress-no-wait
[453.915124] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.844s)
[454.013692] [094/133] (621s left) i915_hangman (gt-engine-error)
[454.094724] Starting subtest: gt-engine-error
[454.096633] Starting dynamic subtest: rcs0
[455.887676] Dynamic subtest rcs0: SUCCESS (1.793s)
[455.900250] Starting dynamic subtest: bcs0
[457.871218] Dynamic subtest bcs0: SUCCESS (1.981s)
[457.883870] Starting dynamic subtest: vcs0
[459.855985] Dynamic subtest vcs0: SUCCESS (1.982s)
[459.867400] Starting dynamic subtest: vcs1
[461.839381] Dynamic subtest vcs1: SUCCESS (1.981s)
[461.852005] Starting dynamic subtest: vecs0
[463.887193] Dynamic subtest vecs0: SUCCESS (2.045s)
[463.899240] Starting dynamic subtest: ccs0
[465.871029] Dynamic subtest ccs0: SUCCESS (1.981s)
[465.874008] Subtest gt-engine-error: SUCCESS (11.779s)
[466.000972] [095/133] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[466.100901] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[466.105049] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.197684] [096/133] (609s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[466.296307] Starting subtest: yf-tiled-addfb-size-offset-overflow
[466.300750] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[466.388995] [097/133] (609s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[466.495462] Starting subtest: 4-tiled-16bpp-rotate-180
[467.832549] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.337s)
[467.975665] [098/133] (607s left) gem_exec_reloc (basic-wc-noreloc)
[468.033502] Subtest basic-wc-noreloc: SKIP (0.000s)
[468.107156] [099/133] (607s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[468.197725] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[468.199493] Starting dynamic subtest: pipe-A-default-mode
[470.943746] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[470.946086] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.747s)
[471.773951] [100/133] (603s left) kms_universal_plane (disable-primary-vs-flip)
[471.876468] Starting subtest: disable-primary-vs-flip
[471.878753] Starting dynamic subtest: pipe-A-eDP-1
[473.473976] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.596s)
[473.484657] Starting dynamic subtest: pipe-B-eDP-1
[475.706088] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.233s)
[475.715655] Starting dynamic subtest: pipe-C-eDP-1
[477.884327] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.176s)
[477.894570] Starting dynamic subtest: pipe-D-eDP-1
[480.067086] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.179s)
[480.068995] Subtest disable-primary-vs-flip: SUCCESS (8.190s)
[480.942836] [101/133] (594s left) gem_ctx_param (set-priority-range)
[480.991252] Starting subtest: set-priority-range
[481.005316] Subtest set-priority-range: SUCCESS (0.014s)
[481.135093] [102/133] (594s left) kms_psr (psr2-primary-mmap-cpu)
[481.219835] Starting subtest: psr2-primary-mmap-cpu
[481.222145] Starting dynamic subtest: eDP-1
[482.928502] Dynamic subtest eDP-1: SUCCESS (1.709s)
[482.930748] Subtest psr2-primary-mmap-cpu: SUCCESS (1.710s)
[483.799132] [103/133] (591s left) kms_content_protection (mei-interface)
[483.942992] Starting subtest: mei-interface
[483.947065] Subtest mei-interface: SKIP (0.001s)
[484.076367] [104/133] (591s left) kms_getfb (getfb-handle-protection)
[484.166426] Starting subtest: getfb-handle-protection
[484.189142] Subtest getfb-handle-protection: SUCCESS (0.023s)
[484.318399] [105/133] (591s left) gem_exec_balancer (nohangcheck)
[484.602844] Starting subtest: nohangcheck
[485.533697] Subtest nohangcheck: SUCCESS (0.930s)
[485.645041] [106/133] (590s left) kms_color (ctm-0-75)
[485.749311] Starting subtest: ctm-0-75
[485.751576] Starting dynamic subtest: pipe-A-eDP-1
[490.728077] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.977s)
[490.741067] Starting dynamic subtest: pipe-B-eDP-1
[496.443924] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.716s)
[496.453267] Starting dynamic subtest: pipe-C-eDP-1
[501.825298] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.381s)
[501.835343] Starting dynamic subtest: pipe-D-eDP-1
[507.178760] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.351s)
[507.181071] Subtest ctm-0-75: SUCCESS (21.428s)
[508.000620] [107/133] (567s left) kms_vblank (ts-continuation-modeset-hang)
[508.112186] Starting subtest: ts-continuation-modeset-hang
[508.114475] Starting dynamic subtest: pipe-A-eDP-1
[534.703900] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.588s)
[534.718699] Starting dynamic subtest: pipe-D-eDP-1
[549.631496] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.922s)
[549.633850] Subtest ts-continuation-modeset-hang: SUCCESS (41.516s)
[550.447649] [108/133] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[550.549160] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[557.961717] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.412s)
[558.112972] [109/133] (517s left) gem_softpin (noreloc)
[558.173384] Starting subtest: noreloc
[563.578997] Subtest noreloc: SUCCESS (5.403s)
[563.702428] [110/133] (512s left) kms_setmode (basic-clone-single-crtc)
[563.768381] Starting subtest: basic-clone-single-crtc
[563.774734] Subtest basic-clone-single-crtc: SKIP (0.000s)
[563.893281] [111/133] (512s left) kms_flip (2x-blocking-absolute-wf_vblank)
[563.992731] Starting subtest: 2x-blocking-absolute-wf_vblank
[564.004655] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[564.085549] [112/133] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[564.177833] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[564.182110] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[564.282078] [113/133] (511s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[564.379593] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[564.383670] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[564.478912] [114/133] (511s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[564.545562] Starting subtest: yf-tiled-to-vebox-y-tiled
[564.549551] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[564.728275] [115/133] (511s left) kms_properties (plane-properties-legacy)
[564.832477] Starting subtest: plane-properties-legacy
[564.834698] Starting dynamic subtest: pipe-A-eDP-1
[565.383491] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[565.396383] Starting dynamic subtest: pipe-B-eDP-1
[566.651155] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s)
[566.661608] Starting dynamic subtest: pipe-C-eDP-1
[567.890651] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s)
[567.902287] Starting dynamic subtest: pipe-D-eDP-1
[569.116889] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[569.119246] Subtest plane-properties-legacy: SUCCESS (4.285s)
[569.939663] [116/133] (506s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[570.032865] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[570.034959] Starting dynamic subtest: pipe-A-default-mode
[571.176717] Dynamic subtest pipe-A-default-mode: SKIP (1.140s)
[571.180548] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.142s)
[571.333887] [117/133] (505s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[571.494859] Starting subtest: basic-flip-after-cursor-atomic
[572.407346] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.912s)
[573.288378] [118/133] (503s left) prime_busy (after-wait)
[573.347103] Starting subtest: after-wait
[573.352199] Starting dynamic subtest: rcs0
[573.376482] Dynamic subtest rcs0: SUCCESS (0.026s)
[573.387548] Starting dynamic subtest: bcs0
[573.423701] Dynamic subtest bcs0: SUCCESS (0.046s)
[573.434498] Starting dynamic subtest: vcs0
[573.464114] Dynamic subtest vcs0: SUCCESS (0.040s)
[573.473419] Starting dynamic subtest: vcs1
[573.505685] Dynamic subtest vcs1: SUCCESS (0.041s)
[573.515291] Starting dynamic subtest: vecs0
[573.548312] Dynamic subtest vecs0: SUCCESS (0.041s)
[573.557475] Starting dynamic subtest: ccs0
[573.589563] Dynamic subtest ccs0: SUCCESS (0.040s)
[573.698184] Subtest after-wait: SUCCESS (0.349s)
[573.779100] [119/133] (502s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[573.849111] Starting subtest: yf-tiled-ccs-to-yf-tiled
[573.853644] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[574.035485] [120/133] (502s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[574.130809] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[574.132972] Starting dynamic subtest: pipe-A-eDP-1
[580.837936] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.707s)
[580.849384] Starting dynamic subtest: pipe-B-eDP-1
[588.010392] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.170s)
[588.012755] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.880s)
[588.894632] [121/133] (487s left) kms_plane_alpha_blend (alpha-transparent-fb)
[588.989586] Starting subtest: alpha-transparent-fb
[589.282122] Starting dynamic subtest: pipe-A-eDP-1
[589.895882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[589.906014] Starting dynamic subtest: pipe-D-eDP-1
[591.263512] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.368s)
[591.265832] Subtest alpha-transparent-fb: SUCCESS (2.276s)
[592.140660] [122/133] (484s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[592.245627] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[596.306546] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.063s)
[597.465562] [123/133] (479s left) intel_hwmon (hwmon-write)
[597.529043] Subtest hwmon-write: SKIP (0.000s)
[597.587337] [124/133] (479s left) gen7_exec_parse (load-register-reg)
[597.651471] Subtest load-register-reg: SKIP (0.000s)
[597.731753] [125/133] (479s left) prime_mmap (test_userptr)
[597.790624] Starting subtest: test_userptr
[597.792855] Starting dynamic subtest: test_userptr-smem
[597.794754] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[597.796659] Subtest test_userptr: SUCCESS (0.001s)
[597.893547] [126/133] (478s left) kms_lease (implicit-plane-lease)
[597.984588] Starting subtest: implicit-plane-lease
[597.986880] Subtest implicit-plane-lease: SUCCESS (0.003s)
[598.097891] [127/133] (478s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[598.191357] Starting subtest: fbc-pr-sprite-mmap-gtt
[598.195675] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[598.266400] [128/133] (478s left) gem_exec_schedule (smoketest)
[598.455418] Starting subtest: smoketest
[598.457850] Starting dynamic subtest: rcs0
[603.990454] Dynamic subtest rcs0: SUCCESS (5.485s)
[604.001104] Starting dynamic subtest: bcs0
[609.515728] Dynamic subtest bcs0: SUCCESS (5.523s)
[609.528312] Starting dynamic subtest: vcs0
[615.021626] Dynamic subtest vcs0: SUCCESS (5.501s)
[615.038382] Starting dynamic subtest: vcs1
[620.551181] Dynamic subtest vcs1: SUCCESS (5.529s)
[620.563289] Starting dynamic subtest: vecs0
[626.056689] Dynamic subtest vecs0: SUCCESS (5.502s)
[626.069385] Starting dynamic subtest: ccs0
[631.595865] Dynamic subtest ccs0: SUCCESS (5.532s)
[631.597912] Subtest smoketest: SUCCESS (33.081s)
[631.798755] [129/133] (445s left) syncobj_wait (reset-during-wait-for-submit)
[631.851488] Starting subtest: reset-during-wait-for-submit
[631.954656] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[632.032564] [130/133] (444s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[632.093738] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[632.096092] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[632.211169] [131/133] (444s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[632.306357] Starting subtest: fbcpsr-modesetfrombusy
[638.528049] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.223s)
[638.671072] [132/133] (438s left) syncobj_eventfd (timeline-wait-before-signal)
[638.718429] Starting subtest: timeline-wait-before-signal
[638.748450] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[638.826846] [133/133] (438s left) gem_fence_thrash (bo-write-verify-threaded-none)
[638.864862] Starting subtest: bo-write-verify-threaded-none
[638.879479] Subtest bo-write-verify-threaded-none: SKIP (0.012s)
[638.930266] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_backlight
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: gem_cs_tlb
results: parsing output: 3/ for test: kms_chamelium_audio
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: fbdev
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_plane_multiple
results: parsing output: 10/ for test: gen3_render_mixed_blits
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: kms_scaling_modes
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: testdisplay
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: gem_mmap
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: gem_mmap
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_draw_crc
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_cursor_edge_walk
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: gem_wait
results: parsing output: 45/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_setmode
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: vgem_slow
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: i915_pm_rc6_residency
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: gem_exec_create
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: kms_busy
results: parsing output: 73/ for test: drm_mm
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_vrr
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_dirtyfb
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: prime_self_import
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: gem_flink_race
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: gem_ppgtt
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: i915_hangman
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_universal_plane
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: kms_setmode
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_properties
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_plane_alpha_blend
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: intel_hwmon
results: parsing output: 123/ for test: gen7_exec_parse
results: parsing output: 124/ for test: prime_mmap
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_eventfd
results: parsing output: 132/ for test: gem_fence_thrash
Done.