[57.906800] Initializing watchdogs
[57.906863]   /dev/watchdog0
[57.921816] [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]
[57.926344] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.929086] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.932267] [001/133] (960s left) gem_exec_balancer (parallel-keep-submit-fence)
[58.232398] Starting subtest: parallel-keep-submit-fence
[59.311108] Subtest parallel-keep-submit-fence: SUCCESS (1.080s)
[59.434779] [002/133] (959s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[59.573718] Starting subtest: 2x-cursor-vs-flip-atomic
[59.578261] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[59.724899] [003/133] (958s left) perf (gen8-unprivileged-single-ctx-counters)
[59.871024] Starting subtest: gen8-unprivileged-single-ctx-counters
[59.875382] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[59.918956] [004/133] (958s left) gem_exec_whisper (basic-sync)
[59.980798] Starting subtest: basic-sync
[66.780721] Subtest basic-sync: SUCCESS (6.799s)
[66.990025] [005/133] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[67.359445] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[67.364091] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[67.673232] [006/133] (950s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[67.798635] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[67.800835] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[67.997261] [007/133] (950s left) api_intel_bb (reset-flags)
[68.148940] Starting subtest: reset-flags
[68.157896] Subtest reset-flags: SUCCESS (0.010s)
[68.284702] [008/133] (950s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[68.384850] Starting subtest: bad-aux-stride-yf-tiled-ccs
[68.387237] Starting dynamic subtest: pipe-A-eDP-1
[68.410381] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.424118] Starting dynamic subtest: pipe-B-eDP-1
[68.445580] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.452755] Starting dynamic subtest: pipe-C-eDP-1
[68.475150] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.482394] Starting dynamic subtest: pipe-D-eDP-1
[68.505753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.510639] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[70.631944] [009/133] (948s left) gem_tiled_partial_pwrite_pread (reads)
[70.695182] Subtest reads: SKIP (0.000s)
[70.778220] [010/133] (948s left) kms_joiner (basic-big-joiner)
[70.898516] Starting subtest: basic-big-joiner
[70.903106] Subtest basic-big-joiner: SKIP (0.000s)
[70.985684] [011/133] (947s left) gem_exec_schedule (deep)
[71.173089] Starting subtest: deep
[71.175669] Starting dynamic subtest: rcs0
[76.232668] Dynamic subtest rcs0: SKIP (5.058s)
[76.241986] Starting dynamic subtest: vcs0
[86.308486] Dynamic subtest vcs0: SUCCESS (10.079s)
[86.319232] Starting dynamic subtest: vcs1
[97.825299] Dynamic subtest vcs1: SUCCESS (11.520s)
[97.834415] Starting dynamic subtest: vecs0
[108.573824] Dynamic subtest vecs0: SUCCESS (10.748s)
[108.583712] Starting dynamic subtest: ccs0
[120.377094] Dynamic subtest ccs0: SUCCESS (11.802s)
[120.379641] Subtest deep: SUCCESS (49.209s)
[122.453840] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[122.456913] [012/133] (896s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[122.551577] Starting subtest: primary-yf-tiled-reflect-x-180
[122.612749] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.061s)
[122.726945] [013/133] (896s left) gem_spin_batch (spin-each)
[122.797892] Starting subtest: spin-each
[126.159572] Subtest spin-each: SUCCESS (3.361s)
[128.006383] [014/133] (890s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[128.101930] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[128.104305] Starting dynamic subtest: pipe-A-default-mode
[130.867238] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[130.869686] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.767s)
[131.704616] [015/133] (887s left) gem_mmap_gtt (cpuset-big-copy-xy)
[131.773225] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[131.828835] [016/133] (887s left) gem_softpin (evict-snoop)
[131.892447] Starting subtest: evict-snoop
[131.896531] Subtest evict-snoop: SKIP (0.000s)
[132.026342] [017/133] (887s left) kms_selftest (drm_format_helper)
[132.060678] Starting subtest: drm_format_helper
[132.130604] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[132.281563] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.150s)
[132.291099] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[132.430302] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.149s)
[132.440111] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[132.518252] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.088s)
[132.528147] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[132.657290] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.138s)
[132.667068] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[132.784257] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.127s)
[132.794066] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[132.902267] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.118s)
[132.912129] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[133.024206] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.121s)
[133.033111] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[133.119313] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.096s)
[133.128669] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[133.262149] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.143s)
[133.272079] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[133.358339] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.095s)
[133.367909] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[133.525148] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.166s)
[133.534390] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[133.680160] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.155s)
[133.689029] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[133.834196] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.154s)
[133.843176] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[133.982109] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.148s)
[133.991391] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[134.141113] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.158s)
[134.149988] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[134.309070] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.168s)
[134.318372] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[134.461686] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.151s)
[134.463648] Subtest drm_format_helper: SUCCESS (2.401s)
[134.663148] [018/133] (884s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[134.760610] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[134.763057] Starting dynamic subtest: pipe-A-eDP-1
[134.784055] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[134.792385] Starting dynamic subtest: pipe-B-eDP-1
[134.811315] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[134.819238] Starting dynamic subtest: pipe-C-eDP-1
[134.837936] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[134.845763] Starting dynamic subtest: pipe-D-eDP-1
[134.864755] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[134.866911] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[137.164230] [019/133] (882s left) syncobj_wait (single-wait-submitted)
[137.221787] Starting subtest: single-wait-submitted
[137.329497] Subtest single-wait-submitted: SUCCESS (0.107s)
[137.412971] [020/133] (881s left) kms_vrr (flip-dpms)
[137.511320] Starting subtest: flip-dpms
[137.517534] Subtest flip-dpms: SKIP (0.000s)
[137.593849] [021/133] (881s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[137.698789] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[137.703070] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[137.829179] [022/133] (881s left) gem_workarounds (suspend-resume)
[137.901565] Starting subtest: suspend-resume
[154.000596] Subtest suspend-resume: SUCCESS (1.276s)
[154.162961] [023/133] (865s left) vgem_basic (dmabuf-fence)
[154.228988] Starting subtest: dmabuf-fence
[154.231152] Subtest dmabuf-fence: SUCCESS (0.000s)
[154.317212] [024/133] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[154.417012] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[154.421141] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[154.539105] [025/133] (864s left) kms_cursor_crc (cursor-size-change)
[154.635016] Starting subtest: cursor-size-change
[154.637421] Starting dynamic subtest: pipe-A-eDP-1
[155.445875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[155.456226] Starting dynamic subtest: pipe-D-eDP-1
[156.926767] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.487s)
[156.929164] Subtest cursor-size-change: SUCCESS (2.304s)
[157.736881] [026/133] (861s left) kms_rotation_crc (cursor-rotation-180)
[157.845202] Starting subtest: cursor-rotation-180
[159.391714] Subtest cursor-rotation-180: SUCCESS (1.553s)
[160.587085] [027/133] (858s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[162.815067] Starting subtest: modeset-lpsp-stress-no-wait
[172.664773] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.863s)
[172.768210] [028/133] (846s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[172.878616] Starting subtest: 4-tiled-64bpp-rotate-180
[174.505659] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.629s)
[174.687134] [029/133] (844s left) kms_psr (pr-dpms)
[174.787540] Starting subtest: pr-dpms
[174.791171] Subtest pr-dpms: SKIP (0.000s)
[174.881674] [030/133] (844s left) dmabuf_sync_file (import-basic)
[174.922196] Starting subtest: import-basic
[174.923986] Subtest import-basic: SUCCESS (0.001s)
[175.000591] [031/133] (844s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[175.097332] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[175.100750] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[175.230869] [032/133] (844s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[175.337566] Starting subtest: psr-dirtyfb-ioctl
[175.339600] Starting dynamic subtest: A-eDP-1
[179.359109] Dynamic subtest A-eDP-1: SUCCESS (4.024s)
[179.361440] Subtest psr-dirtyfb-ioctl: SUCCESS (4.026s)
[180.231387] [033/133] (839s left) kms_flip (dpms-vs-vblank-race)
[180.325679] Starting subtest: dpms-vs-vblank-race
[180.328059] Starting dynamic subtest: A-eDP1
[185.309921] Dynamic subtest A-eDP1: SUCCESS (4.988s)
[185.319693] Starting dynamic subtest: B-eDP1
[189.935416] Dynamic subtest B-eDP1: SUCCESS (4.628s)
[189.944924] Starting dynamic subtest: C-eDP1
[194.561762] Dynamic subtest C-eDP1: SUCCESS (4.626s)
[194.571787] Starting dynamic subtest: D-eDP1
[199.186148] Dynamic subtest D-eDP1: SUCCESS (4.628s)
[199.188732] Subtest dpms-vs-vblank-race: SUCCESS (18.877s)
[200.076341] [034/133] (819s left) kms_content_protection (atomic-hdcp14)
[200.233331] Starting subtest: atomic-hdcp14
[200.238105] Subtest atomic-hdcp14: SKIP (0.000s)
[200.402345] [035/133] (819s left) i915_pm_rpm (sysfs-read)
[201.927074] Starting subtest: sysfs-read
[203.083328] Subtest sysfs-read: SUCCESS (1.158s)
[203.473233] [036/133] (816s left) perf_pmu (module-unload)
[203.598820] Starting subtest: module-unload
[210.529345] Subtest module-unload: FAIL (6.831s)
[210.563126] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[210.563851] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[210.567540] [037/133] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[212.148332] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[212.152541] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[212.258509] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[212.259710] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[212.263132] [038/133] (807s left) gem_bad_reloc (negative-reloc-lut)
[212.338286] Subtest negative-reloc-lut: SKIP (0.000s)
[212.431307] [039/133] (807s left) gem_ctx_bad_destroy (double-destroy)
[212.499840] Starting subtest: double-destroy
[212.502212] Subtest double-destroy: SUCCESS (0.000s)
[212.585677] [040/133] (807s left) kms_atomic (plane-invalid-params-fence)
[212.687419] Starting subtest: plane-invalid-params-fence
[212.689736] Starting dynamic subtest: pipe-A-eDP-1
[213.071339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.383s)
[213.073555] Subtest plane-invalid-params-fence: SUCCESS (0.384s)
[213.912793] [041/133] (806s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[214.023906] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[215.011803] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s)
[215.160614] [042/133] (804s left) kms_psr2_su (frontbuffer-xrgb8888)
[215.226956] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[215.280270] [043/133] (804s left) gem_userptr_blits (vma-merge)
[215.360147] Starting subtest: vma-merge
[215.398738] Subtest vma-merge: SUCCESS (0.041s)
[215.546733] [044/133] (804s left) gem_exec_whisper (basic-contexts-priority)
[215.619318] Starting subtest: basic-contexts-priority
[239.466302] Subtest basic-contexts-priority: SUCCESS (23.803s)
[239.623581] [045/133] (780s left) gem_exec_flush (basic-wb-set-default)
[239.680931] Starting subtest: basic-wb-set-default
[245.166520] Subtest basic-wb-set-default: SUCCESS (5.481s)
[245.360350] [046/133] (774s left) syncobj_timeline (multi-wait-all-available-submitted)
[245.417417] Starting subtest: multi-wait-all-available-submitted
[245.419865] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[245.552695] [047/133] (774s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[245.622020] Subtest writes-after-reads-uncached: SKIP (0.000s)
[245.725209] [048/133] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[245.824433] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[252.420051] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.595s)
[252.593269] [049/133] (767s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[252.700665] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[252.705079] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.829541] [050/133] (767s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[252.934397] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[259.921572] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.983s)
[260.071530] [051/133] (760s left) gem_ccs (ctrl-surf-copy-new-ctx)
[260.124499] Starting subtest: ctrl-surf-copy-new-ctx
[260.128923] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[260.230360] [052/133] (760s left) gem_exec_reloc (basic-write-cpu)
[260.295562] Subtest basic-write-cpu: SKIP (0.000s)
[260.358496] [053/133] (760s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[260.457706] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[260.462044] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[260.568675] [054/133] (760s left) gem_exec_fence (syncobj-signal)
[261.051388] Starting subtest: syncobj-signal
[261.056570] Subtest syncobj-signal: SUCCESS (0.005s)
[262.841856] [055/133] (757s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[262.931377] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[262.935358] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[263.036642] [056/133] (757s left) kms_psr (psr2-sprite-blt)
[263.133433] Starting subtest: psr2-sprite-blt
[263.135672] Starting dynamic subtest: eDP-1
[264.864894] Dynamic subtest eDP-1: SUCCESS (1.730s)
[264.867188] Subtest psr2-sprite-blt: SUCCESS (1.731s)
[265.735148] [057/133] (755s left) gem_exec_alignment (forked)
[265.794445] Starting subtest: forked
[302.789639] Subtest forked: SUCCESS (36.984s)
[303.413680] [058/133] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[303.570104] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[303.574471] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[303.685571] [059/133] (717s left) gem_exec_reloc (basic-cpu-active)
[303.754057] Subtest basic-cpu-active: SKIP (0.000s)
[303.843102] [060/133] (717s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-wc)
[303.948070] Starting subtest: fbcpsr-abgr161616f-draw-mmap-wc
[303.952225] Subtest fbcpsr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[304.055199] [061/133] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[304.167151] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[311.468496] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.306s)
[311.631866] [062/133] (709s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[311.703164] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[311.812503] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[311.901195] [063/133] (709s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[311.957819] Starting subtest: x-tiled-to-vebox-yf-tiled
[311.962209] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[312.157342] [064/133] (708s left) kms_plane_cursor (viewport)
[312.241540] Starting subtest: viewport
[312.246012] Starting dynamic subtest: pipe-A-eDP-1-size-64
[314.911343] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.671s)
[314.971047] Starting dynamic subtest: pipe-A-eDP-1-size-128
[317.590212] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.629s)
[317.650152] Starting dynamic subtest: pipe-A-eDP-1-size-256
[320.223866] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.584s)
[320.583601] Starting dynamic subtest: pipe-B-eDP-1-size-64
[323.836960] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.265s)
[323.897328] Starting dynamic subtest: pipe-B-eDP-1-size-128
[326.493361] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.605s)
[326.553316] Starting dynamic subtest: pipe-B-eDP-1-size-256
[329.138299] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.593s)
[329.496912] Starting dynamic subtest: pipe-C-eDP-1-size-64
[332.409764] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.925s)
[332.450996] Starting dynamic subtest: pipe-C-eDP-1-size-128
[334.677226] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[334.714915] Starting dynamic subtest: pipe-C-eDP-1-size-256
[336.887322] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[337.229765] Starting dynamic subtest: pipe-D-eDP-1-size-64
[340.190158] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.973s)
[340.228750] Starting dynamic subtest: pipe-D-eDP-1-size-128
[342.434484] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[342.473431] Starting dynamic subtest: pipe-D-eDP-1-size-256
[344.677789] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.213s)
[344.997961] Subtest viewport: SUCCESS (32.762s)
[345.819598] [065/133] (675s left) prime_vgem (basic-read)
[345.899843] Starting subtest: basic-read
[345.922006] Subtest basic-read: SKIP (0.021s)
[346.044476] [066/133] (675s left) kms_pm_backlight (fade-with-suspend)
[346.134305] Starting subtest: fade-with-suspend
[361.991087] Starting dynamic subtest: eDP-1
[364.651427] Dynamic subtest eDP-1: SUCCESS (2.673s)
[364.653703] Subtest fade-with-suspend: SUCCESS (3.953s)
[365.517365] [067/133] (655s left) kms_fbcon_fbt (fbc)
[365.598542] Starting subtest: fbc
[371.942354] Subtest fbc: SUCCESS (6.359s)
[373.019647] [068/133] (648s left) gem_mmap_offset (pf-nonblock)
[373.083066] Starting subtest: pf-nonblock
[373.087537] Subtest pf-nonblock: SUCCESS (0.006s)
[373.215018] [069/133] (648s left) gem_eio (wait-10ms)
[373.466338] Starting subtest: wait-10ms
[373.837106] Subtest wait-10ms: SUCCESS (0.370s)
[374.040408] [070/133] (647s left) i915_suspend (fence-restore-untiled)
[374.097647] Starting subtest: fence-restore-untiled
[374.101757] Subtest fence-restore-untiled: SKIP (0.000s)
[374.210728] [071/133] (647s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[374.503838] Starting subtest: cursor-rapid-movement-512x512
[374.508209] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[374.710583] [072/133] (646s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[374.816814] Starting subtest: plane-downscale-factor-0-5-with-rotation
[374.818739] Starting dynamic subtest: pipe-A
[374.837311] Dynamic subtest pipe-A: SKIP (0.018s)
[374.852969] Starting dynamic subtest: pipe-B
[374.870096] Dynamic subtest pipe-B: SKIP (0.031s)
[374.880824] Starting dynamic subtest: pipe-C
[374.925751] Dynamic subtest pipe-C: SKIP (0.052s)
[374.935249] Starting dynamic subtest: pipe-D
[374.959886] Dynamic subtest pipe-D: SKIP (0.033s)
[374.963345] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.141s)
[375.094180] [073/133] (646s left) kms_atomic_transition (plane-all-modeset-transition)
[375.187570] Starting subtest: plane-all-modeset-transition
[375.191214] Subtest plane-all-modeset-transition: SKIP (0.000s)
[375.275450] [074/133] (646s left) kms_properties (colorop-properties-atomic)
[375.375605] Starting subtest: colorop-properties-atomic
[375.377461] Starting dynamic subtest: pipe-A-eDP-1
[375.732865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[375.743921] Starting dynamic subtest: pipe-B-eDP-1
[376.791607] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.059s)
[376.802670] Starting dynamic subtest: pipe-C-eDP-1
[377.832078] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[377.842969] Starting dynamic subtest: pipe-D-eDP-1
[378.869713] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.040s)
[378.872180] Subtest colorop-properties-atomic: SUCCESS (3.499s)
[379.686534] [075/133] (641s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[380.076000] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[380.874562] [076/133] (640s left) i915_pciid
[381.037078] [077/133] (640s left) kms_chamelium_audio (dp-audio)
[381.417342] Subtest dp-audio: SKIP (0.000s)
[382.198290] [078/133] (639s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[382.289386] Starting subtest: fbc-psr2-sprite-mmap-cpu
[382.291734] Starting dynamic subtest: eDP-1
[382.296260] Dynamic subtest eDP-1: SKIP (0.000s)
[382.300738] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[382.375976] [079/133] (639s left) perf (invalid-oa-format-id)
[382.533024] Starting subtest: invalid-oa-format-id
[382.545219] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[382.587070] [080/133] (639s left) kms_psr (fbc-psr-no-drrs)
[382.674943] Starting subtest: fbc-psr-no-drrs
[382.677217] Starting dynamic subtest: eDP-1
[382.681354] Dynamic subtest eDP-1: SKIP (0.000s)
[382.685764] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[382.761518] [081/133] (639s left) gem_mmap_gtt (flink-race)
[382.828194] Subtest flink-race: SKIP (0.000s)
[382.897044] [082/133] (638s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[382.994180] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[382.996483] Starting dynamic subtest: pipe-A-default-mode
[383.283879] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[383.288452] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.288s)
[384.161323] [083/133] (637s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[384.263110] Starting subtest: plane-upscale-20x20-with-modifiers
[384.265489] Starting dynamic subtest: pipe-A
[384.600391] Dynamic subtest pipe-A: SUCCESS (0.341s)
[384.610978] Starting dynamic subtest: pipe-B
[386.040503] Dynamic subtest pipe-B: SUCCESS (1.440s)
[386.057354] Starting dynamic subtest: pipe-C
[387.470391] Dynamic subtest pipe-C: SUCCESS (1.429s)
[387.482096] Starting dynamic subtest: pipe-D
[388.908299] Dynamic subtest pipe-D: SUCCESS (1.438s)
[388.910650] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.653s)
[390.088667] [084/133] (631s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[390.187683] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[390.192162] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[390.338994] [085/133] (631s left) kms_getfb (getfb-repeated-different-handles)
[390.420491] Starting subtest: getfb-repeated-different-handles
[390.422754] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[390.551272] [086/133] (631s left) gem_exec_schedule (u-independent)
[390.615737] Starting subtest: u-independent
[390.617722] Starting dynamic subtest: rcs0
[392.296403] Dynamic subtest rcs0: SUCCESS (1.690s)
[392.309400] Starting dynamic subtest: vcs0
[394.324473] Dynamic subtest vcs0: SUCCESS (2.026s)
[394.337390] Starting dynamic subtest: vcs1
[396.369000] Dynamic subtest vcs1: SUCCESS (2.042s)
[396.383488] Starting dynamic subtest: vecs0
[398.362650] Dynamic subtest vecs0: SUCCESS (1.990s)
[398.375102] Starting dynamic subtest: ccs0
[400.295735] Dynamic subtest ccs0: SUCCESS (1.929s)
[400.298761] Subtest u-independent: SUCCESS (9.690s)
[400.611499] [087/133] (621s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[400.713042] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[400.717544] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[401.817739] [088/133] (620s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[402.203252] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[403.036671] [089/133] (619s left) template (b)
[403.094827] Starting subtest: B
[403.096803] Subtest B: SUCCESS (0.000s)
[403.214989] [090/133] (618s left) i915_drm_fdinfo (memory-info-shared)
[403.258628] Starting subtest: memory-info-shared
[403.260993] Starting dynamic subtest: smem0
[403.319969] Dynamic subtest smem0: SUCCESS (0.062s)
[403.322734] Subtest memory-info-shared: SUCCESS (0.062s)
[403.409520] [091/133] (618s left) gem_exec_reloc (basic-wc-gtt)
[403.470235] Subtest basic-wc-gtt: SKIP (0.000s)
[403.554267] [092/133] (618s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[403.612912] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[403.614830] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[403.719111] [093/133] (618s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[403.813704] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[403.818034] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[403.984068] [094/133] (618s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[404.105935] Starting subtest: fbc-rgb565-draw-pwrite
[408.759999] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.653s)
[409.981063] [095/133] (612s left) syncobj_wait (single-wait-all-signaled)
[410.041381] Starting subtest: single-wait-all-signaled
[410.043740] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[410.155923] [096/133] (612s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[410.253300] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[410.356684] [097/133] (612s left) kms_cursor_crc (cursor-offscreen-256x85)
[410.607251] Starting subtest: cursor-offscreen-256x85
[410.655494] Subtest cursor-offscreen-256x85: SKIP (0.044s)
[410.861110] [098/133] (611s left) kms_plane (pixel-format-linear-modifier)
[410.960012] Starting subtest: pixel-format-linear-modifier
[410.985549] Starting dynamic subtest: pipe-A-plane-0
[414.474169] Dynamic subtest pipe-A-plane-0: SUCCESS (3.489s)
[414.486251] Starting dynamic subtest: pipe-A-plane-3
[416.185541] Dynamic subtest pipe-A-plane-3: SUCCESS (1.710s)
[416.195438] Starting dynamic subtest: pipe-A-plane-5
[416.396708] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[417.539550] Starting dynamic subtest: pipe-B-plane-0
[421.104341] Dynamic subtest pipe-B-plane-0: SUCCESS (3.577s)
[421.116961] Starting dynamic subtest: pipe-B-plane-3
[422.793432] Dynamic subtest pipe-B-plane-3: SUCCESS (1.688s)
[422.803200] Starting dynamic subtest: pipe-B-plane-5
[423.004314] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[423.313783] Subtest pixel-format-linear-modifier: SUCCESS (12.357s)
[424.132760] [099/133] (598s left) syncobj_basic (bad-destroy-pad)
[424.187405] Starting subtest: bad-destroy-pad
[424.189288] Subtest bad-destroy-pad: SUCCESS (0.000s)
[424.307653] [100/133] (598s left) gem_ctx_isolation (dirty-switch)
[424.379082] Starting subtest: dirty-switch
[424.381353] Starting dynamic subtest: rcs0
[424.577767] Dynamic subtest rcs0: SUCCESS (0.198s)
[424.589353] Starting dynamic subtest: bcs0
[424.804871] Dynamic subtest bcs0: SUCCESS (0.226s)
[424.817576] Starting dynamic subtest: vcs0
[425.048391] Dynamic subtest vcs0: SUCCESS (0.243s)
[425.059568] Starting dynamic subtest: vcs1
[426.488664] Dynamic subtest vcs1: SUCCESS (1.439s)
[426.500753] Starting dynamic subtest: vecs0
[428.510913] Dynamic subtest vecs0: SUCCESS (2.022s)
[428.523296] Starting dynamic subtest: ccs0
[430.541777] Dynamic subtest ccs0: SUCCESS (2.030s)
[430.544281] Subtest dirty-switch: SUCCESS (6.164s)
[430.828522] [101/133] (591s left) kms_plane_lowres (tiling-none)
[430.949058] Starting subtest: tiling-none
[430.951334] Starting dynamic subtest: pipe-A-eDP-1
[430.955889] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[431.245154] Starting dynamic subtest: pipe-B-eDP-1
[431.249822] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[431.261771] Starting dynamic subtest: pipe-C-eDP-1
[431.266232] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[431.278587] Starting dynamic subtest: pipe-D-eDP-1
[431.282955] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[431.287323] Subtest tiling-none: SKIP (0.294s)
[432.049651] [102/133] (590s left) perf_pmu (busy-idle-no-semaphores)
[432.094371] Starting subtest: busy-idle-no-semaphores
[432.096758] Starting dynamic subtest: rcs0
[432.780174] Dynamic subtest rcs0: SUCCESS (0.686s)
[432.793214] Starting dynamic subtest: bcs0
[433.431156] Dynamic subtest bcs0: SUCCESS (0.649s)
[433.444070] Starting dynamic subtest: vcs0
[434.083235] Dynamic subtest vcs0: SUCCESS (0.649s)
[434.096315] Starting dynamic subtest: vcs1
[435.920593] Dynamic subtest vcs1: SUCCESS (1.835s)
[435.938100] Starting dynamic subtest: vecs0
[437.905545] Dynamic subtest vecs0: SUCCESS (1.983s)
[437.919227] Starting dynamic subtest: ccs0
[439.953517] Dynamic subtest ccs0: SUCCESS (2.046s)
[439.956771] Subtest busy-idle-no-semaphores: SUCCESS (7.863s)
[440.118329] [103/133] (582s left) kms_flip (blocking-absolute-wf_vblank)
[440.224321] Starting subtest: blocking-absolute-wf_vblank
[440.226592] Starting dynamic subtest: A-eDP1
[449.027795] Dynamic subtest A-eDP1: SUCCESS (8.770s)
[449.039241] Starting dynamic subtest: B-eDP1
[457.744990] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[457.758445] Starting dynamic subtest: C-eDP1
[466.481038] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[466.493882] Starting dynamic subtest: D-eDP1
[475.204900] Dynamic subtest D-eDP1: SUCCESS (8.717s)
[475.207616] Subtest blocking-absolute-wf_vblank: SUCCESS (34.935s)
[476.391670] [104/133] (546s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[476.498024] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[476.502378] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[476.623235] [105/133] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[476.722909] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[476.727103] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[476.851836] [106/133] (546s left) kms_frontbuffer_tracking (basic)
[476.938690] Starting subtest: basic
[480.293123] Subtest basic: SUCCESS (3.358s)
[480.442089] [107/133] (542s left) kms_getfb (getfb2-accept-nv12)
[480.557483] Starting subtest: getfb2-accept-nv12
[480.559249] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[480.693366] [108/133] (542s left) kms_scaling_modes (scaling-mode-full)
[480.796799] Starting subtest: scaling-mode-full
[480.798567] Starting dynamic subtest: pipe-A-eDP-1
[480.891037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[480.901845] Starting dynamic subtest: pipe-B-eDP-1
[482.100532] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s)
[482.111997] Starting dynamic subtest: pipe-C-eDP-1
[483.214220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[483.224591] Starting dynamic subtest: pipe-D-eDP-1
[484.348421] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[484.350733] Subtest scaling-mode-full: SUCCESS (3.554s)
[485.533731] [109/133] (537s left) gem_ringfill (legacy-basic)
[491.307823] Starting subtest: legacy-basic
[491.310441] Starting dynamic subtest: default
[491.395500] Dynamic subtest default: SUCCESS (0.086s)
[491.408208] Starting dynamic subtest: render
[491.439151] Dynamic subtest render: SUCCESS (0.042s)
[491.450557] Starting dynamic subtest: bsd
[491.482003] Dynamic subtest bsd: SUCCESS (0.041s)
[491.492853] Starting dynamic subtest: bsd1
[491.522950] Dynamic subtest bsd1: SUCCESS (0.039s)
[491.533846] Starting dynamic subtest: bsd2
[491.563291] Dynamic subtest bsd2: SUCCESS (0.039s)
[491.575919] Starting dynamic subtest: blt
[491.611319] Dynamic subtest blt: SUCCESS (0.046s)
[491.624606] Starting dynamic subtest: vebox
[491.658564] Dynamic subtest vebox: SUCCESS (0.043s)
[491.661196] Subtest legacy-basic: SUCCESS (0.353s)
[491.769411] [110/133] (531s left) gem_ctx_persistence (heartbeat-many)
[491.834920] Starting subtest: heartbeat-many
[491.839392] Subtest heartbeat-many: SKIP (0.000s)
[491.976772] [111/133] (531s left) gem_softpin (overlap)
[492.037909] Starting subtest: overlap
[492.988960] Subtest overlap: SUCCESS (0.950s)
[493.153303] [112/133] (530s left) gen9_exec_parse (cmd-crossing-page)
[493.230073] Subtest cmd-crossing-page: SKIP (0.000s)
[493.325445] [113/133] (529s left) perf (buffer-fill)
[493.425745] Starting subtest: buffer-fill
[493.428199] Starting dynamic subtest: 0-rcs0
[495.709899] Dynamic subtest 0-rcs0: SUCCESS (2.282s)
[495.721124] Starting dynamic subtest: 1-vcs0
[500.147058] Dynamic subtest 1-vcs0: SUCCESS (4.435s)
[500.149807] Subtest buffer-fill: SUCCESS (6.720s)
[500.201650] [114/133] (523s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[505.252442] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[505.260178] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.006s)
[506.105957] [115/133] (517s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[506.213948] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[507.061458] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.848s)
[507.272545] [116/133] (516s left) api_intel_bb (blit-reloc-keep-cache)
[507.336801] Starting subtest: blit-reloc-keep-cache
[507.341346] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[507.470829] [117/133] (515s left) kms_color (ctm-green-to-red)
[507.577698] Starting subtest: ctm-green-to-red
[507.579817] Starting dynamic subtest: pipe-A-eDP-1
[508.287634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[508.298354] Starting dynamic subtest: pipe-B-eDP-1
[509.701540] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s)
[509.712297] Starting dynamic subtest: pipe-C-eDP-1
[511.072772] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[511.083445] Starting dynamic subtest: pipe-D-eDP-1
[512.417502] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[512.419460] Subtest ctm-green-to-red: SUCCESS (4.841s)
[513.230429] [118/133] (510s left) sw_sync (sync_multi_consumer)
[513.267892] Starting subtest: sync_multi_consumer
[513.700489] Subtest sync_multi_consumer: SUCCESS (0.434s)
[513.777365] [119/133] (509s left) kms_addfb_basic (bad-pitch-32)
[513.841830] Starting subtest: bad-pitch-32
[513.844072] Subtest bad-pitch-32: SUCCESS (0.000s)
[514.021524] [120/133] (509s left) gem_exec_async (forked-writes)
[514.093870] Starting subtest: forked-writes
[514.096242] Starting dynamic subtest: rcs0
[514.118382] Dynamic subtest rcs0: SUCCESS (0.024s)
[514.132735] Starting dynamic subtest: bcs0
[514.142658] Dynamic subtest bcs0: SUCCESS (0.022s)
[514.153313] Starting dynamic subtest: vcs0
[514.165066] Dynamic subtest vcs0: SUCCESS (0.021s)
[514.176100] Starting dynamic subtest: vcs1
[514.186630] Dynamic subtest vcs1: SUCCESS (0.021s)
[514.197817] Starting dynamic subtest: vecs0
[514.207496] Dynamic subtest vecs0: SUCCESS (0.020s)
[514.218105] Starting dynamic subtest: ccs0
[514.228533] Dynamic subtest ccs0: SUCCESS (0.020s)
[514.230672] Subtest forked-writes: SUCCESS (0.135s)
[514.507763] [121/133] (509s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[514.615832] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[514.620398] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[514.751456] [122/133] (508s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[514.860331] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[514.864392] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[514.996368] [123/133] (508s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[515.062728] Starting subtest: single-wait-all-for-submit-signaled
[515.065096] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[515.174708] [124/133] (508s left) kms_hdmi_inject (inject-audio)
[515.530397] Starting subtest: inject-audio
[515.807278] Subtest inject-audio: SUCCESS (0.279s)
[516.394720] [125/133] (507s left) gem_exec_schedule (preemptive-hang)
[516.569582] Starting subtest: preemptive-hang
[516.571545] Starting dynamic subtest: rcs0
[525.398978] Dynamic subtest rcs0: SUCCESS (8.828s)
[525.409053] Starting dynamic subtest: bcs0
[534.421576] Dynamic subtest bcs0: SUCCESS (9.023s)
[534.433779] Starting dynamic subtest: vcs0
[543.440949] Dynamic subtest vcs0: SUCCESS (9.022s)
[543.453944] Starting dynamic subtest: vcs1
[552.400205] Dynamic subtest vcs1: SUCCESS (8.959s)
[552.410862] Starting dynamic subtest: vecs0
[561.427856] Dynamic subtest vecs0: SUCCESS (9.023s)
[561.440745] Starting dynamic subtest: ccs0
[570.449719] Dynamic subtest ccs0: SUCCESS (9.028s)
[570.452197] Subtest preemptive-hang: SUCCESS (53.892s)
[570.724197] [126/133] (453s left) kms_mmap_write_crc (main)
[570.819540] Starting subtest: main
[570.821858] Starting dynamic subtest: pipe-A-eDP-1
[574.422912] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.601s)
[574.424938] Subtest main: SUCCESS (3.603s)
[575.242941] [127/133] (448s left) syncobj_wait (single-wait-all-submitted)
[575.303246] Starting subtest: single-wait-all-submitted
[575.412361] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[575.503629] [128/133] (448s left) kms_feature_discovery (dp-mst)
[575.598284] Starting subtest: dp-mst
[575.602710] Subtest dp-mst: SKIP (0.000s)
[575.684080] [129/133] (448s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[575.791007] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[582.410071] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.624s)
[582.558572] [130/133] (441s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[582.657999] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[582.660296] Starting dynamic subtest: pipe-A-eDP-1
[583.541753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.878s)
[583.558078] Starting dynamic subtest: pipe-B-eDP-1
[585.192735] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.646s)
[585.203779] Starting dynamic subtest: pipe-C-eDP-1
[586.703716] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.512s)
[586.715459] Starting dynamic subtest: pipe-D-eDP-1
[588.180228] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.473s)
[588.182124] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.515s)
[589.426053] [131/133] (434s left) kms_cursor_edge_walk (64x64-right-edge)
[589.535335] Starting subtest: 64x64-right-edge
[589.537684] Starting dynamic subtest: pipe-A-eDP-1
[592.962182] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.424s)
[592.973202] Starting dynamic subtest: pipe-D-eDP-1
[596.140564] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.175s)
[596.142460] Subtest 64x64-right-edge: SUCCESS (6.603s)
[597.069430] [132/133] (426s left) syncobj_eventfd (binary-wait)
[597.128807] Starting subtest: binary-wait
[597.137378] Subtest binary-wait: SUCCESS (0.011s)
[597.228624] [133/133] (426s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[597.325389] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[597.327641] Starting dynamic subtest: pipe-A-default-mode
[597.616483] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[597.621079] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.287s)
[598.445899] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: gem_exec_whisper
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 9/ for test: kms_joiner
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: gem_spin_batch
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: kms_selftest
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_vrr
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_workarounds
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: dmabuf_sync_file
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_dirtyfb
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_content_protection
results: parsing output: 34/ for test: i915_pm_rpm
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_bad_reloc
results: parsing output: 38/ for test: gem_ctx_bad_destroy
results: parsing output: 39/ for test: kms_atomic
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_psr2_su
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_partial_pwrite_pread
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_ccs
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_exec_alignment
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: kms_plane_cursor
results: parsing output: 64/ for test: prime_vgem
results: parsing output: 65/ for test: kms_pm_backlight
results: parsing output: 66/ for test: kms_fbcon_fbt
results: parsing output: 67/ for test: gem_mmap_offset
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: i915_suspend
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: kms_properties
results: parsing output: 74/ for test: kms_chamelium_frames
results: parsing output: 75/ for test: i915_pciid
results: parsing output: 76/ for test: kms_chamelium_audio
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_getfb
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_chamelium_hpd
results: parsing output: 88/ for test: template
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: syncobj_basic
results: parsing output: 99/ for test: gem_ctx_isolation
results: parsing output: 100/ for test: kms_plane_lowres
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: kms_scaling_modes
results: parsing output: 108/ for test: gem_ringfill
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: gen9_exec_parse
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_color
results: parsing output: 117/ for test: sw_sync
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: gem_exec_async
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_hdmi_inject
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_mmap_write_crc
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_feature_discovery
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: syncobj_eventfd
results: parsing output: 132/ for test: kms_flip_scaled_crc
Done.